首页 > 数据库 >Oracle RAC备库启动service报"ORA-16000: database open for read-only access"

Oracle RAC备库启动service报"ORA-16000: database open for read-only access"

时间:2024-05-14 17:54:07浏览次数:27  
标签:03 01 备库 RAC service 19 56597 55 2019

 

Oracle RAC备库启动service报"ORA-16000: database open for read-only access"

 

还是2019.03.01那天的事了,当时在KFT客户就遇到这个问题,最近在规整一些资料看到当时待整理的文档,就抽空做做实验整理下。

报错信息如下,ADG备库:

[oracle@xxxprdoradb01 ~]$ srvctl start service -d xxxdbdr2 -s xxxdbcss
PRCD-1084 : Failed to start service xxxdbcss
PRCR-1079 : Failed to start resource ora.xxxdbdr2.xxxdbcss.svc
CRS-5017: The resource action "ora.xxxdbdr2.xxxdbcss.svc start" encountered the following error: 
ORA-16000: database open for read-only access
ORA-06512: at "SYS.DBMS_SERVICE", line 433
ORA-06512: at "SYS.DBMS_SERVICE", line 304
ORA-06512: at line 1
. For details refer to "(:CLSN00107:)" in "/u01/oracle/grid/110203/log/xxxprdoradb01/agent/crsd/oraagent_oracle/oraagent_oracle.log".

CRS-2674: Start of 'ora.xxxdbdr2.xxxdbcss.svc' on 'xxxprdoradb01' failed
CRS-5017: The resource action "ora.xxxdbdr2.xxxdbcss.svc start" encountered the following error: 
ORA-16000: database open for read-only access
ORA-06512: at "SYS.DBMS_SERVICE", line 433
ORA-06512: at "SYS.DBMS_SERVICE", line 304
ORA-06512: at line 1
. For details refer to "(:CLSN00107:)" in "/u01/oracle/grid/110203/log/xxxprdoradb02/agent/crsd/oraagent_oracle/oraagent_oracle.log".

CRS-2674: Start of 'ora.xxxdbdr2.xxxdbcss.svc' on 'xxxprdoradb02' failed
CRS-2632: There are no more servers to try to place resource 'ora.xxxdbdr2.xxxdbcss.svc' on that would satisfy its placement policy

其中,/u01/oracle/grid/110203/log/xxxprdoradb01/agent/crsd/oraagent_oracle/oraagent_oracle.log文件相关内容如下:

2019-03-01 19:55:48.191: [    AGFW][3892311808] {1:14336:11864} Agent received the message: AGENT_HB[Engine] ID 12293:2664818
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] ClusterSubscriber::SubscriberWorker::InternalClusterSubscriber::handleEventCBexecuting for reason 1
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] event type is CRS_ACTION_FAILURE
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] bodylen = 538
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597} -----------BodyBlock----------
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  ACTION='1'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  CLS_TINT='{1:14336:56597}'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  CURRENT_STATE='OFFLINE'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  DB_UNIQUE_NAME='xxxdbdr2'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  INSTANCE_NAME='xxxdb2'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  NAME='ora.xxxdbdr2.xxxdbcss.svc'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  NUMBER_OF_ATTEMPTS='0'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  REASON='USER_ACTION'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  RESOURCE_CLASS='service'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  RESOURCE_INCARNATION_NUMBER='0'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  RESOURCE_LOCATION='xxxprdoradb02'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  SEQUENCE_NUMBER='1400583'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  SERVICE_NAME=''
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  TARGET_STATE='ONLINE'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  TIMESTAMP='2019-03-01 19:55:49'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  TYPE='ora.service.type'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  USER='oracle'
2019-03-01 19:55:49.300: [ USRTHRD][3758094080] {1:14338:56597}  Version='11.2.0.3.0'
2019-03-01 19:55:49.301: [ USRTHRD][3758094080] {1:14338:56597}  CLUSTER_NAME='xxxdb01-scan'
2019-03-01 19:55:49.301: [ USRTHRD][3758094080] {1:14338:56597}  DB_UNIQUE_NAME='xxxdbdr2'
2019-03-01 19:55:49.301: [ USRTHRD][3758094080] {1:14338:56597}  ORACLE_CLUSTERWARE.SUBCOMPONENT='CRSD'
2019-03-01 19:55:49.301: [ USRTHRD][3758094080] {1:14338:56597}  RESOURCE_CLASS='service'
2019-03-01 19:55:49.301: [ USRTHRD][3758094080] {1:14338:56597}  SERVICE_NAME=''
2019-03-01 19:55:49.301: [ USRTHRD][3758094080] {1:14338:56597} DbAgentEventModule::LsnrRegSubscriber::handleEvent {
2019-03-01 19:55:49.301: [ USRTHRD][3758094080] {1:14338:56597} DbAgentEventModule::LsnrRegSubscriber::handleEvent }
2019-03-01 19:55:49.316: [    AGFW][3892311808] {1:14336:56597} Agent received the message: RESOURCE_START[ora.xxxdbdr2.xxxdbcss.svc 1 1] ID 4098:2664821
2019-03-01 19:55:49.316: [    AGFW][3892311808] {1:14336:56597} Preparing START command for: ora.xxxdbdr2.xxxdbcss.svc 1 1
2019-03-01 19:55:49.317: [    AGFW][3892311808] {1:14336:56597} ora.xxxdbdr2.xxxdbcss.svc 1 1 state changed from: OFFLINE to: STARTING
2019-03-01 19:55:49.318: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] (:CLSN00107:) clsn_agent::start {
2019-03-01 19:55:49.318: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getSvcName SERVICE_NAME xxxdbcss
2019-03-01 19:55:49.318: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::start: enter { 
2019-03-01 19:55:49.318: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::start m_pConnxn lost
2019-03-01 19:55:49.318: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::refresh
2019-03-01 19:55:49.318: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getSvcName SERVICE_NAME xxxdbcss
2019-03-01 19:55:49.318: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] ConnectionPool::ConnectionPool 2 m_oracleHome:/u01/oracle/oracle/product/110203, m_oracleSid:xxxdb2, m_usrOraEnv:
2019-03-01 19:55:49.318: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] ConnectionPool::getConnection 260 pConnxn ac0b52e0
2019-03-01 19:55:49.319: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::start: query network name of xxxdbcss
2019-03-01 19:55:49.319: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::execSql 2  xxxdbcss
2019-03-01 19:55:49.319: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::execSql:QUERY_SVC_STMT m_defineCount 11 m_resServiceName xxxdbcss
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::execSql:QUERY_SVC_STMT result 
m_dbServiceName xxxdbcss 
m_dbNetworkName xxxdbcss 
m_dbRlbGoal NONE 
m_dbDtp 0 
m_dbAqHaNotification 0 
m_dbFailoverMethod NONE 
m_dbFailoverType NONE 
m_dbFailoverRetries 0 
m_dbFailoverDelay 0 
m_dbClbGoal LONG 
m_dbEdition 

2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :goal_name attrib RLB_GOAL value NONE
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :dtp attrib DTP value 0
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :aq_ha_notification attrib AQ_HA_NOTIFICATION value 0
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :failover_method attrib FAILOVER_METHOD value NONE
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :failover_type attrib FAILOVER_TYPE value SESSION
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :failover_retries attrib FAILOVER_RETRIES value 0
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::setBindVal placeHolder :failover_retries value 0 value length 1 intValue 0
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :failover_delay attrib FAILOVER_DELAY value 0
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::setBindVal placeHolder :failover_delay value 0 value length 1 intValue 0
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :clb_goal_name attrib CLB_GOAL value LONG
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::getAndSetBindVal placeholder :edition attrib EDITION value 
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::bindResValues 
m_resServiceName xxxdbcss 
m_resNetworkName xxxdbcss 
m_resRlbGoal NONE 
m_resDtp 0 
m_resAqHaNotification 0 
m_resFailoverMethod NONE 
m_resFailoverType SESSION 
m_resFailoverRetries 0 
m_resFailoverDelay 0 
m_resIntFailoverRetries 0 
m_resIntFailoverDelay 0 
m_resClbGoal LONG 
m_resEdition  
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::execSql 3  xxxdbcss
2019-03-01 19:55:49.320: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::execSql:MODIFY_SVC_STMT m_bindCount 11 m_resServiceName xxxdbcss
2019-03-01 19:55:49.325: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] ORA-16000: database open for read-only access
ORA-06512: at "SYS.DBMS_SERVICE", line 433
ORA-06512: at "SYS.DBMS_SERVICE", line 304
ORA-06512: at line 1

