Fusion Apps Installation : Database Provisioning Failed during listener start

If you are provisioning database for Fusion Applications and provisioning fails then check logs under $PROVISION_HOME/provisioning/logs/<hostname>/

Depending on phase at which build failed, open corresponding log file

  • Pre Verification – runFusionDB-preverify.log
  • Installation –  runFusionDB-install.log
  • Pre Configuration – runFusionDB-preconfigure.log
  • Configuration – runFusionDB-configure.log

In my case database provisioning failed at Configure phase so I looked at runFusionDB-configure.log where error reported was

______

[2011-10-29T08:40:39.002-04:00] [runFusionDB-configure] [ERROR] [] [runFusionDB-configure] [tid: 10] [ecid: 0000JDFgXQD6ESgvDCoItC1EezGz000000,0]  An error occurred while trying to start the listener process. Please view the log for the Configure step.
______

As error was while starting Database Listener so I checked listener log file at $ORACLE_BASE/diag/tnslsnr/<hostname>/listener_<DB_SID>/trace

/listener_<SID>.log

_______
Started with pid=2095

Listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=innowave12.com)(PORT=152

3)))Error listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=IPC)(KEY=EXTPROC1523)))

TNS-12555: TNS:permission denied TNS-12560: TNS:protocol adapter error

  TNS-00525: Insufficient privilege for operation   Linux Error: 1: Operation not permitted

No longer listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=innowave12.com

)(PORT=1523)))

___________

Root Cause : Old IPC Sockets stored in files  /var/tmp/.oracle (hidden folder) was owned by different user (non root user).

Fix:

1. Stop all listeners running on machine

2. Delete folder /var/tmp/.oracle

3. Create folder /var/tmp/.oracle from root user and change permission to 777

Click on “Retry” button of Fusion Application Database Provisioning Screen

About the Author Atul Kumar

Oracle ACE, Author, Speaker and Founder of K21 Technologies & K21 Academy : Specialising in Design, Implement, and Trainings.

follow me on:

Leave a Comment:

4 comments
jinzhexiu999 says November 16, 2011

Hi atul

Thanks for your help.
I deleted /var/tmp/.oracle,made it newly and
done various setting of this directory.

after it i tried to do database installation using fusion application provisioning wizard.

getting error during of progress 60% of installing.
configure->RDBMS_11gR2: private-create-dbinstance execSecure_Build_ERROR
configure->RDBMS_11gR2: private-create-dbinstance creating the databse

I checked
/u01/app/oracle/ORACLE_BASE/cfgtoollogs/dbca/FADB/FADB.log

Creating and starting Oracle instance
DBCA_PROGRESS : 1%
ORA-03113: end-of-file on communication channel
ORA-03113: end-of-file on communication channel

also I checked
/u01/app/oracle/ORACLE_BASE/cfgtoollogs/dbca/FADB/Trace.log

[main] [ 2011-11-15 04:14:34.304 GMT ] [OsUtilsBase.getBaseFromOrabase:680] orabaseLocation= /u01/app/oracle/ORACLE_BASE
[main] [ 2011-11-15 04:14:34.314 GMT ] [SQLEngine.getEnvParams:552] Default NLS_LANG: AMERICAN_AMERICA.AL32UTF8
[main] [ 2011-11-15 04:14:34.315 GMT ] [SQLEngine.getEnvParams:562] NLS_LANG: AMERICAN_AMERICA.AL32UTF8
[main] [ 2011-11-15 04:14:34.352 GMT ] [SQLEngine.initialize:322] Execing SQLPLUS/SVRMGR process…
[main] [ 2011-11-15 04:14:34.531 GMT ] [SQLEngine.initialize:359] m_bReaderStarted: false
[main] [ 2011-11-15 04:14:34.578 GMT ] [SQLEngine.initialize:363] Starting Reader Thread…
[main] [ 2011-11-15 04:14:36.265 GMT ] [SQLEngine.done:2167] Done called
[main] [ 2011-11-15 04:14:36.269 GMT ] [OracleHome.initOptions:1276] ORA-03113: end-of-file on communication channel

oracle.sysman.assistants.util.sqlEngine.SQLFatalErrorException: ORA-03113: end-of-file on communication channel

at oracle.sysman.assistants.util.sqlEngine.SQLEngine.executeImpl(SQLEngine.java:1655)
at oracle.sysman.assistants.util.sqlEngine.SQLEngine.connect(SQLEngine.java:978)
at oracle.sysman.assistants.util.OracleHome.initOptions(OracleHome.java:1233)
at oracle.sysman.assistants.dbca.backend.SilentHost.initialize(SilentHost.java:179)
at oracle.sysman.assistants.dbca.Dbca.execute(Dbca.java:116)
at oracle.sysman.assistants.dbca.Dbca.main(Dbca.java:180)
[main] [ 2011-11-15 04:14:36.270 GMT ] [SQLEngine.reInitialize:735] Reinitializing SQLEngine…

