Skip to content

Instantly share code, notes, and snippets.

@cristianmiranda
Created April 25, 2020 00:43
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save cristianmiranda/8de881b6b0a84ed3992783c289d51bab to your computer and use it in GitHub Desktop.
Save cristianmiranda/8de881b6b0a84ed3992783c289d51bab to your computer and use it in GitHub Desktop.
Oracle DB init error log
[oracle@a6573e40d8b8 dbfiles]$ cat /home/oracle/setup/log/configDB.log
Sat Apr 25 00:35:35 UTC 2020
Start Docker DB configuration
Call configDBora.sh to configure database
Sat Apr 25 00:35:35 UTC 2020
Configure DB as oracle user
Setup Database directories ...
SQL*Plus: Release 12.2.0.1.0 Production on Sat Apr 25 00:35:35 2020
Copyright (c) 1982, 2016, Oracle. All rights reserved.
Connected to an idle instance.
SQL>
File created.
SQL> ORACLE instance started.
Total System Global Area 1342177280 bytes
Fixed Size 8792536 bytes
Variable Size 402654760 bytes
Database Buffers 922746880 bytes
Redo Buffers 7983104 bytes
Database mounted.
ORA-03113: end-of-file on communication channel
Process ID: 124
Session ID: 5 Serial number: 19838
SQL> ERROR:
ORA-03114: not connected to ORACLE
SQL> ERROR:
ORA-03114: not connected to ORACLE
SQL> ERROR:
ORA-03114: not connected to ORACLE
SQL> ERROR:
ORA-03114: not connected to ORACLE
SQL> ERROR:
ORA-03114: not connected to ORACLE
SQL> Disconnected from Oracle Database 12c Enterprise Edition Release 12.2.0.1.0 - 64bit Production
update password
Enter password for SYS:
create pdb : ORCLPDB1
SQL*Plus: Release 12.2.0.1.0 Production on Sat Apr 25 00:35:46 2020
Copyright (c) 1982, 2016, Oracle. All rights reserved.
Connected to an idle instance.
SQL> 2 3 4 5 create pluggable database ORCLPDB1 ADMIN USER sys1 identified by "Oradoc_db1"
*
ERROR at line 1:
ORA-01034: ORACLE not available
Process ID: 0
Session ID: 0 Serial number: 0
SQL> alter pluggable database ORCLPDB1 open
*
ERROR at line 1:
ORA-01034: ORACLE not available
Process ID: 0
Session ID: 0 Serial number: 0
SQL> alter pluggable database all save state
*
ERROR at line 1:
ORA-01034: ORACLE not available
Process ID: 0
Session ID: 0 Serial number: 0
SQL> Disconnected
Reset Database parameters
SQL*Plus: Release 12.2.0.1.0 Production on Sat Apr 25 00:35:47 2020
Copyright (c) 1982, 2016, Oracle. All rights reserved.
Connected to an idle instance.
SQL> alter system set encrypt_new_tablespaces=ddl scope=both
*
ERROR at line 1:
ORA-01034: ORACLE not available
Process ID: 0
Session ID: 0 Serial number: 0
SQL> Disconnected
LSNRCTL for Linux: Version 12.2.0.1.0 - Production on 25-APR-2020 00:35:48
Copyright (c) 1991, 2016, Oracle. All rights reserved.
Starting /u01/app/oracle/product/12.2.0/dbhome_1/bin/tnslsnr: please wait...
TNSLSNR for Linux: Version 12.2.0.1.0 - Production
System parameter file is /u01/app/oracle/product/12.2.0/dbhome_1/admin/ORCLCDB/listener.ora
Log messages written to /u01/app/oracle/diag/tnslsnr/a6573e40d8b8/listener/alert/log.xml
Listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=0.0.0.0)(PORT=1521)))
Listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=ipc)(KEY=EXTPROC1521)))
Connecting to (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=0.0.0.0)(PORT=1521)))
STATUS of the LISTENER
------------------------
Alias LISTENER
Version TNSLSNR for Linux: Version 12.2.0.1.0 - Production
Start Date 25-APR-2020 00:35:49
Uptime 0 days 0 hr. 0 min. 0 sec
Trace Level off
Security ON: Local OS Authentication
SNMP OFF
Listener Parameter File /u01/app/oracle/product/12.2.0/dbhome_1/admin/ORCLCDB/listener.ora
Listener Log File /u01/app/oracle/diag/tnslsnr/a6573e40d8b8/listener/alert/log.xml
Listening Endpoints Summary...
(DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=0.0.0.0)(PORT=1521)))
(DESCRIPTION=(ADDRESS=(PROTOCOL=ipc)(KEY=EXTPROC1521)))
The listener supports no services
The command completed successfully
DONE!
Remove password info
Docker DB configuration is complete !
@cristianmiranda
Copy link
Author

cristianmiranda commented Apr 27, 2020

[oracle@70987400d103 trace]$ more alert_ORCLCDB.log 
2017-08-08T12:27:46.191388+00:00
Adjusting the default value of parameter parallel_max_servers
from 320 to 211 due to the value of parameter processes (300)
Starting ORACLE instance (normal) (OS id: 64)
2017-08-08T12:27:46.200613+00:00
CLI notifier numLatches:13 maxDescs:519
2017-08-08T12:27:46.213915+00:00
**********************************************************************
2017-08-08T12:27:46.214070+00:00
Dump of system resources acquired for SHARED GLOBAL AREA (SGA) 

2017-08-08T12:27:46.214354+00:00
 Domain name: docker/ea25ab458e7ada4528f4e038c5f0315616fa2aedd20bcc6bf6212e2e27c
09514
2017-08-08T12:27:46.214499+00:00
 Per process system memlock (soft) limit = 64K
2017-08-08T12:27:46.214637+00:00
 Expected per process system memlock (soft) limit to lock
 SHARED GLOBAL AREA (SGA) into memory: 5122M
2017-08-08T12:27:46.214938+00:00
 Available system pagesizes:
  4K, 2048K 
2017-08-08T12:27:46.215204+00:00
 Supported system pagesize(s):
2017-08-08T12:27:46.215340+00:00
  PAGESIZE  AVAILABLE_PAGES  EXPECTED_PAGES  ALLOCATED_PAGES  ERROR(s)
2017-08-08T12:27:46.215492+00:00
        4K       Configured               7         1310727        NONE
2017-08-08T12:27:46.215804+00:00
     2048K                0            2561               0        NONE
2017-08-08T12:27:46.216068+00:00
RECOMMENDATION:
2017-08-08T12:27:46.216215+00:00
 1. For optimal performance, configure system with expected number 
 of pages for every supported system pagesize prior to the next 
 instance restart operation.
2017-08-08T12:27:46.246589+00:00
 2. Increase per process memlock (soft) limit to at least 5122MB
 to lock 100% of SHARED GLOBAL AREA (SGA) pages into physical memory
2017-08-08T12:27:46.246918+00:00
**********************************************************************
LICENSE_MAX_SESSION = 0
LICENSE_SESSIONS_WARNING = 0
Initial number of CPU is 8
Number of processor cores in the system is 8
Number of processor sockets in the system is 1
Shared memory segment for instance monitoring created
Using LOG_ARCHIVE_DEST_1 parameter default value as USE_DB_RECOVERY_FILE_DEST
Autotune of undo retention is turned on. 
IMODE=BR
ILAT =51
LICENSE_MAX_USERS = 0
SYS auditing is enabled
NOTE: remote asm mode is local (mode 0x1; from cluster type)
NOTE: Using default ASM root directory ASM
NOTE: Cluster configuration type = NONE [2]
Oracle Database 12c Enterprise Edition Release 12.2.0.1.0 - 64bit Production.
ORACLE_HOME:    /u01/app/oracle/product/12.2.0/dbhome_1
System name:	Linux
Node name:	ea25ab458e7a
Release:	4.1.12-32.2.3.el7uek.x86_64
Version:	#2 SMP Fri Mar 25 18:20:55 PDT 2016
Machine:	x86_64
VM name:	Xen Version: 4.4 (HVM)
Using parameter settings in client-side pfile /u01/app/oracle/product/12.2.0/dbh
ome_1/dbs/initORCL.ora on machine ea25ab458e7a
System parameters with non-default values:
  processes                = 300
  shared_pool_size         = 0
  large_pool_size          = 0
  java_pool_size           = 0
  streams_pool_size        = 0
  nls_language             = "AMERICAN"
  nls_territory            = "AMERICA"
  filesystemio_options     = "setall"
  sga_target               = 5G
  control_files            = "/u02/app/oracle/oradata/ORCL/cntrlORCL.dbf"
  control_files            = "/u03/app/oracle/fast_recovery_area/ORCL/cntrlORCL2