2019-03-01 19:55:49.325: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::execSql action 3 error ORA-16000: database open for read-only access
ORA-06512: at "SYS.DBMS_SERVICE", line 433
ORA-06512: at "SYS.DBMS_SERVICE", line 304
ORA-06512: at line 1

2019-03-01 19:55:49.326: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] InstConnection::connectInt: server not attached
2019-03-01 19:55:49.376: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] InstConnection:connectInt connected
2019-03-01 19:55:49.377: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::execSql:MODIFY_SVC_STMT m_bindCount 11 m_resServiceName xxxdbcss
2019-03-01 19:55:49.380: [CLSFRAME][502269728] TM [MultiThread] is changing desired thread # to 5. Current # is 4
2019-03-01 19:55:49.381: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] ORA-16000: database open for read-only access
ORA-06512: at "SYS.DBMS_SERVICE", line 433
ORA-06512: at "SYS.DBMS_SERVICE", line 304
ORA-06512: at line 1

2019-03-01 19:55:49.381: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] SvcAgent::execSql action 3 error ORA-16000: database open for read-only access
ORA-06512: at "SYS.DBMS_SERVICE", line 433
ORA-06512: at "SYS.DBMS_SERVICE", line 304
ORA-06512: at line 1

2019-03-01 19:55:49.382: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] ConnectionPool::releaseConnection InstConnection ac0b52e0
2019-03-01 19:55:49.382: [   AGENT][2885678848] {1:14336:56597} UserErrorException: Locale is 
2019-03-01 19:55:49.382: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] clsnUtils::error Exception type=2 string=
CRS-5017: The resource action "ora.xxxdbdr2.xxxdbcss.svc start" encountered the following error: 
ORA-16000: database open for read-only access
ORA-06512: at "SYS.DBMS_SERVICE", line 433
ORA-06512: at "SYS.DBMS_SERVICE", line 304
ORA-06512: at line 1
. For details refer to "(:CLSN00107:)" in "/u01/oracle/grid/110203/log/xxxprdoradb02/agent/crsd/oraagent_oracle/oraagent_oracle.log".

2019-03-01 19:55:49.382: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [start] (:CLSN00107:) clsn_agent::start }
2019-03-01 19:55:49.382: [    AGFW][2885678848] {1:14336:56597} Command: start for resource: ora.xxxdbdr2.xxxdbcss.svc 1 1 completed with status: FAIL
2019-03-01 19:55:49.383: [    AGFW][3892311808] {1:14336:56597} Agent sending reply for: RESOURCE_START[ora.xxxdbdr2.xxxdbcss.svc 1 1] ID 4098:2664821
2019-03-01 19:55:49.383: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] isCheckDone m_isCheckDone ac056eb8 1
2019-03-01 19:55:49.383: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] DbAgent::isFailed m_lastState 0
2019-03-01 19:55:49.383: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::refresh
2019-03-01 19:55:49.383: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::getSvcName SERVICE_NAME xxxdbcss
2019-03-01 19:55:49.383: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] ConnectionPool::getConnection 260 pConnxn ac0b52e0
2019-03-01 19:55:49.383: [    AGFW][3892311808] {1:14336:56597} Agent sending reply for: RESOURCE_START[ora.xxxdbdr2.xxxdbcss.svc 1 1] ID 4098:2664821
2019-03-01 19:55:49.384: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::check OCI error 1403
2019-03-01 19:55:49.384: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] ConnectionPool::releaseConnection InstConnection ac0b52e0
2019-03-01 19:55:49.384: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::check 4 ret 1
2019-03-01 19:55:49.384: [ USRTHRD][2885678848] {1:14336:56597} ConnectionPool::~ConnectionPool m_oracleHome:/u01/oracle/oracle/product/110203, m_oracleSid:xxxdb2, m_usrOraEnv:
2019-03-01 19:55:49.384: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::check ret:1 exit }
2019-03-01 19:55:49.385: [    AGFW][3892311808] {1:14336:56597} ora.xxxdbdr2.xxxdbcss.svc 1 1 state changed from: STARTING to: OFFLINE
2019-03-01 19:55:49.385: [    AGFW][3892311808] {1:14336:56597} Agent sending last reply for: RESOURCE_START[ora.xxxdbdr2.xxxdbcss.svc 1 1] ID 4098:2664821
2019-03-01 19:55:49.396: [    AGFW][3892311808] {1:14336:56597} Agent received the message: RESOURCE_CLEAN[ora.xxxdbdr2.xxxdbcss.svc 1 1] ID 4100:2664826
2019-03-01 19:55:49.396: [    AGFW][3892311808] {1:14336:56597} Preparing CLEAN command for: ora.xxxdbdr2.xxxdbcss.svc 1 1
2019-03-01 19:55:49.396: [    AGFW][3892311808] {1:14336:56597} ora.xxxdbdr2.xxxdbcss.svc 1 1 state changed from: OFFLINE to: CLEANING
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597} ClusterSubscriber::SubscriberWorker::InternalClusterSubscriber::handleEventCBexecuting for reason 1
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597} event type is CRS_ACTION_FAILURE
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597} bodylen = 538
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597} -----------BodyBlock----------
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597}  ACTION='1'
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597}  CLS_TINT='{1:14336:56597}'
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597}  CURRENT_STATE='OFFLINE'
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597}  DB_UNIQUE_NAME='xxxdbdr2'
2019-03-01 19:55:49.396: [ USRTHRD][3758094080] {1:14338:56597}  INSTANCE_NAME='xxxdb1'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  NAME='ora.xxxdbdr2.xxxdbcss.svc'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  NUMBER_OF_ATTEMPTS='0'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  REASON='USER_ACTION'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  RESOURCE_CLASS='service'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  RESOURCE_INCARNATION_NUMBER='0'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  RESOURCE_LOCATION='xxxprdoradb01'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  SEQUENCE_NUMBER='1400584'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  SERVICE_NAME=''
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  TARGET_STATE='ONLINE'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  TIMESTAMP='2019-03-01 19:55:49'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  TYPE='ora.service.type'
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] (:CLSN00106:) clsn_agent::clean {
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  USER='oracle'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  Version='11.2.0.3.0'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  CLUSTER_NAME='xxxdb01-scan'
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] clean {
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  DB_UNIQUE_NAME='xxxdbdr2'
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] SvcAgent::stop: enter { 
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  ORACLE_CLUSTERWARE.SUBCOMPONENT='CRSD'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  RESOURCE_CLASS='service'
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597}  SERVICE_NAME=''
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597} DbAgentEventModule::LsnrRegSubscriber::handleEvent {
2019-03-01 19:55:49.397: [ USRTHRD][3758094080] {1:14338:56597} DbAgentEventModule::LsnrRegSubscriber::handleEvent }
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] DbAgent::isFailed m_lastState 0
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] SvcAgent::stop m_pConnxn lost
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] SvcAgent::refresh
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] SvcAgent::getSvcName SERVICE_NAME xxxdbcss
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] ConnectionPool::ConnectionPool 2 m_oracleHome:/u01/oracle/oracle/product/110203, m_oracleSid:xxxdb2, m_usrOraEnv:
2019-03-01 19:55:49.397: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] ConnectionPool::getConnection 260 pConnxn ac0b52e0
2019-03-01 19:55:49.398: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] SvcAgent::stop: stopping xxxdbcss
2019-03-01 19:55:49.399: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] ORA-44311: service xxxdbcss not running
ORA-06512: at "SYS.DBMS_SYS_ERROR", line 86
ORA-06512: at "SYS.DBMS_SERVICE", line 466
ORA-06512: at "SYS.DBMS_SERVICE", line 400
ORA-06512: at line 1