will you advice
Thanks & Best Regards.

Reply
jinzhexiu999 says November 16, 2011

Hi atul

Thanks for your help and support.
I checked runFusionDB-configure.log file

[2011-11-15T04:14:52.854+00:00] [runFusionDB-configure] [NOTIFICATION] [] [runFusionDB-configure] [tid: 10] [ecid: 0000JE_R_fsESOWzLwQLOA1EkUS0000000,0] Look at the log file “/u01/app/oracle/ORACLE_BASE/cfgtoollogs /dbca/FADB/FADB.log” for further details.
[2011-11-15T04:14:52.957+00:00] [runFusionDB-configure] [NOTIFICATION] [] [runFusionDB-configure] [tid: 10] [ecid: 0000JE_R_fsESOWzLwQLOA1EkUS0000000,0] [logStatus] STATE=BUILD_ERROR!TIMESTAMP=2011-11-15 04:14:52 GMT!TARGET=private-create-dbInstance!CATEGORY=BUILD_ERROR!DOMAIN=NONE!HOSTNAME=vslfa.applaudsolutions.com!P RODUCTFAMILY=dbserver!PRODUCT=RDBMS_11gR2!TASK=execSecure!TASKID=dbserver.RDBMS_11gR2.BUILD_ERROR.private-c reate-dbInstance.execSecure!MESSAGE=Process “sh – /u01/app/oracle/ORACLE_BASE/product/11.2.0/dbhome_1/bin/d bca -sid FADB -gdbName FADB -disableSecurityConfiguration ALL -characterSet AL32UTF8 -nationalCharacterSet AL16UTF16 -listeners LISTENER_FADB -datafileDestination /u01/app/oracle/ORACLE_BASE/oradata -emConfiguratio n LOCAL -initParams audit_trail=NONE -silent -createDatabase -templateName /u01/app/oracle/FA_PROV_FRWK/pro visioning/provisioning-build/../template/dbca/empty_database_11.2.dbt” exited with non-zero exit code “1”. Input Stream before decrypting for process execution: “u72KCWz9r+VI1tcJMPNuMQ==u72KCWz9r+VI1tcJMPNuMQ==u72K CWz9r+VI1tcJMPNuMQ==u72KCWz9r+VI1tcJMPNuMQ==”. Environment variables: “(ORACLE_HOME=/u01/app/oracle/ORACLE_ BASE/product/11.2.0/dbhome_1), (TNS_ADMIN=/u01/app/oracle/ORACLE_BASE/product/11.2.0/dbhome_1/network/admin )”.!DETAIL=Process “sh – /u01/app/oracle/ORACLE_BASE/product/11.2.0/dbhome_1/bin/dbca -sid FADB -gdbName FA DB -disableSecurityConfiguration ALL -characterSet AL32UTF8 -nationalCharacterSet AL16UTF16 -listeners LIST ENER_FADB -datafileDestination /u01/app/oracle/ORACLE_BASE/oradata -emConfiguration LOCAL -initParams audit _trail=NONE -silent -createDatabase -templateName /u01/app/oracle/FA_PROV_FRWK/provisioning/provisioning-bu ild/../template/dbca/empty_database_11.2.dbt” exited with non-zero exit code “1”. Input Stream before decry pting for process execution: “u72KCWz9r+VI1tcJMPNuMQ==u72KCWz9r+VI1tcJMPNuMQ==u72KCWz9r+VI1tcJMPNuMQ==u72KC Wz9r+VI1tcJMPNuMQ==”. Environment variables: “(ORACLE_HOME=/u01/app/oracle/ORACLE_BASE/product/11.2.0/dbhom e_1), (TNS_ADMIN=/u01/app/oracle/ORACLE_BASE/product/11.2.0/dbhome_1/network/admin)”.!BUILDFILE=/u01/app/or acle/FA_PROV_FRWK/provisioning/provisioning-build/dbserver-build.xml!LINENUMBER=548!
[2011-11-15T04:14:52.958+00:00] [runFusionDB-configure] [ERROR] [FAPROV-00298] [runFusionDB-configure] [tid : 10] [ecid: 0000JE_R_fsESOWzLwQLOA1EkUS0000000,0] An Error Occured: [[
Process “sh – /u01/app/oracle/ORACLE_BASE/product/11.2.0/dbhome_1/bin/dbca -sid FADB -gdbName FADB -disable SecurityConfiguration ALL -characterSet AL32UTF8 -nationalCharacterSet AL16UTF16 -listeners LISTENER_FADB – datafileDestination /u01/app/oracle/ORACLE_BASE/oradata -emConfiguration LOCAL -initParams audit_trail=NONE -silent -createDatabase -templateName /u01/app/oracle/FA_PROV_FRWK/provisioning/provisioning-build/../temp late/dbca/empty_database_11.2.dbt” exited with non-zero exit code “1”. Input Stream before decrypting for p rocess execution: “u72KCWz9r+VI1tcJMPNuMQ==u72KCWz9r+VI1tcJMPNuMQ==u72KCWz9r+VI1tcJMPNuMQ==u72KCWz9r+VI1tcJ MPNuMQ==”. Environment variables: “(ORACLE_HOME=/u01/app/oracle/ORACLE_BASE/product/11.2.0/dbhome_1), (TNS_ ADMIN=/u01/app/oracle/ORACLE_BASE/product/11.2.0/dbhome_1/network/admin)”.
at oracle.apps.fnd.provisioning.ant.taskdefs.SecureExec.executeTask(SecureExec.java:381)
at oracle.apps.fnd.provisioning.ant.taskdefs.BaseProvisioningTask.execute(BaseProvisioningTask.java :102)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:288)
at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:105)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.taskdefs.Sequential.execute(Sequential.java:62)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:105)
at org.apache.tools.ant.Task.perform(Task.java:348)
at net.sf.antcontrib.logic.TryCatchTask.execute(TryCatchTask.java:206)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:288)
at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:105)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.Target.execute(Target.java:357)
at org.apache.tools.ant.Target.performTasks(Target.java:385)
at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1329)
at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:40)
at org.apache.tools.ant.Project.executeTargets(Project.java:1183)
at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:416)
at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:106)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:288)
at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:105)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.Target.execute(Target.java:357)
at org.apache.tools.ant.Target.performTasks(Target.java:385)
at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1329)
at org.apache.tools.ant.Project.executeTarget(Project.java:1299)
at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
at org.apache.tools.ant.Project.executeTargets(Project.java:1183)
at org.apache.tools.ant.Main.runBuild(Main.java:698)
at org.apache.tools.ant.Main.startAnt(Main.java:200)
at org.apache.tools.ant.launch.Launcher.run(Launcher.java:257)
at org.apache.tools.ant.launch.Launcher.main(Launcher.java:104)

]]
[2011-11-15T04:14:52.985+00:00] [runFusionDB-configure] [NOTIFICATION] [] [runFusionDB-configure] [tid: 10] [ecid: 0000JE_R_fsESOWzLwQLOA1EkUS0000000,0] [logStatus] STATE=BUILD_ERROR!TIMESTAMP=2011-11-15 04:14:52 GMT!TARGET=private-create-dbInstance!CATEGORY=database!DOMAIN=NONE!HOSTNAME=vslfa.applaudsolutions.com!PROD UCTFAMILY=dbserver!PRODUCT=RDBMS_11gR2!TASK=Creating the database instance!TASKID=dbserver.RDBMS_11gR2.NONE .private-create-dbInstance.NONE!MESSAGE=!DETAIL=An error occurred while trying to create the database insta nce. Please view the log for the Configure step.!BUILDFILE=/u01/app/oracle/FA_PROV_FRWK/provisioning/provis ioning-build/common-misc-build.xml!LINENUMBER=107!
[2011-11-15T04:14:53.000+00:00] [runFusionDB-configure] [ERROR] [] [runFusionDB-configure] [tid: 10] [ecid: 0000JE_R_fsESOWzLwQLOA1EkUS0000000,0] An error occurred while trying to create the database instance. Ple ase view the log for the Configure step.
[2011-11-15T04:14:53.015+00:00] [runFusionDB-configure] [ERROR] [] [runFusionDB-configure] [tid: 10] [ecid: 0000JE_R_fsESOWzLwQLOA1EkUS0000000,0] BUILD FAILED[[
/u01/app/oracle/FA_PROV_FRWK/provisioning/provisioning-build/dbserver-build.xml:137: The following error oc curred while executing this line:
/u01/app/oracle/FA_PROV_FRWK/provisioning/provisioning-build/dbserver-build.xml:585: The following error oc curred while executing this line:
/u01/app/oracle/FA_PROV_FRWK/provisioning/provisioning-build/common-misc-build.xml:109: An error occurred w hile trying to create the database instance. Please view the log for the Configure step.

but i didn’t find the factor to happern error.

i wish you will advice.
Thanks % Best Regards.

Reply
Amber Jadhav says March 19, 2012

Hi Atul,

I have got the same error what ‘jinzhexiu999’ has got. Not able to find out the cause behind it. Can you please revert back with the cause and solution for the same.

Thanks,
Amber

Reply
Amber Jadhav says March 19, 2012

I am talking about the second post from ‘jinzhexiu999’

Reply
Add Your Reply

Not found