Homeserver Forum

Arburgmann hat geschrieben:Das hier schreibt er auf den WHS in die Logs

Created at 03.08.2009 07:01:33
***** Started at 03.08.2009 07:01:33 ***
***** Started at 03.08.2009 07:01:33 ***
[1]090803.070134.9687: Error: Error -2147023728 in SendMessage
[1]090803.070135.0625: Error: Error -2147023728 in SendMessage

was ist das denn für ein Log-File, der sieht bei mir völlig anders aus


müsste hier stehen:
C:\Dokumente und Einstellungen\All Users\Anwendungsdaten\Microsoft\Windows Home Server\logs\backup-080609.log

Das komische ist das die Bios Zeit mit der des Clients übereinstimmt. Aber es passiert immer weider mal das die Zeit um 6 Stunden im Minus ist.
Keine Ahnun von welchem Programm aus das geht. Aber auch wen nich dann sichern möchte geht es nciht.

D.H. die Zeit auf dem Server ist falsch ? Sind die Zeitzonen richtig eingestellt ? Welcher Time-Server ist eingestellt ?

Poste doch bitte noch einmal den richtigen LogFile

-welche Log meints du ??

guckst du 4 posts höher

Nobby1805 hat geschrieben:müsste hier stehen:
C:\Dokumente und Einstellungen\All Users\Anwendungsdaten\Microsoft\Windows Home Server\logs\backup-080609.log

So hier nochmal die
backup-080809.log