2019-03-01 19:55:49.399: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] SvcAgent::stop: ignoring OCI error 44311 }
2019-03-01 19:55:49.399: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] ConnectionPool::releaseConnection InstConnection ac0b52e0
2019-03-01 19:55:49.399: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] SvcAgent::stop: m_pConnxn 00000000m_pConnectionPool a40149b0
2019-03-01 19:55:49.399: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] SvcAgent::stop: } 
2019-03-01 19:55:49.399: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] clean  }
2019-03-01 19:55:49.399: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [clean] (:CLSN00106:) clsn_agent::clean }
2019-03-01 19:55:49.399: [    AGFW][2885678848] {1:14336:56597} Command: clean for resource: ora.xxxdbdr2.xxxdbcss.svc 1 1 completed with status: SUCCESS
2019-03-01 19:55:49.400: [    AGFW][3892311808] {1:14336:56597} Agent sending reply for: RESOURCE_CLEAN[ora.xxxdbdr2.xxxdbcss.svc 1 1] ID 4100:2664826
2019-03-01 19:55:49.400: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] isCheckDone m_isCheckDone ac056eb8 1
2019-03-01 19:55:49.400: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] DbAgent::isFailed m_lastState 0
2019-03-01 19:55:49.400: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::refresh
2019-03-01 19:55:49.400: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::getSvcName SERVICE_NAME xxxdbcss
2019-03-01 19:55:49.400: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] ConnectionPool::getConnection 260 pConnxn ac0b52e0
2019-03-01 19:55:49.401: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::check OCI error 1403
2019-03-01 19:55:49.401: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] ConnectionPool::releaseConnection InstConnection ac0b52e0
2019-03-01 19:55:49.401: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::check 4 ret 1
2019-03-01 19:55:49.401: [ USRTHRD][2885678848] {1:14336:56597} ConnectionPool::~ConnectionPool m_oracleHome:/u01/oracle/oracle/product/110203, m_oracleSid:xxxdb2, m_usrOraEnv:
2019-03-01 19:55:49.401: [ora.xxxdbdr2.xxxdbcss.svc][2885678848] {1:14336:56597} [check] SvcAgent::check ret:1 exit }
2019-03-01 19:55:49.401: [    AGFW][3892311808] {1:14336:56597} ora.xxxdbdr2.xxxdbcss.svc 1 1 state changed from: CLEANING to: OFFLINE
2019-03-01 19:55:49.401: [    AGFW][3892311808] {1:14336:56597} Agent sending last reply for: RESOURCE_CLEAN[ora.xxxdbdr2.xxxdbcss.svc 1 1] ID 4100:2664826
View Code

 

2019.03.05进行了问题复现,原因是主库通过srvctl添加的service和备库添加的service名字一样但是个别细节属性定义不同。比如主库添加了服务名s_test:

srvctl add service -d zkm -s s_test -e SELECT -m BASIC -w 10 -z 15 -r zkm1,zkm2

 

 备库同步添加服务名s_test:个别属性不同于主库

srvctl add service -d zkmstd -s s_test -e none -m none  -w 10 -z 15 -r zkm

 

这个时候使用“srvctl start service -d zkmstd -s s_test”启动则会由一样的报错。

此刻修改为属性均一致:

srvctl modify service -d zkmstd -s s_test -e select -m basic -w 10 -z 15

 

再次启动则正常。防。

 

当在主备环境中以完全相同的方式定义服务时,可以启动 dataguard 环境中的服务,(-r,-a可以不同)请参阅参考:

http://docs.oracle.com/cd/E11882_01/server.112/e40771/sofo.htm#DGBKR3548

如果主备定义服务存在差异,引起报错的根本原因是,

主库中:通过srvctl add service的时候并不会修改在数据库中修改数据库的数据字段表,但是,将新增的service启动的时候,会在表service$总添加记录,这时候你查询dba_services能够查询到服务的信息。

这时候备库的表service$的数据是同主库同步过来的,备库定义的服务名中由属性存在差异的时候,服务的启动需要更改数据库中的该值,但这是在只读状态下无法完成的,因此报错:ORA-16000: database open for read-only access

上边的oraagent_oracle.log日志也可以看到如下关键字:

MODIFY_SVC_STMT 

 

参考文档:https://www.cnblogs.com/PiscesCanon/p/18191840

Service Startup Results ORA-16000 ORA-06512 on Active Data Guard When Attached With Edition (文档 ID 2169426.1)

标签:03,01,备库,RAC,service,19,56597,55,2019
From: https://www.cnblogs.com/PiscesCanon/p/18191840

相关文章

  • 阿里云Windows server 2016服务器Antimalware Service Executable进程占比高,cpu接近10
    问题描述:阿里云Windowsserver2016服务器AntimalwareServiceExecutable进程占比高,cpu接近100%,需要强制关闭该进程,排查问题,进入系统服务关闭,提示拒绝访问(该服务关闭后有风险,需评估后操作)  操作步骤:1.进入服务器,进入Windowspowershell界面; 2. 输入 regadd"HKEY_L......
  • Oracle:谈谈service_names和dbms_service的一点问题
     Oracle:谈谈service_names和dbms_service的一点问题 services_name在在19C中官方明确提到已经弃用了,只保留兼容,且在未来版本中可能不再支持该初始化参数。传送门。其次,无论是在12C或者11G,官方都表明了OracleRAC或者OracleRestart环境下,不通过直接修改services_name参数,而......
  • oracle 备份与恢复常见的七大问题
    为了最大限度保障数据的安全性,同时能在不可预计灾难的情况下保证数据的快速恢复,需要根据数据的类型和重要程度制定相应的备份和恢复方案。在这个过程中,DBA的职责就是要保证数据库(其它数据由其它岗位负责)的高可用和高性能,以下典型问题及解答可供参考。1、Oracle的几种备份方式简介......
  • Oracle释放表高水位线(HWM)的j几种方法
    转自:https://blog.csdn.net/loveLAxin/article/details/1293570831.表高水位线概述:高水线(HWM)是数据块未格式化且从未使用过的数据段中的点。也就是说高水位线存在于段。查询表数据时,会扫描高水位线下的所有数据块。(包括删除以后不存在数据的块)原则上高水位线只会增大,不会缩小......
  • Oracle-HWM(High Water Mark) 高水位解读
    转自:https://cloud.tencent.com/developer/article/1861861Oracle的逻辑存储管理ORACLE在逻辑存储上分4个粒度,由大到小为:表空间,段,区和块.块Block块:是粒度最小的存储单位,现在标准的块大小是8K,ORACLE每一次I/O操作也是按块来操作的,也就是说当ORACLE从数据文件读数......
  • Etcd开启trace
    针对处理耗时超过100ms的grpc请求,etcd打印包含耗时长的阶段的trace日志。#etcd容器增加环境变量env:-name:ETCD_LOGGERvalue:zaptrace日志举例{"level":"info","ts":"2024-05-13T14:16:45.478Z","caller":"traceutil/trace.......
  • 【Azure App Service】本地Git部署Python Flask应用上云(Azure App Service For Linux
    问题描述PythonFlash应用上云,本地Git部署(https://docs.azure.cn/zh-cn/app-service/quickstart-python?tabs=flask%2Cwindows%2Cazure-cli%2Clocal-git-deploy%2Cdeploy-instructions-azportal%2Cterminal-bash%2Cdeploy-instructions-zip-azcli),遇见两类问题。1: srcrefspec......
  • Oracle Index Clustering Factor(集群因子)
    转自:https://www.cnblogs.com/Richardzhu/articles/2874972.html一、本文说明:   今天在做测试的时候发现字段上有索引,但是执行计划就是不走索引,经过在网上查找才发现原来是索引的集群因子过高导致的。本文属于转载。二、官网说明    Theindexclusteringfactormeas......
  • Oracle 恢复之using backup controlfile 和 until cancel
    1、recoverdatabase/tablespace/datafileOracle以当前控制文件记录的SCN为恢复终点,将相关的datafile恢复到当前控制文件记录的SCN。控制文件不能比数据文件更旧。完全恢复,利用归档日志和在线重做日志。2、recoverdatabaseuntilcancel只能在sqlplus工具内执行。在丢失日......
  • Oracle中pivot函数详解
    【基本介绍】【格式】:pivot(聚合函数for需要转为列的字段名in(需要转为列的字段值))【说明】:实现将指定字段的字段值转换为列的效果。【环境】:如下图是样例展示所使用的oracle版本。  【准备样例数据】样例数据如下图所示:NAME-学生姓名,SUBJECT-考试科目,GRADES-考试成......