Solved: Solman 7.1 SPS 10 Upgrade using SUM tool hangs

Dear Experts.

After installation of SAP Solution Manager 7.1, i am upgrading SPS 10 using SUM tool. The Upgrade is running too long in the phase: MAIN_SHDIMP/SUBMOD_SHDIMP/SHADOW_IMPORT_INC. It is running since more than 18 hrs.

Gurus Please Help.

Thanks & Regards

Mohd Basis

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Accepted Solutions (1)

Hello

Are the logs getting updated ?

Check for the upgrade logs at /<upgrade_directory>/abap/tmp and /<upgrade_directory>/abap/log directories.

Regards

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Thanks a lot Experts for your prompt replies.

As per SAP Note:1738989, i have added the parameter _use_zero_copy_io=false in init<sid>.ora file and restarted the SUM, now i can see logs in /<upgrade_directory>/abap/tmp and /<upgrade_directory>/abap/log directories being generated and as wel as oraarch logs also generated. Last log was at 02:58 PP - IST after that no logs. I have also check for alert.log file under \saptrace directory but couldn't see any alert.log file (under \usertrace and \background.

Expert Please Suggest.

Thanks

Mohd Basis

Hey

Replace R3trans, TP with latest version and restart the import it should fix the problem.

Regards

Raj

Dear Raj.

During earlier phases - SUM has prompted to replace the latest R3trans and tp and i have replaced the same with latest one available in SMP and proceeded further till this phase.

Thanks for your suggestion.

Regards

Mohd Basis

have you checked the import progress in the TP logs???

for similar hung situations at different other import levels, below solutions worked.

recheck if it helps for you.

if the below import is not production and you have sufficient backup already in place.

1) check if tp.exe or the related tp process is active at OS.

2) check to see if there are related logs getting created for TP in the /.../.../.../trans/log folders.

3) if they are not getting created.

4) check and kill all the TP process

5) go to ../.../.../trans/log/ rename the old files and

6) restart the import and check to monitor the progress of the import there.

Raj

Hello

Are you really suggesting a solution or replying based on some assumptions ?

Do you how an upgrade is carried out and how it is done ?

Read the replies carefully and reply only if you are sure what the problem is.

do not terminate any TP or R3trans processes when the shadow import is in process.

You need to wait until the phase completes.

Like I said before, check the upgrade logs in the /<upgrade_directory>/abap/tmp and /<upgrade_directory>/abap/log directories.

Regards

Hi Mohd,

Sorry for not explicitely mention the path of alert<sid>.log file.

If you are using oracle 11g which I suppose you are then the path is as follows:

/oracle/<SID>/saptrace/diag/rdbms/<sid>/<SID>/trace/alert_<SID>.log

Please note you should always refer this log file in cases of errors. It will report any issue if present in the database.

Just like Benjamin said do not kill the TP or R3Trans process. They can cause inconsistency in the system.

Did you check the tablespaces and filesystem for space?

Regards

Robin

Dear Robin.

Thanks a lot for your Help.

The tablespace PSAPSR3, PSAPSR3702, PSAPSR3702X, SYSAUX were 95% full, i have extended tablespace and bought to 83%,81%,81%,47% respectively, and have more than 100 GB filesystem space.

Please Suggest.

Thanks

Mohd Basis

Hi Mohd,

Can you let us know the status of your upgrade?
Is it still stuck in shadow import state?

Did you check the alert.<sid>.log ?

If you have found any error in your <Upgrade>/SUM/abap/logs/ files or alert file kindly post the same so that we can get a better idea.

Thanks

Regards,

Robin

Dear Robin.

Still the same phase is running. I have restarted the SUM again from the same phase it is still running in the same phase. Below are the latest contents from alert.log file.

Oracle Database 11g Enterprise Edition Release 11.2.0.3.0 - 64bit Production

With the Partitioning, OLAP, Data Mining and Real Application Testing options.

Windows NT Version V6.0 Service Pack 2

CPU : 8 - type 8664, 4 Physical Cores

Process Affinity : 0x0x0000000000000000

Memory (Avail/Total): Ph:14194M/16374M, Ph+PgF:43249M/47879M

Using parameter settings in server-side spfile D:\ORACLE\SOL\11203\DATABASE\SPFILESOL.ORA

System parameters with non-default values:

processes = 190

sessions = 384

shared_pool_size = 1232M

filesystemio_options = "setall"

control_files = "D:\ORACLE\SOL\ORIGLOGA\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\ORIGLOGB\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\SAPDATA1\CNTRL\CNTRLSOL.DBF"

control_file_record_keep_time= 30

db_block_size = 8192

db_cache_size = 1232M

compatible = "11.2.0"

log_archive_dest_1 = "LOCATION=D:\oracle\SOL\oraarch\SOLarch"

log_archive_format = "%t_%s_%r.dbf"

db_recovery_file_dest = "D:\oracle\SOL\oraflash"

db_recovery_file_dest_size= 30000M

log_checkpoints_to_alert = TRUE

replication_dependency_tracking= FALSE

undo_tablespace = "PSAPUNDO"

_in_memory_undo = FALSE

recyclebin = "off"

remote_os_authent = TRUE

remote_login_passwordfile= "EXCLUSIVE"

parallel_execution_message_size= 16384

_table_lookup_prefetch_size= 0

audit_file_dest = "D:\ORACLE\SOL\SAPTRACE\AUDIT"

db_name = "SOL"

open_cursors = 2000

_sort_elimination_cost_ratio= 10

_b_tree_bitmap_plans = FALSE

star_transformation_enabled= "true"

parallel_threads_per_cpu = 1

query_rewrite_enabled = "false"

_index_join_enabled = FALSE

_optim_peek_user_binds = FALSE

pga_aggregate_target = 600M

_optimizer_mjc_enabled = FALSE

diagnostic_dest = "D:\ORACLE\SOL\SAPTRACE"

max_dump_file_size = "20000"

Deprecated system parameters with specified values:

remote_os_authent

End of deprecated system parameter listing

Wed Feb 12 13:00:50 2014

PMON started with pid=2, OS id=5884

Wed Feb 12 13:00:50 2014

PSP0 started with pid=3, OS id=5152

Wed Feb 12 13:00:51 2014

VKTM started with pid=4, OS id=5664 at elevated priority

VKTM running at (10)millisec precision with DBRM quantum (100)ms

Wed Feb 12 13:00:51 2014

GEN0 started with pid=5, OS id=5140

Wed Feb 12 13:00:51 2014

DIAG started with pid=6, OS id=5988

Wed Feb 12 13:00:51 2014

DBRM started with pid=7, OS id=4176

Wed Feb 12 13:00:51 2014

DIA0 started with pid=8, OS id=3708

Wed Feb 12 13:00:51 2014

MMAN started with pid=9, OS id=5892

Wed Feb 12 13:00:51 2014

DBW0 started with pid=10, OS id=3616

Wed Feb 12 13:00:51 2014

LGWR started with pid=11, OS id=3636

Wed Feb 12 13:00:51 2014

CKPT started with pid=12, OS id=3608

Wed Feb 12 13:00:51 2014

SMON started with pid=13, OS id=3572

Wed Feb 12 13:00:51 2014

RECO started with pid=14, OS id=3508

Wed Feb 12 13:00:51 2014

MMON started with pid=15, OS id=3580

Wed Feb 12 13:00:51 2014

MMNL started with pid=16, OS id=3604

ORACLE_BASE from environment = D:\oracle

Wed Feb 12 13:00:51 2014

ALTER DATABASE MOUNT

Successful mount of redo thread 1, with mount id 1427385475

Database mounted in Exclusive Mode

Lost write protection disabled

Completed: ALTER DATABASE MOUNT

Wed Feb 12 13:00:56 2014

ALTER DATABASE OPEN

LGWR: STARTING ARCH PROCESSES

Wed Feb 12 13:00:56 2014

ARC0 started with pid=18, OS id=1844

ARC0: Archival started

LGWR: STARTING ARCH PROCESSES COMPLETE

ARC0: STARTING ARCH PROCESSES

Wed Feb 12 13:00:57 2014

ARC1 started with pid=19, OS id=3584

Wed Feb 12 13:00:57 2014

ARC2 started with pid=20, OS id=2480

Wed Feb 12 13:00:57 2014

ARC3 started with pid=21, OS id=4024

ARC1: Archival started

ARC2: Archival started

ARC2: Becoming the 'no FAL' ARCH

ARC2: Becoming the 'no SRL' ARCH

ARC1: Becoming the heartbeat ARCH

Thread 1 opened at log sequence 703

Current log# 3 seq# 703 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 703 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Successful open of redo thread 1

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

SMON: enabling cache recovery

Incremental checkpoint up to RBA [0x2bf.1db.0], current log tail at RBA [0x2bf.1db.0]

[4908] Successfully onlined Undo Tablespace 2.

Undo initialization finished serial:0 start:998421 end:998671 diff:250 (2 seconds)

Verifying file header compatibility for 11g tablespace encryption..

Verifying 11g file header compatibility for tablespace encryption completed

SMON: enabling tx recovery

Database Characterset is UTF8

No Resource Manager plan active

Starting background process QMNC

Wed Feb 12 13:00:59 2014

QMNC started with pid=22, OS id=4028

ARC3: Archival started

ARC0: STARTING ARCH PROCESSES COMPLETE

Completed: ALTER DATABASE OPEN

Wed Feb 12 13:01:01 2014

db_recovery_file_dest_size of 30000 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.

Wed Feb 12 13:02:03 2014

Starting ORACLE instance (normal)

Wed Feb 12 13:02:38 2014

Starting background process SMCO

Wed Feb 12 13:02:38 2014

SMCO started with pid=45, OS id=6884

Wed Feb 12 13:03:43 2014

Time drift detected. Please check VKTM trace file for more details.

Wed Feb 12 13:08:33 2014

Shared IO Pool defaulting to 288MB. Trying to get it from Buffer Cache for process 7740.

Wed Feb 12 13:10:04 2014

Beginning log switch checkpoint up to RBA [0x2c0.2.10], SCN: 20907500

Thread 1 advanced to log sequence 704 (LGWR switch)

Current log# 4 seq# 704 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 704 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Wed Feb 12 13:10:07 2014

Archived Log entry 497 added for thread 1 sequence 703 ID 0x550c5329 dest 1:

Wed Feb 12 13:15:07 2014

Completed checkpoint up to RBA [0x2c0.2.10], SCN: 20907500

Wed Feb 12 13:31:00 2014

Incremental checkpoint up to RBA [0x2c0.1b025.0], current log tail at RBA [0x2c0.1be18.0]

Wed Feb 12 14:01:03 2014

Incremental checkpoint up to RBA [0x2c0.1c7fa.0], current log tail at RBA [0x2c0.1c9b5.0]

Wed Feb 12 14:05:07 2014

Time drift detected. Please check VKTM trace file for more details.

Wed Feb 12 14:21:35 2014

Shutting down instance (immediate)

Stopping background process SMCO

Shutting down instance: further logons disabled

Stopping background process QMNC

Stopping background process MMNL

Stopping background process MMON

License high water mark = 34