.dbf"
  db_block_size            = 8192
  compatible               = "12.2.0"
  db_files                 = 250
  db_recovery_file_dest    = "/u03/app/oracle/fast_recovery_area"
  db_recovery_file_dest_size= 17814M
  undo_tablespace          = "UNDOTBS1"
  remote_login_passwordfile= "EXCLUSIVE"
  db_domain                = "localdomain"
  dispatchers              = "(PROTOCOL=TCP) (SERVICE=ORCLXDB)"
  audit_file_dest          = "/u02/app/oracle/audit/ORCL"
  audit_trail              = "DB"
  db_name                  = "ORCL"
  open_cursors             = 300
  pga_aggregate_target     = 3G
  diagnostic_dest          = "/u01/app/oracle"
  enable_pluggable_database= TRUE
NOTE: remote asm mode is local (mode 0x1; from cluster type)
2017-08-08T12:27:46.890016+00:00
============================================================
NOTE: PatchLevel of this instance 0
============================================================
2017-08-08T12:28:00.524518+00:00
Starting background process PMON
2017-08-08T12:28:00.537275+00:00
PMON started with pid=2, OS id=68 
Starting background process CLMN
2017-08-08T12:28:00.550021+00:00
CLMN started with pid=3, OS id=70 
Starting background process PSP0
Starting background process VKTM
2017-08-08T12:28:00.570170+00:00
PSP0 started with pid=4, OS id=72 
2017-08-08T12:28:01.597217+00:00
Error attempting to elevate VKTM's priority: no further priority changes will be
 attempted for this process
VKTM started with pid=5, OS id=74 
2017-08-08T12:28:01.597638+00:00
Starting background process GEN0
VKTM running at (100ms) precision 
2017-08-08T12:28:01.616438+00:00
GEN0 started with pid=6, OS id=78 
Starting background process MMAN
2017-08-08T12:28:01.632737+00:00
MMAN started with pid=7, OS id=80 
Starting background process GEN1
Starting background process DIAG
2017-08-08T12:28:01.686874+00:00
GEN1 started with pid=9, OS id=84_86 
Starting background process OFSD
2017-08-08T12:28:01.707301+00:00
DIAG started with pid=11, OS id=88 
Starting background process DBRM
2017-08-08T12:28:01.724567+00:00
OFSD started with pid=12, OS id=90_92 
2017-08-08T12:28:01.725479+00:00
Oracle running with ofslib:'Oracle File Server Library' version=2
Starting background process VKRM
2017-08-08T12:28:01.743283+00:00
DBRM started with pid=14, OS id=94 
Starting background process SVCB
2017-08-08T12:28:01.763396+00:00
VKRM started with pid=15, OS id=96 
2017-08-08T12:28:01.776239+00:00
SVCB started with pid=16, OS id=98 
Starting background process PMAN
2017-08-08T12:28:01.794322+00:00
PMAN started with pid=17, OS id=100 
Starting background process DIA0
2017-08-08T12:28:01.806299+00:00
DIA0 started with pid=18, OS id=102 
Starting background process DBW0
2017-08-08T12:28:01.846640+00:00
DBW0 started with pid=19, OS id=104 
Starting background process LGWR
Starting background process CKPT
2017-08-08T12:28:01.867095+00:00
LGWR started with pid=20, OS id=106 
2017-08-08T12:28:01.878536+00:00
CKPT started with pid=21, OS id=108 
2017-08-08T12:28:01.899715+00:00
LGWR slave LG00 created with pid=22, OS pid=110
Starting background process SMON
2017-08-08T12:28:01.919420+00:00
SMON started with pid=23, OS id=112 
LGWR slave LG01 created with pid=24, OS pid=114
Starting background process SMCO
2017-08-08T12:28:01.954864+00:00
SMCO started with pid=25, OS id=116 
Starting background process RECO
2017-08-08T12:28:01.965927+00:00
RECO started with pid=26, OS id=118 
Starting background process LREG
2017-08-08T12:28:02.001696+00:00
LREG started with pid=28, OS id=122 
Starting background process PXMN
2017-08-08T12:28:02.050534+00:00
PXMN started with pid=30, OS id=126 
Starting background process FENC
2017-08-08T12:28:02.061943+00:00
FENC started with pid=31, OS id=128 
Starting background process MMON
2017-08-08T12:28:02.081594+00:00
MMON started with pid=32, OS id=130 
Starting background process MMNL
2017-08-08T12:28:02.095416+00:00
MMNL started with pid=31, OS id=132 
2017-08-08T12:28:02.095582+00:00
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL
=TCP))'...
starting up 1 shared server(s) ...
Starting background process TMON
2017-08-08T12:28:02.159265+00:00
TMON started with pid=35, OS id=138 
ORACLE_BASE from environment = /u01/app/oracle
2017-08-08T12:28:02.275248+00:00
ALTER DATABASE   MOUNT
2017-08-08T12:28:04.749030+00:00
Using default pga_aggregate_limit of 6144 MB
2017-08-08T12:28:06.547075+00:00
Network throttle feature is disabled as mount time

2017-08-08T12:28:06.951100+00:00
Successful mount of redo thread 1, with mount id 1479296210
2017-08-08T12:28:06.953407+00:00
Database mounted in Exclusive Mode
Lost write protection disabled
Using STANDBY_ARCHIVE_DEST parameter default value as USE_DB_RECOVERY_FILE_DEST
Create Relation IPS_PACKAGE_UNPACK_HISTORY
Completed: ALTER DATABASE   MOUNT
2017-08-08T12:28:07.653018+00:00
*** DBNEWID utility started ***
DBID will be changed from 1465335565 to new DBID of 2722566360 for database ORCL
DBNAME will be changed from ORCL to new DBNAME of ORCLCDB
Starting datafile conversion
Datafile conversion complete
Database name changed to ORCLCDB.
Modify parameter file and generate a new password file before restarting.
Database ID for database ORCLCDB changed to 2722566360.
All previous backups and archived redo logs for this database are unusable.
Database has been shutdown, open with RESETLOGS option.
Succesfully changed database name and ID.
*** DBNEWID utility finished succesfully ***

Shutting down instance (immediate) (OS id: 149)
2017-08-08T12:28:10.733373+00:00
Stopping background process SMCO
2017-08-08T12:28:11.762574+00:00
Shutting down instance: further logons disabled
Stopping background process MMNL
2017-08-08T12:28:12.763337+00:00
Stopping background process MMON
2017-08-08T12:28:13.721268+00:00
OS process OFSD (ospid 90) idle for 30 seconds, exiting
2017-08-08T12:28:13.763949+00:00
License high water mark = 2
2017-08-08T12:28:13.794130+00:00
Dispatchers and shared servers shutdown
alter database dismount
Shutting down archive processes
Archiving is disabled
Completed: alter database dismount
ARCH: Archival disabled due to shutdown: 1089
Shutting down archive processes
Archiving is disabled
2017-08-08T12:28:15.033460+00:00
JIT: pid 149 requesting stop
2017-08-08T12:28:16.033478+00:00
ARCH: Archival disabled due to shutdown: 1089
Shutting down archive processes
Archiving is disabled
JIT: pid 149 requesting stop
2017-08-08T12:28:16.119976+00:00
Stopping background process VKTM
2017-08-08T12:28:25.597693+00:00
Instance shutdown complete (OS id: 149)
2017-08-08T12:28:27.009801+00:00
Adjusting the default value of parameter parallel_max_servers
from 320 to 211 due to the value of parameter processes (300)
Starting ORACLE instance (normal) (OS id: 177)
2017-08-08T12:28:27.013348+00:00
CLI notifier numLatches:13 maxDescs:519
2017-08-08T12:28:27.015214+00:00
**********************************************************************
2017-08-08T12:28:27.015285+00:00
Dump of system resources acquired for SHARED GLOBAL AREA (SGA) 

2017-08-08T12:28:27.015421+00:00
 Domain name: docker/ea25ab458e7ada4528f4e038c5f0315616fa2aedd20bcc6bf6212e2e27c
09514
2017-08-08T12:28:27.015488+00:00
 Per process system memlock (soft) limit = 64K
2017-08-08T12:28:27.015553+00:00
 Expected per process system memlock (soft) limit to lock
 SHARED GLOBAL AREA (SGA) into memory: 5122M
2017-08-08T12:28:27.015677+00:00
 Available system pagesizes:
  4K, 2048K 
2017-08-08T12:28:27.015811+00:00
 Supported system pagesize(s):
2017-08-08T12:28:27.015897+00:00
  PAGESIZE  AVAILABLE_PAGES  EXPECTED_PAGES  ALLOCATED_PAGES  ERROR(s)
2017-08-08T12:28:27.015963+00:00
        4K       Configured               7         1310727        NONE
2017-08-08T12:28:27.016112+00:00
     2048K                0            2561               0        NONE
2017-08-08T12:28:27.016179+00:00
RECOMMENDATION:
2017-08-08T12:28:27.016242+00:00
 1. For optimal performance, configure system with expected number 
 of pages for every supported system pagesize prior to the next 
 instance restart operation.
2017-08-08T12:28:27.020714+00:00
 2. Increase per process memlock (soft) limit to at least 5122MB
 to lock 100% of SHARED GLOBAL AREA (SGA) pages into physical memory