[08.08.2009 00:00:00]
[08.08.2009 07:46:56 c8] TransportHelper TransportHelperSink received SessionDisconnected for {C492A43B-3AA7-4D57-82BC-0465492E91B0}
[08.08.2009 07:46:56 c8] ReconnectableStream: MarkSessionDead for {C492A43B-3AA7-4D57-82BC-0465492E91B0}, not found
[08.08.2009 07:48:22 bb0] Listener TcpEventCallback
[08.08.2009 07:48:22 bb0] Listener TcpConditionCallback from 192.168.1.58
[08.08.2009 07:48:22 868] Session: ThreadMain for 00EF6E88
[08.08.2009 07:48:22 868] Creating the server instance.
[08.08.2009 07:48:22 868] Created the server instance.
[08.08.2009 07:48:22 868] Client subject: CN=C47DC4CE527D145FA918B4131554EB361
[08.08.2009 07:48:22 868] Client issuer: CN=M795C14D52F704994B9BA5095484EFD01
[08.08.2009 07:48:22 868] Auth succeeded, ready for command
[08.08.2009 07:48:22 868] Header: 5, Trailer: 16, MaxMessage: 16384
[08.08.2009 07:48:22 868] Partner cert name is <CN=C47DC4CE527D145FA918B4131554EB361>
[08.08.2009 07:48:22 868] Partner GUID is {47dc4ce5-27d1-45fa-...}
[08.08.2009 07:48:22 868] Session: DoBeginVolumeConfig {47DC4CE5-27D1-45FA-918B-4131554EB361}
[08.08.2009 07:48:23 868] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\IBMPC.VolumeConfig.configdat
[08.08.2009 07:48:23 868] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\IBMPC.VolumeConfig.confignew to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\IBMPC.VolumeConfig.configdat
[08.08.2009 07:48:23 868] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{47DC4CE5-27D1-45FA-918B-4131554EB361}.Machine.configdat
[08.08.2009 07:48:23 868] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{47DC4CE5-27D1-45FA-918B-4131554EB361}.Machine.confignew to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{47DC4CE5-27D1-45FA-918B-4131554EB361}.Machine.configdat
[08.08.2009 07:48:23 868] CommitFile: Neutering Commit file: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\Commit.dat
[08.08.2009 07:48:23 868] Partner shut down the connection
[08.08.2009 07:48:23 868] Breaking TLS sesssion...
[08.08.2009 07:48:23 868] Read 0 bytes, hr=80004004
[08.08.2009 07:48:23 868] Session: ThreadMain end for 00EF6E88
[08.08.2009 07:48:23 868] TLS::~TLS going away (first time)...
[08.08.2009 07:48:23 868] Breaking TLS sesssion...
[08.08.2009 07:56:24 bb0] Listener TcpEventCallback
[08.08.2009 07:56:24 bb0] Listener TcpConditionCallback from 192.168.1.58
[08.08.2009 07:56:24 1428] Session: ThreadMain for 00EF6E88
[08.08.2009 07:56:24 1428] Creating the server instance.
[08.08.2009 07:56:24 1428] Created the server instance.
[08.08.2009 07:56:24 1428] Client subject: CN=C47DC4CE527D145FA918B4131554EB361
[08.08.2009 07:56:24 1428] Client issuer: CN=M795C14D52F704994B9BA5095484EFD01
[08.08.2009 07:56:24 1428] Auth succeeded, ready for command
[08.08.2009 07:56:24 1428] Header: 5, Trailer: 16, MaxMessage: 16384
[08.08.2009 07:56:24 1428] Partner cert name is <CN=C47DC4CE527D145FA918B4131554EB361>
[08.08.2009 07:56:24 1428] Partner GUID is {47dc4ce5-27d1-45fa-...}
[08.08.2009 07:56:24 bcc] TransportHelper TransportHelperSink received SessionDisconnected for {C492A43B-3AA7-4D57-82BC-0465492E91B0}
[08.08.2009 07:56:24 bcc] ReconnectableStream: MarkSessionDead for {C492A43B-3AA7-4D57-82BC-0465492E91B0}, not found
[08.08.2009 07:56:24 1428] Session: DoBeginVolumeConfig {47DC4CE5-27D1-45FA-918B-4131554EB361}
[08.08.2009 07:56:24 1428] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\IBMPC.VolumeConfig.configdat
[08.08.2009 07:56:24 1428] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\IBMPC.VolumeConfig.confignew to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\IBMPC.VolumeConfig.configdat
[08.08.2009 07:56:24 1428] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{47DC4CE5-27D1-45FA-918B-4131554EB361}.Machine.configdat
[08.08.2009 07:56:24 1428] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{47DC4CE5-27D1-45FA-918B-4131554EB361}.Machine.confignew to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{47DC4CE5-27D1-45FA-918B-4131554EB361}.Machine.configdat
[08.08.2009 07:56:24 1428] CommitFile: Neutering Commit file: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\Commit.dat
[08.08.2009 07:56:24 1428] Partner shut down the connection
[08.08.2009 07:56:24 1428] Breaking TLS sesssion...
[08.08.2009 07:56:24 1428] Read 0 bytes, hr=80004004
[08.08.2009 07:56:24 1428] Session: ThreadMain end for 00EF6E88
[08.08.2009 07:56:24 1428] TLS::~TLS going away (first time)...
[08.08.2009 07:56:24 1428] Breaking TLS sesssion...
[08.08.2009 08:05:00 bb0] Listener TcpEventCallback
[08.08.2009 08:05:00 bb0] Listener TcpConditionCallback from 192.168.1.55
[08.08.2009 08:05:00 248] Session: ThreadMain for 00EF6E88
[08.08.2009 08:05:00 248] Creating the server instance.
[08.08.2009 08:05:00 248] Created the server instance.
[08.08.2009 08:05:00 248] Client subject: CN=C27F6B184ECDB48AE8B3017037EEDA4DF
[08.08.2009 08:05:00 248] Client issuer: CN=M795C14D52F704994B9BA5095484EFD01
[08.08.2009 08:05:00 248] Auth succeeded, ready for command
[08.08.2009 08:05:00 248] Header: 5, Trailer: 16, MaxMessage: 16384
[08.08.2009 08:05:00 248] Partner cert name is <CN=C27F6B184ECDB48AE8B3017037EEDA4DF>
[08.08.2009 08:05:00 248] Partner GUID is {27f6b184-ecdb-48ae-...}
[08.08.2009 08:05:00 248] Session: DoBeginVolumeConfig {27F6B184-ECDB-48AE-8B30-17037EEDA4DF}
[08.08.2009 08:05:01 248] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\QUADCORE.VolumeConfig.configdat
[08.08.2009 08:05:01 248] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\QUADCORE.VolumeConfig.confignew to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\QUADCORE.VolumeConfig.configdat
[08.08.2009 08:05:01 248] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{27F6B184-ECDB-48AE-8B30-17037EEDA4DF}.Machine.configdat
[08.08.2009 08:05:01 248] DataFile: Renamed from: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{27F6B184-ECDB-48AE-8B30-17037EEDA4DF}.Machine.confignew to: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\{27F6B184-ECDB-48AE-8B30-17037EEDA4DF}.Machine.configdat
[08.08.2009 08:05:01 248] CommitFile: Neutering Commit file: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\Commit.dat
[08.08.2009 08:05:01 248] Partner shut down the connection
[08.08.2009 08:05:01 248] Breaking TLS sesssion...
[08.08.2009 08:05:01 248] Read 0 bytes, hr=80004004
[08.08.2009 08:05:01 248] Session: ThreadMain end for 00EF6E88
[08.08.2009 08:05:01 248] TLS::~TLS going away (first time)...
[08.08.2009 08:05:01 248] Breaking TLS sesssion...