ALTER DATABASE CLOSE NORMAL

Wed Feb 12 14:21:44 2014

SMON: disabling tx recovery

SMON: disabling cache recovery

Wed Feb 12 14:21:44 2014

Shutting down archive processes

Archiving is disabled

Wed Feb 12 14:21:44 2014

ARCH shutting down

Wed Feb 12 14:21:44 2014

ARCH shutting down

ARC3: Archival stopped

ARC2: Archival stopped

Wed Feb 12 14:21:44 2014

ARCH shutting down

ARC0: Archival stopped

Wed Feb 12 14:21:44 2014

ARCH shutting down

ARC1: Archival stopped

Thread 1 closed at log sequence 704

Successful close of redo thread 1

Wed Feb 12 14:21:48 2014

Completed: ALTER DATABASE CLOSE NORMAL

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

ARCH: Archival disabled due to shutdown: 1089

Wed Feb 12 14:21:49 2014

Stopping background process VKTM

Shutting down archive processes

Archiving is disabled

Wed Feb 12 14:21:51 2014

Instance shutdown complete

Wed Feb 12 14:23:06 2014

Starting ORACLE instance (normal)

LICENSE_MAX_SESSION = 0

LICENSE_SESSIONS_WARNING = 0

Picked latch-free SCN scheme 3

Autotune of undo retention is turned on.

LICENSE_MAX_USERS = 0

SYS auditing is disabled

Starting up:

Oracle Database 11g Enterprise Edition Release 11.2.0.3.0 - 64bit Production

With the Partitioning, OLAP, Data Mining and Real Application Testing options.

Windows NT Version V6.0 Service Pack 2

CPU : 8 - type 8664, 4 Physical Cores

Process Affinity : 0x0x0000000000000000

Memory (Avail/Total): Ph:12268M/16374M, Ph+PgF:22750M/47879M

Using parameter settings in server-side spfile D:\ORACLE\SOL\11203\DATABASE\SPFILESOL.ORA

System parameters with non-default values:

processes = 190

sessions = 384

shared_pool_size = 1232M

filesystemio_options = "setall"

control_files = "D:\ORACLE\SOL\ORIGLOGA\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\ORIGLOGB\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\SAPDATA1\CNTRL\CNTRLSOL.DBF"

control_file_record_keep_time= 30

db_block_size = 8192

db_cache_size = 1232M

compatible = "11.2.0"

log_archive_dest_1 = "LOCATION=D:\oracle\SOL\oraarch\SOLarch"

log_archive_format = "%t_%s_%r.dbf"

db_recovery_file_dest = "D:\oracle\SOL\oraflash"

db_recovery_file_dest_size= 30000M

log_checkpoints_to_alert = TRUE

replication_dependency_tracking= FALSE

undo_tablespace = "PSAPUNDO"

_in_memory_undo = FALSE

recyclebin = "off"

remote_os_authent = TRUE

remote_login_passwordfile= "EXCLUSIVE"

parallel_execution_message_size= 16384

_table_lookup_prefetch_size= 0

audit_file_dest = "D:\ORACLE\SOL\SAPTRACE\AUDIT"

db_name = "SOL"

open_cursors = 2000

_sort_elimination_cost_ratio= 10

_b_tree_bitmap_plans = FALSE

star_transformation_enabled= "true"

parallel_threads_per_cpu = 1

query_rewrite_enabled = "false"

_index_join_enabled = FALSE

_optim_peek_user_binds = FALSE

pga_aggregate_target = 600M

_optimizer_mjc_enabled = FALSE

diagnostic_dest = "D:\ORACLE\SOL\SAPTRACE"

max_dump_file_size = "20000"

Deprecated system parameters with specified values:

remote_os_authent

End of deprecated system parameter listing

Wed Feb 12 14:23:06 2014

PMON started with pid=2, OS id=5164

Wed Feb 12 14:23:06 2014

PSP0 started with pid=3, OS id=3656

Wed Feb 12 14:23:07 2014

VKTM started with pid=4, OS id=4136 at elevated priority

VKTM running at (10)millisec precision with DBRM quantum (100)ms

Wed Feb 12 14:23:08 2014

GEN0 started with pid=5, OS id=1864

Wed Feb 12 14:23:08 2014

DIAG started with pid=6, OS id=4172

Wed Feb 12 14:23:08 2014

DBRM started with pid=7, OS id=5976

Wed Feb 12 14:23:08 2014

DIA0 started with pid=8, OS id=7532

Wed Feb 12 14:23:08 2014

MMAN started with pid=9, OS id=4872

Wed Feb 12 14:23:08 2014

DBW0 started with pid=10, OS id=5296

Wed Feb 12 14:23:08 2014

LGWR started with pid=11, OS id=5316

Wed Feb 12 14:23:08 2014

CKPT started with pid=12, OS id=7508

Wed Feb 12 14:23:08 2014

SMON started with pid=14, OS id=6328

Wed Feb 12 14:23:08 2014

RECO started with pid=13, OS id=4028

Wed Feb 12 14:23:08 2014

MMON started with pid=15, OS id=6884

Wed Feb 12 14:23:08 2014

MMNL started with pid=16, OS id=3580

ORACLE_BASE from environment = D:\oracle

Wed Feb 12 14:23:08 2014

ALTER DATABASE MOUNT

Successful mount of redo thread 1, with mount id 1427380428

Database mounted in Exclusive Mode

Lost write protection disabled

Completed: ALTER DATABASE MOUNT

Wed Feb 12 14:23:12 2014

ALTER DATABASE OPEN

LGWR: STARTING ARCH PROCESSES

Wed Feb 12 14:23:12 2014

ARC0 started with pid=18, OS id=7332

ARC0: Archival started

LGWR: STARTING ARCH PROCESSES COMPLETE

ARC0: STARTING ARCH PROCESSES

Wed Feb 12 14:23:13 2014

ARC1 started with pid=19, OS id=4700

Wed Feb 12 14:23:13 2014

ARC2 started with pid=20, OS id=7952

Wed Feb 12 14:23:13 2014

ARC3 started with pid=22, OS id=3908

ARC1: Archival started

ARC2: Archival started

ARC1: Becoming the 'no FAL' ARCH

ARC1: Becoming the 'no SRL' ARCH

ARC2: Becoming the heartbeat ARCH

Thread 1 opened at log sequence 704

Current log# 4 seq# 704 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 704 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Successful open of redo thread 1

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

SMON: enabling cache recovery

Incremental checkpoint up to RBA [0x2c0.1d65e.0], current log tail at RBA [0x2c0.1d65e.0]

[7388] Successfully onlined Undo Tablespace 2.

Undo initialization finished serial:0 start:5935136 end:5935494 diff:358 (3 seconds)

Verifying file header compatibility for 11g tablespace encryption..

Verifying 11g file header compatibility for tablespace encryption completed

SMON: enabling tx recovery

Database Characterset is UTF8

No Resource Manager plan active

Starting background process QMNC

Wed Feb 12 14:23:15 2014

QMNC started with pid=21, OS id=7800

ARC3: Archival started

ARC0: STARTING ARCH PROCESSES COMPLETE

Completed: ALTER DATABASE OPEN

Wed Feb 12 14:23:18 2014

db_recovery_file_dest_size of 30000 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.

Wed Feb 12 14:25:20 2014

Shutting down instance (immediate)

Shutting down instance: further logons disabled

Stopping background process QMNC

Stopping background process MMNL

Stopping background process MMON

License high water mark = 3

ALTER DATABASE CLOSE NORMAL

Wed Feb 12 14:25:23 2014

SMON: disabling tx recovery

SMON: disabling cache recovery

Wed Feb 12 14:25:24 2014

Shutting down archive processes

Archiving is disabled

Wed Feb 12 14:25:24 2014

ARCH shutting down

Wed Feb 12 14:25:24 2014

ARCH shutting down

ARC2: Archival stopped

ARC0: Archival stopped

Wed Feb 12 14:25:24 2014

ARCH shutting down

ARC1: Archival stopped

Wed Feb 12 14:25:24 2014

ARCH shutting down

ARC3: Archival stopped

Thread 1 closed at log sequence 704

Successful close of redo thread 1

Completed: ALTER DATABASE CLOSE NORMAL

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

ARCH: Archival disabled due to shutdown: 1089

Shutting down archive processes

Archiving is disabled

Wed Feb 12 14:25:28 2014

Stopping background process VKTM

Wed Feb 12 14:25:31 2014

Instance shutdown complete

Wed Feb 12 14:26:36 2014

Starting ORACLE instance (normal)

LICENSE_MAX_SESSION = 0

LICENSE_SESSIONS_WARNING = 0

Picked latch-free SCN scheme 3

Autotune of undo retention is turned on.

LICENSE_MAX_USERS = 0

SYS auditing is disabled

Starting up:

Oracle Database 11g Enterprise Edition Release 11.2.0.3.0 - 64bit Production

With the Partitioning, OLAP, Data Mining and Real Application Testing options.

Windows NT Version V6.0 Service Pack 2

CPU : 8 - type 8664, 4 Physical Cores

Process Affinity : 0x0x0000000000000000

Memory (Avail/Total): Ph:13809M/16374M, Ph+PgF:43181M/47879M

Using parameter settings in server-side spfile D:\ORACLE\SOL\11203\DATABASE\SPFILESOL.ORA

System parameters with non-default values:

processes = 190

sessions = 384

shared_pool_size = 1232M

filesystemio_options = "setall"

control_files = "D:\ORACLE\SOL\ORIGLOGA\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\ORIGLOGB\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\SAPDATA1\CNTRL\CNTRLSOL.DBF"

control_file_record_keep_time= 30

db_block_size = 8192

db_cache_size = 1232M

compatible = "11.2.0"

log_archive_dest_1 = "LOCATION=D:\oracle\SOL\oraarch\SOLarch"

log_archive_format = "%t_%s_%r.dbf"

db_recovery_file_dest = "D:\oracle\SOL\oraflash"

db_recovery_file_dest_size= 30000M

log_checkpoints_to_alert = TRUE

replication_dependency_tracking= FALSE

undo_tablespace = "PSAPUNDO"

_in_memory_undo = FALSE

recyclebin = "off"

remote_os_authent = TRUE

remote_login_passwordfile= "EXCLUSIVE"

parallel_execution_message_size= 16384

_table_lookup_prefetch_size= 0

audit_file_dest = "D:\ORACLE\SOL\SAPTRACE\AUDIT"

db_name = "SOL"

open_cursors = 2000

_sort_elimination_cost_ratio= 10

_b_tree_bitmap_plans = FALSE

star_transformation_enabled= "true"

parallel_threads_per_cpu = 1

query_rewrite_enabled = "false"

_index_join_enabled = FALSE

_optim_peek_user_binds = FALSE

pga_aggregate_target = 600M

_optimizer_mjc_enabled = FALSE

diagnostic_dest = "D:\ORACLE\SOL\SAPTRACE"

max_dump_file_size = "20000"

Deprecated system parameters with specified values:

remote_os_authent

End of deprecated system parameter listing

Wed Feb 12 14:26:37 2014

PMON started with pid=2, OS id=3604

Wed Feb 12 14:26:37 2014