2017-08-08T12:28:27.020876+00:00
**********************************************************************
LICENSE_MAX_SESSION = 0
LICENSE_SESSIONS_WARNING = 0
Initial number of CPU is 8
Number of processor cores in the system is 8
Number of processor sockets in the system is 1
Using LOG_ARCHIVE_DEST_1 parameter default value as USE_DB_RECOVERY_FILE_DEST
Autotune of undo retention is turned on. 
IMODE=BR
ILAT =51
LICENSE_MAX_USERS = 0
SYS auditing is enabled
NOTE: remote asm mode is local (mode 0x1; from cluster type)
NOTE: Using default ASM root directory ASM
NOTE: Cluster configuration type = NONE [2]
Oracle Database 12c Enterprise Edition Release 12.2.0.1.0 - 64bit Production.
ORACLE_HOME:    /u01/app/oracle/product/12.2.0/dbhome_1
System name:	Linux
Node name:	ea25ab458e7a
Release:	4.1.12-32.2.3.el7uek.x86_64
Version:	#2 SMP Fri Mar 25 18:20:55 PDT 2016
Machine:	x86_64
VM name:	Xen Version: 4.4 (HVM)
Using parameter settings in server-side spfile /u01/app/oracle/product/12.2.0/db
home_1/dbs/spfileORCLCDB.ora
System parameters with non-default values:
  processes                = 300
  shared_pool_size         = 0
  large_pool_size          = 0
  java_pool_size           = 0
  streams_pool_size        = 0
  nls_language             = "AMERICAN"
  nls_territory            = "AMERICA"
  filesystemio_options     = "setall"
  sga_target               = 5G
  control_files            = "/u02/app/oracle/oradata/ORCLCDB/cntrlORCLCDB.dbf"
  control_files            = "/u03/app/oracle/fast_recovery_area/ORCLCDB/cntrlOR
CLCDB2.dbf"
  db_block_size            = 8192
  compatible               = "12.2.0"
  db_files                 = 250
  db_recovery_file_dest    = "/u03/app/oracle/fast_recovery_area"
  db_recovery_file_dest_size= 17814M
  undo_tablespace          = "UNDOTBS1"
  remote_login_passwordfile= "EXCLUSIVE"
  db_domain                = "localdomain"
  dispatchers              = "(PROTOCOL=TCP) (SERVICE=ORCLCDBXDB)"
  audit_file_dest          = "/u02/app/oracle/audit/ORCLCDB"
  audit_trail              = "DB"
  db_name                  = "ORCLCDB"
  open_cursors             = 300
  pga_aggregate_target     = 3G
  diagnostic_dest          = "/u01/app/oracle"
  enable_pluggable_database= TRUE
NOTE: remote asm mode is local (mode 0x1; from cluster type)
2017-08-08T12:28:27.477242+00:00
============================================================
NOTE: PatchLevel of this instance 0
============================================================
2017-08-08T12:28:36.967425+00:00
Starting background process PMON
2017-08-08T12:28:36.980546+00:00
PMON started with pid=2, OS id=181 
Starting background process CLMN
2017-08-08T12:28:36.991125+00:00
CLMN started with pid=3, OS id=183 
Starting background process PSP0
2017-08-08T12:28:37.001695+00:00
PSP0 started with pid=4, OS id=185 
Starting background process VKTM
2017-08-08T12:28:38.025727+00:00
Error attempting to elevate VKTM's priority: no further priority changes will be
 attempted for this process
VKTM started with pid=5, OS id=187 
2017-08-08T12:28:38.026173+00:00
Starting background process GEN0
VKTM running at (100ms) precision 
2017-08-08T12:28:38.044816+00:00
GEN0 started with pid=6, OS id=191 
Starting background process MMAN
2017-08-08T12:28:38.057184+00:00
MMAN started with pid=7, OS id=193 
Starting background process GEN1
2017-08-08T12:28:38.091007+00:00
GEN1 started with pid=9, OS id=197_199 
Starting background process DIAG
2017-08-08T12:28:38.110515+00:00
DIAG started with pid=11, OS id=201 
Starting background process OFSD
Starting background process DBRM
2017-08-08T12:28:38.128517+00:00
OFSD started with pid=12, OS id=203_205 
2017-08-08T12:28:38.129778+00:00
Oracle running with ofslib:'Oracle File Server Library' version=2
2017-08-08T12:28:38.139012+00:00
DBRM started with pid=14, OS id=207 
Starting background process VKRM
2017-08-08T12:28:38.148883+00:00
VKRM started with pid=15, OS id=209 
Starting background process SVCB
Starting background process PMAN
2017-08-08T12:28:38.168126+00:00
SVCB started with pid=16, OS id=211 
2017-08-08T12:28:38.184793+00:00
PMAN started with pid=17, OS id=213 
Starting background process DIA0
2017-08-08T12:28:38.198230+00:00
DIA0 started with pid=18, OS id=215 
Starting background process DBW0
2017-08-08T12:28:38.221873+00:00
DBW0 started with pid=19, OS id=217 
Starting background process LGWR
Starting background process CKPT
2017-08-08T12:28:38.239001+00:00
LGWR started with pid=20, OS id=219 
2017-08-08T12:28:38.254279+00:00
CKPT started with pid=21, OS id=221 
2017-08-08T12:28:38.267671+00:00
LGWR slave LG00 created with pid=22, OS pid=223
Starting background process SMON
2017-08-08T12:28:38.278486+00:00
SMON started with pid=23, OS id=225 
LGWR slave LG01 created with pid=24, OS pid=227
Starting background process SMCO
2017-08-08T12:28:38.301463+00:00
SMCO started with pid=25, OS id=229 
Starting background process RECO
2017-08-08T12:28:38.311950+00:00
RECO started with pid=26, OS id=231 
Starting background process LREG
2017-08-08T12:28:38.333804+00:00
LREG started with pid=28, OS id=235 
Starting background process PXMN
2017-08-08T12:28:38.356597+00:00
PXMN started with pid=30, OS id=239 
Starting background process FENC
2017-08-08T12:28:38.370359+00:00
FENC started with pid=31, OS id=241 
Starting background process MMON
2017-08-08T12:28:38.380843+00:00
MMON started with pid=32, OS id=243 
Starting background process MMNL
2017-08-08T12:28:38.390389+00:00
MMNL started with pid=33, OS id=245 
2017-08-08T12:28:38.390544+00:00
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL
=TCP))'...
starting up 1 shared server(s) ...
Starting background process TMON
2017-08-08T12:28:38.429164+00:00
TMON started with pid=35, OS id=251 
ORACLE_BASE from environment = /u01/app/oracle
2017-08-08T12:28:38.539301+00:00
ALTER DATABASE   MOUNT
2017-08-08T12:28:41.072568+00:00
Spfile /u01/app/oracle/product/12.2.0/dbhome_1/dbs/spfileORCLCDB.ora is in old p
re-11 format and compatible >= 11.0.0; converting to new H.A.R.D. compliant form
at.
2017-08-08T12:28:41.150486+00:00
Using default pga_aggregate_limit of 6144 MB
2017-08-08T12:28:43.092306+00:00
Changing di2dbun from ORCL to ORCLCDB
Network throttle feature is disabled as mount time

2017-08-08T12:28:43.566951+00:00
Successful mount of redo thread 1, with mount id 2722562806
2017-08-08T12:28:43.569045+00:00
Database mounted in Exclusive Mode
Lost write protection disabled
Using STANDBY_ARCHIVE_DEST parameter default value as USE_DB_RECOVERY_FILE_DEST
Completed: ALTER DATABASE   MOUNT
2017-08-08T12:28:43.942953+00:00
      alter database open resetlogs
2017-08-08T12:28:44.012279+00:00
RESETLOGS after complete recovery through change 2550642
Resetting resetlogs activation ID 1465321485 (0x5757080d)
2017-08-08T12:28:44.999624+00:00
Setting recovery target incarnation to 3
2017-08-08T12:28:45.100984+00:00
Ping without log force is disabled:
  instance mounted in exclusive mode.
Buffer Cache Full DB Caching mode changing from FULL CACHING DISABLED to FULL CA
CHING ENABLED 
Endian type of dictionary set to little
2017-08-08T12:28:45.380553+00:00
Assigning activation ID 2722562806 (0xa24702f6)
2017-08-08T12:28:45.411352+00:00
TT00: Gap Manager starting (PID:261)
2017-08-08T12:28:45.732306+00:00
Thread 1 opened at log sequence 1
  Current log# 1 seq# 1 mem# 0: /u04/app/oracle/redo/redo001.log