und dazu bitte auch noch den passende Logfile vom Client ...

Das sieht für mich aber so aus, als ob du 3 Verbindungen von 2 verschiedenen Rechnern (IMBPC und QUADCORE) gemacht hast ... aber nie ein Backup gestartet wurde

bei mir sieht das so aus

[08.08.2009 08:20:57 9ac] Listener TcpEventCallback
[08.08.2009 08:20:57 9ac] Listener TcpConditionCallback from 192.168.1.55
[08.08.2009 08:20:57 430] Session: ThreadMain for 00EFE5D8
[08.08.2009 08:20:57 430] Creating the server instance.
[08.08.2009 08:20:57 430] Created the server instance.
[08.08.2009 08:20:57 430] Client subject: CN=C2B0E6A2F209141429571DEFADF2DFC12
[08.08.2009 08:20:57 430] Client issuer: CN=M716EF33BD5864EC3B53B1B250A5C1C73
[08.08.2009 08:20:57 430] Auth succeeded, ready for command
[08.08.2009 08:20:57 430] Header: 5, Trailer: 16, MaxMessage: 16384
[08.08.2009 08:20:57 430] Partner cert name is <CN=C2B0E6A2F209141429571DEFADF2DFC12>
[08.08.2009 08:20:57 430] Partner GUID is {2b0e6a2f-2091-4142-...}
[08.08.2009 08:20:57 430] Session: DoBeginReconnectableSession
[08.08.2009 08:20:57 430] ReconnectableStream: Created ServerReconnectableStream for {7FF62DC9-950E-460D-B29A-8D210DD0347F}, sizes 1048576,16384,1048576,16384
[08.08.2009 08:20:57 430] Session: DoBackupSet
[08.08.2009 08:20:58 430] Sicherungssatz 45 für NORBERT3 wurde gestartet.

Müsste die hier sein denke ich mal:

Created at 07.08.2009 07:33:42
***** Started at 07.08.2009 07:33:42 ***
***** Started at 07.08.2009 07:33:42 ***
[1]090807.073342.7368: Status: Start
[1]090807.073342.9864: Status: Connect to server HOMESERVER, session 4fdfe572-cc8d-4010-8e67-d8d4e0bc8905, protocol 20
[1]090807.073343.4232: Status: Volume 04c54c62-730f-11de-8b5b-806e6f6e6963 = C:
[1]090807.073343.7508: Status: Acquire volume shadows
[1]090807.073350.5524: Status: Volume 1 of 1 is C: size 74247569408 used 35635154944
[1]090807.073350.6148: Status: Start volume C: using \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy14
[1]090807.073350.7708: Status: Volume (shadow) size 74247565312 used 36094173184
[1]090807.073358.7112: Status: File records: 70204 sent, 21604 changed, 11 metadata, 68197 received (bytes sent=1392540 received=1355692)
[1]090807.073358.7112: Status: Prepare fixups: total restore size 43450793984
[1]090807.073358.8204: Status: Determine changed: scan 2446631 size 10021400576
[1]090807.073711.3715: Status: Exception: ClientIoError
[1]090807.073711.3715: Status: : C:
[1]090807.073711.3715: Status: Bytes sent=14094429, bytes received=1355713, 0 reconnects

