craigothy
asked on
Exchange 2010 Database Availability Group Error
Successfully created a DAG and added one server but getting an error when adding the second. Both Servers are running Windows Server 2008 R2 Enterprise. Any ideas on what the problem could be. Detailed error below while trying to add bradtestsrv1 to dag1. Adding bradtestsrv3 worked just fine. Thank you...
Summary: 1 item(s). 0 succeeded, 1 failed.
Elapsed time: 00:06:18
BRADTESTSRV1
Failed
Error:
A server-side database availability group administrative operation failed. Error: The operation failed with message: An error occurred while attempting a cluster operation. Error: Cluster API '"AddClusterNode() (MaxPercentage=100) failed with 0x5b4. Error: This operation returned because the timeout period expired"' failed. [Server: BRADTESTSRV3.utopia.local]
An Active Manager operation failed. Error: An error occurred while attempting a cluster operation. Error: Cluster API '"AddClusterNode() (MaxPercentage=100) failed with 0x5b4. Error: This operation returned because the timeout period expired"' failed.
This operation returned because the timeout period expired
Warning:
The operation wasn't successful because an error was encountered. You may find more details in log file "C:\ExchangeSetupLogs\DagT asks\dagta sk_2009-12 -23_20-22- 37.495_add -databasea vailabilty groupserve r.log".
Exchange Management Shell command attempted:
Add-DatabaseAvailabilityGr oupServer -Identity 'DAG1' -MailboxServer 'BRADTESTSRV1'
Elapsed Time: 00:06:18
Summary: 1 item(s). 0 succeeded, 1 failed.
Elapsed time: 00:06:18
BRADTESTSRV1
Failed
Error:
A server-side database availability group administrative operation failed. Error: The operation failed with message: An error occurred while attempting a cluster operation. Error: Cluster API '"AddClusterNode() (MaxPercentage=100) failed with 0x5b4. Error: This operation returned because the timeout period expired"' failed. [Server: BRADTESTSRV3.utopia.local]
An Active Manager operation failed. Error: An error occurred while attempting a cluster operation. Error: Cluster API '"AddClusterNode() (MaxPercentage=100) failed with 0x5b4. Error: This operation returned because the timeout period expired"' failed.
This operation returned because the timeout period expired
Warning:
The operation wasn't successful because an error was encountered. You may find more details in log file "C:\ExchangeSetupLogs\DagT
Exchange Management Shell command attempted:
Add-DatabaseAvailabilityGr
Elapsed Time: 00:06:18
Can you post the dagtask log add-databaseavailabiltygro upserver.l og?
ASKER
I believe my issue is with using vmware vsphere template to deploy the 2008 R2 box. Going to try to run sysprep and see if that resolves my problem.
ASKER
Still getting the same error. Here is the detailed log file. Any ideas? (Prereqs are okay)
add-databaseavailabiltygro upserver started on machine BRADTESTSRV1.
[2009-12-28T17:03:52] add-dagserver started
[2009-12-28T17:03:52] commandline: $scriptCmd = {& $wrappedCmd @PSBoundParameters }
[2009-12-28T17:03:52] Option 'Identity' = 'DAG1'.
[2009-12-28T17:03:52] Option 'MailboxServer' = 'BradTestSrv1'.
[2009-12-28T17:03:52] Option 'DatabaseAvailabilityGroup IpAddresse s' = ''.
[2009-12-28T17:03:52] Option 'WhatIf' = ''.
[2009-12-28T17:03:52] Process: w3wp w3wp.exe:3136.
[2009-12-28T17:03:52] User context = 'NT AUTHORITY\SYSTEM'.
[2009-12-28T17:03:52] Member of group 'Everyone'.
[2009-12-28T17:03:52] Member of group 'BUILTIN\Users'.
[2009-12-28T17:03:52] Member of group 'NT AUTHORITY\SERVICE'.
[2009-12-28T17:03:52] Member of group 'CONSOLE LOGON'.
[2009-12-28T17:03:52] Member of group 'NT AUTHORITY\Authenticated Users'.
[2009-12-28T17:03:52] Member of group 'NT AUTHORITY\This Organization'.
[2009-12-28T17:03:52] Member of group 'BUILTIN\IIS_IUSRS'.
[2009-12-28T17:03:52] Member of group 'LOCAL'.
[2009-12-28T17:03:52] Member of group 'IIS APPPOOL\MSExchangePowerShe llAppPool' .
[2009-12-28T17:03:52] Member of group 'BUILTIN\Administrators'.
[2009-12-28T17:03:52] Updated Progress 'Validating the parameters.' 2%.
[2009-12-28T17:03:52] Working
[2009-12-28T17:03:53] Mailbox server: value passed in = BradTestSrv1, mailboxServer.Name = BRADTESTSRV1, mailboxServer.Fqdn = BradTestSrv1.utopia.local
[2009-12-28T17:03:53] LogClussvcState: clussvc is Stopped on BradTestSrv1.utopia.local. Exception (if any) = none
[2009-12-28T17:03:53] The IP addresses for the DAG are (blank means DHCP): 172.31.8.13
[2009-12-28T17:03:53] Looking up IP addresses for DAG1.
[2009-12-28T17:03:53] DAG1 = [ 172.31.8.13 ].
[2009-12-28T17:03:53] Looking up IP addresses for bradtestsrv1.
[2009-12-28T17:03:53] bradtestsrv1 = [ fe80::7d5f:6c38:d2e2:b6d4% 18, 172.31.8.10 ].
[2009-12-28T17:03:53] Looking up IP addresses for BradTestSrv1.utopia.local.
[2009-12-28T17:03:53] BradTestSrv1.utopia.local = [ fe80::7d5f:6c38:d2e2:b6d4% 18, 172.31.8.10 ].
[2009-12-28T17:03:53] DAG DAG1 has 1 servers:
[2009-12-28T17:03:53] DAG DAG1 contains server BRADTESTSRV3.
[2009-12-28T17:03:53] Updated Progress 'Checking if Mailbox server 'BRADTESTSRV1' is in a database availability group.' 4%.
[2009-12-28T17:03:53] Working
[2009-12-28T17:03:53] GetRemoteCluster() for the mailbox server failed with exception = An Active Manager operation failed. Error: An error occurred while attempting a cluster operation. Error: Cluster API '"OpenCluster(BradTestSrv1 .utopia.lo cal) failed with 0x6d9. Error: There are no more endpoints available from the endpoint mapper"' failed.. This is OK.
[2009-12-28T17:03:53] Ignoring previous error, as it is acceptable if the cluster does not exist yet.
[2009-12-28T17:03:53] DumpClusterTopology: Opening remote cluster DAG1.
[2009-12-28T17:03:53] Dumping the cluster by connecting to: DAG1.
[2009-12-28T17:03:53] The cluster's name is: DAG1.
[2009-12-28T17:03:53] Groups
[2009-12-28T17:03:53] group: Available Storage [not a CMS]
[2009-12-28T17:03:53] OwnerNode: BRADTESTSRV3.utopia.local
[2009-12-28T17:03:53] State: Offline
[2009-12-28T17:03:53] group: Cluster Group [Cluster Main Group]
[2009-12-28T17:03:53] OwnerNode: BRADTESTSRV3.utopia.local
[2009-12-28T17:03:53] State: Online
[2009-12-28T17:03:53] Resource: Cluster IP Address [Online, type = IP Address, PossibleOwners = BRADTESTSRV3 ]
[2009-12-28T17:03:53] Address = [172.31.8.13]
[2009-12-28T17:03:53] EnableDhcp = [0]
[2009-12-28T17:03:53] Network = [Cluster Network 1]
[2009-12-28T17:03:53] Resource: Cluster Name [Online, type = Network Name, PossibleOwners = BRADTESTSRV3 ]
[2009-12-28T17:03:53] NetName = [DAG1]
[2009-12-28T17:03:53] Nodes
[2009-12-28T17:03:53] node: BRADTESTSRV3.utopia.local [ state = Up ]
[2009-12-28T17:03:53] Subnets
[2009-12-28T17:03:54] Name(Cluster Network 1), Mask(172.31.8.0/24), Role(ClusterNetworkRoleInt ernalAndCl ient)
[2009-12-28T17:03:54] NIC 172.31.8.12 on Node BRADTESTSRV3 in State=Up
[2009-12-28T17:03:54] Opening the cluster on nodes [bradtestsrv3].
[2009-12-28T17:03:54] Other mailbox servers in the DAG are already members of cluster 'DAG1'
[2009-12-28T17:03:54] The server BRADTESTSRV1 does not belong to a cluster, and the other servers belong to DAG1.
[2009-12-28T17:03:54] Successfully resolved servers based on the AD configuration.
[2009-12-28T17:03:54] The following servers are in the StartedServers list:
[2009-12-28T17:03:54] The following servers are in the StoppedServers list:
[2009-12-28T17:03:54] Verifiying that the members of database availability group 'DAG1' are also members of the cluster.
[2009-12-28T17:03:54] Verifying that the members of cluster 'DAG1' are also members of the database availability group.
[2009-12-28T17:03:54] According to GetNodeClusterState(), the server BRADTESTSRV1 is NotConfigured.
[2009-12-28T17:03:54] The CNO is currently Online.
[2009-12-28T17:03:54] InternalValidate() done.
[2009-12-28T17:03:54] Updated Progress 'Adding server 'BRADTESTSRV1' to database availability group 'DAG1'.' 6%.
[2009-12-28T17:03:54] Working
[2009-12-28T17:03:54] Updated Progress 'Adding server 'BRADTESTSRV1' to the cluster.' 8%.
[2009-12-28T17:03:54] Working
[2009-12-28T17:13:51] The operation wasn't successful because an error was encountered. You may find more details in log file "C:\ExchangeSetupLogs\DagT asks\dagta sk_2009-12 -28_17-03- 52.477_add -databasea vailabilty groupserve r.log".
[2009-12-28T17:13:51] WriteError! Exception = Microsoft.Exchange.Cluster .Replay.Da gTaskOpera tionFailed Exception: A server-side database availability group administrative operation failed. Error: The operation failed with message: Error 0x71a (The remote procedure call was cancelled) from cli_RpccAddNodeToCluster ---> Microsoft.Exchange.Rpc.Rpc Exception: Error 0x71a (The remote procedure call was cancelled) from cli_RpccAddNodeToCluster
at ThrowRpcException(Int32 rpcStatus, String message)
at Microsoft.Exchange.Rpc.Rpc ClientBase .ThrowRpcE xception(I nt32 rpcStatus, String routineName)
at Microsoft.Exchange.Rpc.Clu ster.Repla yRpcClient .RpccAddNo deToCluste r(String newNode, String& verboseLog)
at Microsoft.Exchange.Cluster .Replay.Re playRpcCli entWrapper .<>c__Disp layClass26 .<RunAddNo deToCluste r>b__24()
at Microsoft.Exchange.Cluster .Replay.Re playRpcCli entWrapper .<>c__Disp layClass32 .<RunRpcOp erationDbN ame>b__30( )
at Microsoft.Exchange.Data.St orage.Clus ter.HaRpcE xceptionWr apperBase` 2.ClientRe tryableOpe ration(Str ing serverName, RpcClientOperation rpcOperation)
--- End of inner exception stack trace ---
at Microsoft.Exchange.Data.St orage.Clus ter.HaRpcE xceptionWr apperBase` 2.ClientHa ndleRpcExc eption(Rpc Exception ex, String serverName)
at Microsoft.Exchange.Data.St orage.Clus ter.HaRpcE xceptionWr apperBase` 2.ClientRe tryableOpe ration(Str ing serverName, RpcClientOperation rpcOperation)
at Microsoft.Exchange.Cluster .Replay.Re playRpcCli entWrapper .RunRpcOpe rationDbNa me(String serverName, String databaseName, Int32 timeoutMs, ReplayRpcClient& rpcClient, IHaRpcExceptionWrapper rpcExceptionWrapperInstanc e, InternalRpcOperation rpcOperation)
at Microsoft.Exchange.Cluster .Replay.Re playRpcCli entWrapper .RunRpcOpe ration(Str ing serverName, Nullable`1 dbGuid, Int32 timeoutMs, ReplayRpcClient& rpcClient, IHaRpcExceptionWrapper rpcExceptionWrapperInstanc e, InternalRpcOperation rpcOperation)
at Microsoft.Exchange.Cluster .Replay.Re playRpcCli entWrapper .RunAddNod eToCluster (AmServerN ame serverName, AmServerName newNode, String& verboseLog)
at Microsoft.Exchange.Managem ent.System Configurat ionTasks.A ddDatabase Availabili tyGroupSer ver.JoinNo deToCluste r()
[2009-12-28T17:13:51] Updated Progress 'Done!' 100%.
[2009-12-28T17:13:51] COMPLETED
add-databaseavailabiltygro upserver explicitly called CloseTempLogFile().
add-databaseavailabiltygro
[2009-12-28T17:03:52] add-dagserver started
[2009-12-28T17:03:52] commandline: $scriptCmd = {& $wrappedCmd @PSBoundParameters }
[2009-12-28T17:03:52] Option 'Identity' = 'DAG1'.
[2009-12-28T17:03:52] Option 'MailboxServer' = 'BradTestSrv1'.
[2009-12-28T17:03:52] Option 'DatabaseAvailabilityGroup
[2009-12-28T17:03:52] Option 'WhatIf' = ''.
[2009-12-28T17:03:52] Process: w3wp w3wp.exe:3136.
[2009-12-28T17:03:52] User context = 'NT AUTHORITY\SYSTEM'.
[2009-12-28T17:03:52] Member of group 'Everyone'.
[2009-12-28T17:03:52] Member of group 'BUILTIN\Users'.
[2009-12-28T17:03:52] Member of group 'NT AUTHORITY\SERVICE'.
[2009-12-28T17:03:52] Member of group 'CONSOLE LOGON'.
[2009-12-28T17:03:52] Member of group 'NT AUTHORITY\Authenticated Users'.
[2009-12-28T17:03:52] Member of group 'NT AUTHORITY\This Organization'.
[2009-12-28T17:03:52] Member of group 'BUILTIN\IIS_IUSRS'.
[2009-12-28T17:03:52] Member of group 'LOCAL'.
[2009-12-28T17:03:52] Member of group 'IIS APPPOOL\MSExchangePowerShe
[2009-12-28T17:03:52] Member of group 'BUILTIN\Administrators'.
[2009-12-28T17:03:52] Updated Progress 'Validating the parameters.' 2%.
[2009-12-28T17:03:52] Working
[2009-12-28T17:03:53] Mailbox server: value passed in = BradTestSrv1, mailboxServer.Name = BRADTESTSRV1, mailboxServer.Fqdn = BradTestSrv1.utopia.local
[2009-12-28T17:03:53] LogClussvcState: clussvc is Stopped on BradTestSrv1.utopia.local.
[2009-12-28T17:03:53] The IP addresses for the DAG are (blank means DHCP): 172.31.8.13
[2009-12-28T17:03:53] Looking up IP addresses for DAG1.
[2009-12-28T17:03:53] DAG1 = [ 172.31.8.13 ].
[2009-12-28T17:03:53] Looking up IP addresses for bradtestsrv1.
[2009-12-28T17:03:53] bradtestsrv1 = [ fe80::7d5f:6c38:d2e2:b6d4%
[2009-12-28T17:03:53] Looking up IP addresses for BradTestSrv1.utopia.local.
[2009-12-28T17:03:53] BradTestSrv1.utopia.local = [ fe80::7d5f:6c38:d2e2:b6d4%
[2009-12-28T17:03:53] DAG DAG1 has 1 servers:
[2009-12-28T17:03:53] DAG DAG1 contains server BRADTESTSRV3.
[2009-12-28T17:03:53] Updated Progress 'Checking if Mailbox server 'BRADTESTSRV1' is in a database availability group.' 4%.
[2009-12-28T17:03:53] Working
[2009-12-28T17:03:53] GetRemoteCluster() for the mailbox server failed with exception = An Active Manager operation failed. Error: An error occurred while attempting a cluster operation. Error: Cluster API '"OpenCluster(BradTestSrv1
[2009-12-28T17:03:53] Ignoring previous error, as it is acceptable if the cluster does not exist yet.
[2009-12-28T17:03:53] DumpClusterTopology: Opening remote cluster DAG1.
[2009-12-28T17:03:53] Dumping the cluster by connecting to: DAG1.
[2009-12-28T17:03:53] The cluster's name is: DAG1.
[2009-12-28T17:03:53] Groups
[2009-12-28T17:03:53] group: Available Storage [not a CMS]
[2009-12-28T17:03:53] OwnerNode: BRADTESTSRV3.utopia.local
[2009-12-28T17:03:53] State: Offline
[2009-12-28T17:03:53] group: Cluster Group [Cluster Main Group]
[2009-12-28T17:03:53] OwnerNode: BRADTESTSRV3.utopia.local
[2009-12-28T17:03:53] State: Online
[2009-12-28T17:03:53] Resource: Cluster IP Address [Online, type = IP Address, PossibleOwners = BRADTESTSRV3 ]
[2009-12-28T17:03:53] Address = [172.31.8.13]
[2009-12-28T17:03:53] EnableDhcp = [0]
[2009-12-28T17:03:53] Network = [Cluster Network 1]
[2009-12-28T17:03:53] Resource: Cluster Name [Online, type = Network Name, PossibleOwners = BRADTESTSRV3 ]
[2009-12-28T17:03:53] NetName = [DAG1]
[2009-12-28T17:03:53] Nodes
[2009-12-28T17:03:53] node: BRADTESTSRV3.utopia.local [ state = Up ]
[2009-12-28T17:03:53] Subnets
[2009-12-28T17:03:54] Name(Cluster Network 1), Mask(172.31.8.0/24), Role(ClusterNetworkRoleInt
[2009-12-28T17:03:54] NIC 172.31.8.12 on Node BRADTESTSRV3 in State=Up
[2009-12-28T17:03:54] Opening the cluster on nodes [bradtestsrv3].
[2009-12-28T17:03:54] Other mailbox servers in the DAG are already members of cluster 'DAG1'
[2009-12-28T17:03:54] The server BRADTESTSRV1 does not belong to a cluster, and the other servers belong to DAG1.
[2009-12-28T17:03:54] Successfully resolved servers based on the AD configuration.
[2009-12-28T17:03:54] The following servers are in the StartedServers list:
[2009-12-28T17:03:54] The following servers are in the StoppedServers list:
[2009-12-28T17:03:54] Verifiying that the members of database availability group 'DAG1' are also members of the cluster.
[2009-12-28T17:03:54] Verifying that the members of cluster 'DAG1' are also members of the database availability group.
[2009-12-28T17:03:54] According to GetNodeClusterState(), the server BRADTESTSRV1 is NotConfigured.
[2009-12-28T17:03:54] The CNO is currently Online.
[2009-12-28T17:03:54] InternalValidate() done.
[2009-12-28T17:03:54] Updated Progress 'Adding server 'BRADTESTSRV1' to database availability group 'DAG1'.' 6%.
[2009-12-28T17:03:54] Working
[2009-12-28T17:03:54] Updated Progress 'Adding server 'BRADTESTSRV1' to the cluster.' 8%.
[2009-12-28T17:03:54] Working
[2009-12-28T17:13:51] The operation wasn't successful because an error was encountered. You may find more details in log file "C:\ExchangeSetupLogs\DagT
[2009-12-28T17:13:51] WriteError! Exception = Microsoft.Exchange.Cluster
at ThrowRpcException(Int32 rpcStatus, String message)
at Microsoft.Exchange.Rpc.Rpc
at Microsoft.Exchange.Rpc.Clu
at Microsoft.Exchange.Cluster
at Microsoft.Exchange.Cluster
at Microsoft.Exchange.Data.St
--- End of inner exception stack trace ---
at Microsoft.Exchange.Data.St
at Microsoft.Exchange.Data.St
at Microsoft.Exchange.Cluster
at Microsoft.Exchange.Cluster
at Microsoft.Exchange.Cluster
at Microsoft.Exchange.Managem
[2009-12-28T17:13:51] Updated Progress 'Done!' 100%.
[2009-12-28T17:13:51] COMPLETED
add-databaseavailabiltygro
Please verify:
1. The operating systems are exactly the same on each node being added to the DAG (no mix of R2 vs non-R2; no mix of SP2 vs non-SP2, no mix of Enterprise vs Standard, etc)
2. The same service packs and exact same windows updates patches are applied
3. The MAC/self-assigned IP addresses of your NICs and pseudo-devices are different between the two VM servers (If you are using a Gold image/vm template!)
I had to disable Teredo tunneling during a similar situation... [When examining two different instances of an image from master image W2K8x64_gold_image, the two different Teredo pseudo-interfaces had the same self-assigned v6 ip address!!! Since the Cluster Role was installed on my Gold-image before the template was created, we could uninstall Cluster Role and reinstall it on each node perhaps...? I need to test this in the lab]
I ended up doing this:
Disable Teredo through command line
a. Open ‘Command Prompt’ and ‘Run as Administrator’
b. Type:
i. > netsh
ii. > interface
iii. > teredo
iv. > set state disabled
c. Teredo will now be disabled
Also, I Uninstalled the Teredo Tunneling Pseudo-device using Device Manager; but I had to 'Show Hidden Devices' within Device Manager in order to 'see' it.
Ref: http://technet.microsoft.com/en-us/library/cc770710(WS.10).aspx
Disable/remove Teredo on both servers, and try adding your cluster node again to the DAG.
1. The operating systems are exactly the same on each node being added to the DAG (no mix of R2 vs non-R2; no mix of SP2 vs non-SP2, no mix of Enterprise vs Standard, etc)
2. The same service packs and exact same windows updates patches are applied
3. The MAC/self-assigned IP addresses of your NICs and pseudo-devices are different between the two VM servers (If you are using a Gold image/vm template!)
I had to disable Teredo tunneling during a similar situation... [When examining two different instances of an image from master image W2K8x64_gold_image, the two different Teredo pseudo-interfaces had the same self-assigned v6 ip address!!! Since the Cluster Role was installed on my Gold-image before the template was created, we could uninstall Cluster Role and reinstall it on each node perhaps...? I need to test this in the lab]
I ended up doing this:
Disable Teredo through command line
a. Open ‘Command Prompt’ and ‘Run as Administrator’
b. Type:
i. > netsh
ii. > interface
iii. > teredo
iv. > set state disabled
c. Teredo will now be disabled
Also, I Uninstalled the Teredo Tunneling Pseudo-device using Device Manager; but I had to 'Show Hidden Devices' within Device Manager in order to 'see' it.
Ref: http://technet.microsoft.com/en-us/library/cc770710(WS.10).aspx
Disable/remove Teredo on both servers, and try adding your cluster node again to the DAG.
Some other things to try:
4. Please check the NIC binding order in ‘Advanced Settings’ under ‘Network’.
5. Please try to ping the cluster IP address and Cluster name from the problematic machine.
6. look in the events logs on both nodes for any Windows Install errors or any Cluster related errors
4. Please check the NIC binding order in ‘Advanced Settings’ under ‘Network’.
5. Please try to ping the cluster IP address and Cluster name from the problematic machine.
6. look in the events logs on both nodes for any Windows Install errors or any Cluster related errors
ASKER CERTIFIED SOLUTION
membership
This solution is only available to members.
To access this solution, you must be a member of Experts Exchange.
I also had this problem and Symantec Endpoint Protection was the issue. However I did not uninstall the product. I just turned off "Network Threat Protection" and the second server was added with no errors.
RSAT-Clustering
http://blog.exchangegeek.com/2009/07/exchange-2010-windows-server-2008-r2.html