PSP0 started with pid=3, OS id=8000

Wed Feb 12 14:26:38 2014

VKTM started with pid=4, OS id=3752 at elevated priority

VKTM running at (10)millisec precision with DBRM quantum (100)ms

Wed Feb 12 14:26:38 2014

GEN0 started with pid=5, OS id=6068

Wed Feb 12 14:26:38 2014

DIAG started with pid=6, OS id=3900

Wed Feb 12 14:26:38 2014

DBRM started with pid=7, OS id=932

Wed Feb 12 14:26:38 2014

DIA0 started with pid=8, OS id=1676

Wed Feb 12 14:26:38 2014

MMAN started with pid=9, OS id=1856

Wed Feb 12 14:26:38 2014

DBW0 started with pid=10, OS id=1860

Wed Feb 12 14:26:38 2014

LGWR started with pid=11, OS id=6012

Wed Feb 12 14:26:38 2014

CKPT started with pid=12, OS id=5424

Wed Feb 12 14:26:38 2014

SMON started with pid=13, OS id=4308

Wed Feb 12 14:26:38 2014

RECO started with pid=14, OS id=6156

Wed Feb 12 14:26:38 2014

MMON started with pid=15, OS id=3712

Wed Feb 12 14:26:38 2014

MMNL started with pid=16, OS id=6148

ORACLE_BASE from environment = D:\oracle

Wed Feb 12 14:26:38 2014

ALTER DATABASE MOUNT

Successful mount of redo thread 1, with mount id 1427351198

Database mounted in Exclusive Mode

Lost write protection disabled

Completed: ALTER DATABASE MOUNT

Wed Feb 12 14:26:42 2014

ALTER DATABASE OPEN

LGWR: STARTING ARCH PROCESSES

Wed Feb 12 14:26:42 2014

ARC0 started with pid=18, OS id=6000

ARC0: Archival started

LGWR: STARTING ARCH PROCESSES COMPLETE

ARC0: STARTING ARCH PROCESSES

Thread 1 opened at log sequence 704

Current log# 4 seq# 704 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 704 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Successful open of redo thread 1

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

SMON: enabling cache recovery

Wed Feb 12 14:26:45 2014

ARC1 started with pid=19, OS id=6956

Wed Feb 12 14:26:45 2014

ARC2 started with pid=20, OS id=7812

Wed Feb 12 14:26:45 2014

ARC3 started with pid=21, OS id=5288

ARC1: Archival started

ARC2: Archival started

ARC2: Becoming the 'no FAL' ARCH

ARC2: Becoming the 'no SRL' ARCH

ARC1: Becoming the heartbeat ARCH

[6912] Successfully onlined Undo Tablespace 2.

Undo initialization finished serial:0 start:6146080 end:6146376 diff:296 (2 seconds)

Verifying file header compatibility for 11g tablespace encryption..

Verifying 11g file header compatibility for tablespace encryption completed

SMON: enabling tx recovery

Database Characterset is UTF8

No Resource Manager plan active

Starting background process QMNC

Wed Feb 12 14:26:46 2014

QMNC started with pid=22, OS id=5784

ARC3: Archival started

ARC0: STARTING ARCH PROCESSES COMPLETE

Completed: ALTER DATABASE OPEN

Incremental checkpoint up to RBA [0x2c0.1d847.0], current log tail at RBA [0x2c0.1d89d.0]

Wed Feb 12 14:26:48 2014

db_recovery_file_dest_size of 30000 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.

Wed Feb 12 14:30:24 2014

Shutting down instance (immediate)

Shutting down instance: further logons disabled

Stopping background process QMNC

Stopping background process MMNL

Stopping background process MMON

License high water mark = 1

ALTER DATABASE CLOSE NORMAL

Wed Feb 12 14:30:28 2014

SMON: disabling tx recovery

SMON: disabling cache recovery

Wed Feb 12 14:30:28 2014

Shutting down archive processes

Archiving is disabled

Wed Feb 12 14:30:28 2014

ARCH shutting down

Wed Feb 12 14:30:28 2014

ARCH shutting down

Wed Feb 12 14:30:28 2014

ARCH shutting down

ARC2: Archival stopped

ARC0: Archival stopped

ARC1: Archival stopped

Wed Feb 12 14:30:28 2014

ARCH shutting down

ARC3: Archival stopped

Thread 1 closed at log sequence 704

Successful close of redo thread 1

Completed: ALTER DATABASE CLOSE NORMAL

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

ARCH: Archival disabled due to shutdown: 1089

Shutting down archive processes

Archiving is disabled

Wed Feb 12 14:30:31 2014

Stopping background process VKTM

Wed Feb 12 14:30:34 2014

Instance shutdown complete

Wed Feb 12 14:32:48 2014

Starting ORACLE instance (normal)

LICENSE_MAX_SESSION = 0

LICENSE_SESSIONS_WARNING = 0

Picked latch-free SCN scheme 3

Autotune of undo retention is turned on.

LICENSE_MAX_USERS = 0

SYS auditing is disabled

Starting up:

Oracle Database 11g Enterprise Edition Release 11.2.0.3.0 - 64bit Production

With the Partitioning, OLAP, Data Mining and Real Application Testing options.

Windows NT Version V6.0 Service Pack 2

CPU : 8 - type 8664, 4 Physical Cores

Process Affinity : 0x0x0000000000000000

Memory (Avail/Total): Ph:14153M/16374M, Ph+PgF:43542M/47879M

Using parameter settings in server-side spfile D:\ORACLE\SOL\11203\DATABASE\SPFILESOL.ORA

System parameters with non-default values:

processes = 190

sessions = 384

shared_pool_size = 1232M

filesystemio_options = "setall"

control_files = "D:\ORACLE\SOL\ORIGLOGA\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\ORIGLOGB\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\SAPDATA1\CNTRL\CNTRLSOL.DBF"

control_file_record_keep_time= 30

db_block_size = 8192

db_cache_size = 1232M

compatible = "11.2.0"

log_archive_dest_1 = "LOCATION=D:\oracle\SOL\oraarch\SOLarch"

log_archive_format = "%t_%s_%r.dbf"

db_recovery_file_dest = "D:\oracle\SOL\oraflash"

db_recovery_file_dest_size= 30000M

log_checkpoints_to_alert = TRUE

replication_dependency_tracking= FALSE

undo_tablespace = "PSAPUNDO"

_in_memory_undo = FALSE

recyclebin = "off"

remote_os_authent = TRUE

remote_login_passwordfile= "EXCLUSIVE"

parallel_execution_message_size= 16384

_table_lookup_prefetch_size= 0

audit_file_dest = "D:\ORACLE\SOL\SAPTRACE\AUDIT"

db_name = "SOL"

open_cursors = 2000

_sort_elimination_cost_ratio= 10

_b_tree_bitmap_plans = FALSE

star_transformation_enabled= "true"

parallel_threads_per_cpu = 1

query_rewrite_enabled = "false"

_index_join_enabled = FALSE

_optim_peek_user_binds = FALSE

pga_aggregate_target = 600M

_optimizer_mjc_enabled = FALSE

diagnostic_dest = "D:\ORACLE\SOL\SAPTRACE"

max_dump_file_size = "20000"

Deprecated system parameters with specified values:

remote_os_authent

End of deprecated system parameter listing

Wed Feb 12 14:32:49 2014

PMON started with pid=2, OS id=7844

Wed Feb 12 14:32:49 2014

PSP0 started with pid=3, OS id=6808

Wed Feb 12 14:32:50 2014

VKTM started with pid=4, OS id=6584 at elevated priority

VKTM running at (10)millisec precision with DBRM quantum (100)ms

Wed Feb 12 14:32:50 2014

GEN0 started with pid=5, OS id=6624

Wed Feb 12 14:32:50 2014

DIAG started with pid=6, OS id=3912

Wed Feb 12 14:32:50 2014

DBRM started with pid=7, OS id=6508

Wed Feb 12 14:32:50 2014

DIA0 started with pid=8, OS id=7640

Wed Feb 12 14:32:50 2014

MMAN started with pid=9, OS id=7060

Wed Feb 12 14:32:50 2014

DBW0 started with pid=10, OS id=6544

Wed Feb 12 14:32:50 2014

LGWR started with pid=11, OS id=6908

Wed Feb 12 14:32:50 2014

CKPT started with pid=12, OS id=6968

Wed Feb 12 14:32:50 2014

SMON started with pid=13, OS id=6860

Wed Feb 12 14:32:50 2014

RECO started with pid=14, OS id=6232

Wed Feb 12 14:32:50 2014

MMON started with pid=15, OS id=8184

Wed Feb 12 14:32:50 2014

MMNL started with pid=16, OS id=6532

ORACLE_BASE from environment = D:\oracle

Wed Feb 12 14:32:50 2014

ALTER DATABASE MOUNT

Successful mount of redo thread 1, with mount id 1427403282

Database mounted in Exclusive Mode

Lost write protection disabled

Completed: ALTER DATABASE MOUNT

Wed Feb 12 14:32:54 2014

ALTER DATABASE OPEN

LGWR: STARTING ARCH PROCESSES

Wed Feb 12 14:32:54 2014

ARC0 started with pid=18, OS id=5388

ARC0: Archival started

LGWR: STARTING ARCH PROCESSES COMPLETE

ARC0: STARTING ARCH PROCESSES

Thread 1 opened at log sequence 704

Current log# 4 seq# 704 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 704 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Successful open of redo thread 1

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

Wed Feb 12 14:32:56 2014

ARC1 started with pid=19, OS id=7628

Wed Feb 12 14:32:56 2014

ARC2 started with pid=20, OS id=8188

SMON: enabling cache recovery

Wed Feb 12 14:32:56 2014

ARC3 started with pid=21, OS id=7880

ARC1: Archival started

ARC2: Archival started

ARC2: Becoming the 'no FAL' ARCH

ARC2: Becoming the 'no SRL' ARCH

ARC1: Becoming the heartbeat ARCH

[8132] Successfully onlined Undo Tablespace 2.

Undo initialization finished serial:0 start:6517971 end:6518236 diff:265 (2 seconds)

Verifying file header compatibility for 11g tablespace encryption..

Verifying 11g file header compatibility for tablespace encryption completed

SMON: enabling tx recovery

Database Characterset is UTF8

No Resource Manager plan active

Starting background process QMNC

Wed Feb 12 14:32:58 2014

QMNC started with pid=22, OS id=7888

ARC3: Archival started

ARC0: STARTING ARCH PROCESSES COMPLETE

Completed: ALTER DATABASE OPEN

Incremental checkpoint up to RBA [0x2c0.1d9e5.0], current log tail at RBA [0x2c0.1da3a.0]

Wed Feb 12 14:33:00 2014

db_recovery_file_dest_size of 30000 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.

Wed Feb 12 14:34:27 2014

Starting ORACLE instance (normal)

Wed Feb 12 14:34:58 2014

Starting background process SMCO

Wed Feb 12 14:34:58 2014

SMCO started with pid=45, OS id=5992

Wed Feb 12 14:41:51 2014

Beginning log switch checkpoint up to RBA [0x2c1.2.10], SCN: 21025267