Sorry, aber das poasst doch nicht ... der ist vom 7.8.

UPS - SORRY

Created at 08.08.2009 14:48:52
***** Started at 08.08.2009 14:48:52 ***
***** Started at 08.08.2009 14:48:52 ***
[1]090808.144852.5012: Status: Start
[1]090808.144852.7508: Status: Connect to server HOMESERVER, session 2131e3dc-c023-40ed-ade6-75de0d1e3159, protocol 20
[1]090808.144853.5620: Status: Volume 04c54c62-730f-11de-8b5b-806e6f6e6963 = C:
[1]090808.144853.8740: Status: Acquire volume shadows
[1]090808.144857.1500: Status: Volume 1 of 1 is C: size 74247569408 used 35085373440
[1]090808.144857.3060: Status: Start volume C: using \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy11
[1]090808.144857.4776: Status: Volume (shadow) size 74247565312 used 35409772544
[1]090808.144859.0220: Status: Exception: ClientIoError
[1]090808.144859.0220: Status: : C:
[1]090808.144859.0220: Status: Bytes sent=310877, bytes received=311296, 0 reconnects

und dazu jetzt bitte, bitte den passenden vom Server

Na das ist der obere

D.H. du hast immer noch unterschiedliche Zeiten auf Server und Client ?

Nobby1805 hat geschrieben:D.H. die Zeit auf dem Server ist falsch ? Sind die Zeitzonen richtig eingestellt ? Welcher Time-Server ist eingestellt ?

ich glaube, dieses Problem sollten wir als erstes mal lösen

Edith fragt nach: dein Log sieht etwas anders aus als bei mir ... wie hast du den Backup denn gestartet ?

Nobby1805 hat geschrieben:[08.08.2009 08:20:57 430] Partner cert name is <CN=C2B0E6A2F209141429571DEFADF2DFC12>
[08.08.2009 08:20:57 430] Partner GUID is {2b0e6a2f-2091-4142-...}
[08.08.2009 08:20:57 430] Session: DoBeginReconnectableSession
[08.08.2009 08:20:57 430] ReconnectableStream: Created ServerReconnectableStream for {7FF62DC9-950E-460D-B29A-8D210DD0347F}, sizes 1048576,16384,1048576,16384

Arburgmann hat geschrieben:[08.08.2009 07:48:22 868] Partner cert name is <CN=C47DC4CE527D145FA918B4131554EB361>
[08.08.2009 07:48:22 868] Partner GUID is {47dc4ce5-27d1-45fa-...}
[08.08.2009 07:48:22 868] Session: DoBeginVolumeConfig {47DC4CE5-27D1-45FA-918B-4131554EB361}
[08.08.2009 07:48:23 868] DataFile: Deleted: D:\folders\{00008086-058D-4C89-AB57-A7F909A47AB4}\IBMPC.VolumeConfig.configdat

in letzter Zeit Manuel - auch jetzt gerade wieder und nun lief es durch - ich las das mal jetzt so und dann poste ich hier mal das nächste mal die logs wenn er versucht hat alleine zu sichern.
Normal müsste er heute Abend zwischen 18 - 19 Uhr eine Sicherung machen.

Arburgmann hat geschrieben:Normal müsste er heute Abend zwischen 18 - 19 Uhr eine Sicherung machen.

ich glaube, die Zeit wiurd durch manuelle Backup neu berechnet
Manuell aus der Konsole oder über das Icon auf dem Client ?
Hast du mal die Sicherungskonfiguration in der Konsole aufgerufen? Dann kommt nbei mir ein ähnliches Logging wie bei dir

Ich drück' dir alle drei Daumen