Google Groups no longer supports new Usenet posts or subscriptions. Historical content remains viewable.
Dismiss

Strange Cluster Issue

0 views
Skip to first unread message

Lee Armstrong

unread,
Sep 1, 2008, 8:52:40 AM9/1/08
to
I have an issue where a node cannot start the cluster service to join
a cluster. If all nodes are offline and it is the first to "create/
start" the cluster it is fine.

The error I get is as follows....

Cluster service suffered an unexpected fatal error at line 542 of
source module d:\nt\base\cluster\service\dm\dmsync.c. The error code
was 1728.

Edwin vMierlo [MVP]

unread,
Sep 1, 2008, 9:30:13 AM9/1/08
to
# for decimal 1728 / hex 0x6c0
RPC_S_PROTOCOL_ERROR winerror.h
# A remote procedure call (RPC) protocol error occurred.

that in itself doesn't say much,

are you running the same version OS ?
(service packs / patches)


"Lee Armstrong" <les...@gmail.com> wrote in message
news:0e9ccf0c-d267-4c96...@s50g2000hsb.googlegroups.com...

Lee Armstrong

unread,
Sep 1, 2008, 9:40:24 AM9/1/08
to
On 1 Sep, 14:30, "Edwin vMierlo [MVP]"

<EdwinvMie...@discussions.microsoft.com> wrote:
> # for decimal 1728 / hex 0x6c0
>   RPC_S_PROTOCOL_ERROR                                           winerror.h
> # A remote procedure call (RPC) protocol error occurred.
>
> that in itself doesn't say much,
>
> are you running the same version OS ?
> (service packs / patches)
>
> "Lee Armstrong" <lesm...@gmail.com> wrote in message

>
> news:0e9ccf0c-d267-4c96...@s50g2000hsb.googlegroups.com...
>
> > I have an issue where a node cannot start the cluster service to join
> > a cluster.  If all nodes are offline and it is the first to "create/
> > start" the cluster it is fine.
>
> > The error I get is as follows....
>
> > Cluster service suffered an unexpected fatal error at line 542 of
> > source module d:\nt\base\cluster\service\dm\dmsync.c. The error code
> > was 1728.

Both W2k3 Enterprise SP2 (non-R2). Winver shows exactly the same
details on both nodes.
Both fully patched too.

Edwin vMierlo [MVP]

unread,
Sep 1, 2008, 10:23:55 AM9/1/08
to
can you post a larger sniplet of the log, there could be messages before
that error which might give us a clue

"Lee Armstrong" <les...@gmail.com> wrote in message

news:b2f6e113-ca30-4930...@i76g2000hsf.googlegroups.com...

Lee Armstrong

unread,
Sep 1, 2008, 10:36:42 AM9/1/08
to
On 1 Sep, 15:23, "Edwin vMierlo [MVP]"

<EdwinvMie...@discussions.microsoft.com> wrote:
> can you post a larger sniplet of the log, there could be messages before
> that error which might give us a clue
>
> "Lee Armstrong" <lesm...@gmail.com> wrote in message
>
> news:b2f6e113-ca30-4930...@i76g2000hsf.googlegroups.com...
> On 1 Sep, 14:30, "Edwin vMierlo [MVP]"
>
>
>
> <EdwinvMie...@discussions.microsoft.com> wrote:
> > # for decimal 1728 / hex 0x6c0
> > RPC_S_PROTOCOL_ERROR winerror.h
> > # A remote procedure call (RPC) protocol error occurred.
>
> > that in itself doesn't say much,
>
> > are you running the same version OS ?
> > (service packs / patches)
>
> > "Lee Armstrong" <lesm...@gmail.com> wrote in message
>
> >news:0e9ccf0c-d267-4c96...@s50g2000hsb.googlegroups.com...
>
> > > I have an issue where a node cannot start the cluster service to join
> > > a cluster. If all nodes are offline and it is the first to "create/
> > > start" the cluster it is fine.
>
> > > The error I get is as follows....
>
> > > Cluster service suffered an unexpected fatal error at line 542 of
> > > source module d:\nt\base\cluster\service\dm\dmsync.c. The error code
> > > was 1728.
>
> Both W2k3 Enterprise SP2 (non-R2).  Winver shows exactly the same
> details on both nodes.
> Both fully patched too.
00008550.00008554::2008/09/01-14:35:11.291 INFO