Thread 1 advanced to log sequence 705 (LGWR switch)

Current log# 1 seq# 705 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 705 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Wed Feb 12 14:41:54 2014

Archived Log entry 498 added for thread 1 sequence 704 ID 0x550c5329 dest 1:

Wed Feb 12 14:43:42 2014

Beginning log switch checkpoint up to RBA [0x2c2.2.10], SCN: 21140960

Thread 1 advanced to log sequence 706 (LGWR switch)

Current log# 2 seq# 706 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 706 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Wed Feb 12 14:43:45 2014

Archived Log entry 499 added for thread 1 sequence 705 ID 0x550c5329 dest 1:

Wed Feb 12 14:44:05 2014

Shared IO Pool defaulting to 288MB. Trying to get it from Buffer Cache for process 8204.

Wed Feb 12 14:45:45 2014

Beginning log switch checkpoint up to RBA [0x2c3.2.10], SCN: 21219920

Thread 1 advanced to log sequence 707 (LGWR switch)

Current log# 3 seq# 707 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 707 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Wed Feb 12 14:45:48 2014

Archived Log entry 500 added for thread 1 sequence 706 ID 0x550c5329 dest 1:

Wed Feb 12 14:46:54 2014

Completed checkpoint up to RBA [0x2c1.2.10], SCN: 21025267

Wed Feb 12 14:47:12 2014

Beginning log switch checkpoint up to RBA [0x2c4.2.10], SCN: 21271395

Thread 1 advanced to log sequence 708 (LGWR switch)

Current log# 4 seq# 708 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 708 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Wed Feb 12 14:47:16 2014

Archived Log entry 501 added for thread 1 sequence 707 ID 0x550c5329 dest 1:

Wed Feb 12 14:48:20 2014

Completed checkpoint up to RBA [0x2c2.2.10], SCN: 21140960

Wed Feb 12 14:48:49 2014

Beginning log switch checkpoint up to RBA [0x2c5.2.10], SCN: 21322089

Thread 1 advanced to log sequence 709 (LGWR switch)

Current log# 1 seq# 709 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 709 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Wed Feb 12 14:48:52 2014

Archived Log entry 502 added for thread 1 sequence 708 ID 0x550c5329 dest 1:

Wed Feb 12 14:50:16 2014

Completed checkpoint up to RBA [0x2c3.2.10], SCN: 21219920

Wed Feb 12 14:50:31 2014

Beginning log switch checkpoint up to RBA [0x2c6.2.10], SCN: 21362722

Thread 1 advanced to log sequence 710 (LGWR switch)

Current log# 2 seq# 710 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 710 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Wed Feb 12 14:50:36 2014

Archived Log entry 503 added for thread 1 sequence 709 ID 0x550c5329 dest 1:

Wed Feb 12 14:51:30 2014

Completed checkpoint up to RBA [0x2c4.2.10], SCN: 21271395

Wed Feb 12 14:51:31 2014

Beginning log switch checkpoint up to RBA [0x2c7.2.10], SCN: 21394766

Thread 1 advanced to log sequence 711 (LGWR switch)

Current log# 3 seq# 711 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 711 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Wed Feb 12 14:51:43 2014

Archived Log entry 504 added for thread 1 sequence 710 ID 0x550c5329 dest 1:

Wed Feb 12 14:51:47 2014

Completed checkpoint up to RBA [0x2c5.2.10], SCN: 21322089

Wed Feb 12 14:51:49 2014

Beginning log switch checkpoint up to RBA [0x2c8.2.10], SCN: 21418425

Thread 1 advanced to log sequence 712 (LGWR switch)

Current log# 4 seq# 712 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 712 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Wed Feb 12 14:52:01 2014

Archived Log entry 505 added for thread 1 sequence 711 ID 0x550c5329 dest 1:

Wed Feb 12 14:52:33 2014

Completed checkpoint up to RBA [0x2c6.2.10], SCN: 21362722

Wed Feb 12 14:52:41 2014

Beginning log switch checkpoint up to RBA [0x2c9.2.10], SCN: 21449671

Thread 1 advanced to log sequence 713 (LGWR switch)

Current log# 1 seq# 713 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 713 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Wed Feb 12 14:52:45 2014

Archived Log entry 506 added for thread 1 sequence 712 ID 0x550c5329 dest 1:

Wed Feb 12 14:53:55 2014

Completed checkpoint up to RBA [0x2c7.2.10], SCN: 21394766

Wed Feb 12 14:54:08 2014

Beginning log switch checkpoint up to RBA [0x2ca.2.10], SCN: 21487439

Thread 1 advanced to log sequence 714 (LGWR switch)

Current log# 2 seq# 714 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 714 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Wed Feb 12 14:54:11 2014

Archived Log entry 507 added for thread 1 sequence 713 ID 0x550c5329 dest 1:

Wed Feb 12 14:55:39 2014

Completed checkpoint up to RBA [0x2c8.2.10], SCN: 21418425

Wed Feb 12 14:55:44 2014

Beginning log switch checkpoint up to RBA [0x2cb.2.10], SCN: 21535899

Thread 1 advanced to log sequence 715 (LGWR switch)

Current log# 3 seq# 715 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 715 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Wed Feb 12 14:55:47 2014

Archived Log entry 508 added for thread 1 sequence 714 ID 0x550c5329 dest 1:

Wed Feb 12 14:57:12 2014

Completed checkpoint up to RBA [0x2c9.2.10], SCN: 21449671

Wed Feb 12 14:57:17 2014

Beginning log switch checkpoint up to RBA [0x2cc.2.10], SCN: 21605103

Thread 1 advanced to log sequence 716 (LGWR switch)

Current log# 4 seq# 716 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 716 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Wed Feb 12 14:57:20 2014

Archived Log entry 509 added for thread 1 sequence 715 ID 0x550c5329 dest 1:

Wed Feb 12 14:58:23 2014

Completed checkpoint up to RBA [0x2ca.2.10], SCN: 21487439

Wed Feb 12 14:58:29 2014

Beginning log switch checkpoint up to RBA [0x2cd.2.10], SCN: 21655138

Thread 1 advanced to log sequence 717 (LGWR switch)

Current log# 1 seq# 717 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 717 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Wed Feb 12 14:58:33 2014

Archived Log entry 510 added for thread 1 sequence 716 ID 0x550c5329 dest 1:

Wed Feb 12 15:00:46 2014

Completed checkpoint up to RBA [0x2cb.2.10], SCN: 21535899

Wed Feb 12 15:02:19 2014

Completed checkpoint up to RBA [0x2cc.2.10], SCN: 21605103

Wed Feb 12 15:03:06 2014

Incremental checkpoint up to RBA [0x2cc.2ea25.0], current log tail at RBA [0x2cd.3d8db.0]

Wed Feb 12 15:03:31 2014

Completed checkpoint up to RBA [0x2cd.2.10], SCN: 21655138

Wed Feb 12 15:33:08 2014

Incremental checkpoint up to RBA [0x2cd.3f797.0], current log tail at RBA [0x2cd.40764.0]

Wed Feb 12 15:43:40 2014

Time drift detected. Please check VKTM trace file for more details.

Wed Feb 12 16:03:09 2014

Incremental checkpoint up to RBA [0x2cd.40ef1.0], current log tail at RBA [0x2cd.4109d.0]

Wed Feb 12 16:33:11 2014

Incremental checkpoint up to RBA [0x2cd.41575.0], current log tail at RBA [0x2cd.4223d.0]

Wed Feb 12 16:50:46 2014

***********************************************************************

Fatal NI connect error 12638, connecting to:

(DESCRIPTION=(LOCAL=YES)(ADDRESS=(PROTOCOL=beq)))

VERSION INFORMATION:

TNS for 64-bit Windows: Version 11.2.0.3.0 - Production

Oracle Bequeath NT Protocol Adapter for 64-bit Windows: Version 11.2.0.3.0 - Production

Time: 12-FEB-2014 16:50:46

Tracing not turned on.

Tns error struct:

ns main err code: 12638

TNS-12638: Credential retrieval failed

ns secondary err code: 0

nt main err code: 0

nt secondary err code: 0

nt OS err code: 0

Wed Feb 12 16:51:03 2014

Time drift detected. Please check VKTM trace file for more details.

Wed Feb 12 17:04:47 2014

Starting ORACLE instance (normal)

LICENSE_MAX_SESSION = 0

LICENSE_SESSIONS_WARNING = 0

Picked latch-free SCN scheme 3

Autotune of undo retention is turned on.

LICENSE_MAX_USERS = 0

SYS auditing is disabled

Starting up:

Oracle Database 11g Enterprise Edition Release 11.2.0.3.0 - 64bit Production

With the Partitioning, OLAP, Data Mining and Real Application Testing options.

Windows NT Version V6.0 Service Pack 2

CPU : 8 - type 8664, 4 Physical Cores

Process Affinity : 0x0x0000000000000000

Memory (Avail/Total): Ph:14230M/16374M, Ph+PgF:43271M/47879M

Using parameter settings in server-side spfile D:\ORACLE\SOL\11203\DATABASE\SPFILESOL.ORA

System parameters with non-default values:

processes = 190

sessions = 384

shared_pool_size = 1232M

filesystemio_options = "setall"

control_files = "D:\ORACLE\SOL\ORIGLOGA\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\ORIGLOGB\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\SAPDATA1\CNTRL\CNTRLSOL.DBF"

control_file_record_keep_time= 30

db_block_size = 8192

db_cache_size = 1232M

compatible = "11.2.0"

log_archive_dest_1 = "LOCATION=D:\oracle\SOL\oraarch\SOLarch"

log_archive_format = "%t_%s_%r.dbf"

db_recovery_file_dest = "D:\oracle\SOL\oraflash"

db_recovery_file_dest_size= 30000M

log_checkpoints_to_alert = TRUE

replication_dependency_tracking= FALSE

undo_tablespace = "PSAPUNDO"

_in_memory_undo = FALSE

recyclebin = "off"

remote_os_authent = TRUE

remote_login_passwordfile= "EXCLUSIVE"

parallel_execution_message_size= 16384

_table_lookup_prefetch_size= 0

audit_file_dest = "D:\ORACLE\SOL\SAPTRACE\AUDIT"

db_name = "SOL"

open_cursors = 2000

_sort_elimination_cost_ratio= 10

_b_tree_bitmap_plans = FALSE

star_transformation_enabled= "true"

parallel_threads_per_cpu = 1

query_rewrite_enabled = "false"

_index_join_enabled = FALSE

_optim_peek_user_binds = FALSE

pga_aggregate_target = 600M

_optimizer_mjc_enabled = FALSE

diagnostic_dest = "D:\ORACLE\SOL\SAPTRACE"

max_dump_file_size = "20000"

Deprecated system parameters with specified values:

remote_os_authent

End of deprecated system parameter listing

Wed Feb 12 17:04:50 2014

PMON started with pid=2, OS id=4856

Wed Feb 12 17:04:50 2014

PSP0 started with pid=3, OS id=3808

Wed Feb 12 17:04:51 2014

VKTM started with pid=4, OS id=5108 at elevated priority

