My Oracle Support Banner

Starting DBconsole Fails with 'The OracleDBConsoleorcl service could not be started' when dbconsole is Configured on Hostname which Resolves to IpV6 Address (Doc ID 1455565.1)

Last updated on JANUARY 26, 2018

Applies to:

Enterprise Manager for Oracle Database - Version 11.2.0.1 and later
Information in this document applies to any platform.

Symptoms

The Enterprise Manager Database Control web site, dbconsole, has been created successfully via emca, but will not start on a machine running Windows 2008.  For example:

C:\app\orabase\11202\BIN>emca -config dbcontrol db -repos create

STARTED EMCA at May 3, 2012 10:46:44 PM
EM Configuration Assistant, Version 11.2.0.0.2 Production
Copyright (c) 2003, 2005, Oracle.  All rights reserved.

Enter the following information:
Database SID: orcl
Listener port number: 1526
Listener ORACLE_HOME [ C:\app\orabase\11202 ]:
Password for SYS user:
Password for DBSNMP user:
Password for SYSMAN user:
Email address for notifications (optional):
Outgoing Mail (SMTP) server for notifications (optional):
-----------------------------------------------------------------

You have specified the following settings

Database ORACLE_HOME ................ C:\app\orabase\11202
Local hostname ................ testmachine
Listener ORACLE_HOME ................ C:\app\orabase\11202
Listener port number ................ 1526
Database SID ................ orcl
Email address for notifications ...............
Outgoing Mail (SMTP) server for notifications ...............

-----------------------------------------------------------------
Do you wish to continue? [yes(Y)/no(N)]: yes
May 3, 2012 10:47:04 PM oracle.sysman.emcp.EMConfig perform
INFO: This operation is being logged at C:\app\orabase\cfgtoollogs\emca\orcl\emca_2012_05_03_22_46_44.log.
May 3, 2012 10:47:05 PM oracle.sysman.emcp.EMReposConfig createRepository
INFO: Creating the EM repository (this may take a while) ...
May 3, 2012 10:52:00 PM oracle.sysman.emcp.EMReposConfig invoke
INFO: Repository successfully created
May 3, 2012 10:52:12 PM oracle.sysman.emcp.EMReposConfig uploadConfigDataToRepository
INFO: Uploading configuration data to EM repository (this may take a while) ...
May 3, 2012 10:53:25 PM oracle.sysman.emcp.EMReposConfig invoke
INFO: Uploaded configuration data successfully
May 3, 2012 10:53:37 PM oracle.sysman.emcp.util.DBControlUtil configureSoftwareLib
INFO: Software library configured successfully.
May 3, 2012 10:53:37 PM oracle.sysman.emcp.EMDBPostConfig configureSoftwareLibrary
INFO: Deploying Provisioning archives ...
May 3, 2012 10:54:26 PM oracle.sysman.emcp.EMDBPostConfig configureSoftwareLibrary
INFO: Provisioning archives deployed successfully.
May 3, 2012 10:54:26 PM oracle.sysman.emcp.util.DBControlUtil secureDBConsole
INFO: Securing Database Control (this may take a while) ...
May 3, 2012 10:54:42 PM oracle.sysman.emcp.util.DBControlUtil secureDBConsole
INFO: Database Control secured successfully.
May 3, 2012 10:54:42 PM oracle.sysman.emcp.util.DBControlUtil startOMS
INFO: Starting Database Control (this may take a while) ...
May 3, 2012 11:23:35 PM oracle.sysman.emcp.EMDBPostConfig performConfiguration
INFO: >>>>>>>>>>> The Database Control URL is https://testmachine:5500/em <<<<<<<<<<<
May 3, 2012 11:23:44 PM oracle.sysman.emcp.EMDBPostConfig invoke WARNING:
************************  WARNING  ************************

Management Repository has been placed in secure mode wherein Enterprise Manager data will be encrypted.  The encryption key has been placed in the file: C:/app/
orabase/11202/testmachine_orcl/sysman/config/emkey.ora.   Please ensure this file is backed up as the encrypted data will become unusable if this file is lost.


***********************************************************
May 3, 2012 11:23:44 PM oracle.sysman.emcp.EMDBPostConfig invoke
WARNING: Error starting Database Control.Please execute the following command(s).

 1) Set the environment variable ORACLE_UNQNAME to Database unique name
 2) C:\app\orabase\11202\bin\emctl.bat start dbconsole

 

Attempting to start dbconsole manually after setting ORACLE_UNQNAME is also unsuccessful:

C:\app\orabase\11202\BIN>set ORACLE_UNQNAME=orcl

C:\app\orabase\11202\testmachine_orcl\sysman\log>emctl start dbconsole
Oracle Enterprise Manager 11g Database Control Release 11.2.0.1.0
Copyright (c) 1996, 2010 Oracle Corporation.  All rights reserved.
https://testmachine:5500/em/console/aboutApplication
Starting Oracle Enterprise Manager 11g Database Control ...The OracleDBConsolerach service is
starting..........................................................
................................................................................
................................................................................
................................................................................
................................................................................
................................................................................
................................................................................
................................................................................
................................................................................
.................
The OracleDBConsoleorcl service could not be started.