00008550.00008554::2008/09/01-14:35:11.291 INFO [CS] Cluster Service
started - Cluster Node Version 4.3790
00008550.00008554::2008/09/01-14:35:11.291
INFO OS Version 5.2.3790 - Service Pack
2 (ADS 03000112L)
00008550.00008554::2008/09/01-14:35:11.291
INFO Local Time is
2008/09/01-15:35:11.291
00008550.0000855c::2008/09/01-14:35:11.291 INFO [CS] Service
Starting...
00008550.0000855c::2008/09/01-14:35:11.291 INFO [INIT]
ClusterInitialize called to start cluster.
00008550.0000855c::2008/09/01-14:35:11.291 INFO [EP] Initialization...
00008550.0000855c::2008/09/01-14:35:11.291 INFO [DM] Initialization
00008550.0000855c::2008/09/01-14:35:11.291 ERR [DM] DmInitialize: The
hive was loaded- rollback, unload and reload again
00008550.0000855c::2008/09/01-14:35:11.291 INFO [DM]
DmpRestartFlusher: Entry
00008550.0000855c::2008/09/01-14:35:11.307 INFO [DM] DmpUnloadHive:
unloading the hive
00008550.0000855c::2008/09/01-14:35:11.307 INFO [Qfs]
QfsSetFileAttributes C:\WINDOWS\Cluster\CLUSDB.BKP$ 80, status 2
00008550.0000855c::2008/09/01-14:35:11.307 INFO [Qfs] QfsDeleteFile C:
\WINDOWS\Cluster\CLUSDB.BKP$, status 2
00008550.0000855c::2008/09/01-14:35:11.307 INFO [DM] Loading cluster
database from C:\WINDOWS\Cluster\CLUSDB
00008550.0000855c::2008/09/01-14:35:11.323 INFO [DM] DmpStartFlusher:
Entry
00008550.0000855c::2008/09/01-14:35:11.323 INFO [DM] DmpStartFlusher:
thread created
00008550.0000855c::2008/09/01-14:35:11.323 INFO [NM] Initializing...
00008550.0000855c::2008/09/01-14:35:11.323 INFO [NM] Local node name =
S-MPL-GPMS1.
00008550.0000855c::2008/09/01-14:35:11.323 INFO [NM] Local node ID =
1.
00008550.0000855c::2008/09/01-14:35:11.323 INFO [NM] Creating object
for node 1 (S-MPL-GPMS1)
00008550.0000855c::2008/09/01-14:35:11.323 INFO [NM] Initializing
networks.
00008550.0000855c::2008/09/01-14:35:11.323 INFO [NM] Initializing
network interfaces.
00008550.0000855c::2008/09/01-14:35:11.338 WARN [NM] Failed to open
cluster parameters key, status 2.
00008550.0000855c::2008/09/01-14:35:11.385 INFO [NM] Initialization
complete.
00008550.0000855c::2008/09/01-14:35:11.385 INFO [FM] Starting worker
thread...
00008550.0000855c::2008/09/01-14:35:11.385 INFO [API] Initializing
00008550.0000858c::2008/09/01-14:35:11.385 INFO [FM] Worker thread
running
00008550.0000855c::2008/09/01-14:35:11.385 INFO [LM] LmInitialize
Entry.
00008550.0000855c::2008/09/01-14:35:11.385 INFO [LM]
TimerActInitialize Entry.
00008550.0000855c::2008/09/01-14:35:11.385 INFO [CS] Service Domain
Account = MPL\cluster
00008550.0000855c::2008/09/01-14:35:11.385 INFO [CS] Initializing RPC
server.
00008550.0000855c::2008/09/01-14:35:11.385 INFO [INIT]
CspRegisterDynamicLRPCEndpoint: Successfully registered LRPC endpoint
with EP mapper
00008550.0000855c::2008/09/01-14:35:11.401 INFO [INIT] Attempting to
join cluster S-MPL-CLUSTERF
00008550.0000855c::2008/09/01-14:35:11.401 INFO [JOIN] Spawning thread
to connect to sponsor 172.20.106.38
00008550.0000855c::2008/09/01-14:35:11.401 INFO [JOIN] Spawning thread
to connect to sponsor 10.0.0.14
00008550.000085c8::2008/09/01-14:35:11.401 INFO [JOIN] Asking
10.0.0.14 to sponsor us after delay of 0 milliseconds.
00008550.0000855c::2008/09/01-14:35:11.401 INFO [JOIN] Spawning thread
to connect to sponsor S-MPL-GPMS2
00008550.0000855c::2008/09/01-14:35:11.401 INFO [JOIN] Spawning thread
to connect to sponsor 172.20.104.41
00008550.000085c8::2008/09/01-14:35:11.401 INFO [JOIN] Selecting
10.0.0.14 as join sponsor.
00008550.0000855c::2008/09/01-14:35:11.401 INFO [JOIN] Got out of the
join wait, CsJoinThreadCount = 4.
00008550.0000855c::2008/09/01-14:35:11.401 WARN [JOIN] Attempting join
with sponsor 10.0.0.14.
00008550.0000855c::2008/09/01-14:35:11.401 INFO [NMJOIN] Beginning
cluster join process.
00008550.000085cc::2008/09/01-14:35:12.401 INFO [JOIN] No need to ask
S-MPL-GPMS2 to sponsor us after delay of 1000 milliseconds.
00008550.000085c4::2008/09/01-14:35:12.401 INFO [JOIN] No need to ask
172.20.106.38 to sponsor us after delay of 1000 milliseconds.
00008550.000085d0::2008/09/01-14:35:13.401 INFO [JOIN] No need to ask
172.20.104.41 to sponsor us after delay of 2000 milliseconds.
00008550.0000855c::2008/09/01-14:35:22.072 WARN [NMJOIN] Unable to
begin join, status 5041. Retrying ...
00008550.0000855c::2008/09/01-14:35:25.103 INFO [NMJOIN] Sponsor node
ID = 2. Join sequence number = 5507, endpoint = 3343.
00008550.0000855c::2008/09/01-14:35:25.103 INFO [NM] Synchronizing
node information.
00008550.0000855c::2008/09/01-14:35:25.103 INFO [NM] Creating node
objects.
00008550.0000855c::2008/09/01-14:35:25.103 INFO [NM] Creating object
for node 2 (S-MPL-GPMS2)
00008550.0000855c::2008/09/01-14:35:25.103 INFO [NM] Enabling
communication for node 2
00008550.0000855c::2008/09/01-14:35:25.103 INFO [NM] Synchronizing
network information.
00008550.0000855c::2008/09/01-14:35:25.103 INFO [NM] Synchronizing
interface information.
00008550.0000855c::2008/09/01-14:35:25.103 INFO [NM] Running network
configuration engine.
00008550.0000855c::2008/09/01-14:35:25.181 WARN [ClNet] Tcpip is not
bound to adapter 6AD0A380-3664-497E-A036-9E4D35038A28.
00008550.0000855c::2008/09/01-14:35:25.181 WARN [ClNet] Tcpip is not
bound to adapter 96EDF5A6-003E-4680-BC99-DCBA655AC443.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Processing
network configuration changes.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Matched 2
networks, created 0 new networks.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Resynchronizing
network information.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Resynchronizing
interface information.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Creating network
objects.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Creating object
for network 2018b582-fd7d-4f4d-98bd-e929964136a5 (DEFAULT_VLAN VNIC).
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Creating object
for network 427c6b78-ebf8-4a4c-8d29-6b2841da5ed5 (Cluster VNIC).
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Creating
interface objects.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Creating object
for interface 33c45b6e-4d97-4864-9c8a-9694f862c1c3 (DEFAULT_VLAN VNIC
- S-MPL-GPMS1).
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Using preassigned
index 0 for interface 33c45b6e-4d97-4864-9c8a-9694f862c1c3.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Registering
network 2018b582-fd7d-4f4d-98bd-e929964136a5 (DEFAULT_VLAN VNIC) with
cluster transport.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Bringing network
2018b582-fd7d-4f4d-98bd-e929964136a5 online.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Deferring dynamic
multicast start until initial configuration.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Registering
interface 33c45b6e-4d97-4864-9c8a-9694f862c1c3 (DEFAULT_VLAN VNIC - S-
MPL-GPMS1) with cluster transport, addr 172.20.104.38, endpoint 3343.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Scheduled network
connectivity report worker thread.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Creating object
for interface 8bf42bea-bd6e-4da3-9664-ee026953ab43 (Cluster VNIC - S-
MPL-GPMS1).
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Using preassigned
index 0 for interface 8bf42bea-bd6e-4da3-9664-ee026953ab43.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Registering
network 427c6b78-ebf8-4a4c-8d29-6b2841da5ed5 (Cluster VNIC) with
cluster transport.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Bringing network
427c6b78-ebf8-4a4c-8d29-6b2841da5ed5 online.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Deferring dynamic
multicast start until initial configuration.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Registering
interface 8bf42bea-bd6e-4da3-9664-ee026953ab43 (Cluster VNIC - S-MPL-
GPMS1) with cluster transport, addr 10.0.0.13, endpoint 3343.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Creating object
for interface e9ddf141-4b5f-43b9-9e84-ffaa40950deb (DEFAULT_VLAN VNIC
- S-MPL-GPMS2).
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Connectivity
report worker thread running.
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Processing local
interface up event for network 2018b582-fd7d-4f4d-98bd-e929964136a5.
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Updating local
connectivity info for network 2018b582-fd7d-4f4d-98bd-e929964136a5.
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Reporting
connectivity to sponsor for network 2018b582-fd7d-4f4d-98bd-
e929964136a5.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Using preassigned
index 1 for interface e9ddf141-4b5f-43b9-9e84-ffaa40950deb.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Registering
interface e9ddf141-4b5f-43b9-9e84-ffaa40950deb (DEFAULT_VLAN VNIC - S-
MPL-GPMS2) with cluster transport, addr 172.20.106.38, endpoint 3343.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Creating object
for interface ec457fb4-4f29-4775-a812-361593cee795 (Cluster VNIC - S-
MPL-GPMS2).
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Using preassigned
index 1 for interface ec457fb4-4f29-4775-a812-361593cee795.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Registering
interface ec457fb4-4f29-4775-a812-361593cee795 (Cluster VNIC - S-MPL-
GPMS2) with cluster transport, addr 10.0.0.14, endpoint 3343.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NMJOIN] Verifying
connectivity to active cluster nodes
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] nodes 1 & 2 are
connected over network 2018b582-fd7d-4f4d-98bd-e929964136a5
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Initializing
membership...
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Processing local
interface up event for network 427c6b78-ebf8-4a4c-8d29-6b2841da5ed5.
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Updating local
connectivity info for network 427c6b78-ebf8-4a4c-8d29-6b2841da5ed5.
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Reporting
connectivity to sponsor for network 427c6b78-
ebf8-4a4c-8d29-6b2841da5ed5.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [RGP] Node 1: RGP Init
called : 0x1, 0x10, 0x269fb0, 0x269f88.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [ClMsg] Initializing.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [ClMsg] Initialized
NTLM package.
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] More connectivity
reports to send. Rescheduling worker thread.
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Scheduled network
connectivity report worker thread.
00008550.00008560::2008/09/01-14:35:25.197 INFO [NM] Connectivity
report worker thread finished.
00008550.000086f8::2008/09/01-14:35:25.197 INFO [NM] Connectivity
report worker thread running.
00008550.000086f8::2008/09/01-14:35:25.197 INFO [NM] Connectivity
report worker thread finished.
00008550.0000855c::2008/09/01-14:35:25.197 WARN [MM]
MmQuorumArbitrationTimeout 60.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Membership
initialization complete.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Started NM timer
thread, thread id 0x8708.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM]
NmpCalcClusterVersion: status = 0 ClusHighestVer=0x00040ece,
ClusLowestVer=0x00030893
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM]
[NmpResetClusterVersion] ClusterHighestVer=0x00040ece
ClusterLowestVer=0x00030893
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NM] Disabling mixed
NT5/NT5.1 operation.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NMJOIN] Creating RPC
bindings for member node 2
00008550.0000855c::2008/09/01-14:35:25.197 INFO [NMJOIN] Attempting to
use network DEFAULT_VLAN VNIC to create bindings for node 2
00008550.000085b8::2008/09/01-14:35:25.197 INFO [API] Cluster security
descriptor unavailable. Trying again with default security descriptor.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [API] User granted
access using default cluster SD.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [ClMsg] Deleting
security contexts for node 2.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [ClMsg] Deleting
security contexts for node 2.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [ClMsg] Deleting
security contexts for node 2.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [ClMsg] Deleting
security contexts for node 2.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [ClMsg] Deleting
security contexts for node 2.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [ClMsg] Deleting
security contexts for node 2.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [ClMsg] Deleting
security contexts for node 2.
00008550.000085b8::2008/09/01-14:35:25.197 INFO [ClMsg] Deleting
security contexts for node 2.
00008550.0000855c::2008/09/01-14:35:25.197 INFO [ClMsg]
BindingGeneration 1
00008550.0000855c::2008/09/01-14:35:25.197 INFO [ClMsg] Creating RPC
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Using NTLM
package for RPC security contexts.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Creating RPC
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Using NTLM
package for RPC security contexts.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Creating RPC
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Using NTLM
package for RPC security contexts.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [GUM] Creating RPC
bindings for node 2.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Creating RPC
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Using NTLM
package for RPC security contexts.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Creating RPC
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Using NTLM
package for RPC security contexts.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [EVT] Creating RPC
bindings for node 2.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Creating RPC
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Using NTLM
package for RPC security contexts.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [FM] Creating RPC
bindings for node 2.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Creating RPC
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Using NTLM
package for RPC security contexts.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Creating RPC
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Using NTLM
package for RPC security contexts.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [NMJOIN] Created
binding for node 2
00008550.0000855c::2008/09/01-14:35:25.213 INFO [NMJOIN] Establishing
security contexts with all active nodes.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Establishing
outbound security context with the NTLM package.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] The outbound
security context to node 2 was initialized, status 00090312.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] The outbound
security context was accepted by node 2, status 0x00090312.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] The outbound
security context to node 2 was initialized, status 00000000.
00008550.000085b8::2008/09/01-14:35:25.213 INFO [ClMsg] Establishing
inbound security context with node 2, sequence 5507
00008550.000085b8::2008/09/01-14:35:25.213 INFO [ClMsg] The inbound
security context from node 2 using the NTLM package was accepted,
status 00090312
00008550.000085b8::2008/09/01-14:35:25.213 INFO [ClMsg] The inbound
security context from node 2 using the NTLM package was accepted,
status: 00000000
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] The outbound
security context was accepted by node 2, status 0x00000000.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [ClMsg] Importing
security contexts from NTLM package.
00008550.0000855c::2008/09/01-14:35:25.213 INFO [NMJOIN] Petitioning
to join cluster membership.
00008550.000085b8::2008/09/01-14:35:25.213 INFO [RGP] Node 1: RGP
Debug event : 0xf, 0x1, 0x0, 0x0.
00008550.000085b8::2008/09/01-14:35:25.213 INFO [RGP] Node 1: RGP
SetRGPInfo : 0x1, 0x5, 0x4, 0x4000.
00008550.000085b8::2008/09/01-14:35:26.431 INFO [RGP] Node 1: RGP
Debug event : 0xc, 0x1, 0x0, 0x0.
00008550.000085b8::2008/09/01-14:35:26.431 INFO [RGP] Node 1: RGP
Monitor node: 0x1, 0x0, 0xc000, 0xc000.
00008550.000085b8::2008/09/01-14:35:26.431 INFO [RGP] Node 1: RGP
Debug event : 0xa, 0x1, 0x0, 0x0.
00008550.000085b8::2008/09/01-14:35:26.431 INFO [RGP] Node 1: RGP
Start called: 0x0, 0x10917b8, 0x0, 0x0.
00008550.0000855c::2008/09/01-14:35:26.431 INFO [GUM] GumpNodeCallback
setting node 2 active.
00008550.0000855c::2008/09/01-14:35:26.431 INFO [GUM]
GumBeginJoinUpdate succeeded with sequence 5508 for type 1
00008550.0000855c::2008/09/01-14:35:26.431 INFO [DM] DmJoin: getting
new registry database
00008550.0000855c::2008/09/01-14:35:26.431 INFO [Qfs]
QfsGetTempFileName C:\DOCUME~1\cluster\LOCALS~1\Temp\, CLS, 173 => C:
\DOCUME~1\cluster\LOCALS~1\Temp\CLSAD.tmp, status 0
00008550.0000855c::2008/09/01-14:35:26.431 INFO [Qfs] QfsOpenFile C:
\DOCUME~1\cluster\LOCALS~1\Temp\CLSAD.tmp => 2, 530 status 0
00008550.0000855c::2008/09/01-14:35:26.431 WARN [NM] Cryptor: Data is
not encrypted.
00008550.0000855c::2008/09/01-14:35:26.431 WARN [NM] Cryptor received
unencrypted data.
00008550.0000855c::2008/09/01-14:35:26.431 INFO [Qfs] WriteFile 530
(regf) 4096, status 0 (0=>0)
00008550.0000855c::2008/09/01-14:35:26.431 INFO [Qfs] WriteFile 530
(hbin) 3880, status 0 (0=>0)
00008550.0000855c::2008/09/01-14:35:26.431 INFO [Qfs] QfsFlushBuffers
530, status 0
00008550.0000855c::2008/09/01-14:35:26.431 INFO [Qfs] QfsCloseHandle
530, status 0
00008550.0000855c::2008/09/01-14:35:26.431 WARN [DM] Failed to get a
new database, status 1728
00008550.0000855c::2008/09/01-14:35:26.431 ERR Cluster service

Lee Armstrong

unread,
Sep 1, 2008, 10:41:05 AM9/1/08
to
> e929964136a5. ...
>
> read more »

The node that has the issue joining is s-mpl-gpms1, however s-mpl-
gpms2 will join the cluster fine,.

Edwin vMierlo [MVP]

unread,
Sep 2, 2008, 4:03:17 AM9/2/08
to
hmm...

other than this

00008550.0000855c::2008/09/01-14:35:26.431 WARN [DM] Failed to get a
new database, status 1728

there is not a lot of info.

It could be some sort of network issue, I would check NIC drivers at this
point. Ensure they are up-to-date and same version accross all your nodes.
Ensure you are not teaming any NIC's, if you do, break the team and see if
this changes the symptom.

And probably get Microsoft Product Support involved.

rgds,
Edwin.

"Lee Armstrong" <les...@gmail.com> wrote in message

news:c7057098-869e-4329...@z66g2000hsc.googlegroups.com...

Lee Armstrong

unread,
Sep 2, 2008, 4:30:39 AM9/2/08
to
On Sep 2, 9:03 am, "Edwin vMierlo [MVP]"

<EdwinvMie...@discussions.microsoft.com> wrote:
> hmm...
>
> other than this
>
> 00008550.0000855c::2008/09/01-14:35:26.431 WARN [DM] Failed to get a
> new database, status 1728
>
> there is not a lot of info.
>
> It could be some sort of network issue, I would check NIC drivers at this
> point. Ensure they are up-to-date and same version accross all your nodes.
> Ensure you are not teaming any NIC's, if you do, break the team and see if
> this changes the symptom.
>
> And probably get Microsoft Product Support involved.
>
> rgds,
> Edwin.
>
> for ...
>
> read more »- Hide quoted text -
>
> - Show quoted text -