Successful open of redo thread 1
2017-08-08T12:28:45.733022+00:00
MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set
[259] Successfully onlined Undo Tablespace 2.
Undo initialization finished serial:0 start:810704874 end:810705023 diff:149 ms 
(0.1 seconds)
Dictionary check beginning
2017-08-08T12:28:46.844295+00:00
Dictionary check complete
Verifying minimum file header compatibility for tablespace encryption for pdb 1.
.
Verifying file header compatibility for tablespace encryption completed for pdb 
1
Database Characterset is AL32UTF8
No Resource Manager plan active
**********************************************************
WARNING: Files may exists in db_recovery_file_dest
that are not known to the database. Use the RMAN command
CATALOG RECOVERY AREA to re-catalog any such files.
If files cannot be cataloged, then manually delete them
using OS command.
One of the following events caused this:
1. A backup controlfile was restored.
2. A standby controlfile was restored.
3. The controlfile was re-created.
4. db_recovery_file_dest had previously been enabled and
   then disabled.
**********************************************************
replication_dependency_tracking turned off (no async multimaster replication fou
nd)
2017-08-08T12:28:48.020010+00:00
Starting background process AQPC
2017-08-08T12:28:48.037215+00:00
AQPC started with pid=39, OS id=269 
LOGSTDBY: Validating controlfile with logical metadata
LOGSTDBY: Validation complete
2017-08-08T12:28:48.613534+00:00
Global Name changed to ORCLCDB
PDB$SEED(2):Autotune of undo retention is turned on. 
2017-08-08T12:28:49.112942+00:00
PDB$SEED(2):Endian type of dictionary set to little
PDB$SEED(2):Undo initialization finished serial:0 start:810708252 end:810708252 
diff:0 ms (0.0 seconds)
PDB$SEED(2):Pluggable database PDB$SEED dictionary check beginning
2017-08-08T12:28:50.116674+00:00
PDB$SEED(2):Pluggable Database PDB$SEED Dictionary check complete
PDB$SEED(2):Database Characterset for PDB$SEED is AL32UTF8
PDB$SEED(2):Opatch validation is skipped for PDB PDB$SEED (con_id=0)
2017-08-08T12:28:51.534278+00:00
PDB$SEED(2):Opening pdb with no Resource Manager plan active
Starting background process CJQ0
2017-08-08T12:28:52.029458+00:00
CJQ0 started with pid=40, OS id=337 
2017-08-08T12:28:54.229194+00:00
Completed:       alter database open resetlogs
      alter database rename global_name to ORCLCDB.localdomain