VKTM running at (10)millisec precision with DBRM quantum (100)ms

Wed Feb 12 17:04:51 2014

GEN0 started with pid=5, OS id=2352

Wed Feb 12 17:04:51 2014

DIAG started with pid=6, OS id=1752

Wed Feb 12 17:04:51 2014

DBRM started with pid=7, OS id=1452

Wed Feb 12 17:04:51 2014

DIA0 started with pid=8, OS id=4152

Wed Feb 12 17:04:51 2014

MMAN started with pid=9, OS id=4792

Wed Feb 12 17:04:51 2014

DBW0 started with pid=10, OS id=2348

Wed Feb 12 17:04:51 2014

LGWR started with pid=11, OS id=2420

Wed Feb 12 17:04:51 2014

CKPT started with pid=12, OS id=4468

Wed Feb 12 17:04:51 2014

SMON started with pid=13, OS id=992

Wed Feb 12 17:04:51 2014

RECO started with pid=14, OS id=4736

Wed Feb 12 17:04:51 2014

MMON started with pid=15, OS id=3484

Wed Feb 12 17:04:51 2014

MMNL started with pid=16, OS id=320

ORACLE_BASE from environment = D:\oracle

Wed Feb 12 17:04:52 2014

ALTER DATABASE MOUNT

Successful mount of redo thread 1, with mount id 1427359156

Database mounted in Exclusive Mode

Lost write protection disabled

Completed: ALTER DATABASE MOUNT

Wed Feb 12 17:04:57 2014

ALTER DATABASE OPEN

Beginning crash recovery of 1 threads

parallel recovery started with 7 processes

Started redo scan

Completed redo scan

read 41 KB redo, 10 data blocks need recovery

Started redo application at

Thread 1: logseq 717, block 271821

Recovery of Online Redo Log: Thread 1 Group 1 Seq 717 Reading mem 0

Mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Completed redo application of 0.00MB

Completed crash recovery at

Thread 1: logseq 717, block 271904, scn 21716241

10 data blocks read, 10 data blocks written, 41 redo k-bytes read

LGWR: STARTING ARCH PROCESSES

Wed Feb 12 17:04:58 2014

ARC0 started with pid=25, OS id=1072

ARC0: Archival started

LGWR: STARTING ARCH PROCESSES COMPLETE

ARC0: STARTING ARCH PROCESSES

Wed Feb 12 17:04:59 2014

ARC1 started with pid=26, OS id=5020

Wed Feb 12 17:04:59 2014

ARC2 started with pid=27, OS id=3476

Wed Feb 12 17:04:59 2014

ARC3 started with pid=28, OS id=476

ARC1: Archival started

ARC2: Archival started

ARC2: Becoming the 'no FAL' ARCH

ARC2: Becoming the 'no SRL' ARCH

ARC1: Becoming the heartbeat ARCH

Thread 1 advanced to log sequence 718 (thread open)

Thread 1 opened at log sequence 718

Current log# 2 seq# 718 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 718 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Successful open of redo thread 1

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

SMON: enabling cache recovery

ARC3: Archival started

ARC0: STARTING ARCH PROCESSES COMPLETE

Incremental checkpoint up to RBA [0x2ce.3.0], current log tail at RBA [0x2ce.3.0]

Archived Log entry 511 added for thread 1 sequence 717 ID 0x550c5329 dest 1:

[4520] Successfully onlined Undo Tablespace 2.

Undo initialization finished serial:0 start:739881 end:740536 diff:655 (6 seconds)

Verifying file header compatibility for 11g tablespace encryption..

Verifying 11g file header compatibility for tablespace encryption completed

Wed Feb 12 17:05:02 2014

SMON: enabling tx recovery

Database Characterset is UTF8

No Resource Manager plan active

Starting background process QMNC

Wed Feb 12 17:05:04 2014

QMNC started with pid=29, OS id=832

Completed: ALTER DATABASE OPEN

Wed Feb 12 17:05:07 2014

db_recovery_file_dest_size of 30000 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.

Wed Feb 12 17:08:08 2014

Starting ORACLE instance (normal)

Wed Feb 12 17:08:48 2014

Starting background process SMCO

Wed Feb 12 17:08:48 2014

SMCO started with pid=51, OS id=6584

Wed Feb 12 17:16:06 2014

Shared IO Pool defaulting to 288MB. Trying to get it from Buffer Cache for process 8348.

Wed Feb 12 17:16:49 2014

Beginning log switch checkpoint up to RBA [0x2cf.2.10], SCN: 21804960

Thread 1 advanced to log sequence 719 (LGWR switch)

Current log# 3 seq# 719 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 719 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Wed Feb 12 17:16:53 2014

Archived Log entry 512 added for thread 1 sequence 718 ID 0x550c5329 dest 1:

Wed Feb 12 17:17:49 2014

Beginning log switch checkpoint up to RBA [0x2d0.2.10], SCN: 21835420

Thread 1 advanced to log sequence 720 (LGWR switch)

Current log# 4 seq# 720 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 720 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Wed Feb 12 17:17:53 2014

Archived Log entry 513 added for thread 1 sequence 719 ID 0x550c5329 dest 1:

Wed Feb 12 17:19:01 2014

Beginning log switch checkpoint up to RBA [0x2d1.2.10], SCN: 21878266

Thread 1 advanced to log sequence 721 (LGWR switch)

Current log# 1 seq# 721 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 721 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Wed Feb 12 17:19:04 2014

Archived Log entry 514 added for thread 1 sequence 720 ID 0x550c5329 dest 1:

Wed Feb 12 17:21:05 2014

Completed checkpoint up to RBA [0x2cf.2.10], SCN: 21804960

Wed Feb 12 17:21:16 2014

Beginning log switch checkpoint up to RBA [0x2d2.2.10], SCN: 21938096

Thread 1 advanced to log sequence 722 (LGWR switch)

Current log# 2 seq# 722 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 722 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Wed Feb 12 17:21:20 2014

Archived Log entry 515 added for thread 1 sequence 721 ID 0x550c5329 dest 1:

Wed Feb 12 17:22:53 2014

Completed checkpoint up to RBA [0x2d0.2.10], SCN: 21835420

Wed Feb 12 17:24:05 2014

Completed checkpoint up to RBA [0x2d1.2.10], SCN: 21878266

Wed Feb 12 17:25:28 2014

Beginning log switch checkpoint up to RBA [0x2d3.2.10], SCN: 21995918

Thread 1 advanced to log sequence 723 (LGWR switch)

Current log# 3 seq# 723 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 723 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Wed Feb 12 17:25:32 2014

Archived Log entry 516 added for thread 1 sequence 722 ID 0x550c5329 dest 1:

Wed Feb 12 17:26:20 2014

Completed checkpoint up to RBA [0x2d2.2.10], SCN: 21938096

Wed Feb 12 17:30:32 2014

Completed checkpoint up to RBA [0x2d3.2.10], SCN: 21995918

Wed Feb 12 17:35:04 2014

Incremental checkpoint up to RBA [0x2d3.301fe.0], current log tail at RBA [0x2d3.313cb.0]

Wed Feb 12 17:47:53 2014

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.OLD'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.OLD'

/* BRSPACE */ alter tablespace PSAPSR3 add datafile 'D:\oracle\SOL\sapdata4\sr3_13\sr3.data13' size 3220M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:48:15 2014

Completed: /* BRSPACE */ alter tablespace PSAPSR3 add datafile 'D:\oracle\SOL\sapdata4\sr3_13\sr3.data13' size 3220M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:48:15 2014

Beginning log switch checkpoint up to RBA [0x2d4.2.10], SCN: 22068100

Thread 1 advanced to log sequence 724 (LGWR switch)

Current log# 4 seq# 724 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 724 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Wed Feb 12 17:48:17 2014

Archived Log entry 517 added for thread 1 sequence 723 ID 0x550c5329 dest 1:

Wed Feb 12 17:49:10 2014

/* BRSPACE */ alter tablespace PSAPSR3702 add datafile 'D:\oracle\SOL\sapdata4\sr3702_11\sr3702.data11' size 2580M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:49:27 2014

Completed: /* BRSPACE */ alter tablespace PSAPSR3702 add datafile 'D:\oracle\SOL\sapdata4\sr3702_11\sr3702.data11' size 2580M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:49:27 2014

Beginning log switch checkpoint up to RBA [0x2d5.2.10], SCN: 22069140

Thread 1 advanced to log sequence 725 (LGWR switch)

Current log# 1 seq# 725 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 725 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Wed Feb 12 17:49:27 2014

Archived Log entry 518 added for thread 1 sequence 724 ID 0x550c5329 dest 1:

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Wed Feb 12 17:51:08 2014

/* BRSPACE */ alter tablespace PSAPSR3USR add datafile 'D:\oracle\SOL\sapdata1\sr3usr_2\sr3usr.data2' size 100M autoextend on next 20M maxsize 10000M

Completed: /* BRSPACE */ alter tablespace PSAPSR3USR add datafile 'D:\oracle\SOL\sapdata1\sr3usr_2\sr3usr.data2' size 100M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:51:08 2014

Beginning log switch checkpoint up to RBA [0x2d6.2.10], SCN: 22069477

Thread 1 advanced to log sequence 726 (LGWR switch)

Current log# 2 seq# 726 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 726 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Wed Feb 12 17:51:08 2014

Archived Log entry 519 added for thread 1 sequence 725 ID 0x550c5329 dest 1:

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Wed Feb 12 17:52:06 2014

/* BRSPACE */ alter tablespace SYSAUX add datafile 'D:\oracle\SOL\sapdata1\sysaux_2\sysaux.data2' size 340M autoextend on next 20M maxsize 10000M

Completed: /* BRSPACE */ alter tablespace SYSAUX add datafile 'D:\oracle\SOL\sapdata1\sysaux_2\sysaux.data2' size 340M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:52:08 2014

Thread 1 cannot allocate new log, sequence 727

Checkpoint not complete

Current log# 2 seq# 726 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 726 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Wed Feb 12 17:52:11 2014

Completed checkpoint up to RBA [0x2d4.2.10], SCN: 22068100

Beginning log switch checkpoint up to RBA [0x2d7.2.10], SCN: 22069790

Thread 1 advanced to log sequence 727 (LGWR switch)

Current log# 3 seq# 727 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 727 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Wed Feb 12 17:52:11 2014

Archived Log entry 520 added for thread 1 sequence 726 ID 0x550c5329 dest 1:

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Wed Feb 12 17:53:15 2014

/* BRSPACE */ alter tablespace PSAPSR3 add datafile 'D:\oracle\SOL\sapdata4\sr3_14\sr3.data14' size 1024M autoextend on next 20M maxsize 10000M

Completed: /* BRSPACE */ alter tablespace PSAPSR3 add datafile 'D:\oracle\SOL\sapdata4\sr3_14\sr3.data14' size 1024M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:53:21 2014

Thread 1 cannot allocate new log, sequence 728

Checkpoint not complete

Current log# 3 seq# 727 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 727 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Wed Feb 12 17:53:23 2014

Completed checkpoint up to RBA [0x2d5.2.10], SCN: 22069140

Beginning log switch checkpoint up to RBA [0x2d8.2.10], SCN: 22070114

Thread 1 advanced to log sequence 728 (LGWR switch)

Current log# 4 seq# 728 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 728 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Wed Feb 12 17:53:23 2014

Archived Log entry 521 added for thread 1 sequence 727 ID 0x550c5329 dest 1:

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Wed Feb 12 17:53:59 2014

/* BRSPACE */ alter tablespace PSAPSR3702 add datafile 'D:\oracle\SOL\sapdata4\sr3702_12\sr3702.data12' size 2048M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:54:12 2014

Completed: /* BRSPACE */ alter tablespace PSAPSR3702 add datafile 'D:\oracle\SOL\sapdata4\sr3702_12\sr3702.data12' size 2048M autoextend on next 20M maxsize 10000M

Wed Feb 12 17:54:12 2014

Thread 1 cannot allocate new log, sequence 729

Checkpoint not complete

Current log# 4 seq# 728 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 728 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Wed Feb 12 17:54:14 2014

Completed checkpoint up to RBA [0x2d6.2.10], SCN: 22069477

Beginning log switch checkpoint up to RBA [0x2d9.2.10], SCN: 22070427

Thread 1 advanced to log sequence 729 (LGWR switch)

Current log# 1 seq# 729 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 729 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Wed Feb 12 17:54:14 2014

Archived Log entry 522 added for thread 1 sequence 728 ID 0x550c5329 dest 1:

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Wed Feb 12 17:57:14 2014

Completed checkpoint up to RBA [0x2d7.2.10], SCN: 22069790

Wed Feb 12 17:58:29 2014

Completed checkpoint up to RBA [0x2d8.2.10], SCN: 22070114

Wed Feb 12 17:59:17 2014

Completed checkpoint up to RBA [0x2d9.2.10], SCN: 22070427

Wed Feb 12 18:05:13 2014

Incremental checkpoint up to RBA [0x2d9.436.0], current log tail at RBA [0x2d9.4de.0]

Wed Feb 12 18:16:46 2014

/* BRSPACE */ alter tablespace PSAPSR3 add datafile 'D:\oracle\SOL\sapdata2\sr3_15\sr3.data15' size 500M autoextend on next 20M maxsize 10000M

Completed: /* BRSPACE */ alter tablespace PSAPSR3 add datafile 'D:\oracle\SOL\sapdata2\sr3_15\sr3.data15' size 500M autoextend on next 20M maxsize 10000M

Wed Feb 12 18:16:49 2014

Beginning log switch checkpoint up to RBA [0x2da.2.10], SCN: 22109572

Thread 1 advanced to log sequence 730 (LGWR switch)

Current log# 2 seq# 730 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 730 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Wed Feb 12 18:16:50 2014

Archived Log entry 523 added for thread 1 sequence 729 ID 0x550c5329 dest 1:

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Wed Feb 12 18:17:26 2014

/* BRSPACE */ alter tablespace PSAPSR3 add datafile 'D:\oracle\SOL\sapdata2\sr3_16\sr3.data16' size 1024M autoextend on next 20M maxsize 10000M

Completed: /* BRSPACE */ alter tablespace PSAPSR3 add datafile 'D:\oracle\SOL\sapdata2\sr3_16\sr3.data16' size 1024M autoextend on next 20M maxsize 10000M

Wed Feb 12 18:17:33 2014

Beginning log switch checkpoint up to RBA [0x2db.2.10], SCN: 22109872

Thread 1 advanced to log sequence 731 (LGWR switch)

Current log# 3 seq# 731 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 731 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Wed Feb 12 18:17:33 2014

Archived Log entry 524 added for thread 1 sequence 730 ID 0x550c5329 dest 1:

/* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Completed: /* BRSPACE */ ALTER DATABASE BACKUP CONTROLFILE TO 'D:\oracle\SOL\sapreorg\seneosjz\CNTRLSOL.NEW'

Wed Feb 12 18:21:53 2014

Completed checkpoint up to RBA [0x2da.2.10], SCN: 22109572

Wed Feb 12 18:22:38 2014

Completed checkpoint up to RBA [0x2db.2.10], SCN: 22109872

Wed Feb 12 18:35:15 2014

Incremental checkpoint up to RBA [0x2db.2d12.0], current log tail at RBA [0x2db.46a0.0]

Wed Feb 12 19:05:17 2014

Incremental checkpoint up to RBA [0x2db.4e3b.0], current log tail at RBA [0x2db.4ee9.0]

Wed Feb 12 19:35:19 2014

Incremental checkpoint up to RBA [0x2db.54ad.0], current log tail at RBA [0x2db.624c.0]

Wed Feb 12 20:05:20 2014

Incremental checkpoint up to RBA [0x2db.6885.0], current log tail at RBA [0x2db.6919.0]

Wed Feb 12 20:23:40 2014

Time drift detected. Please check VKTM trace file for more details.

Wed Feb 12 20:35:22 2014

Incremental checkpoint up to RBA [0x2db.7b9e.0], current log tail at RBA [0x2db.7c87.0]

Wed Feb 12 21:05:24 2014

Incremental checkpoint up to RBA [0x2db.830b.0], current log tail at RBA [0x2db.83b7.0]

Wed Feb 12 21:34:58 2014

Starting background process CJQ0

Wed Feb 12 21:34:58 2014

CJQ0 started with pid=52, OS id=9144

Wed Feb 12 21:35:25 2014

Incremental checkpoint up to RBA [0x2db.896e.0], current log tail at RBA [0x2db.97a4.0]

Wed Feb 12 22:00:00 2014

Setting Resource Manager plan SCHEDULER[0x318B]:DEFAULT_MAINTENANCE_PLAN via scheduler window

Setting Resource Manager plan DEFAULT_MAINTENANCE_PLAN via parameter

Wed Feb 12 22:00:00 2014

Starting background process VKRM

Wed Feb 12 22:00:00 2014

VKRM started with pid=23, OS id=8392

Wed Feb 12 22:00:03 2014

Begin automatic SQL Tuning Advisor run for special tuning task "SYS_AUTO_SQL_TUNING_TASK"

Wed Feb 12 22:00:48 2014

DBMS_STATS: GATHER_STATS_JOB encountered errors. Check the trace file.

Errors in file D:\ORACLE\SOL\SAPTRACE\diag\rdbms\sol\sol\trace\sol_j003_7520.trc:

ORA-20011: Approximate NDV failed: ORA-29913: error in executing ODCIEXTTABLEFETCH callout

ORA-29400: data cartridge error

KUP-04027: file name check failed: \\SOLMAN\sapmnt\SOL\SYS\profile\oracle\tnsnames.ora

Wed Feb 12 22:05:27 2014

Incremental checkpoint up to RBA [0x2db.aa80.0], current log tail at RBA [0x2db.20cf5.0]

Wed Feb 12 22:27:10 2014

End automatic SQL Tuning Advisor run for special tuning task "SYS_AUTO_SQL_TUNING_TASK"

Wed Feb 12 22:35:29 2014

Incremental checkpoint up to RBA [0x2db.2ca4d.0], current log tail at RBA [0x2db.2cb59.0]

Wed Feb 12 22:51:59 2014

Time drift detected. Please check VKTM trace file for more details.

Wed Feb 12 23:05:31 2014

Incremental checkpoint up to RBA [0x2db.2f0bf.0], current log tail at RBA [0x2db.2f31c.0]

Wed Feb 12 23:35:33 2014

Incremental checkpoint up to RBA [0x2db.2f90c.0], current log tail at RBA [0x2db.306e2.0]

Thu Feb 13 00:05:34 2014

Incremental checkpoint up to RBA [0x2db.30ed7.0], current log tail at RBA [0x2db.30f87.0]

Thu Feb 13 00:35:36 2014

Incremental checkpoint up to RBA [0x2db.325fc.0], current log tail at RBA [0x2db.32860.0]

Thu Feb 13 00:51:31 2014

Time drift detected. Please check VKTM trace file for more details.

Thu Feb 13 01:05:38 2014

Incremental checkpoint up to RBA [0x2db.32f3c.0], current log tail at RBA [0x2db.3302a.0]

Thu Feb 13 01:24:55 2014

Shutting down instance (immediate)

Stopping background process SMCO

Shutting down instance: further logons disabled

Stopping background process QMNC

Thu Feb 13 01:24:56 2014

Stopping background process CJQ0

Stopping background process MMNL

Stopping background process MMON

License high water mark = 37

ALTER DATABASE CLOSE NORMAL

Thu Feb 13 01:24:59 2014

SMON: disabling tx recovery

SMON: disabling cache recovery

Thu Feb 13 01:24:59 2014

Shutting down archive processes

Archiving is disabled

Thu Feb 13 01:24:59 2014

ARCH shutting down

Thu Feb 13 01:24:59 2014

ARCH shutting down

ARC2: Archival stopped

ARC1: Archival stopped

Thu Feb 13 01:24:59 2014

ARCH shutting down

ARC3: Archival stopped

Thu Feb 13 01:24:59 2014

ARCH shutting down

ARC0: Archival stopped

Thread 1 closed at log sequence 731

Successful close of redo thread 1

Completed: ALTER DATABASE CLOSE NORMAL

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

ARCH: Archival disabled due to shutdown: 1089

Thu Feb 13 01:25:03 2014

Stopping background process VKTM

Shutting down archive processes

Archiving is disabled

Thu Feb 13 01:25:06 2014

Instance shutdown complete

Thu Feb 13 01:59:02 2014

Starting ORACLE instance (normal)

LICENSE_MAX_SESSION = 0

LICENSE_SESSIONS_WARNING = 0

Picked latch-free SCN scheme 3

Autotune of undo retention is turned on.

LICENSE_MAX_USERS = 0

SYS auditing is disabled

Starting up:

Oracle Database 11g Enterprise Edition Release 11.2.0.3.0 - 64bit Production

With the Partitioning, OLAP, Data Mining and Real Application Testing options.

Windows NT Version V6.0 Service Pack 2

CPU : 8 - type 8664, 4 Physical Cores

Process Affinity : 0x0x0000000000000000

Memory (Avail/Total): Ph:14271M/16374M, Ph+PgF:43322M/47879M

Using parameter settings in server-side spfile D:\ORACLE\SOL\11203\DATABASE\SPFILESOL.ORA

System parameters with non-default values:

processes = 190

sessions = 384

shared_pool_size = 1232M

filesystemio_options = "setall"

control_files = "D:\ORACLE\SOL\ORIGLOGA\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\ORIGLOGB\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\SAPDATA1\CNTRL\CNTRLSOL.DBF"

control_file_record_keep_time= 30

db_block_size = 8192

db_cache_size = 1232M

compatible = "11.2.0"

log_archive_dest_1 = "LOCATION=D:\oracle\SOL\oraarch\SOLarch"

log_archive_format = "%t_%s_%r.dbf"

db_recovery_file_dest = "D:\oracle\SOL\oraflash"

db_recovery_file_dest_size= 30000M

log_checkpoints_to_alert = TRUE

replication_dependency_tracking= FALSE

undo_tablespace = "PSAPUNDO"

_in_memory_undo = FALSE

recyclebin = "off"

remote_os_authent = TRUE

remote_login_passwordfile= "EXCLUSIVE"

parallel_execution_message_size= 16384

_table_lookup_prefetch_size= 0

audit_file_dest = "D:\ORACLE\SOL\SAPTRACE\AUDIT"

db_name = "SOL"

open_cursors = 2000

_sort_elimination_cost_ratio= 10

_b_tree_bitmap_plans = FALSE

star_transformation_enabled= "true"

parallel_threads_per_cpu = 1

query_rewrite_enabled = "false"

_index_join_enabled = FALSE

_optim_peek_user_binds = FALSE

pga_aggregate_target = 600M

_optimizer_mjc_enabled = FALSE

diagnostic_dest = "D:\ORACLE\SOL\SAPTRACE"

max_dump_file_size = "20000"

Deprecated system parameters with specified values:

remote_os_authent

End of deprecated system parameter listing

Thu Feb 13 01:59:04 2014

PMON started with pid=2, OS id=3708

Thu Feb 13 01:59:04 2014

PSP0 started with pid=3, OS id=4312

Thu Feb 13 01:59:05 2014

VKTM started with pid=4, OS id=4236 at elevated priority

VKTM running at (10)millisec precision with DBRM quantum (100)ms

Thu Feb 13 01:59:05 2014

GEN0 started with pid=5, OS id=3544

Thu Feb 13 01:59:05 2014

DIAG started with pid=6, OS id=4560

Thu Feb 13 01:59:05 2014

DBRM started with pid=7, OS id=4300

Thu Feb 13 01:59:05 2014

DIA0 started with pid=8, OS id=4764

Thu Feb 13 01:59:05 2014

MMAN started with pid=9, OS id=3900

Thu Feb 13 01:59:05 2014

DBW0 started with pid=10, OS id=324

Thu Feb 13 01:59:05 2014

LGWR started with pid=11, OS id=4432

Thu Feb 13 01:59:05 2014

CKPT started with pid=12, OS id=1836

Thu Feb 13 01:59:05 2014

SMON started with pid=13, OS id=4288

Thu Feb 13 01:59:05 2014

RECO started with pid=14, OS id=4360

Thu Feb 13 01:59:05 2014

MMON started with pid=15, OS id=3888

Thu Feb 13 01:59:05 2014

MMNL started with pid=16, OS id=3584

ORACLE_BASE from environment = D:\oracle

Thu Feb 13 01:59:07 2014

ALTER DATABASE MOUNT

Successful mount of redo thread 1, with mount id 1427368171

Database mounted in Exclusive Mode

Lost write protection disabled

Completed: ALTER DATABASE MOUNT

Thu Feb 13 01:59:11 2014

ALTER DATABASE OPEN

LGWR: STARTING ARCH PROCESSES

Thu Feb 13 01:59:12 2014

ARC0 started with pid=18, OS id=4296

ARC0: Archival started

LGWR: STARTING ARCH PROCESSES COMPLETE

ARC0: STARTING ARCH PROCESSES

Thu Feb 13 01:59:13 2014

ARC1 started with pid=19, OS id=4132

Thu Feb 13 01:59:13 2014

ARC2 started with pid=20, OS id=4860

Thu Feb 13 01:59:13 2014

ARC3 started with pid=21, OS id=1860

ARC1: Archival started

ARC2: Archival started

ARC2: Becoming the 'no FAL' ARCH

ARC2: Becoming the 'no SRL' ARCH

ARC1: Becoming the heartbeat ARCH

Thread 1 opened at log sequence 731

Current log# 3 seq# 731 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G13M1.DBF

Current log# 3 seq# 731 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G13M2.DBF

Successful open of redo thread 1

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

SMON: enabling cache recovery

ARC3: Archival started

ARC0: STARTING ARCH PROCESSES COMPLETE

Incremental checkpoint up to RBA [0x2db.3582a.0], current log tail at RBA [0x2db.3582a.0]

[3484] Successfully onlined Undo Tablespace 2.

Undo initialization finished serial:0 start:1340157 end:1340797 diff:640 (6 seconds)

Verifying file header compatibility for 11g tablespace encryption..

Verifying 11g file header compatibility for tablespace encryption completed

SMON: enabling tx recovery

Database Characterset is UTF8

No Resource Manager plan active

Starting background process QMNC

Thu Feb 13 01:59:16 2014

QMNC started with pid=22, OS id=3936

Completed: ALTER DATABASE OPEN

Thu Feb 13 01:59:19 2014

Starting background process CJQ0

Thu Feb 13 01:59:19 2014

CJQ0 started with pid=24, OS id=3576

Thu Feb 13 01:59:20 2014

db_recovery_file_dest_size of 30000 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.

Setting Resource Manager plan SCHEDULER[0x318B]:DEFAULT_MAINTENANCE_PLAN via scheduler window

Setting Resource Manager plan DEFAULT_MAINTENANCE_PLAN via parameter

Thu Feb 13 01:59:22 2014

Starting background process VKRM

Thu Feb 13 01:59:22 2014

VKRM started with pid=23, OS id=4864

Thu Feb 13 02:00:00 2014

Closing scheduler window

Closing Resource Manager plan via scheduler window

Clearing Resource Manager plan via parameter

Thu Feb 13 02:00:37 2014

Starting ORACLE instance (normal)

Thu Feb 13 02:01:16 2014

Starting background process SMCO

Thu Feb 13 02:01:16 2014

SMCO started with pid=45, OS id=6884

Thu Feb 13 02:09:24 2014

Shared IO Pool defaulting to 288MB. Trying to get it from Buffer Cache for process 8140.

Thu Feb 13 02:10:27 2014

Beginning log switch checkpoint up to RBA [0x2dc.2.10], SCN: 22920232

Thread 1 advanced to log sequence 732 (LGWR switch)

Current log# 4 seq# 732 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G14M1.DBF

Current log# 4 seq# 732 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G14M2.DBF

Thu Feb 13 02:10:31 2014

Archived Log entry 525 added for thread 1 sequence 731 ID 0x550c5329 dest 1:

Thu Feb 13 02:12:15 2014

Beginning log switch checkpoint up to RBA [0x2dd.2.10], SCN: 22969743

Thread 1 advanced to log sequence 733 (LGWR switch)

Current log# 1 seq# 733 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 733 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Thu Feb 13 02:12:18 2014

Archived Log entry 526 added for thread 1 sequence 732 ID 0x550c5329 dest 1:

Thu Feb 13 02:15:30 2014

Completed checkpoint up to RBA [0x2dc.2.10], SCN: 22920232

Thu Feb 13 02:17:15 2014

Completed checkpoint up to RBA [0x2dd.2.10], SCN: 22969743

Thu Feb 13 02:29:18 2014

Incremental checkpoint up to RBA [0x2dd.25908.0], current log tail at RBA [0x2dd.259d0.0]

Thu Feb 13 02:59:20 2014

Incremental checkpoint up to RBA [0x2dd.26e2f.0], current log tail at RBA [0x2dd.26edd.0]

Thu Feb 13 03:14:56 2014

Stopping background process CJQ0

Thu Feb 13 03:29:22 2014

Incremental checkpoint up to RBA [0x2dd.27544.0], current log tail at RBA [0x2dd.2761d.0]

Thu Feb 13 03:36:38 2014

Time drift detected. Please check VKTM trace file for more details.

Thu Feb 13 03:59:24 2014

Incremental checkpoint up to RBA [0x2dd.289be.0], current log tail at RBA [0x2dd.28a5f.0]

Thu Feb 13 04:29:25 2014

Incremental checkpoint up to RBA [0x2dd.2906f.0], current log tail at RBA [0x2dd.29119.0]

Thu Feb 13 04:59:27 2014

Incremental checkpoint up to RBA [0x2dd.2a478.0], current log tail at RBA [0x2dd.2a511.0]

Thu Feb 13 05:04:49 2014

Time drift detected. Please check VKTM trace file for more details.

Thu Feb 13 05:29:29 2014

Incremental checkpoint up to RBA [0x2dd.2aad0.0], current log tail at RBA [0x2dd.2ab74.0]

Thu Feb 13 05:59:30 2014

Incremental checkpoint up to RBA [0x2dd.2be91.0], current log tail at RBA [0x2dd.2bf33.0]

Thu Feb 13 06:29:32 2014

Incremental checkpoint up to RBA [0x2dd.2c4f8.0], current log tail at RBA [0x2dd.2c5a2.0]

Thu Feb 13 06:59:34 2014

Incremental checkpoint up to RBA [0x2dd.2d860.0], current log tail at RBA [0x2dd.2d925.0]

Thu Feb 13 07:29:35 2014

Incremental checkpoint up to RBA [0x2dd.2df05.0], current log tail at RBA [0x2dd.2dfa7.0]

Thu Feb 13 07:59:37 2014

Incremental checkpoint up to RBA [0x2dd.2f38f.0], current log tail at RBA [0x2dd.2f42e.0]

Thu Feb 13 08:02:14 2014

Time drift detected. Please check VKTM trace file for more details.

Thu Feb 13 08:29:39 2014

Incremental checkpoint up to RBA [0x2dd.2f9fa.0], current log tail at RBA [0x2dd.2facf.0]

Thu Feb 13 08:59:40 2014

Incremental checkpoint up to RBA [0x2dd.30dc8.0], current log tail at RBA [0x2dd.30e66.0]

Thu Feb 13 09:29:42 2014

Incremental checkpoint up to RBA [0x2dd.31443.0], current log tail at RBA [0x2dd.314e0.0]

Thu Feb 13 09:59:44 2014

Incremental checkpoint up to RBA [0x2dd.3288d.0], current log tail at RBA [0x2dd.32939.0]

Thu Feb 13 10:14:06 2014

Shutting down instance (immediate)

Stopping background process SMCO

Shutting down instance: further logons disabled

Stopping background process QMNC

Stopping background process MMNL

Stopping background process MMON

License high water mark = 35

ALTER DATABASE CLOSE NORMAL

Thu Feb 13 10:14:10 2014

SMON: disabling tx recovery

SMON: disabling cache recovery

Thu Feb 13 10:14:10 2014

Shutting down archive processes

Archiving is disabled

Thu Feb 13 10:14:10 2014

ARCH shutting down

ARC3: Archival stopped

Thu Feb 13 10:14:10 2014

ARCH shutting down

Thu Feb 13 10:14:10 2014

ARCH shutting down

ARC1: Archival stopped

Thu Feb 13 10:14:10 2014

ARCH shutting down

ARC0: Archival stopped

ARC2: Archival stopped

Thread 1 closed at log sequence 733

Successful close of redo thread 1

Completed: ALTER DATABASE CLOSE NORMAL

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

ARCH: Archival disabled due to shutdown: 1089

Shutting down archive processes

Archiving is disabled

Thu Feb 13 10:14:15 2014

Stopping background process VKTM

Thu Feb 13 10:14:17 2014

Instance shutdown complete

Thu Feb 13 10:19:01 2014

Starting ORACLE instance (normal)

LICENSE_MAX_SESSION = 0

LICENSE_SESSIONS_WARNING = 0

Picked latch-free SCN scheme 3

Autotune of undo retention is turned on.

LICENSE_MAX_USERS = 0

SYS auditing is disabled

Starting up:

Oracle Database 11g Enterprise Edition Release 11.2.0.3.0 - 64bit Production

With the Partitioning, OLAP, Data Mining and Real Application Testing options.

Windows NT Version V6.0 Service Pack 2

CPU : 8 - type 8664, 4 Physical Cores

Process Affinity : 0x0x0000000000000000

Memory (Avail/Total): Ph:14268M/16374M, Ph+PgF:43365M/48301M

Using parameter settings in server-side spfile D:\ORACLE\SOL\11203\DATABASE\SPFILESOL.ORA

System parameters with non-default values:

processes = 190

sessions = 384

shared_pool_size = 1232M

filesystemio_options = "setall"

control_files = "D:\ORACLE\SOL\ORIGLOGA\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\ORIGLOGB\CNTRL\CNTRLSOL.DBF"

control_files = "D:\ORACLE\SOL\SAPDATA1\CNTRL\CNTRLSOL.DBF"

control_file_record_keep_time= 30

db_block_size = 8192

db_cache_size = 1232M

compatible = "11.2.0"

log_archive_dest_1 = "LOCATION=D:\oracle\SOL\oraarch\SOLarch"

log_archive_format = "%t_%s_%r.dbf"

db_recovery_file_dest = "D:\oracle\SOL\oraflash"

db_recovery_file_dest_size= 30000M

log_checkpoints_to_alert = TRUE

replication_dependency_tracking= FALSE

undo_tablespace = "PSAPUNDO"

_in_memory_undo = FALSE

recyclebin = "off"

remote_os_authent = TRUE

remote_login_passwordfile= "EXCLUSIVE"

parallel_execution_message_size= 16384

_table_lookup_prefetch_size= 0

audit_file_dest = "D:\ORACLE\SOL\SAPTRACE\AUDIT"

db_name = "SOL"

open_cursors = 2000

_sort_elimination_cost_ratio= 10

_b_tree_bitmap_plans = FALSE

star_transformation_enabled= "true"

parallel_threads_per_cpu = 1

query_rewrite_enabled = "false"

_index_join_enabled = FALSE

_optim_peek_user_binds = FALSE

pga_aggregate_target = 600M

_optimizer_mjc_enabled = FALSE

diagnostic_dest = "D:\ORACLE\SOL\SAPTRACE"

max_dump_file_size = "20000"

Deprecated system parameters with specified values:

remote_os_authent

End of deprecated system parameter listing

Thu Feb 13 10:19:01 2014

PMON started with pid=2, OS id=6748

Thu Feb 13 10:19:01 2014

PSP0 started with pid=3, OS id=8432

Thu Feb 13 10:19:02 2014

VKTM started with pid=4, OS id=5180 at elevated priority

VKTM running at (10)millisec precision with DBRM quantum (100)ms

Thu Feb 13 10:19:03 2014

GEN0 started with pid=5, OS id=8732

Thu Feb 13 10:19:03 2014

DIAG started with pid=6, OS id=6744

Thu Feb 13 10:19:03 2014

DBRM started with pid=7, OS id=9168

Thu Feb 13 10:19:03 2014

DIA0 started with pid=8, OS id=1676

Thu Feb 13 10:19:03 2014

MMAN started with pid=9, OS id=8768

Thu Feb 13 10:19:03 2014

DBW0 started with pid=10, OS id=6736

Thu Feb 13 10:19:03 2014

LGWR started with pid=11, OS id=7656

Thu Feb 13 10:19:03 2014

CKPT started with pid=12, OS id=5724

Thu Feb 13 10:19:03 2014

SMON started with pid=13, OS id=8896

Thu Feb 13 10:19:03 2014

RECO started with pid=14, OS id=8500

Thu Feb 13 10:19:03 2014

MMON started with pid=15, OS id=8512

Thu Feb 13 10:19:03 2014

MMNL started with pid=16, OS id=8832

ORACLE_BASE from environment = D:\oracle

Thu Feb 13 10:19:03 2014

ALTER DATABASE MOUNT

Successful mount of redo thread 1, with mount id 1427451671

Database mounted in Exclusive Mode

Lost write protection disabled

Completed: ALTER DATABASE MOUNT

Thu Feb 13 10:19:07 2014

ALTER DATABASE OPEN

LGWR: STARTING ARCH PROCESSES

Thu Feb 13 10:19:07 2014

ARC0 started with pid=18, OS id=8816

ARC0: Archival started

LGWR: STARTING ARCH PROCESSES COMPLETE

ARC0: STARTING ARCH PROCESSES

Thu Feb 13 10:19:08 2014

ARC1 started with pid=19, OS id=8540

Thu Feb 13 10:19:08 2014

ARC2 started with pid=20, OS id=6676

Thu Feb 13 10:19:08 2014

ARC3 started with pid=21, OS id=4992

ARC1: Archival started

ARC2: Archival started

ARC1: Becoming the 'no FAL' ARCH

ARC1: Becoming the 'no SRL' ARCH

ARC2: Becoming the heartbeat ARCH

Thread 1 opened at log sequence 733

Current log# 1 seq# 733 mem# 0: D:\ORACLE\SOL\ORIGLOGA\LOG_G11M1.DBF

Current log# 1 seq# 733 mem# 1: D:\ORACLE\SOL\MIRRLOGA\LOG_G11M2.DBF

Successful open of redo thread 1

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

SMON: enabling cache recovery

Incremental checkpoint up to RBA [0x2dd.32ced.0], current log tail at RBA [0x2dd.32ced.0]

[3860] Successfully onlined Undo Tablespace 2.

Undo initialization finished serial:0 start:31336622 end:31336903 diff:281 (2 seconds)

Verifying file header compatibility for 11g tablespace encryption..

Verifying 11g file header compatibility for tablespace encryption completed

SMON: enabling tx recovery

Database Characterset is UTF8

No Resource Manager plan active

Starting background process QMNC

Thu Feb 13 10:19:10 2014

QMNC started with pid=22, OS id=7728

ARC3: Archival started

ARC0: STARTING ARCH PROCESSES COMPLETE

Completed: ALTER DATABASE OPEN

Thu Feb 13 10:19:12 2014

db_recovery_file_dest_size of 30000 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.

Thu Feb 13 10:19:46 2014

Starting ORACLE instance (normal)

Thu Feb 13 10:20:15 2014

Starting background process SMCO

Thu Feb 13 10:20:15 2014

SMCO started with pid=43, OS id=8256

Thu Feb 13 10:24:48 2014

Shared IO Pool defaulting to 288MB. Trying to get it from Buffer Cache for process 9108.

Thu Feb 13 10:25:03 2014

Beginning log switch checkpoint up to RBA [0x2de.2.10], SCN: 23067225

Thread 1 advanced to log sequence 734 (LGWR switch)

Current log# 2 seq# 734 mem# 0: D:\ORACLE\SOL\ORIGLOGB\LOG_G12M1.DBF

Current log# 2 seq# 734 mem# 1: D:\ORACLE\SOL\MIRRLOGB\LOG_G12M2.DBF

Thu Feb 13 10:25:06 2014

Archived Log entry 527 added for thread 1 sequence 733 ID 0x550c5329 dest 1:

Thu Feb 13 10:30:06 2014

Completed checkpoint up to RBA [0x2de.2.10], SCN: 23067225

Thu Feb 13 10:49:11 2014

Incremental checkpoint up to RBA [0x2de.30073.0], current log tail at RBA [0x2de.3023d.0]

Thu Feb 13 11:15:00 2014

Time drift detected. Please check VKTM trace file for more details.

Thu Feb 13 11:19:13 2014

Incremental checkpoint up to RBA [0x2de.307d5.0], current log tail at RBA [0x2de.3099c.0]

Thu Feb 13 11:49:15 2014

Incremental checkpoint up to RBA [0x2de.31b9e.0], current log tail at RBA [0x2de.31e6e.0]

Thu Feb 13 12:19:17 2014

Incremental checkpoint up to RBA [0x2de.32324.0], current log tail at RBA [0x2de.324de.0]

Thu Feb 13 12:49:18 2014

Incremental checkpoint up to RBA [0x2de.3665a.0], current log tail at RBA [0x2de.39b2d.0]

Please Help.

Thanks

Mohd Basis

Dear Experts.

Please Help me to come out of this Situation. After Solman 7.1 installation i have not upgraded Kernel Patch. Would the issue be because of not upgrading the kernel patch.

Experts Please Help.

Thanks & Regards

Mohd Basis.

What does the upgrade logs say ?

You need to provide accurate information to get help.

Regards

Hi Mohd,

Kindly send only the error logs not the whole log file?

Please also monitor the current processes running on os level.

Also send the cat /proc/meminfo result ?

When you restarted the SUM which step did it start from?

Regards,

Robin

Dear Robin.

When i restart SUM it was starting from the same phase where is stooped and as mentioned - MAIN_SHDIMP/SUBMOD_SHDIMP/SHADOW_IMPORT_INC.As of now i have stopped the process, as per the SAP Note 1738989- the error might be because of bug so i am going to apply the Bundle Patch and restart the process again.

Thanks for your support.

Regards

Mohd Basis

Dear Experts.

Issue resolved with the SAP note 1738989, thanks to everyone who participated to resolve the issue.

Regards

Mohd Basis

Answers (2)

Hi Mohd,

The shadow import phase does take much. However 18 hrs is something to worry about.

Please follow the below steps which can help discover the error if there is any

1.Check the available memory of your server which you are upgrading. I hope its not too low,

2.Check the alert_<SAPSID>.log file in the database logs under the path /oracle/SID/saptrace/....

Make sure it does not show any errors. If it does analyse the issue. Usually you will face errors due to insufficient tablespace or file system full.

3.Check the working directory for further logs. Path : /usr/sap/SID/<instance number>/work

4.If you are still able to log on to the system, go to sm37 and check if the shadow import phase is waiting on some jobs which are still running. If so wait for these jobs to finish.(They are the reason that import phase is taking so long.

5. Make sure that your /oracle/SID/oraarch directory is having sufficient space. If it is full it can cause a situation called archivestuck. Clear old archive files if already backed up.

Finally if you do find an error and even after solving it the upgrade does not move further, you can end the SUM gui and start it again. You might even have to end the SUM process itself. Do not panic in such case. You can safely start SUM again and it will resume from the last error step.

Hope this helps.

Regards,

Robin

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Hello,

This phase usually takes long time. But you should check log files for any error. You can also refer to SAP note 1945399.

Please also refer to SAP note 1738989 for possible bug in oracle.

Thanks,

Sunny

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Ask a Question

Top Q&A Solution Author

User

Count

Solman 7.1 SPS 10 Upgrade using SUM tool hangs

Accepted Solutions (1)

Accepted Solutions (1)

Answers (2)

Answers (2)

Iterating through JSONModel with multiple nested a...

Re: Connecting SAP CAP with SAP Cloud ALM

How to use CopyProvider on Table created by TypeSc...

How to execute/fire onPost when user press enter o...

Re: Connecting SAP CAP with SAP Cloud ALM