locked
Replaced Laptop hard drive - would not restore, now more problems RRS feed

  • Question

  • Hi there, hopefully somebody can point me in the right direction here!

    WHS PP1 running on a Shuttle k45 with E2220 Pentium Dual Core, 2GB OCZ DDR2-667 RAM, 2 x WD Green 640GB Drives.

    Vista 32bit on Acer Aspire 5720; originally with WD 5400 80GB Drive with 2 main partition and hidden restore.

    I had 3 full successfull backups from the laptop to the WHS box on the existing 80GB drive (buil new server for my newley purchased WHS after liking the trial on old machine)

    Took out laptop drive and fitted a new 320GB 7200rpm WD Black drive.
    BIOS saw it ok, booted to restore cd. Found the server ok and started recovery. Set up 3 partitions and tried recovering - failed at 24 minutes left; no option but to cancel and "Make drive unusable".

    Had to use some WD tools to re-format the drive again.

    Repeated it again, but thought the "PQService" hidden partition may have been the problem so just partitioned with 2. Only selected C and D drive to restore. It failed again.

    Again I had to cancel and make the "Drive Unusable", then sort with a WD boot CD.

    3rd attempt, tried using the drivers from the recovery file onto a USB stick; same again (with and without the hidden partition)

    Gave up and got a 15 day trial of Acronis Migrate Easy, this copied my old disc perfectly and got me a running Vista Laptop again.

    Next step was to get it backed up to WHS and prove that "hopefully" it can restore ok back to the new drive. The old one is to be formatted and replace the failing drive on wifes laptop, so I need to be 100% sure the restore feature actually works!!!

    I logged into the console to check that it still saw the 3 partitions to backup; and saw this:

    backup.jpg

    I assumed it would be ok as it had de-selected the non-existant partitions, and selected the current ones.

    It failed saying that I should run chkdsk /f /r on the drive. I did this for C and D set for next boot. It did the scans ok.

    I tried again and it also failed. Below is screen shot of failure in WHS Console:

    backup2.jpg

    I then tried re-installing the connector software in case it was confused with the disc change; still got the same problem.

    I RDP into WHS and checked the event log; and got abort reason 5. The Microsoft link for this gives no information at all.

    backup3.jpg

    I also tried restarting the server, this made no difference either. I have checked the Vista Event viewer and saw this:

    backup4.jpg

    Could there be some rubbish in the registry causing the connector software to fail?

    I need this to work right, the ease of backup and security etc was what warranted the purchase of all the new parts to build the server!

    Thanks in advance!


    Sunday, February 15, 2009 8:08 PM

All replies

  • Hi,

    Is you server still available for you to submit a bug to us? I tried clicking on the links above and they were not available. If you can access the server, please file a bug on Connect. We will need client and server CABs and there is information regarding how to submit those to Microsoft here.

    In addition, bare metal restore logs would be helpful if you feel like trying a restore one more time:

    1. To the root of a USB key add two files named:

    "HomeServerPCRestore.log"
    "HomeServerPCRestore_Update.log"

    2. Restore looks for those files and will log to them when found.
    3. Do a bare metal restore.
    4. Attach the files to the bug.


    Thank you
    Lara Jones [MSFT] | Program Manager
    Community Support and Beta | Windows Home Server Team
    Windows Home Server Team Blog
    Connect Windows Home Server
    Windows Home Server
    Tuesday, February 17, 2009 10:16 PM
    Moderator
  • Lara,

    Brilliant, nice to see some interest in my problem :)

    I am currently at work on nights (UK). The server website is down at the moment; rushing before I left for work I deleted the wrong account on my server and lost the mini site and images!

    Just for further information (until tomorrow when I can get the information you have requested) I have moved on from the initial post.

    I was getting nowhere fast, so decided that the problem must have been caused by the imaged hard drive as the connector software was seeing duplicated partitions when asking which to backup (although it new the old ones were missing).

    This morning because I decided that there must have been a problem with the Vista (32bit) installation on my laptop. I decided to do a factory restore from the hidden recovery partition. I did this and then installed all Windows updates, then SP1, then my antivirus (Bullguard). After a few hours getting it to ths position I decided that this was a good position to get the first backup to WHS.

    When I set up the laptop I gave it a slightly different name than before, and also used a different log-in for me too; this was incase anything was still lingering around on the WHS after removing the laptop before the restore.

    I picked up the server from the upnp discovery which then opens IE with the download link for the connector software (to make sure I got newest version). It did not find the server automatically (it never does on my network as I dont use the standard network name). Chose manual and then it found it ok. Put in the password, and it all went ok. BUT then when I selected backup (just as I was walking out of office for some sleep!) it failed with the same errors. It was the cannot lock the volumes (or similar) run chkdsk /f/r.

    Thats where I am at the moment; maybe there is a problem with WHS rather than the VIsta Laptop :(

    Tim
    Tuesday, February 17, 2009 11:23 PM
  • TimboUK said:

    Lara,

    Brilliant, nice to see some interest in my problem :)

    I am currently at work on nights (UK). The server website is down at the moment; rushing before I left for work I deleted the wrong account on my server and lost the mini site and images!

    Just for further information (until tomorrow when I can get the information you have requested) I have moved on from the initial post.

    I was getting nowhere fast, so decided that the problem must have been caused by the imaged hard drive as the connector software was seeing duplicated partitions when asking which to backup (although it new the old ones were missing).

    This morning because I decided that there must have been a problem with the Vista (32bit) installation on my laptop. I decided to do a factory restore from the hidden recovery partition. I did this and then installed all Windows updates, then SP1, then my antivirus (Bullguard). After a few hours getting it to ths position I decided that this was a good position to get the first backup to WHS.

    When I set up the laptop I gave it a slightly different name than before, and also used a different log-in for me too; this was incase anything was still lingering around on the WHS after removing the laptop before the restore.

    I picked up the server from the upnp discovery which then opens IE with the download link for the connector software (to make sure I got newest version). It did not find the server automatically (it never does on my network as I dont use the standard network name). Chose manual and then it found it ok. Put in the password, and it all went ok. BUT then when I selected backup (just as I was walking out of office for some sleep!) it failed with the same errors. It was the cannot lock the volumes (or similar) run chkdsk /f/r.

    Thats where I am at the moment; maybe there is a problem with WHS rather than the VIsta Laptop :(

    Tim



    You might try running chkdsk /f/r on the server as well.  If you install the toolkit, you can view the event logs for the server and see if they provide any clues i.e referencing drive errors.

    Or, you can wait until we have the CABs for the bug and let us dig through the logs.

    Thanks!


    Lara Jones [MSFT] | Program Manager
    Community Support and Beta | Windows Home Server Team
    Windows Home Server Team Blog
    Connect Windows Home Server
    Windows Home Server
    Wednesday, February 18, 2009 1:37 AM
    Moderator
  • Lara Jones said:

    Hi,

    Is you server still available for you to submit a bug to us? I tried clicking on the links above and they were not available. If you can access the server, please file a bug on Connect. We will need client and server CABs and there is information regarding how to submit those to Microsoft here.

    In addition, bare metal restore logs would be helpful if you feel like trying a restore one more time:

    1. To the root of a USB key add two files named:

    "HomeServerPCRestore.log"
    "HomeServerPCRestore_Update.log"

    2. Restore looks for those files and will log to them when found.
    3. Do a bare metal restore.
    4. Attach the files to the bug.


    Thank you
    Lara Jones [MSFT] | Program Manager
    Community Support and Beta | Windows Home Server Team
    Windows Home Server Team Blog
    Connect Windows Home Server
    Windows Home Server



    Hi Lara, sorry but I cannot give you this information. When I decided to use the laptop partition to restore to new condition, I deleted the backups of the laptop so there was no confusion.

    I am trying to get the CABs to you, but I either get no CAB number or a "-1" number!

    Thanks so far

    Tim
    Wednesday, February 18, 2009 7:48 AM
  • Hi, still cannot get the CAB numbers, but here is something from the server log:

    [18/02/2009 08:00:33 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:33 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:36  b38] Listener TcpEventCallback  
    [18/02/2009 08:00:36  b38] Listener TcpConditionCallback from 192.168.1.10  
    [18/02/2009 08:00:36 12d4] Session: ThreadMain for 0026BC50  
    [18/02/2009 08:00:36 12d4] Creating the server instance.  
    [18/02/2009 08:00:36 12d4] Created the server instance.  
    [18/02/2009 08:00:36 12d4] Client subject: CN=CEED8CD1769FD4F90A636EE44F1747F62 
    [18/02/2009 08:00:36 12d4] Client issuer: CN=M807C11FDFA0E47BF8A9B88D04CD33C38 
    [18/02/2009 08:00:36 12d4] Auth succeeded, ready for command  
    [18/02/2009 08:00:36 12d4] Header: 5, Trailer: 16, MaxMessage: 16384  
    [18/02/2009 08:00:36 12d4] Partner cert name is <CN=CEED8CD1769FD4F90A636EE44F1747F62>  
    [18/02/2009 08:00:36 12d4] Partner GUID is {eed8cd17-69fd-4f90-...}  
    [18/02/2009 08:00:37 12d4] Session: DoBeginReconnectableSession  
    [18/02/2009 08:00:37 12d4] ReconnectableStream: Created ServerReconnectableStream for {0A800F66-584F-4470-970A-2E2F8AFA01C1}, sizes 1048576,16384,1048576,16384  
    [18/02/2009 08:00:37 12d4] Session: DoBackupSet  
    [18/02/2009 08:00:37 12d4] Backup set 5 for TIMS-LAPTOP has started.  
    [18/02/2009 08:00:37 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:37 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:37 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.PQSERVICE.Volume.dat  
    [18/02/2009 08:00:37 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.PQSERVICE.Volume.new to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.PQSERVICE.Volume.dat  
    [18/02/2009 08:00:38 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.C.Volume.dat  
    [18/02/2009 08:00:38 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.C.Volume.new to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.C.Volume.dat  
    [18/02/2009 08:00:38 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.D.Volume.dat  
    [18/02/2009 08:00:38 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.D.Volume.new to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.D.Volume.dat  
    [18/02/2009 08:00:38 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{EED8CD17-69FD-4F90-A636-EE44F1747F62}.Machine.configdat  
    [18/02/2009 08:00:38 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{EED8CD17-69FD-4F90-A636-EE44F1747F62}.Machine.confignew to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{EED8CD17-69FD-4F90-A636-EE44F1747F62}.Machine.configdat  
    [18/02/2009 08:00:38 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.BackupSet.dat  
    [18/02/2009 08:00:38 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.BackupSet.new to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.BackupSet.dat  
    [18/02/2009 08:00:38 12d4] CommitFile: Neutering Commit file: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\Commit.dat  
    [18/02/2009 08:00:41 12d4] Received abort message from TIMS-LAPTOP with reason 5.  
    [18/02/2009 08:00:41  b38] Listener TcpEventCallback  
    [18/02/2009 08:00:41  b38] Listener TcpConditionCallback from 192.168.1.10  
    [18/02/2009 08:00:41  33c] Session: ThreadMain for 00EE0088  
    [18/02/2009 08:00:41  33c] Session: ThreadMain end for 00EE0088  
    [18/02/2009 08:00:41  b50] TransportHelper TransportHelperSink received SessionDisconnected for {0A800F66-584F-4470-970A-2E2F8AFA01C1}  
    [18/02/2009 08:00:41  b50] ReconnectableStream: MarkSessionDead for {0A800F66-584F-4470-970A-2E2F8AFA01C1}, found  
    [18/02/2009 08:00:42 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.PQSERVICE.Volume.dat  
    [18/02/2009 08:00:42 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.PQSERVICE.Volume.new to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.PQSERVICE.Volume.dat  
    [18/02/2009 08:00:42 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.C.Volume.dat  
    [18/02/2009 08:00:42 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.C.Volume.new to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.C.Volume.dat  
    [18/02/2009 08:00:42 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.D.Volume.dat  
    [18/02/2009 08:00:42 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.D.Volume.new to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.D.Volume.dat  
    [18/02/2009 08:00:42 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.BackupSet.dat  
    [18/02/2009 08:00:42 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.BackupSet.new to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\TIMSLAPTOP.BackupSet.dat  
    [18/02/2009 08:00:42 12d4] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{EED8CD17-69FD-4F90-A636-EE44F1747F62}.Machine.configdat  
    [18/02/2009 08:00:42 12d4] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{EED8CD17-69FD-4F90-A636-EE44F1747F62}.Machine.confignew to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{EED8CD17-69FD-4F90-A636-EE44F1747F62}.Machine.configdat  
    [18/02/2009 08:00:42 12d4] CommitFile: Neutering Commit file: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\Commit.dat  
    [18/02/2009 08:00:42 12d4] Backup set 5 for TIMS-LAPTOP has finished.  
    [18/02/2009 08:00:42 12d4] Session: ThreadMain end for 0026BC50  
    [18/02/2009 08:00:42 12d4] ReconnectableStream: Destroyed ServerReconnectableStream for {0A800F66-584F-4470-970A-2E2F8AFA01C1}  
    [18/02/2009 08:00:42 12d4]  TLS::~TLS going away (first time)...  
    [18/02/2009 08:00:42 12d4] Breaking TLS sesssion...  
    [18/02/2009 08:00:42 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:42 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:45 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:45 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:52 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:00:52 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:01:12 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:01:12 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:01:49 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:01:49 14d0] Session: DoGetConfiguration  
    [18/02/2009 08:01:49 14d0] Session: DoGetConfiguration  
     

    Found these on my PC event viewer:

    Log Name:      Application  
    Source:        HomeServer  
    Date:          18/02/2009 08:00:09  
    Event ID:      768  
    Task Category: HomeBackup  
    Level:         Information  
    Keywords:      Classic  
    User:          N/A  
    Computer:      Tims-Laptop  
    Description:  
    Backup set 5 started on SERVER.  
    Event Xml:  
    <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">  
      <System> 
        <Provider Name="HomeServer" /> 
        <EventID Qualifiers="20479">768</EventID> 
        <Level>4</Level> 
        <Task>3</Task> 
        <Keywords>0x80000000000000</Keywords> 
        <TimeCreated SystemTime="2009-02-18T08:00:09.000Z" /> 
        <EventRecordID>1437</EventRecordID> 
        <Channel>Application</Channel> 
        <Computer>Tims-Laptop</Computer> 
        <Security /> 
      </System> 
      <EventData> 
        <Data>5</Data> 
        <Data>SERVER</Data> 
      </EventData> 
    </Event> 
     

    and

    Log Name:      Application  
    Source:        HomeServer  
    Date:          18/02/2009 08:00:12  
    Event ID:      770  
    Task Category: HomeBackup  
    Level:         Error  
    Keywords:      Classic  
    User:          N/A  
    Computer:      Tims-Laptop  
    Description:  
    Backup set 5 on SERVER failed: Microsoft.HomeServer.Backup.VSS.ShadowVolumeException: VSS Operation timed out ---> System.TimeoutException: VSS Operation timed out  
       at Microsoft.HomeServer.Backup.VSS.ShadowVolumeSet.Wait(IVssAsync va)  
       at Microsoft.HomeServer.Backup.VSS.ShadowVolumeSet.CreateShadowVolume(VolumeInfo[] volumes)  
       --- End of inner exception stack trace ---  
       at Microsoft.HomeServer.Backup.VSS.ShadowVolumeSet.CreateShadowVolume(VolumeInfo[] volumes)  
       at Microsoft.HomeServer.Backup.VSS.ShadowVolumeSet..ctor(VolumeInfo[] volumes)  
       at Microsoft.HomeServer.Backup.BackupOp.BackupSetOperation.RunWithoutCatch()  
       at Microsoft.HomeServer.Backup.BackupOp.BackupSetOperation.Run()  
    Event Xml:  
    <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">  
      <System> 
        <Provider Name="HomeServer" /> 
        <EventID Qualifiers="53247">770</EventID> 
        <Level>2</Level> 
        <Task>3</Task> 
        <Keywords>0x80000000000000</Keywords> 
        <TimeCreated SystemTime="2009-02-18T08:00:12.000Z" /> 
        <EventRecordID>1438</EventRecordID> 
        <Channel>Application</Channel> 
        <Computer>Tims-Laptop</Computer> 
        <Security /> 
      </System> 
      <EventData> 
        <Data>5</Data> 
        <Data>SERVER</Data> 
        <Data>Microsoft.HomeServer.Backup.VSS.ShadowVolumeException: VSS Operation timed out ---&gt; System.TimeoutException: VSS Operation timed out  
       at Microsoft.HomeServer.Backup.VSS.ShadowVolumeSet.Wait(IVssAsync va)  
       at Microsoft.HomeServer.Backup.VSS.ShadowVolumeSet.CreateShadowVolume(VolumeInfo[] volumes)  
       --- End of inner exception stack trace ---  
       at Microsoft.HomeServer.Backup.VSS.ShadowVolumeSet.CreateShadowVolume(VolumeInfo[] volumes)  
       at Microsoft.HomeServer.Backup.VSS.ShadowVolumeSet..ctor(VolumeInfo[] volumes)  
       at Microsoft.HomeServer.Backup.BackupOp.BackupSetOperation.RunWithoutCatch()  
       at Microsoft.HomeServer.Backup.BackupOp.BackupSetOperation.Run()</Data> 
      </EventData> 
    </Event> 

    Does this help at all? I will try uploading the logs later; time for sleep :)

    Thanks
    Wednesday, February 18, 2009 8:28 AM
  • Quick update, I guesse your CAB server was down. Now filed under ref 415887

    Thanks
    Wednesday, February 18, 2009 8:47 AM
  • My feeling now is that there maybe something wrong with the install of WHS? I am waiting for Microsoft team to get back to me before I re-install.

    Just want it all to work :(
    Thursday, February 19, 2009 4:04 PM
  • TimboUK said:

    Hi Lara, sorry but I cannot give you this information. When I decided to use the laptop partition to restore to new condition, I deleted the backups of the laptop so there was no confusion.

    I am trying to get the CABs to you, but I either get no CAB number or a "-1" number!

    Thanks so far

    Tim



    The "-1" for the CAB number indicates that the log files are too large to be sent. I see from the bug that you filed that you were able to resolve this.
    Lara Jones [MSFT] | Program Manager
    Community Support and Beta | Windows Home Server Team
    Windows Home Server Team Blog
    Connect Windows Home Server
    Windows Home Server
    Thursday, February 19, 2009 4:38 PM
    Moderator
  • TimboUK said:

    My feeling now is that there maybe something wrong with the install of WHS? I am waiting for Microsoft team to get back to me before I re-install.

    Just want it all to work :(



    This has been assigned to a backup developer. We will let you know as soon as we have an update.

    Thanks!
    Lara Jones [MSFT] | Program Manager
    Community Support and Beta | Windows Home Server Team
    Windows Home Server Team Blog
    Connect Windows Home Server
    Windows Home Server
    Thursday, February 19, 2009 4:39 PM
    Moderator