A service specific error occurred: 1.

More help is available by typing NET HELPMSG 3547.

 

Note that it takes a long time for the message "The OracleDBConsoleorcl service could not be started." to be returned.
Whilst the dbconsole "service is starting" message is shown, for some of the time, the agent actually runs, for example:

C:\app\orabase\11202\BIN>emctl status agent
Oracle Enterprise Manager 11g Database Control Release 11.2.0.1.0
Copyright (c) 1996, 2010 Oracle Corporation.  All rights reserved.
---------------------------------------------------------------
Agent Version     : 10.2.0.4.2
OMS Version       : 10.2.0.4.2
Protocol Version  : 10.2.0.4.2
Agent Home        : C:\app\orabase\11202\testmachine_orcl
Agent binaries    : C:\app\orabase\11202
Agent Process ID  : 4276
Agent URL         : https://testmachine:3938/emd/main
Repository URL    : https://testmachine:5500/em/upload/
Started at        : 2012-05-04 06:37:04
Started by user   : SYSTEM
Last Reload       : 2012-05-04 06:37:04
Last successful upload                       : (none)
Last attempted upload                        : (none)
Total Megabytes of XML files uploaded so far :     0.00
Number of XML files pending upload           :       84
Size of XML files pending upload(MB)         :     9.42
Available disk space on upload filesystem    :    43.58%
Data channel upload directory                : C:/app/orabase/11202/testmachine_orcl/sysman/recv
Last attempted heartbeat to OMS              : 2012-05-04 07:03:11
Last successful heartbeat to OMS             : unknown
---------------------------------------------------------------
Agent is Running and Ready

 

At the same time as the "service is starting" message is seen, the output from netstat -an shows the ipv6 address with lots of connections on the database port (1526 in this example) in TIME_WAIT, for example:

C:\app\orabase\11202\BIN>netstat -an

Active Connections

  Proto  Local Address          Foreign Address        State
  TCP    0.0.0.0:135            0.0.0.0:0              LISTENING
  TCP    0.0.0.0:445            0.0.0.0:0              LISTENING
  TCP    0.0.0.0:1522           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:2301           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:3389           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:3938           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:5500           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:5521           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:5802           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:5902           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:8180           0.0.0.0:0              LISTENING
  TCP    0.0.0.0:49152          0.0.0.0:0              LISTENING
  TCP    0.0.0.0:49153          0.0.0.0:0              LISTENING
  TCP    0.0.0.0:49154          0.0.0.0:0              LISTENING
  TCP    0.0.0.0:49155          0.0.0.0:0              LISTENING
  TCP    0.0.0.0:49156          0.0.0.0:0              LISTENING
  TCP    0.0.0.0:49159          0.0.0.0:0              LISTENING
  TCP    0.0.0.0:49178          0.0.0.0:0              LISTENING
  TCP    0.0.0.0:49257          0.0.0.0:0              LISTENING
  TCP    11.22.33.44:3389      10.20.30.40:3356     ESTABLISHED
  TCP    11.22.33.44:49199     12.23.34.45:445       ESTABLISHED
  TCP    127.0.0.1:10000        0.0.0.0:0              LISTENING
  TCP    127.0.0.1:49191        0.0.0.0:0              LISTENING
  TCP    127.0.0.1:50252        0.0.0.0:0              LISTENING
  TCP    127.0.0.1:52011        127.0.0.1:52012        ESTABLISHED
  TCP    127.0.0.1:52012        127.0.0.1:52011        ESTABLISHED
  TCP    [::]:135               [::]:0                 LISTENING
  TCP    [::]:445               [::]:0                 LISTENING
  TCP    [::]:3389              [::]:0                 LISTENING
  TCP    [::]:3938              [::]:0                 LISTENING
  TCP    [::]:5521              [::]:0                 LISTENING
  TCP    [::]:49152             [::]:0                 LISTENING
  TCP    [::]:49153             [::]:0                 LISTENING
  TCP    [::]:49154             [::]:0                 LISTENING
  TCP    [::]:49155             [::]:0                 LISTENING
  TCP    [::]:49156             [::]:0                 LISTENING
  TCP    [::]:49159             [::]:0                 LISTENING
  TCP    [::]:49257             [::]:0                 LISTENING
  TCP    [fd80::d953:978a:1067:66d0]:1526  [::]:0                 LISTENING
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:51998  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52018  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52027  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52048  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52051  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52057  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52063  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52065  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52068  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52079  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52083  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52088  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52098  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52099  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52100  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52102  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52105  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52106  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52118  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:1526  [fd80::d953:978a:1067:66d0]:52119  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:51998  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52018  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52027  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52048  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52051  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52057  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52063  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52065  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52068  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52075  [fd80::d953:978a:1067:66d0]:1526  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:52076  [fd80::d953:978a:1067:66d0]:1526  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:52084  [fd80::d953:978a:1067:66d0]:1526  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:52086  [fd80::d953:978a:1067:66d0]:1526  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:52087  [fd80::d953:978a:1067:66d0]:1526  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:52090  [fd80::d953:978a:1067:66d0]:1526  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:52093  [fd80::d953:978a:1067:66d0]:1526  TIME_WAIT
  TCP    [fd80::d953:978a:1067:66d0]:52098  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52099  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52100  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52102  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52105  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52106  [fd80::d953:978a:1067:66d0]:1526  ESTABLISHED
  TCP    [fd80::d953:978a:1067:66d0]:52125  [fd80::d953:978a:1067:66d0]:5500  SYN_SENT
  TCP    [fd80::d953:978a:1067:66d0]:52126  [fd80::d953:978a:1067:66d0]:1521  SYN_SENT
  UDP    0.0.0.0:123            *:*
  UDP    0.0.0.0:500            *:*
  UDP    0.0.0.0:4500           *:*
  UDP    0.0.0.0:5355           *:*
  UDP    0.0.0.0:8180           *:*
  UDP    0.0.0.0:8280           *:*
  UDP    [::]:123               *:*
  UDP    [::]:500               *:*
  UDP    [::]:5355              *:*

 

The %ORACLE_HOME%\<hostname>_<sid>\sysman\log\OracleDBConsole<sid>srvc.log shows:
(C:\app\orabase\11202\testmachine_orcl\sysman\log\OracleDBConsoleorclsrvc.log, in this example case)

MDROOT=C:\app\orabase\11202
ORACLE_HOME=C:\app\orabase\11202
EMSTATE=C:\app\orabase\11202\testmachine_orcl
CONSOLE_CFG=dbconsole
TRACE_LEVEL=16
TIMEOUT=30
05/04/12 06:36:31 Job Process API is available
05/04/12 06:36:32 Start pending...
05/04/12 06:36:32 Verifying dbconsole is not started already. Command line "C:\app\orabase\11202\bin\emctl.bat" istatus dbconsole
05/04/12 06:36:32 Service Job object queried for basic limit information
05/04/12 06:36:32 Service Job object set with JOB_OBJECT_LIMIT_BREAKAWAY_OK limit
05/04/12 06:36:37 dbconsole launch commandline is "C:\app\orabase\11202\bin\emctl.bat" istart dbconsole
05/04/12 06:36:37 Tracking process launch...
05/04/12 06:37:12 Received exitCode 1 from emctl istatus
05/04/12 06:37:22 Did not hear back from emctl istatus.
05/04/12 06:37:22 Waiting a further 5 secs...
05/04/12 06:37:27 Did not hear back from emctl istatus.
05/04/12 06:37:27 Waiting a further 5 secs...
05/04/12 06:37:27 Received exitCode 1 from emctl istatus
05/04/12 06:37:37 Did not hear back from emctl istatus.
05/04/12 06:37:37 Waiting a further 5 secs...
05/04/12 06:37:39 Received exitCode 1 from emctl istatus
05/04/12 06:37:49 Did not hear back from emctl istatus.
05/04/12 06:37:49 Waiting a further 5 secs...
05/04/12 06:37:52 Received exitCode 1 from emctl istatus
05/04/12 06:38:02 Did not hear back from emctl istatus.
05/04/12 06:38:02 Waiting a further 5 secs...
....Entries are recorded every minute until...
05/04/12 07:08:59 Did not hear back from emctl istatus.
05/04/12 07:08:59 Waiting a further 5 secs...
05/04/12 07:09:01 Received exitCode 1 from emctl istatus
05/04/12 07:09:06 Timedout while tracking process to start. Terminating..

 

%ORACLE_HOME%\<hostname>_<sid>\sysman\log\emdctl.trc shows:

2012-05-04 17:01:22,966 Thread-1592 ERROR main: nmectla_agentctl: Error connecting to https://testmachine:3938/emd/main. Returning status code 1

 

%ORACLE_HOME%\<hostname>_<sid>\sysman\log\emdb.nohup shows:

----- Fri May  4 06:43:13 2012::Checking status of DBConsole : 2076 -----
12/05/04 06:43:23 ExtendClusterIntegration: init: start
12/05/04 06:43:23 ExtendClusterIntegration: init: end
12/05/04 06:43:23 ProvCommonIntegration.init, registering the Page Handlers and Page Segment Handlers
12/05/04 06:43:29 PAF Integration init BEGIN
12/05/04 06:43:29 PAF Integration init END
12/05/04 06:43:44 Oracle Containers for J2EE 10g (10.1.3.4.0)  initialized
----- Fri May  4 06:43:50 2012::Checking status of DBConsole : 2076 -----
----- Fri May  4 06:44:26 2012::Checking status of DBConsole : 2076 -----
...entries every minute until....
----- Fri May  4 07:09:00 2012::Checking status of DBConsole : 2076 -----

 

 

Changes

 

Cause

To view full details, sign in with your My Oracle Support account.

Don't have a My Oracle Support account? Click to get started!


In this Document
Symptoms
Changes
Cause
Solution

My Oracle Support provides customers with access to over a million knowledge articles and a vibrant support community of peers and Oracle experts.