Re: XCP Message Archiver Not Starting and Oracle Database Table Creation

Qamar Haq · ‎07-12-2019

I have set up a Oracle Database and configured it in IM&P. I have then selected this Database under the Compliance Settings - Message Archiver and then tried to start the Message Archiver, but it just does not start.

The Database connectivity has a failure with

The following Cisco Unified IM and Presence Service node to external database server connections failed: x.x.x.x >> devdev (Message Archiver).

So a couple of questions

1. Does the Message Archiver have to be up and running for it to connect to the database? or does the Database make a connection first then the Message Archiver is a seperate piece?
2. Does this indiciate there is an issue with the IM&P connecting to the database, even thought it says (Message Archiver) in the error message at the end?

3. Are the Database tables created automatically before the message archiver?

Jaime Valencia · ‎07-12-2019

The service will not start if some part of the configuration is wrong, permissions, user, connectivity, etc.

You can look at the service logs for more details, only when the service finds all the requirements are met, it will start.

HTH

java

if this helps, please rate

Qamar Haq · ‎07-12-2019

@Jaime ValenciaThanks for your response, appreciated..

Okay at the moment the message service logs state

11:42:51.976 |f7657b70| debug| MAService.cpp:206 Got db config. Configuring.
11:42:51.989 |f7657b70| error| OCIConnection.cpp:1562
11:42:51.989 |f7657b70| error| OCIConnection.cpp:1563 (SQLError -1, 12514) ORA-12514: TNS:listener does not currently know of service requested in connect descriptor
11:42:51.989 |f7657b70| info| OCIConnection.cpp:376 disconnect dsn:f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e username:jabber type:3
11:42:51.989 |f7657b70| error| OCIConnection.cpp:254 failed to connect dsn:f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e username:jabber type:3
11:42:51.989 |f7657b70| error| OCIConnection.cpp:273 already disconnected dsn:f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e username:jabber type:3

I assume this is suggesting the service is strugglign to connect to the DB for one of the reasons you've listed possibly (user, permissions, table name etc

What logs and services in RTMT do I need to collect to see the external database logs as there is nothing specific for this to help identify which aspect o the connection to the database it's failing on.

Qamar Haq · ‎07-12-2019

Sorry in advance for a spam of a log below, but this may help, it was the only other peice of info I could get related in teh cupadmin0000x.log file.

It basically seems to be the connection attempt to the base on the External Database settings page.. however it doesn't give much information as to what or why it's failing.., it suggests (as it does on the GUI) that it may be SSL but we're not using SSL for it. - Again the same applies, maybe there is another service logs within RTMT i need to obtain that may show more about the database connection attempt?

The Oracle team have had a look on their end and they can't see anything untoward with the database or settings..

2019-07-12 15:56:43,355 DEBUG [http-bio-443-exec-2] utilities.ComplianceUtilities - SELECT e.pkid, p.pkid, p.name FROM processnode AS p LEFT OUTER JOIN maextdbprocessnodemap AS m ON m.fkprocessnode=p.pkid LEFT OUTER JOIN extdatabase AS e ON e.pkid=m.fkextdatabase WHERE p.systemnode='f' AND p.tkprocessnoderole=(SELECT enum FROM typeprocessnoderole WHERE moniker='PROCESS_NODE_ROLE_PRESENCE')
2019-07-12 15:56:43,358 DEBUG [http-bio-443-exec-2] utilities.ComplianceUtilities - Successfully retrieved 1 rows using query: SELECT e.pkid, p.pkid, p.name FROM processnode AS p LEFT OUTER JOIN maextdbprocessnodemap AS m ON m.fkprocessnode=p.pkid LEFT OUTER JOIN extdatabase AS e ON e.pkid=m.fkextdatabase WHERE p.systemnode='f' AND p.tkprocessnoderole=(SELECT enum FROM typeprocessnoderole WHERE moniker='PROCESS_NODE_ROLE_PRESENCE')
2019-07-12 15:56:43,359 DEBUG [http-bio-443-exec-2] utilities.ComplianceUtilities - SELECT e.pkid, p.pkid, p.name FROM processnode AS p LEFT OUTER JOIN tcextdatabaseprocessnodemap AS m ON m.fkprocessnode=p.pkid LEFT OUTER JOIN extdatabase AS e ON e.pkid=m.fkextdatabase WHERE p.systemnode='f' AND p.tkprocessnoderole=(SELECT enum FROM typeprocessnoderole WHERE moniker='PROCESS_NODE_ROLE_PRESENCE')
2019-07-12 15:56:43,361 DEBUG [http-bio-443-exec-2] utilities.ComplianceUtilities - Successfully retrieved 1 rows using query: SELECT e.pkid, p.pkid, p.name FROM processnode AS p LEFT OUTER JOIN tcextdatabaseprocessnodemap AS m ON m.fkprocessnode=p.pkid LEFT OUTER JOIN extdatabase AS e ON e.pkid=m.fkextdatabase WHERE p.systemnode='f' AND p.tkprocessnoderole=(SELECT enum FROM typeprocessnoderole WHERE moniker='PROCESS_NODE_ROLE_PRESENCE')
2019-07-12 15:56:43,362 DEBUG [http-bio-443-exec-2] utilities.FileTransferUtilities - SELECT e.pkid, p.pkid, p.name, f.pkid, n.PublicKey FROM processnode AS p LEFT OUTER JOIN filetransferprocessnodeextdbmap AS m ON m.fkprocessnode=p.pkid LEFT OUTER JOIN extfilesystemconfig AS f ON f.pkid=m.fkextfilesystemconfig LEFT OUTER JOIN processnodekeypairdata AS n ON n.fkProcessNode=p.pkid LEFT OUTER JOIN extdatabase AS e ON e.pkid=m.fkextdatabase WHERE p.systemnode='f' AND p.tkprocessnoderole=(SELECT enum FROM typeprocessnoderole WHERE moniker='PROCESS_NODE_ROLE_PRESENCE')
2019-07-12 15:56:43,364 DEBUG [http-bio-443-exec-2] utilities.FileTransferUtilities - getExternalDBMapping(): Successfully retrieved 1 rows using query: SELECT e.pkid, p.pkid, p.name, f.pkid, n.PublicKey FROM processnode AS p LEFT OUTER JOIN filetransferprocessnodeextdbmap AS m ON m.fkprocessnode=p.pkid LEFT OUTER JOIN extfilesystemconfig AS f ON f.pkid=m.fkextfilesystemconfig LEFT OUTER JOIN processnodekeypairdata AS n ON n.fkProcessNode=p.pkid LEFT OUTER JOIN extdatabase AS e ON e.pkid=m.fkextdatabase WHERE p.systemnode='f' AND p.tkprocessnoderole=(SELECT enum FROM typeprocessnoderole WHERE moniker='PROCESS_NODE_ROLE_PRESENCE')
2019-07-12 15:56:43,364 DEBUG [http-bio-443-exec-2] diagnostics.ExtDbDiagnosticsTask - checkExtDBStatus(ping) called
2019-07-12 15:56:43,364 DEBUG [http-bio-443-exec-2] diagnostics.ExtDbDiagnosticsTask - Invoking DBLRemoteSystemCallExtdb with 1 entries for service type MSGARCHIVER
2019-07-12 15:56:43,364 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - SELECT e.pkid, e.databasename, p.name FROM processnode AS p LEFT OUTER JOIN maextdbprocessnodemap AS m ON m.fkprocessnode=p.pkid LEFT OUTER JOIN extdatabase AS e ON e.pkid=m.fkextdatabase WHERE p.systemnode='f' and p.name='186.14.32.23'
2019-07-12 15:56:43,378 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - Executing:>SELECT username from extdatabase where pkid='f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e'<
2019-07-12 15:56:43,380 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - Executing:>SELECT tablespace from extdatabase where pkid='f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e'<
2019-07-12 15:56:43,381 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - Executing:>SELECT databasetype from extdatabase where pkid='f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e'<
2019-07-12 15:56:43,382 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - Executing:>SELECT hostname from extdatabase where pkid='f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e'<
2019-07-12 15:56:43,383 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - Command to execute is: [/usr/bin/sudo, -u, root, /usr/local/cm/bin/dbl, rpcextdb, f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e, jabber, f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e, oracle-oci, 186.14.32.23, JABBER_TSP]
2019-07-12 15:56:43,384 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - Current node is: 186.14.32.23
2019-07-12 15:56:44,160 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - executor returned 1 entries.
2019-07-12 15:56:44,160 ERROR [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - getextdbhostStatus:: result=DBL RPC ext db Test Done assiging..arg = 186.14.32.23 dns =f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e usr = jabber pwd = pwd dbtype = oracle-oci tblspace = JABBER_TSP.ext.db.admin ping f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e jabber PASSWORD oracle-oci JABBER_TSP ping()ping(): PING_FAILED[OK] error=
2019-07-12 15:56:44,160 DEBUG [http-bio-443-exec-2] util.DBLRemoteSystemCallExtdb - nodeName=186.14.32.23 status=FAIL nptstatus=DBL RPC ext db Test Done assiging..arg = 186.14.32.23 dns =f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e usr = jabber pwd = pwd dbtype = oracle-oci tblspace = JABBER_TSP.ext.db.admin ping f9bc0eeb-43f2-4e9c-8d45-16efb19bff2e jabber PASSWORD oracle-oci JABBER_TSP ping()ping(): PING_FAILED[OK]
2019-07-12 15:56:44,160 DEBUG [http-bio-443-exec-2] diagnostics.ExtDbDiagnosticsTask - DBLRemoteSystemCallExtdb returned 1 entries for service type MSGARCHIVER
2019-07-12 15:56:44,162 ERROR [http-bio-443-exec-2] diagnostics.ExtDbDiagnosticsTask - The following Cisco Unified IM and Presence Service node to external database server connections failed:
2019-07-12 15:56:44,162 DEBUG [http-bio-443-exec-2] diagnostics.ExtDbDiagnosticsTask - Result: FAIL
Summary: Verify external database server connectivity (database connection check)
Problem: The following Cisco Unified IM and Presence Service node to external database server connections failed:<li>186.14.32.23 >> devdev.world (Message Archiver)</li>
Solution: One or more parameters are invalid. Please check them once again. If the 'Enable SSL' field is unchecked and the External Database chosen in the 'Database Name' field is SSL enabled, please check the 'Enable SSL' field and choose the certificate that corresponds to the chosen External Database and save your changes. If the 'Enable SSL' field is checked on the External Database Settings page then the following steps could help resolve the connectivity issue:<ul><li>Please try refreshing the page after 60 secs of saving the changes.</li><li>Please verify if the Certificate chosen in the 'Certificate Name' field is valid and corresponds to the chosen External Database in the 'Database Name' field.</li><li>If the problem persists, please restart the Cisco XCP Config Manager Service.</li></ul>
More Info URL: null