Thanks Edwin for your help, I am tempted to rebuild those nodes in
question just to keep them clean.

The 3 nodes in question were upgraded from W2K3 standard to W2K3
Enterprise if that adds any help? We have since re-applied driver
pack and SP2.

Edwin vMierlo [MVP]

unread,
Sep 3, 2008, 5:24:55 AM9/3/08
to
Pretty drastic to rebuild, but if you have to opportunity, do.
Just hoping that with a rebuild the symptoms will dissapear

Good Luck with your cluster project
Rgds,
edwin.

Lee Armstrong

unread,
Sep 4, 2008, 4:30:55 AM9/4/08
to
On Sep 3, 10:24 am, "Edwin vMierlo [MVP]"

Edwin,

PSC helped me out a treat! They noticed that there was a filter
driver on the NIC as part of "Kaseya" software. Although this
software should have been passive it was obviously blocking! Once we
removed this it all worked again. Moral of the story is to check NIC
filter drivers, I had already checked the AV one!

Thanks

Edwin vMierlo [MVP]

unread,
Sep 4, 2008, 5:29:09 AM9/4/08
to

"Lee Armstrong" <les...@gmail.com> wrote in message
news:682d4673-d08c-4203...@w1g2000prk.googlegroups.com...

>Edwin,

>Thanks

hmm... open a support call with the vendor of that sofware ?

0 new messages