Completed:       alter database rename global_name to ORCLCDB.localdomain
TABLE AUDSYS.AUD$UNIFIED: ADDED INTERVAL PARTITION SYS_P255 (38) VALUES LESS THA
N (TIMESTAMP' 2017-09-01 00:00:00')
2017-08-08T12:28:54.666347+00:00
    create pluggable database ORCLPDB1 ADMIN USER sys1 identified by *
    default tablespace users
      datafile '/u02/app/oracle/oradata/ORCL/pdb1/users01.dbf'
      size 10M reuse autoextend on maxsize unlimited
      file_name_convert=('/u02/app/oracle/oradata/ORCL/pdbseed','/u02/app/oracle
/oradata/ORCL/pdb1')
2017-08-08T12:28:55.342135+00:00
Thread 1 advanced to log sequence 2 (LGWR switch)
  Current log# 2 seq# 2 mem# 0: /u04/app/oracle/redo/redo002.log
2017-08-08T12:28:56.960693+00:00
PDB$SEED(2): APEX_050000.WWV_FLOW_FLASH_CHART5_SERIES (SERIES_QUERY) - CLOB popu
lated
2017-08-08T12:29:01.581543+00:00
Unable to obtain current patch information due to error: 20001, ORA-20001: Lates
t xml inventory is not loaded into table
ORA-06512: at "SYS.DBMS_QOPATCH", line 777
ORA-06512: at "SYS.DBMS_QOPATCH", line 864
ORA-06512: at "SYS.DBMS_QOPATCH", line 2222
ORA-06512: at "SYS.DBMS_QOPATCH", line 740
ORA-06512: at "SYS.DBMS_QOPATCH", line 2247

===========================================================
Dumping current patch information
===========================================================
Unable to obtain current patch information due to error: 20001
===========================================================
2017-08-08T12:29:03.916774+00:00
ORCLPDB1(3):Endian type of dictionary set to little
2017-08-08T12:29:04.238654+00:00
db_recovery_file_dest_size of 17814 MB is 0.00% used. This is a
user-specified limit on the amount of space that will be used by this
database for recovery-related files, and does not reflect the amount of
space available in the underlying filesystem or ASM diskgroup.
2017-08-08T12:29:05.424106+00:00
****************************************************************
Pluggable Database ORCLPDB1 with pdb id - 3 is created as UNUSABLE.
If any errors are encountered before the pdb is marked as NEW,
then the pdb must be dropped
local undo-1, localundoscn-0x00000000000000e1
****************************************************************
ORCLPDB1(3):Autotune of undo retention is turned on. 
ORCLPDB1(3):[341] Successfully onlined Undo Tablespace 2.
ORCLPDB1(3):Undo initialization finished serial:0 start:810725137 end:810725227 
diff:90 ms (0.1 seconds)
ORCLPDB1(3):Database Characterset for ORCLPDB1 is AL32UTF8
2017-08-08T12:29:06.357001+00:00
TABLE SYS.WRP$_REPORTS: ADDED INTERVAL PARTITION SYS_P262 (2777) VALUES LESS THA
N (TO_DATE(' 2017-08-09 01:00:00', 'SYYYY-MM-DD HH24:MI:SS', 'NLS_CALENDAR=GREGO
RIAN'))
TABLE SYS.WRP$_REPORTS_DETAILS: ADDED INTERVAL PARTITION SYS_P263 (2777) VALUES 
LESS THAN (TO_DATE(' 2017-08-09 01:00:00', 'SYYYY-MM-DD HH24:MI:SS', 'NLS_CALEND
AR=GREGORIAN'))
TABLE SYS.WRP$_REPORTS_TIME_BANDS: ADDED INTERVAL PARTITION SYS_P266 (2776) VALU
ES LESS THAN (TO_DATE(' 2017-08-08 01:00:00', 'SYYYY-MM-DD HH24:MI:SS', 'NLS_CAL
ENDAR=GREGORIAN'))
2017-08-08T12:29:06.447418+00:00
ORCLPDB1(3):JIT: pid 341 requesting stop
2017-08-08T12:29:07.796106+00:00
Completed:     create pluggable database ORCLPDB1 ADMIN USER sys1 identified by 
*
    default tablespace users
      datafile '/u02/app/oracle/oradata/ORCL/pdb1/users01.dbf'
      size 10M reuse autoextend on maxsize unlimited
      file_name_convert=('/u02/app/oracle/oradata/ORCL/pdbseed','/u02/app/oracle
/oradata/ORCL/pdb1')
    alter pluggable database ORCLPDB1 open
ORCLPDB1(3):Autotune of undo retention is turned on. 
2017-08-08T12:29:08.622233+00:00
ORCLPDB1(3):Endian type of dictionary set to little
2017-08-08T12:29:09.019521+00:00
ORCLPDB1(3):[341] Successfully onlined Undo Tablespace 2.
ORCLPDB1(3):Undo initialization finished serial:0 start:810727770 end:810728019 
diff:249 ms (0.2 seconds)
ORCLPDB1(3):Deleting old file#5 from file$ 
ORCLPDB1(3):Deleting old file#6 from file$ 
ORCLPDB1(3):Deleting old file#8 from file$ 
ORCLPDB1(3):Adding new file#13 to file$(old file#5) 
ORCLPDB1(3):Adding new file#14 to file$(old file#6) 
ORCLPDB1(3):Adding new file#15 to file$(old file#8) 
ORCLPDB1(3):Successfully created internal service orclpdb1.localdomain at open
ORCLPDB1(3):CREATE TABLESPACE USERS DATAFILE  '/u02/app/oracle/oradata/ORCL/pdb1
/users01.dbf'
      size 10M reuse autoextend on maxsize unlimited
       SEGMENT SPACE MANAGEMENT AUTO
ORCLPDB1(3):Completed: CREATE TABLESPACE USERS DATAFILE  '/u02/app/oracle/oradat
a/ORCL/pdb1/users01.dbf'
      size 10M reuse autoextend on maxsize unlimited
       SEGMENT SPACE MANAGEMENT AUTO
2017-08-08T12:29:10.114686+00:00
****************************************************************
Post plug operations are now complete.
Pluggable database ORCLPDB1 with pdb id - 3 is now marked as NEW.
****************************************************************
ORCLPDB1(3):Database Characterset for ORCLPDB1 is AL32UTF8
ORCLPDB1(3):Opatch validation is skipped for PDB ORCLPDB1 (con_id=0)
2017-08-08T12:29:14.000403+00:00
Thread 1 advanced to log sequence 3 (LGWR switch)
  Current log# 3 seq# 3 mem# 0: /u04/app/oracle/redo/redo003.log
2017-08-08T12:29:14.356563+00:00
ORCLPDB1(3):Opening pdb with no Resource Manager plan active
Pluggable database ORCLPDB1 opened read write
Completed:     alter pluggable database ORCLPDB1 open
    alter pluggable database all save state
Completed:     alter pluggable database all save state
2017-08-08T12:29:14.814022+00:00
ALTER SYSTEM SET encrypt_new_tablespaces='DDL' SCOPE=BOTH;
2017-08-08T12:31:14.311852+00:00
Shutting down instance (normal) (OS id: 743)
2017-08-08T12:31:16.612511+00:00
Stopping background process SMCO
2017-08-08T12:31:17.670808+00:00
Shutting down instance: further logons disabled
2017-08-08T12:31:18.243490+00:00
Stopping background process CJQ0
2017-08-08T12:31:18.246701+00:00
Killed process oracle@ea25ab458e7a (Q004) with pid is 73, OS pid 617
Stopping background process MMNL
2017-08-08T12:31:19.247349+00:00
Stopping background process MMON
2017-08-08T12:31:20.248617+00:00
alter pluggable database all close
2017-08-08T12:31:20.263380+00:00
ORCLPDB1(3):JIT: pid 743 requesting stop
Pluggable database ORCLPDB1 closed
Completed: alter pluggable database all close
PDB$SEED(2):JIT: pid 743 requesting stop
License high water mark = 23
Dispatchers and shared servers shutdown
2017-08-08T12:31:21.715112+00:00
ALTER DATABASE CLOSE NORMAL
2017-08-08T12:31:21.776897+00:00
Stopping Emon pool
Stopping background process AQPC
2017-08-08T12:31:22.782158+00:00
alter pluggable database all close
Completed: alter pluggable database all close
2017-08-08T12:31:22.810989+00:00
Stopping Emon pool
2017-08-08T12:31:23.057500+00:00
Shutting down archive processes
2017-08-08T12:31:23.057986+00:00
TT00: Gap Manager exiting (PID:261)
2017-08-08T12:31:24.058091+00:00
Archiving is disabled
2017-08-08T12:31:24.058797+00:00
Thread 1 closed at log sequence 3
Successful close of redo thread 1
2017-08-08T12:31:24.183482+00:00
OS process OFSD (ospid 203) idle for 30 seconds, exiting
2017-08-08T12:31:24.247008+00:00
Completed: ALTER DATABASE CLOSE NORMAL
ALTER DATABASE DISMOUNT
Shutting down archive processes
Archiving is disabled
Completed: ALTER DATABASE DISMOUNT
2017-08-08T12:31:25.347474+00:00
ARCH: Archival disabled due to shutdown: 1090
Shutting down archive processes
Archiving is disabled
2017-08-08T12:31:26.350816+00:00
JIT: pid 743 requesting stop
2017-08-08T12:31:27.351519+00:00
ARCH: Archival disabled due to shutdown: 1090
Shutting down archive processes
Archiving is disabled
JIT: pid 743 requesting stop
2017-08-08T12:31:27.379028+00:00
Stopping background process VKTM
2017-08-08T12:31:33.064338+00:00
Instance shutdown complete (OS id: 743)
2017-08-08T17:39:40.647530+00:00
Adjusting the default value of parameter parallel_max_servers
from 320 to 211 due to the value of parameter processes (300)
Starting ORACLE instance (normal) (OS id: 5311)
2017-08-08T17:39:40.654562+00:00
CLI notifier numLatches:13 maxDescs:519
2017-08-08T17:39:40.659262+00:00
**********************************************************************
2017-08-08T17:39:40.659527+00:00
Dump of system resources acquired for SHARED GLOBAL AREA (SGA) 

2017-08-08T17:39:40.659892+00:00
 Domain name: docker/ea25ab458e7ada4528f4e038c5f0315616fa2aedd20bcc6bf6212e2e27c
09514
2017-08-08T17:39:40.660065+00:00
 Per process system memlock (soft) limit = 64K
2017-08-08T17:39:40.660236+00:00
 Expected per process system memlock (soft) limit to lock
 SHARED GLOBAL AREA (SGA) into memory: 5122M
2017-08-08T17:39:40.660640+00:00
 Available system pagesizes:
  4K, 2048K 
2017-08-08T17:39:40.660999+00:00
 Supported system pagesize(s):
2017-08-08T17:39:40.661180+00:00
  PAGESIZE  AVAILABLE_PAGES  EXPECTED_PAGES  ALLOCATED_PAGES  ERROR(s)
2017-08-08T17:39:40.661343+00:00
        4K       Configured               7         1310727        NONE
2017-08-08T17:39:40.661743+00:00
     2048K                0            2561               0        NONE
2017-08-08T17:39:40.661969+00:00
RECOMMENDATION:
2017-08-08T17:39:40.662163+00:00
 1. For optimal performance, configure system with expected number 
 of pages for every supported system pagesize prior to the next 
 instance restart operation.
2017-08-08T17:39:40.668580+00:00
 2. Increase per process memlock (soft) limit to at least 5122MB
 to lock 100% of SHARED GLOBAL AREA (SGA) pages into physical memory
2017-08-08T17:39:40.669043+00:00
**********************************************************************
LICENSE_MAX_SESSION = 0
LICENSE_SESSIONS_WARNING = 0
Initial number of CPU is 8
Number of processor cores in the system is 8
Number of processor sockets in the system is 1
Using LOG_ARCHIVE_DEST_1 parameter default value as USE_DB_RECOVERY_FILE_DEST
Autotune of undo retention is turned on. 
IMODE=BR
ILAT =51
LICENSE_MAX_USERS = 0
SYS auditing is enabled
NOTE: remote asm mode is local (mode 0x1; from cluster type)
NOTE: Using default ASM root directory ASM
NOTE: Cluster configuration type = NONE [2]
Oracle Database 12c Enterprise Edition Release 12.2.0.1.0 - 64bit Production.
ORACLE_HOME:    /u01/app/oracle/product/12.2.0/dbhome_1
System name:	Linux
Node name:	ea25ab458e7a
Release:	4.1.12-32.2.3.el7uek.x86_64
Version:	#2 SMP Fri Mar 25 18:20:55 PDT 2016
Machine:	x86_64
VM name:	Xen Version: 4.4 (HVM)
Using parameter settings in server-side spfile /u01/app/oracle/product/12.2.0/db
home_1/dbs/spfileORCLCDB.ora
System parameters with non-default values:
  processes                = 300
  shared_pool_size         = 0
  large_pool_size          = 0
  java_pool_size           = 0
  streams_pool_size        = 0
  nls_language             = "AMERICAN"
  nls_territory            = "AMERICA"
  filesystemio_options     = "setall"
  sga_target               = 5G
  control_files            = "/u02/app/oracle/oradata/ORCLCDB/cntrlORCLCDB.dbf"
  control_files            = "/u03/app/oracle/fast_recovery_area/ORCLCDB/cntrlOR
CLCDB2.dbf"
  db_block_size            = 8192
  encrypt_new_tablespaces  = "DDL"
  compatible               = "12.2.0"
  db_files                 = 250
  db_recovery_file_dest    = "/u03/app/oracle/fast_recovery_area"
  db_recovery_file_dest_size= 17814M
  undo_tablespace          = "UNDOTBS1"
  remote_login_passwordfile= "EXCLUSIVE"
  db_domain                = "localdomain"
  dispatchers              = "(PROTOCOL=TCP) (SERVICE=ORCLCDBXDB)"
  audit_file_dest          = "/u02/app/oracle/audit/ORCLCDB"
  audit_trail              = "DB"
  db_name                  = "ORCLCDB"
  open_cursors             = 300
  pga_aggregate_target     = 3G
  diagnostic_dest          = "/u01/app/oracle"
  enable_pluggable_database= TRUE
NOTE: remote asm mode is local (mode 0x1; from cluster type)
2017-08-08T17:39:40.929913+00:00
============================================================
NOTE: PatchLevel of this instance 0
============================================================
2017-08-08T17:39:48.508542+00:00
Starting background process PMON
2017-08-08T17:39:48.523998+00:00
PMON started with pid=2, OS id=5315 
Starting background process CLMN
2017-08-08T17:39:48.535117+00:00
CLMN started with pid=3, OS id=5317 
Starting background process PSP0
2017-08-08T17:39:48.546094+00:00
PSP0 started with pid=4, OS id=5319 
Starting background process VKTM
2017-08-08T17:39:49.570494+00:00
Error attempting to elevate VKTM's priority: no further priority changes will be
 attempted for this process
VKTM started with pid=5, OS id=5321 
2017-08-08T17:39:49.570965+00:00
Starting background process GEN0
VKTM running at (100ms) precision 
2017-08-08T17:39:49.590586+00:00
GEN0 started with pid=6, OS id=5325 
Starting background process MMAN
2017-08-08T17:39:49.610185+00:00
MMAN started with pid=7, OS id=5327 
Starting background process GEN1
2017-08-08T17:39:49.659960+00:00
GEN1 started with pid=9, OS id=5331_5333 
Starting background process DIAG
Starting background process OFSD
2017-08-08T17:39:49.677364+00:00
DIAG started with pid=11, OS id=5335 
Starting background process DBRM
2017-08-08T17:39:49.705502+00:00
OFSD started with pid=12, OS id=5337_5339 
2017-08-08T17:39:49.707105+00:00
Oracle running with ofslib:'Oracle File Server Library' version=2
2017-08-08T17:39:49.726084+00:00
DBRM started with pid=14, OS id=5341 
Starting background process VKRM
Starting background process SVCB
2017-08-08T17:39:49.745552+00:00
VKRM started with pid=15, OS id=5343 
Starting background process PMAN
2017-08-08T17:39:49.765932+00:00
SVCB started with pid=16, OS id=5345 
2017-08-08T17:39:49.781581+00:00
PMAN started with pid=17, OS id=5347 
Starting background process DIA0
2017-08-08T17:39:49.798697+00:00
DIA0 started with pid=18, OS id=5349 
Starting background process DBW0
2017-08-08T17:39:49.818955+00:00
DBW0 started with pid=19, OS id=5351 
Starting background process LGWR
2017-08-08T17:39:49.838992+00:00
LGWR started with pid=20, OS id=5353 
Starting background process CKPT
2017-08-08T17:39:49.857163+00:00
CKPT started with pid=21, OS id=5355 
2017-08-08T17:39:49.877643+00:00
LGWR slave LG00 created with pid=22, OS pid=5357
Starting background process SMON
2017-08-08T17:39:49.888719+00:00
SMON started with pid=23, OS id=5359 
LGWR slave LG01 created with pid=24, OS pid=5361
Starting background process SMCO
2017-08-08T17:39:49.911531+00:00
SMCO started with pid=25, OS id=5363 
Starting background process RECO
2017-08-08T17:39:49.921987+00:00
RECO started with pid=26, OS id=5365 
Starting background process LREG
2017-08-08T17:39:49.943438+00:00
LREG started with pid=28, OS id=5369 
Starting background process PXMN
2017-08-08T17:39:49.965174+00:00
PXMN started with pid=30, OS id=5373 
Starting background process FENC
2017-08-08T17:39:49.974647+00:00
FENC started with pid=31, OS id=5375 
Starting background process MMON
2017-08-08T17:39:49.993977+00:00
MMON started with pid=32, OS id=5377 
Starting background process MMNL
2017-08-08T17:39:50.010706+00:00
MMNL started with pid=31, OS id=5379 
2017-08-08T17:39:50.010738+00:00
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL
=TCP))'...
starting up 1 shared server(s) ...
Starting background process TMON
2017-08-08T17:39:50.044356+00:00
TMON started with pid=35, OS id=5385 
ORACLE_BASE from environment = /u01/app/oracle
2017-08-08T17:39:50.095558+00:00
ALTER DATABASE   MOUNT
2017-08-08T17:39:52.739806+00:00
Using default pga_aggregate_limit of 6144 MB
2017-08-08T17:39:54.676279+00:00
Network throttle feature is disabled as mount time

2017-08-08T17:39:54.967274+00:00
Successful mount of redo thread 1, with mount id 2722575590
2017-08-08T17:39:54.969451+00:00
Database mounted in Exclusive Mode
Lost write protection disabled
Using STANDBY_ARCHIVE_DEST parameter default value as USE_DB_RECOVERY_FILE_DEST
2017-08-08T17:39:55.810965+00:00
Completed: ALTER DATABASE   MOUNT
2017-08-08T17:39:55.846048+00:00
ALTER DATABASE OPEN
2017-08-08T17:39:56.039695+00:00
Ping without log force is disabled:
  instance mounted in exclusive mode.
Buffer Cache Full DB Caching mode changing from FULL CACHING DISABLED to FULL CA
CHING ENABLED 
Endian type of dictionary set to little
2017-08-08T17:39:56.325359+00:00
TT00: Gap Manager starting (PID:5410)
2017-08-08T17:39:56.539092+00:00
Thread 1 opened at log sequence 3
  Current log# 3 seq# 3 mem# 0: /u04/app/oracle/redo/redo003.log
Successful open of redo thread 1
2017-08-08T17:39:56.540032+00:00
MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set
2017-08-08T17:39:58.668939+00:00
[5408] Successfully onlined Undo Tablespace 2.
Undo initialization finished serial:0 start:829376875 end:829377668 diff:793 ms 
(0.8 seconds)
Verifying minimum file header compatibility for tablespace encryption for pdb 1.
.
Verifying file header compatibility for tablespace encryption completed for pdb 
1
Database Characterset is AL32UTF8
No Resource Manager plan active
2017-08-08T17:40:02.454135+00:00
replication_dependency_tracking turned off (no async multimaster replication fou
nd)
2017-08-08T17:40:03.935198+00:00
Starting background process AQPC
2017-08-08T17:40:03.947850+00:00
AQPC started with pid=39, OS id=5418 
2017-08-08T17:40:05.954805+00:00
PDB$SEED(2):Autotune of undo retention is turned on. 
2017-08-08T17:40:06.170315+00:00
PDB$SEED(2):Endian type of dictionary set to little
PDB$SEED(2):Undo initialization finished serial:0 start:829385649 end:829385649 
diff:0 ms (0.0 seconds)
2017-08-08T17:40:07.227559+00:00
PDB$SEED(2):Database Characterset for PDB$SEED is AL32UTF8
2017-08-08T17:40:09.584358+00:00
PDB$SEED(2):Opatch validation is skipped for PDB PDB$SEED (con_id=0)
2017-08-08T17:40:11.377994+00:00
PDB$SEED(2):Opening pdb with no Resource Manager plan active
ORCLPDB1(3):Autotune of undo retention is turned on. 
2017-08-08T17:40:12.668682+00:00
ORCLPDB1(3):Endian type of dictionary set to little
2017-08-08T17:40:13.825582+00:00
Unable to obtain current patch information due to error: 20001, ORA-20001: Lates
t xml inventory is not loaded into table
ORA-06512: at "SYS.DBMS_QOPATCH", line 777
ORA-06512: at "SYS.DBMS_QOPATCH", line 864
ORA-06512: at "SYS.DBMS_QOPATCH", line 2222
ORA-06512: at "SYS.DBMS_QOPATCH", line 740
ORA-06512: at "SYS.DBMS_QOPATCH", line 2247

===========================================================
Dumping current patch information
===========================================================
Unable to obtain current patch information due to error: 20001
===========================================================
2017-08-08T17:40:14.242943+00:00
ORCLPDB1(3):[5408] Successfully onlined Undo Tablespace 2.
ORCLPDB1(3):Undo initialization finished serial:0 start:829392276 end:829393258 
diff:982 ms (1.0 seconds)
ORCLPDB1(3):Database Characterset for ORCLPDB1 is AL32UTF8
2017-08-08T17:40:15.738611+00:00
ORCLPDB1(3):Opatch validation is skipped for PDB ORCLPDB1 (con_id=0)
2017-08-08T17:40:15.928314+00:00
db_recovery_file_dest_size of 17814 MB is 0.00% used. This is a
user-specified limit on the amount of space that will be used by this
database for recovery-related files, and does not reflect the amount of
space available in the underlying filesystem or ASM diskgroup.
2017-08-08T17:40:20.918309+00:00
ORCLPDB1(3):Opening pdb with no Resource Manager plan active
Pluggable database ORCLPDB1 opened read write
2017-08-08T17:40:23.614551+00:00
Starting background process CJQ0
Completed: ALTER DATABASE OPEN
2017-08-08T17:40:23.635772+00:00
CJQ0 started with pid=77, OS id=5707 
2017-08-08T17:41:04.209359+00:00
drop pluggable database ORCLPDB1 including datafiles
ORA-65025 signalled during: drop pluggable database ORCLPDB1 including datafiles
...
2017-08-08T17:41:15.689023+00:00
alter pluggable database ORCLPDB1 close
2017-08-08T17:41:15.701317+00:00
ORCLPDB1(3):JIT: pid 5408 requesting stop
2017-08-08T17:41:16.816652+00:00
Pluggable database ORCLPDB1 closed
Completed: alter pluggable database ORCLPDB1 close
2017-08-08T17:41:21.427575+00:00
drop pluggable database ORCLPDB1 including datafiles
2017-08-08T17:41:24.274231+00:00
Deleted file /u02/app/oracle/oradata/ORCL/pdb1/users01.dbf
Deleted file /u02/app/oracle/oradata/ORCL/pdb1/temp012017-03-02_07-54-38-075-AM.
dbf
Deleted file /u02/app/oracle/oradata/ORCL/pdb1/undotbs01.dbf
Deleted file /u02/app/oracle/oradata/ORCL/pdb1/sysaux01.dbf
Deleted file /u02/app/oracle/oradata/ORCL/pdb1/system01.dbf
Completed: drop pluggable database ORCLPDB1 including datafiles
2017-08-08T17:41:30.942719+00:00
Shutting down instance (normal) (OS id: 5408)
Stopping background process SMCO
2017-08-08T17:41:32.854321+00:00
Shutting down instance: further logons disabled
2017-08-08T17:41:32.906146+00:00
Stopping background process CJQ0
Stopping background process MMNL
2017-08-08T17:41:33.909285+00:00
Stopping background process MMON
2017-08-08T17:41:34.910110+00:00
alter pluggable database all close
Completed: alter pluggable database all close
2017-08-08T17:41:34.914409+00:00
PDB$SEED(2):JIT: pid 5408 requesting stop
License high water mark = 20
Dispatchers and shared servers shutdown
ALTER DATABASE CLOSE NORMAL
Stopping Emon pool
Stopping background process AQPC
2017-08-08T17:41:36.656864+00:00
alter pluggable database all close
Completed: alter pluggable database all close
2017-08-08T17:41:36.773617+00:00
Stopping Emon pool
2017-08-08T17:41:37.175254+00:00
Shutting down archive processes
2017-08-08T17:41:37.175635+00:00
TT00: Gap Manager exiting (PID:5410)
2017-08-08T17:41:37.952286+00:00
OS process OFSD (ospid 5337) idle for 30 seconds, exiting
2017-08-08T17:41:38.175770+00:00
Archiving is disabled
2017-08-08T17:41:38.176230+00:00
Thread 1 closed at log sequence 3
Successful close of redo thread 1
2017-08-08T17:41:38.268584+00:00
Completed: ALTER DATABASE CLOSE NORMAL
ALTER DATABASE DISMOUNT
Shutting down archive processes
Archiving is disabled
Completed: ALTER DATABASE DISMOUNT
2017-08-08T17:41:39.412470+00:00
ARCH: Archival disabled due to shutdown: 1090
Shutting down archive processes
Archiving is disabled
2017-08-08T17:41:40.417565+00:00
JIT: pid 5408 requesting stop
2017-08-08T17:41:41.417556+00:00
ARCH: Archival disabled due to shutdown: 1090
Shutting down archive processes
Archiving is disabled
JIT: pid 5408 requesting stop
2017-08-08T17:41:41.436309+00:00
Stopping background process VKTM
2017-08-08T17:41:47.017665+00:00
Instance shutdown complete (OS id: 5408)
2020-04-27T13:46:53.926219+00:00
Adjusting the default value of parameter parallel_max_servers
from 320 to 211 due to the value of parameter processes (300)
Starting ORACLE instance (normal) (OS id: 48)
2020-04-27T13:46:53.940997+00:00
CLI notifier numLatches:13 maxDescs:519
2020-04-27T13:46:53.951709+00:00
**********************************************************************
2020-04-27T13:46:53.951778+00:00
Dump of system resources acquired for SHARED GLOBAL AREA (SGA) 

2020-04-27T13:46:53.951893+00:00
 Domain name: docker/70987400d103802f2942a16849f822ca921042246e2a570df8bc19a74ce
d4625
2020-04-27T13:46:53.951958+00:00
 Per process system memlock (soft) limit = 64K
2020-04-27T13:46:53.952023+00:00
 Expected per process system memlock (soft) limit to lock
 SHARED GLOBAL AREA (SGA) into memory: 1282M
2020-04-27T13:46:53.952157+00:00
 Available system pagesizes:
  4K, 2048K 
2020-04-27T13:46:53.952281+00:00
 Supported system pagesize(s):
2020-04-27T13:46:53.952357+00:00
  PAGESIZE  AVAILABLE_PAGES  EXPECTED_PAGES  ALLOCATED_PAGES  ERROR(s)
2020-04-27T13:46:53.952433+00:00
        4K       Configured               2          327682        NONE
2020-04-27T13:46:53.952555+00:00
     2048K                0             641               0        NONE
2020-04-27T13:46:53.952657+00:00
RECOMMENDATION:
2020-04-27T13:46:53.952762+00:00
 1. For optimal performance, configure system with expected number 
 of pages for every supported system pagesize prior to the next 
 instance restart operation.
2020-04-27T13:46:53.955464+00:00
 2. Increase per process memlock (soft) limit to at least 1282MB
 to lock 100% of SHARED GLOBAL AREA (SGA) pages into physical memory
2020-04-27T13:46:53.955639+00:00
**********************************************************************
2020-04-27T13:46:53.979698+00:00
Errors in file /u01/app/oracle/diag/rdbms/orclcdb/ORCLCDB/trace/ORCLCDB_ora_48.t
rc:
ORA-27167: Attempt to determine if Oracle binary image is stored on remote serve
r failed
ORA-27300: OS system dependent operation:parse_df failed with status: 2
ORA-27301: OS failure message: No such file or directory
ORA-27302: failure occurred at: parse failed
ORA-27303: additional information: Filesystem     1K-blocks      Used Available 
Use% Mounted on
overlay        393032580 226114868 146883052  61% /
Image consistency checking encountered an error, checking disabled
LICENSE_MAX_SESSION = 0
LICENSE_SESSIONS_WARNING = 0
Initial number of CPU is 8
Number of processor cores in the system is 4
Number of processor sockets in the system is 1
Using LOG_ARCHIVE_DEST_1 parameter default value as USE_DB_RECOVERY_FILE_DEST
Autotune of undo retention is turned on. 
IMODE=BR
ILAT =51
LICENSE_MAX_USERS = 0
SYS auditing is enabled
NOTE: remote asm mode is local (mode 0x1; from cluster type)
NOTE: Using default ASM root directory ASM
NOTE: Cluster configuration type = NONE [2]
Oracle Database 12c Enterprise Edition Release 12.2.0.1.0 - 64bit Production.
ORACLE_HOME:    /u01/app/oracle/product/12.2.0/dbhome_1
System name:	Linux
Node name:	70987400d103
Release:	5.6.0-1007-oem
Version:	#7-Ubuntu SMP Mon Apr 6 08:54:58 UTC 2020
Machine:	x86_64
Using parameter settings in server-side spfile /u01/app/oracle/product/12.2.0/db
home_1/dbs/spfileORCLCDB.ora
System parameters with non-default values:
  processes                = 300
  shared_pool_size         = 0
  large_pool_size          = 0
  java_pool_size           = 0
  streams_pool_size        = 0
  nls_language             = "AMERICAN"
  nls_territory            = "AMERICA"
  filesystemio_options     = "setall"
  sga_target               = 1280M
  control_files            = "/u02/app/oracle/oradata/ORCLCDB/cntrlORCLCDB.dbf"
  control_files            = "/u03/app/oracle/fast_recovery_area/ORCLCDB/cntrlOR
CLCDB2.dbf"
  db_block_size            = 8192
  compatible               = "12.2.0"
  db_files                 = 250
  db_recovery_file_dest    = "/u03/app/oracle/fast_recovery_area"
  db_recovery_file_dest_size= 17814M
  undo_tablespace          = "UNDOTBS1"
  remote_login_passwordfile= "EXCLUSIVE"
  db_domain                = "localdomain"
  dispatchers              = "(PROTOCOL=TCP) (SERVICE=ORCLCDBXDB)"
  audit_file_dest          = "/u02/app/oracle/audit/ORCLCDB"
  audit_trail              = "DB"
  db_name                  = "ORCLCDB"
  open_cursors             = 300
  pga_aggregate_target     = 768M
  diagnostic_dest          = "/u01/app/oracle"
  enable_pluggable_database= TRUE
NOTE: remote asm mode is local (mode 0x1; from cluster type)
2020-04-27T13:46:54.262990+00:00
============================================================
NOTE: PatchLevel of this instance 0
============================================================
2020-04-27T13:46:56.245175+00:00
Starting background process PMON
2020-04-27T13:46:56.264688+00:00
PMON started with pid=2, OS id=52 
Starting background process CLMN
2020-04-27T13:46:56.278256+00:00
CLMN started with pid=3, OS id=54 
Starting background process PSP0
2020-04-27T13:46:56.289387+00:00
PSP0 started with pid=4, OS id=56 
Starting background process VKTM
2020-04-27T13:46:57.335351+00:00
Error attempting to elevate VKTM's priority: no further priority changes will be
 attempted for this process
VKTM started with pid=5, OS id=58 
2020-04-27T13:46:57.335632+00:00
Starting background process GEN0
VKTM running at (100ms) precision 
2020-04-27T13:46:57.348224+00:00
GEN0 started with pid=6, OS id=62 
Starting background process MMAN
2020-04-27T13:46:57.360321+00:00
MMAN started with pid=7, OS id=64 
Starting background process GEN1
Starting background process DIAG
2020-04-27T13:46:57.392071+00:00
GEN1 started with pid=9, OS id=68_70 
2020-04-27T13:46:57.403900+00:00
DIAG started with pid=11, OS id=72 
Starting background process OFSD
Starting background process DBRM
2020-04-27T13:46:57.423904+00:00
OFSD started with pid=12, OS id=74_76 
2020-04-27T13:46:57.424778+00:00
Oracle running with ofslib:'Oracle File Server Library' version=2
Starting background process VKRM
2020-04-27T13:46:57.436412+00:00
DBRM started with pid=14, OS id=78 
2020-04-27T13:46:57.447939+00:00
VKRM started with pid=15, OS id=80 
Starting background process SVCB
2020-04-27T13:46:57.459808+00:00
SVCB started with pid=16, OS id=82 
Starting background process PMAN
2020-04-27T13:46:57.470758+00:00
PMAN started with pid=17, OS id=84 
Starting background process DIA0
Starting background process DBW0
2020-04-27T13:46:57.482544+00:00
DIA0 started with pid=18, OS id=86 
2020-04-27T13:46:57.498237+00:00
DBW0 started with pid=19, OS id=88 
Starting background process LGWR
Starting background process CKPT
2020-04-27T13:46:57.509130+00:00
LGWR started with pid=20, OS id=90 
2020-04-27T13:46:57.523326+00:00
CKPT started with pid=21, OS id=92 
Starting background process SMON
2020-04-27T13:46:57.536674+00:00
LGWR slave LG00 created with pid=22, OS pid=94
2020-04-27T13:46:57.548662+00:00
SMON started with pid=23, OS id=96 
Starting background process SMCO
LGWR slave LG01 created with pid=24, OS pid=98
2020-04-27T13:46:57.575225+00:00
SMCO started with pid=25, OS id=100 
Starting background process RECO
2020-04-27T13:46:57.591973+00:00
RECO started with pid=26, OS id=102 
Starting background process LREG
2020-04-27T13:46:57.617647+00:00
LREG started with pid=28, OS id=106 
Starting background process PXMN
2020-04-27T13:46:57.642303+00:00
PXMN started with pid=30, OS id=110 
Starting background process FENC
2020-04-27T13:46:57.654249+00:00
FENC started with pid=31, OS id=112 
Starting background process MMON
2020-04-27T13:46:57.667359+00:00
MMON started with pid=32, OS id=114 
Starting background process MMNL
2020-04-27T13:46:57.680456+00:00
MMNL started with pid=31, OS id=116 
2020-04-27T13:46:57.680497+00:00
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL
=TCP))'...
starting up 1 shared server(s) ...
Starting background process TMON
2020-04-27T13:46:57.715681+00:00
TMON started with pid=35, OS id=122 
ORACLE_BASE from environment = /u01/app/oracle
2020-04-27T13:46:57.810798+00:00
ALTER DATABASE   MOUNT
2020-04-27T13:47:00.567124+00:00
Using default pga_aggregate_limit of 2048 MB
2020-04-27T13:47:01.872202+00:00
Network throttle feature is disabled as mount time

2020-04-27T13:47:01.912910+00:00
Successful mount of redo thread 1, with mount id 2809925073
2020-04-27T13:47:01.913872+00:00
Database mounted in Exclusive Mode
Lost write protection disabled
Using STANDBY_ARCHIVE_DEST parameter default value as USE_DB_RECOVERY_FILE_DEST
Completed: ALTER DATABASE   MOUNT
2020-04-27T13:47:02.056163+00:00
ALTER DATABASE OPEN
2020-04-27T13:47:02.066495+00:00
Ping without log force is disabled:
  instance mounted in exclusive mode.
Database SCN compatibility changed from 1 to 3 due to auto-rollover
Endian type of dictionary set to little
2020-04-27T13:47:02.132768+00:00
Errors in file /u01/app/oracle/diag/rdbms/orclcdb/ORCLCDB/trace/ORCLCDB_lgwr_90.
trc:
ORA-00313: open failed for members of log group 1 of thread 1
ORA-00312: online log 1 thread 1: '/u04/app/oracle/redo/redo001.log'
ORA-27047: unable to read the header block of file
Linux-x86_64 Error: 22: Invalid argument
Additional information: 1
2020-04-27T13:47:02.133304+00:00
Errors in file /u01/app/oracle/diag/rdbms/orclcdb/ORCLCDB/trace/ORCLCDB_lgwr_90.
trc:
ORA-00313: open failed for members of log group 1 of thread 1
ORA-00312: online log 1 thread 1: '/u04/app/oracle/redo/redo001.log'
ORA-27047: unable to read the header block of file
Linux-x86_64 Error: 22: Invalid argument
Additional information: 1
2020-04-27T13:47:02.137933+00:00
Errors in file /u01/app/oracle/diag/rdbms/orclcdb/ORCLCDB/trace/ORCLCDB_ora_130.
trc:
ORA-00313: open failed for members of log group 1 of thread 
ORA-00312: online log 1 thread 1: '/u04/app/oracle/redo/redo001.log'
2020-04-27T13:47:02.150067+00:00
TT00: Gap Manager starting (PID:132)
2020-04-27T13:47:02.174229+00:00
USER (ospid: 130): terminating the instance due to error 313
2020-04-27T13:47:02.220695+00:00
System state dump requested by (instance=1, osid=130), summary=[abnormal instanc
e termination].
System State dumped to trace file /u01/app/oracle/diag/rdbms/orclcdb/ORCLCDB/tra
ce/ORCLCDB_diag_72_20200427134702.trc
2020-04-27T13:47:02.319155+00:00
Dumping diagnostic data in directory=[cdmp_20200427134702], requested by (instan
ce=1, osid=130), summary=[abnormal instance termination].
2020-04-27T13:47:03.425577+00:00
Instance terminated by USER, pid = 130

@cristianmiranda
Copy link
Author

[oracle@70987400d103 redo]$ cat /u01/app/oracle/diag/rdbms/orclcdb/ORCLCDB/trace/ORCLCDB_lgwr_90.trc
Trace file /u01/app/oracle/diag/rdbms/orclcdb/ORCLCDB/trace/ORCLCDB_lgwr_90.trc
Oracle Database 12c Enterprise Edition Release 12.2.0.1.0 - 64bit Production
Build label:    RDBMS_12.2.0.1.0_LINUX.X64_170125
ORACLE_HOME:    /u01/app/oracle/product/12.2.0/dbhome_1
System name:	Linux
Node name:	70987400d103
Release:	5.6.0-1007-oem
Version:	#7-Ubuntu SMP Mon Apr 6 08:54:58 UTC 2020
Machine:	x86_64
Instance name: ORCLCDB
Redo thread mounted by this instance: 0 <none>
Oracle process number: 20
Unix process pid: 90, image: oracle@70987400d103 (LGWR)


*** 2020-04-27T13:46:57.562638+00:00 (CDB$ROOT(1))
*** SESSION ID:(239.51864) 2020-04-27T13:46:57.562690+00:00
*** CLIENT ID:() 2020-04-27T13:46:57.562700+00:00
*** SERVICE NAME:() 2020-04-27T13:46:57.562710+00:00
*** MODULE NAME:() 2020-04-27T13:46:57.562718+00:00
*** ACTION NAME:() 2020-04-27T13:46:57.562727+00:00
*** CLIENT DRIVER:() 2020-04-27T13:46:57.562735+00:00
*** CONTAINER ID:(1) 2020-04-27T13:46:57.562745+00:00
 
Created 2 redo writer workers (2 groups of 1 each)

*** 2020-04-27T13:47:02.130753+00:00
DDE rules only execution for: ORA 312
----- START Event Driven Actions Dump ----
---- END Event Driven Actions Dump ----
----- START DDE Actions Dump -----
Executing SYNC actions
----- START DDE Action: 'DB_STRUCTURE_INTEGRITY_CHECK' (Async) -----
Successfully dispatched
----- END DDE Action: 'DB_STRUCTURE_INTEGRITY_CHECK' (SUCCESS, 1 csec) -----
Executing ASYNC actions
----- END DDE Actions Dump (total 1 csec) -----
DDE rules only execution for: ORA 313
----- START Event Driven Actions Dump ----
---- END Event Driven Actions Dump ----
----- START DDE Actions Dump -----
Executing SYNC actions
----- START DDE Action: 'DB_STRUCTURE_INTEGRITY_CHECK' (Async) -----
DDE Action 'DB_STRUCTURE_INTEGRITY_CHECK' was flood controlled
----- END DDE Action: 'DB_STRUCTURE_INTEGRITY_CHECK' (FLOOD CONTROLLED, 0 csec) -----
Executing ASYNC actions
----- END DDE Actions Dump (total 0 csec) -----
ORA-00313: open failed for members of log group 1 of thread 1
ORA-00312: online log 1 thread 1: '/u04/app/oracle/redo/redo001.log'
ORA-27047: unable to read the header block of file
Linux-x86_64 Error: 22: Invalid argument
Additional information: 1
ORA-00313: open failed for members of log group 1 of thread 1
ORA-00312: online log 1 thread 1: '/u04/app/oracle/redo/redo001.log'
ORA-27047: unable to read the header block of file
Linux-x86_64 Error: 22: Invalid argument
Additional information: 1

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment