Добрый день, коллеги.
Выполнял процедуру system copy с одной NW 7.3 системы на другую (SLES11 + Oracle11). В существующую БД.
После процедуры DB и CI запустились нормально.
Но при открытии экрана для входа в SAP, выскакивает окно с предупреждением. Рабочий процесс был сброшен. Прошу пинуть в нужном направлении

Еще при сборке статистики через BRTOOLS говорит что нет лицензии SAP. Но это, наверное, не причина сброса процессов.
Ядро обновил. Результат тот же.
Code:
[size=85]
---------------------------------------------------
trc file: "dev_w3", trc level: 1, release: "721"
---------------------------------------------------
*
* ACTIVE TRACE LEVEL 1
* ACTIVE TRACE COMPONENTS all, MJ
*
M sysno 07
M sid BQS
M systemid 390 (AMD/Intel x86_64 with Linux)
M relno 7210
M patchlevel 0
M patchno 100
M intno 20020600
M make single threaded, Unicode, 64 bit, optimized
M profile /sapmnt/BQS/profile/BQS_DVEBMGS07_cibqs
M pid 19567
M
M
M Thu Aug 22 19:25:37 2013
M kernel runs with dp version 137000(ext=119000) (@(#) DPLIB-INT-VERSION-137000-UC)
M length of sys_adm_ext is 588 bytes
M ThStart: taskhandler started
M ThInit: initializing DIA work process W3
M ***LOG Q01=> ThInit, WPStart (Workp. 3 1 19567) [thxxhead.c 1328]
M ThInit: running on host cibqs
M calling db_connect ...
B Loading DB library '/usr/sap/BQS/DVEBMGS07/exe/dboraslib.so' ...
B Library '/usr/sap/BQS/DVEBMGS07/exe/dboraslib.so' loaded
B Version of '/usr/sap/BQS/DVEBMGS07/exe/dboraslib.so' is "721.02", patchlevel (0.42)
C Register application info.
C Oracle client version: 11.2.0.3.0, V1, default build, (dbsl 721 240113, UNICODE[2])
C Installed Oracle client patches:
C # Patch 13508485 : Created on 21 Dec 2011, 13:23:38 hrs PST8PDT
C # Patch Description: Created on 3 Jan 2012, 02:50:27 hrs PST8PDT
C # Patch 11742262 : Created on 7 Mar 2012, 12:22:41 hrs CET
C Client NLS setting (by OCINlsGetInfo(con=0)): 'AMERICAN_AMERICA.UTF16'
C Logon as OPS$-user to get SAPSR3's password
C Connecting as /@BQS on connection 0 (nls 0) ... (dbsl 721 240113, UNICODE[2])
C Attaching to database server BQS (con=0, svchp=672cc28, srvhp=672f570)
C Starting user session: OCISessionBegin(con=0, usr='/', svc=672cc28, srv=672f570, usr=675d5f0)
C Now '/@BQS' is connected: con=0, nls=0, session=272, time='2013-08-22 19:25:37'
C Got SAPSR3's password from OPS$-user
C Disconnecting from connection 0 ...
C Closing user session (con=0, svc=672cc28, usr=675d5f0)
C Disconnected (con=0) from ORACLE.
C Connecting as SAPSR3/<pwd>@BQS on connection 0 (nls 0) ... (dbsl 721 240113, UNICODE[2])
C Starting user session: OCISessionBegin(con=0, usr='SAPSR3', svc=672cc28, srv=672f570, usr=675d5f0)
C Now 'SAPSR3/<pwd>@BQS' is connected: con=0, nls=0, session=272, time='2013-08-22 19:25:37'
C DB instance BQS is running on sap-srv-03 with ORACLE version 11.2.0.2.0 since AUG 22, 2013, 19:23:54.
C
C Thu Aug 22 19:25:38 2013
C con=0, V$NLS_PARAMETERS: NLS_LANG=AMERICAN_AMERICA.UTF8, NLS_NCHAR=UTF8
C Nls CharacterSet NationalCharSet EnvHp ErrHp ErrBt
C 0 UTF16 AL16UTF16 671f9a0 672bc28 672cd08
B Connection 0 opened (DBSL handle 0)
C DbSlControl(DBSL_CMD_SAPRELEASE_SET,abap='730')
M ThInit: db_connect o.k.
M ICT: exclude compression: *.zip,*.rar,*.arj,*.z,*.gz,*.tar,*.lzh,*.cab,*.hqx,*.ace,*.jar,*.ear,*.war,*.css,*.pdf,*.gzip,*.uue,*.bz2,*.iso,*.sda,*.sar,*.gif,*.png,*.swc,*.swf
I
I Thu Aug 22 19:25:40 2013
I MtxInit: 3 0 0
M SHM_PRES_BUF (addr: 7fe29101e000, size: 15000000)
M SHM_ROLL_AREA (addr: 7fdb13e3c000, size: 268435456)
M SHM_PAGING_AREA (addr: 7fdb03e3c000, size: 268435456)
M SHM_ROLL_ADM (addr: 7fe291e6e000, size: 11142696)
M SHM_PAGING_ADM (addr: 7fdb03b1b000, size: 3277856)
M ThCreateNoBuffer allocated 564152 bytes for 1000 entries at 7fdaed0b7000
M ThCreateNoBuffer index size: 3000 elems
M ThCreateVBAdm allocated 31072 bytes (50 server) at 7fe2a3161000
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 3 initializing ....
X Using implementation std
X Linux: Kernel supports shared memory disclaiming
X Linux: using madvise(<pointer>, <size>, 9).
X Linux: disclaiming for shared memory enabled
X ES initialized.
X mm.dump: set maximum dump mem to 96 MB
I *** INFO SHM 44 in POOL 40 43803 KB estimated 35000 KB real ( -8802 KB -21 %)
I *** INFO SHM 45 in POOL 40 23803 KB estimated 15000 KB real ( -8802 KB -37 %)
B db_con_shm_ini: WP_ID = 3, WP_CNT = 19, CON_ID = -1
B dbtbxbuf: Buffer TABL (addr: 7fdae6c71100, size: 90000000, end: 7fdaec245b80)
B dbtbxbuf: Buffer TABLP (addr: 7fdae4f25100, size: 30720000, end: 7fdae6c71100)
B dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 7fdafdf14000
B dbsync[db_syinit]: Buffer synchronisation started with
B sync_concept = SEQ_NR
B sendon = 1
B bufreftime = 120
B max_gap_wait_time = 60
B ddlog_del_time = 60
B last_counter = -2147483648
B oldest_gap = (2147483647,00000000000000)
B time_of_last_sync = 20130822192538
B MySysId = 'cibqs 07'
B dbexpbuf[EXP_SHB]: buffer EIBUF installed with
B semkey = 35
B shmkey = 54
B wp_n = 19
B sclass = 0
B block_length = 256
B max_objects = 8000
B max_obj_size = 7571552
B pref_obj_size = 0
B est_large_obj_size = 65536
B free_vec_lg = 257
B hash_vec_size = 16001
B buffer_l = 33554432
B max_blocks = 118308
B free_blocks = 118308
B mutex_n = 16001
B max_mtx_wait_time = 17000
B recovery_delay = 500000
B tracing = 0
B force_checks = 0
B protect_shm = 0
B dbexpbuf[EXP_SHM]: buffer ESM installed with
B semkey = 56
B shmkey = 65
B wp_n = 19
B sclass = 0
B block_length = 256
B max_objects = 2000
B max_obj_size = 843872
B pref_obj_size = 0
B est_large_obj_size = 16384
B free_vec_lg = 65
B hash_vec_size = 4001
B buffer_l = 4194304
B max_blocks = 13188
B free_blocks = 13188
B mutex_n = 4001
B max_mtx_wait_time = 17000
B recovery_delay = 500000
B tracing = 0
B force_checks = 0
B protect_shm = 0
B dbexpbuf[EXP_CUA]: buffer CUA installed with
B semkey = 30
B shmkey = 47
B wp_n = 19
B sclass = 10
B block_length = 512
B max_objects = 10000
B max_obj_size = 4098784
B pref_obj_size = 0
B est_large_obj_size = 98304
B free_vec_lg = 193
B hash_vec_size = 20011
B buffer_l = 20480000
B max_blocks = 32023
B free_blocks = 32023
B mutex_n = 20011
B max_mtx_wait_time = 17000
B recovery_delay = 500000
B tracing = 0
B force_checks = 0
B protect_shm = 0
B dbexpbuf[EXP_OTR]: buffer OTR installed with
B semkey = 55
B shmkey = 64
B wp_n = 19
B sclass = 13
B block_length = 256
B max_objects = 2000
B max_obj_size = 843872
B pref_obj_size = 0
B est_large_obj_size = 20480
B free_vec_lg = 81
B hash_vec_size = 4001
B buffer_l = 4194304
B max_blocks = 13188
B free_blocks = 13188
B mutex_n = 4001
B max_mtx_wait_time = 17000
B recovery_delay = 500000
B tracing = 0
B force_checks = 0
B protect_shm = 0
I MPI: dynamic quotas disabled.
I MPI init: pipes=4000 buffers=1279 reserved=383 quota=10%
M rdisp/thwpsf_critical_path : -1 -> 0
M CCMS: SemInMgt: Semaphore Management initialized by AlAttachShm_Doublestack.
M CCMS: SemInit: Semaphore 38 initialized by AlAttachShm_Doublestack.
G
G Thu Aug 22 19:25:41 2013
G RelWritePermissionForShm( pLocation = 120, pEnforce = 0 )
G GetWritePermissionForShm( pLocation = 99, pEnforce = 1 )
G RelWritePermissionForShm( pLocation = 100, pEnforce = 1 )
S *** init spool environment
S TSPEVJOB updates outside critical section: event_update_nocsec = 1
S initialize debug system
T Stack direction is downwards.
T debug control: prepare exclude for printer trace
T new memory block 684b830
S spool kernel/ddic check: Ok
S using table TSP02FX for frontend printing
S 1 spool work process(es) found
S frontend print via spool service enabled
S printer list size is 150
S printer type list size is 50
S queue size (profile) = 300
S hostspool list size = 3000
S option list size is 30
I *** INFO SHM 49 in POOL 40 2898 KB estimated 1632 KB real ( -1266 KB -44 %)
S intervals: query=50, rescan=1800, global=300 info=120
S init processing groups
S InitGroups parm=rdisp/wp_no_spo_Snm_max
S No SPOs are reserved for SNMP
S processing queue enabled
S creating spool memory service RSPO-RCLOCKS at 7fdaff29f070
S doing lock recovery
S setting server cache root
S using server cache size 100 (prof=100)
S creating spool memory service RSPO-SERVERCACHE at 7fdaff29f750
S using messages for server info
B dbtran INFO (init_connection '<DEFAULT>' [ORACLE:721.02]):
B max_blocking_factor = 5, min_blocking_factor = 5,
B max_in_blocking_factor = 5, min_in_blocking_factor = 5,
B max_union_blocking_factor = 5, min_union_blocking_factor = 5,
B prefer_union_all = 0, prefer_join = 0,
B prefer_fix_blocking = 0, prefer_in_itab_opt = 1,
B convert AVG = 0, alias table FUPD = 0,
B escape_as_literal = 1,
B select * =0x0f, character encoding = STD / <none>:-,
B use_hints = abap->1, dbif->0x1, upto->18446744073709551615
S size of spec char cache entry: 297032 bytes (timeout 100 sec)
S size of open spool request entry: 2512 bytes
S immediate print option for implicitely closed spool requests is disabled
C -> 'OCI_112, 11.2.0.3.0, V1, default build'
A ***GENER* Trace switched on ***
A
A ---PXA-------------------------------------------
A PXA INITIALIZATION
A PXA: Locked PXA-Semaphore.
A PXA: max_map_count = 1000000: ok
A System page size: 4kb, total admin_size: 149448kb, dir_size: 24680kb.
A Attached to PXA (address 7fda649b2000, size 2000000K, 6 fragments of 308428K )
A PXA allocated (address 7fda649b2000, size 2000000K)
A abap/pxa = shared protect gen_remote
A PXA: checking structure sizes: 752|272|8
A PXA INITIALIZATION FINISHED
A ---PXA-------------------------------------------
A
A ATRA: pfclock execution time = 0
A abap/force_local_update_task=0
A ABAP ShmAdm attached (addr=7fdb328d2000 leng=20955136 end=7fdb33cce000)
A >> Shm MMADM area (addr=7fdb32dd4b70 leng=241472 end=7fdb32e0fab0)
A >> Shm MMDAT area (addr=7fdb32e10000 leng=15454208 end=7fdb33ccd000)
A RFC rfc/signon_error_log = -1
A RFC rfc/dump_connection_info = 0
A RFC rfc/dump_client_info = 0
A RFC rfc/cp_convert/ignore_error = 1
A RFC rfc/cp_convert/conversion_char = 23
A RFC rfc/wan_compress/threshold = 251
A RFC rfc/recorder_pcs not set, use defaule value: 2
A RFC rfc/delta_trc_level not set, use default value: 0
A RFC rfc/no_uuid_check not set, use default value: 0
H HTTP> Parameter icf/ssocookie_mandatory set to 0
M ThrCreateShObjects allocated 39514 bytes at 7fda648e7000
Y dyWpInit
Y ztta/dynpro_ara 800000
Y ztta/cua_ara 500000
Y ztta/diag_ara 250000
N SsfSapSecin: putenv(SECUDIR=/usr/sap/BQS/DVEBMGS07/sec): ok
N
N =================================================
N === SSF INITIALIZATION:
N ===...SSF Security Toolkit name SAPSECULIB .
N ===...SSF library is /usr/sap/BQS/DVEBMGS07/exe/libsapsecu.so .
N ===...SSF default hash algorithm is SHA1 .
N ===...SSF default symmetric encryption algorithm is DES-CBC .
N ===...SECUDIR="/usr/sap/BQS/DVEBMGS07/sec"
N ===...loading of Security Toolkit completed with rc 5 (SSF_SUP_NOTALLFUNCTIONS).
N === SAPSECULIB Version 5.4.28M-6
N =================================================
N
N Thu Aug 22 19:25:42 2013
N MskiInitLogonTicketCacheHandle: Logon Ticket cache pointer retrieved from shared memory.
N MskiInitLogonTicketCacheHandle: Workprocess runs with Logon Ticket cache.
M JrfcVmcRegisterNativesDriver o.k.
W =================================================
W === ipl_Init() called
W ITS Plugin: Path dw_gui
W ITS Plugin: Description ITS Plugin - ITS rendering DLL
W ITS Plugin: sizeof(SAP_UC) 2
W ITS Plugin: Release: 721, [7210.0.100.20020600]
W ITS Plugin: Int.version, [34]
W ITS Plugin: Feature set: [31]
W ===... Calling itsp_Init in external dll ===>
W === ipl_Init() returns 0, ITSPE_OK: OK
W =================================================
N SignInit: successfully obtained handle for Security Context cache
N SignInit: Not attempted to load Kerberos Library (ABAP parts missing, note TODO)
N VSI: WP init in ABAP VM completed with rc=0
E EnqLockTableSizeCalculate: session quota = 100%
E EnqLockTableAttach2: attach to lock table (size = 33554432)
E EnqLockTableMapToLocalContext: enque/use_pfclock2 = FALSE
E EnqId_Initialize: local EnqId initialization o.k.
M rdisp/thsend_order : -1 -> 0
M ThISend: set thsend_order to 0
E Enqueue Info: enque/use_pfclock2 = FALSE
E Enqueue Info: row condense enabled
A
A Thu Aug 22 19:25:43 2013
A UpdateProfile (new settings): on,krn_impl,(no dyn check),(no logging),(no stat err),(local generation),(no commit)
A UpdateProfile (new exceptions): tmp_off,(home_err),(local_err)
A UpdateProfile (new version): 0
A UpdateProfile (new maximal defenv size): 10000
M SecAudit(rsauinit): WP attached to existing shared memory.
M SecAudit(RsauShmInit): addr of SHM for Audit.. = 7fda62462000
M SecAudit(RsauShmInit): addr of RSAUSHM........ = 7fda62463000
M SecAudit(RsauShmInit): addr of RSAUSLOTINFO... = 7fda62463610
M SecAudit(RsauShmInit): addr of RSAUSLOTS...... = 7fda62463620
M SecAudit(check_daily_file): audit file opened /usr/sap/BQS/DVEBMGS07/log/audit_20130822
A ***GENER* Trace switched off ***
B dbrda: Redirect database access is disabled via rsdb/rda profile parameter setting.
M extStatHook: This process does not report performance statistics
C
C Thu Aug 22 19:30:57 2013
C OCIStmtExecute() failed with -1=OCI_ERROR
C SQL error 2289:
C *** ERROR => Error 2289 in stmt_execute() from oci_execute_stmt(), orpc=0
[dbsloci.c 17300]
C {root-id=60EB69BAE0681EE382E7FAE759A0136F}_{conn-id=00000000000000000000000000000000}_0
C *** ERROR => ORA-02289 occurred at SQL stmt (parse error offset=79)
[dbsloci.c 17301]
C {root-id=60EB69BAE0681EE382E7FAE759A0136F}_{conn-id=00000000000000000000000000000000}_0
C Dump statement cache:
C sc_p=667f1b0,no=44,idc_p=6699810,con=0,act=1,slen=121,smax=256,#vars=4,stmt=6ab1070,table=DDLOG
C INSERT INTO DDLOG (SEQNUMBER, TIMESTAMP, SYSTEMID, NBLENGTH, NOTEBOOK) VALUES (DDLOG_SEQ.NEXTVAL, :A\
C 0 , :A1 , :A2 , :A3 );
C Dump statement cache:
C sc_p=667f1b0,no=44,idc_p=6699810,con=0,act=1,slen=121,smax=256,#vars=4,stmt=6ab1070,table=DDLOG
C Dumping stmt. cache (DBSL private attributes):
C sch=667f1b0, scp=6689e00, ups_sch=0000NULL, stp=6aab818, r_c=0
C prep=0, lit=0, nsql=0, lobret_cnt=0, fae_cnt=0, xop=1, dbcount=0
C IN : col_cnt=4, row_max=1, row_xcnt=1, row_pcnt=0, row_i=140733193388032, row_total=1,
C row_upto=4294967295, row_size=32078, vda_max=32, bound=1, itp=680b000, vda_arr=6ab23d0
C lob_cnt=0, lob_max=0, lob_pw_cnt=0, lob_arr=0000NULL, rows_ret=0
C OUT: col_cnt=0, row_max=0, row_xcnt=0, row_pcnt=0, row_i=140578574565376, row_total=0,
C row_upto=0, row_size=0, vda_max=0, bound=0, itp=0000NULL, vda_arr=0000NULL
C lob_cnt=0, lob_max=0, lob_pw_cnt=0, lob_arr=0000NULL, rows_ret=0
C INSERT INTO DDLOG (SEQNUMBER, TIMESTAMP, SYSTEMID, NBLENGTH, NOTEBOOK) VALUES (DDLOG_SEQ.NEXTVAL, :A\
C 0 , :A1 , :A2 , :A3 );
B ***LOG BY4=> sql error 2289 performing INS on table DDLOG [dbsynseq 586]
B ***LOG BY0=> ORA-02289: sequence does not exist [dbsynseq 586]
B ***LOG BZY=> unexpected return code 2 calling ins_ddlog [dbsync 1398]
B db_syflush (TRUE) failed
B db_con_commit received error 1024 in before-commit action, returning 8
M ***LOG R38=> ThICommit3, db_commit98 ( 001024) [thxxhead.c 14369]
M ***LOG R18=> ThPrivCommit, ThICommit () [thxxhead.c 15272]
M in_ThErrHandle: 1
M *** ERROR => ThPrivCommit: ThICommit (step 4, th_errno 9, action 2, level 1) [thxxhead.c 11348]
M {root-id=60EB69BAE0681EE382E7FAE759A0136F}_{conn-id=00000000000000000000000000000000}_0
M DpVmcGetVmByTmAdm: no VM found for T3/M0/I0 (locked VMs ignored)
M ThResetEmMagic: reset em magic for T3/M0/I0
M
M Info for wp 3
M
M pid = 19567
M severity = 0
M status = 0
M stat = WP_RUN
M waiting_for = NO_WAITING
M reqtype = DP_RQ_DIAWP
M act_reqtype = DP_RQ_DIAWP
M req.req_info = BTC_SCHEDULER,SET_SYSTEM_USER
M req.tid = 3
M req.uid = 4
M req.mode = 0
M req.len = 24
M req.rq_id = 156
M req.rq_source = FROM_WP_CA
M last_tid = 3
M last_uid = 4
M last_mode = 0
M act_cs_count = 0
M csTrack = 0
M csTrackRwExcl = 0
M csTrackRwShrd = 0
M mode_cleaned_counter = 0
M control_flag = 0
M int_checked_resource(RFC) = 0
M ext_checked_resource(RFC) = 0
M int_checked_resource(HTTP) = 0
M ext_checked_resource(HTTP) = 0
M report = >/1BCDWBEN/SAPLSENQ10 <
M action = 0
M tab_name = > <
M attachedVm = no VM
M
M Modeinfo for User T3/M0
M
M tm state = 2
M uid = 4
M term type = 0x2
M display = 0x0
M cpic_no = 0
M cpic_idx = -1
M usr = >SAPSYS <
M terminal = > <
M client = >000<
M conversation_ID = > <
M appc_tm_conv_idx = -1
M its_plugin = NO
M allowCreateMode = YES
M blockSoftCanel = NO
M Session Resources:
M HEAD: adr/max_elems/act_elems/tbl = 7fe290952b10/0/0/(nil)
M imode = 0
M mode state = 0x42
M task_type = ZTTABTC
M lastThFc = THFCBTCH
M lastAction = TH_IACT_NO_ACTION
M th_errno = SAP commit failed, session terminated (9)
M rollout_reason = 0
M last_rollout_level = 0
M async_receives = 0
M cpic_receive = 0
M em handle = 2
M roll state = DP_ROLL_INITIALIZED
M abap state = DP_ROLL_INITIALIZED
M em state = DP_EM_ATTACHED
M eg state = DP_EM_NO_CONTEXT
M spa state = DP_SPA_INITIALIZED
M enq state = 0
M softcancel = 0
M cancelInitiator = ?
M clean_state = DP_DEFAULT_CLEANING
M next hook = T-1/U-1/M255
M master hook = T-1/U-1/M255
M slave hook = T-1/U-1/M255
M debug_tid = -1
M debug_mode = 255
M mode type = 0x1
M debug = DP_DEBUGGING_OFF
M msg_count = 6
M tcode = > <
M act_wp = 3
M last_wp = 3
M client conversation_ID = > <
M server conversation_ID = > <
M lock = 0
M max enq infos = 9
M act enq infos = 2
M em_hyper_hdl = 7fdb33d10398
M plugin_info = NULL
M act_plugin_hdl = -1
M act_plugin_no = 0
M max_plugin_no = 0
M Context Resources:
M HEAD: adr/max_elems/act_elems/tbl = 7fe29094c4e8/0/0/(nil)
M
M ThPrintDataBlks: associated blocks: wp/appc=260/260, len=24/80
M
M Adresse Offset Data from input buffer
M ------------------------------------------------------------------------
M 7fe28d1574c0 000000 00000000 03000000 01000000 04ff4900 |..............I.|
M 7fe28d1574d0 000016 0c000000 01000000 |........ |
M ------------------------------------------------------------------------
M Adresse Offset Data from output buffer
M ------------------------------------------------------------------------
M 7fe28d1574c0 000000 00000000 03000000 01000000 04ff4900 |..............I.|
M 7fe28d1574d0 000016 0c000000 01000000 |........ |
M ------------------------------------------------------------------------
M
M ThIErrHandle: current request:
M
M -IN-- sender_id DISPATCHER tid 3 wp_ca_blk -1 wp_id -1
M -IN-- action SEND_TO_WP uid 4 appc_ca_blk -1 type DIA
M -IN-- new_stat NO_CHANGE mode 0 len 24 rq_id 156
M -IN-- req_info BTC_SCHEDULER,SET_SYSTEM_USER
M
M *****************************************************************************
M *
M * LOCATION SAP-Server cibqs_BQS_07 on host cibqs (wp 3)
M * ERROR ThPrivCommit: ThICommit
M *
M * TIME Thu Aug 22 19:30:57 2013
M * RELEASE 721
M * COMPONENT Taskhandler
M * VERSION 1
M * RC 9
M * MODULE thxxhead.c
M * LINE 11629
M * COUNTER 5
M *
M *****************************************************************************
M
M PfStatDisconnect: disconnect statistics
M Entering TH_CALLHOOKS
M ThCallHooks: call hook >TrThHookFunc< for event BEFORE_DUMP
M TrThHookFunc: called for WP dump
M ThCallHooks: hook >TrThHookFunc< o.k.
M ThCallHooks: call hook >ThrSaveSPAFields< for event BEFORE_DUMP
M ThrSaveSPAFields: save spa fields
M ThrSaveSPAFields: not an update task, no update info saved
M ThrSaveSPAFields: save field zttabtckey (%_TIME_SCHEDULER) into thr_wpadm
M ThCallHooks: hook >ThrSaveSPAFields< o.k.
M ThCallHooks: call hook >ThrBtcCallLgCl< for event BEFORE_DUMP
M ThrBtcCallLgCl: call function BtcLgCl
M ThGetTransactionId: got trans id (SPA) >5216F34B2D764C6FE1000000AC175A0A< (32)
M ThEppGetRootContextIdAsUuid: ThEppGetRootContextIdAsXuuid for epp -2 failed (4/TH_EPP_BAD_HANDLE)
M ThEppGetConnectionIdAsUuid: ThEppGetConnectionIdAsXuuid for epp -2 failed (4/TH_EPP_BAD_HANDLE)
M *** ERROR => ThCallHooks: event handler ThrBtcCallLgCl for event BEFORE_DUMP failed [thxxtool3.c 303]
M {root-id=60EB69BAE0681EE382E7FAE759A0136F}_{conn-id=00000000000000000000000000000000}_0
M ThIErrHandle: entering ThSetStatError
M ThIErrHandle: do a full roll out of T3/M0
M ThRollOut: roll out T3/U4/M0/I0 (level=0x7, short_roll_out=0)
M level=ROLLIN_0,ROLLIN_1,ROLLIN_2
M ThRollOut: call ab_rollout
M ThRollOut: call rrol_out
M ThRollOut: act roll state = DP_ROLLED_OUT
M ThRollOut: full roll out of U4 M0 I0 (Level 7) ok
M ThIErrHandle: prv_action of W3: 0x8
C -->oci_break(con=0,Acon=-1,cb=0000NULL): cancel of current SQL
C No OCI call running -> OCIBreak() not called
C <--oci_break() -> Aorc=-24200
C <--DbSlControl(con=0,cmd=57=DBSL_CMD_SQLBREAK), rc=1=DBSL_ERR_ACCESS
B db_sqlbreak() = 1
M ThCallDbBreak: no sql statement active
M ThIErrHandle: don't try rollback again
M ThIErrHandle: do not call ThrCoreInfo (no_core_info=0, in_dynp_env=1)
M ThIErrHandle: Entering ThReplyToMsg
M ThIErrHandle: Entering ThErrHdlUser
M ThErrHdlUser: set th_errno (9)
M ThErrHdlUser: save context
M ThEmContextDetach2: detach T3/M0 from em memory (em_hdl=2, force=0)
M ThEmContextDetach2: reset local em info
M call ThrShutDown ...
B Disconnecting from ALL connections:
B Wp Hdl ConName ConId ConState TX BC HC PRM RCT FRC TIM MAX OPT Date Time DBHost Program
B 003 000 R/3 000000000 ACTIVE YES NO NO YES NO NO 000 255 255 20130822 192537 sap-srv-03
C Disconnecting from connection 0 ...
C Closing user session (con=0, svc=672cc28, usr=675d5f0)
C Server handle (con=0,svchp=672cc28,srvhp=672f570) detached
C Disconnected (con=0) from ORACLE.
B Disconnected from connection 0
B statistics db_con_commit (com_total=8, com_tx=2)
B statistics db_con_rollback (roll_total=0, roll_tx=0)
M ***LOG Q02=> wp_halt, WPStop (Workp. 3 19567) [dpuxtool.c 327]
---------------------------------------------------
trc file: "dev_w3", trc level: 1, release: "721"
---------------------------------------------------
*
* ACTIVE TRACE LEVEL 1
* ACTIVE TRACE COMPONENTS all, MJ
*
M sysno 07
M sid BQS
M systemid 390 (AMD/Intel x86_64 with Linux)
M relno 7210
M patchlevel 0
M patchno 100
M intno 20020600
M make single threaded, Unicode, 64 bit, optimized
M profile /sapmnt/BQS/profile/BQS_DVEBMGS07_cibqs
M pid 20864
M
M
M Thu Aug 22 19:30:57 2013
M kernel runs with dp version 137000(ext=119000) (@(#) DPLIB-INT-VERSION-137000-UC)
M length of sys_adm_ext is 588 bytes
M ThStart: taskhandler started
M ThStart: prv_action of W3 = 0x8
M ThInit: initializing DIA work process W3
M ThInit: found previous user T3/M0/U4
M ***LOG Q01=> ThInit, WPStart (Workp. 3 2 20864) [thxxhead.c 1328]
M
M Thu Aug 22 19:30:58 2013
M ThInit: running on host cibqs
M calling db_connect ...
B Loading DB library '/usr/sap/BQS/DVEBMGS07/exe/dboraslib.so' ...
B Library '/usr/sap/BQS/DVEBMGS07/exe/dboraslib.so' loaded
B Version of '/usr/sap/BQS/DVEBMGS07/exe/dboraslib.so' is "721.02", patchlevel (0.42)
C Register application info.
C Oracle client version: 11.2.0.3.0, V1, default build, (dbsl 721 240113, UNICODE[2])
C Installed Oracle client patches:
C # Patch 13508485 : Created on 21 Dec 2011, 13:23:38 hrs PST8PDT
C # Patch Description: Created on 3 Jan 2012, 02:50:27 hrs PST8PDT
C # Patch 11742262 : Created on 7 Mar 2012, 12:22:41 hrs CET
C Client NLS setting (by OCINlsGetInfo(con=0)): 'AMERICAN_AMERICA.UTF16'
C Logon as OPS$-user to get SAPSR3's password
C Connecting as /@BQS on connection 0 (nls 0) ... (dbsl 721 240113, UNICODE[2])
C Attaching to database server BQS (con=0, svchp=67463d8, srvhp=6748d20)
C Starting user session: OCISessionBegin(con=0, usr='/', svc=67463d8, srv=6748d20, usr=6776d60)
C Now '/@BQS' is connected: con=0, nls=0, session=272, time='2013-08-22 19:30:58'
C Got SAPSR3's password from OPS$-user
C Disconnecting from connection 0 ...
C Closing user session (con=0, svc=67463d8, usr=6776d60)
C Disconnected (con=0) from ORACLE.
C Connecting as SAPSR3/<pwd>@BQS on connection 0 (nls 0) ... (dbsl 721 240113, UNICODE[2])
C Starting user session: OCISessionBegin(con=0, usr='SAPSR3', svc=67463d8, srv=6748d20, usr=6776d60)
C Now 'SAPSR3/<pwd>@BQS' is connected: con=0, nls=0, session=272, time='2013-08-22 19:30:58'
C DB instance BQS is running on sap-srv-03 with ORACLE version 11.2.0.2.0 since AUG 22, 2013, 19:23:54.
C con=0, V$NLS_PARAMETERS: NLS_LANG=AMERICAN_AMERICA.UTF8, NLS_NCHAR=UTF8
C Nls CharacterSet NationalCharSet EnvHp ErrHp ErrBt
C 0 UTF16 AL16UTF16 6739150 67453d8 67464b8
B Connection 0 opened (DBSL handle 0)
C DbSlControl(DBSL_CMD_SAPRELEASE_SET,abap='730')
M ThInit: db_connect o.k.
M ICT: exclude compression: *.zip,*.rar,*.arj,*.z,*.gz,*.tar,*.lzh,*.cab,*.hqx,*.ace,*.jar,*.ear,*.war,*.css,*.pdf,*.gzip,*.uue,*.bz2,*.iso,*.sda,*.sar,*.gif,*.png,*.swc,*.swf
I MtxInit: 3 0 0
M SHM_PRES_BUF (addr: 7fe29101e000, size: 15000000)
M SHM_ROLL_AREA (addr: 7fdb19273000, size: 268435456)
M SHM_PAGING_AREA (addr: 7fdb09273000, size: 268435456)
M SHM_ROLL_ADM (addr: 7fe291e6e000, size: 11142696)
M SHM_PAGING_ADM (addr: 7fdb08f52000, size: 3277856)
M ThCreateNoBuffer allocated 564152 bytes for 1000 entries at 7fdaf24ee000
M ThCreateNoBuffer index size: 3000 elems
M ThCreateVBAdm allocated 31072 bytes (50 server) at 7fe2a3161000
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 3 initializing ....
X Using implementation std
X Linux: Kernel supports shared memory disclaiming
X Linux: using madvise(<pointer>, <size>, 9).
X Linux: disclaiming for shared memory enabled
X ES initialized.
X mm.dump: set maximum dump mem to 96 MB
I *** INFO SHM 44 in POOL 40 43803 KB estimated 35000 KB real ( -8802 KB -21 %)
I *** INFO SHM 45 in POOL 40 23803 KB estimated 15000 KB real ( -8802 KB -37 %)
B db_con_shm_ini: WP_ID = 3, WP_CNT = 19, CON_ID = -1
B dbtbxbuf: Buffer TABL (addr: 7fdaec0a8100, size: 90000000, end: 7fdaf167cb80)
B dbtbxbuf: Buffer TABLP (addr: 7fdaea35c100, size: 30720000, end: 7fdaec0a8100)
B dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 7fdb0334b000
B dbsync[db_syinit]: Buffer synchronisation started with
B sync_concept = SEQ_NR
B sendon = 1
B bufreftime = 120
B max_gap_wait_time = 60
B ddlog_del_time = 60
B last_counter = -2147483648
B oldest_gap = (2147483647,00000000000000)
B time_of_last_sync = 20130822192957
B MySysId = 'cibqs 07'
B dbexpbuf[EXP_SHB]: buffer EIBUF installed with
B semkey = 35
B shmkey = 54
B wp_n = 19
B sclass = 0
B block_length = 256
B max_objects = 8000
B max_obj_size = 7571552
B pref_obj_size = 0
B est_large_obj_size = 65536
B free_vec_lg = 257
B hash_vec_size = 16001
B buffer_l = 33554432
B max_blocks = 118308
B free_blocks = 118270
B mutex_n = 16001
B max_mtx_wait_time = 17000
B recovery_delay = 500000
B tracing = 0
B force_checks = 0
B protect_shm = 0
B dbexpbuf[EXP_SHM]: buffer ESM installed with
B semkey = 56
B shmkey = 65
B wp_n = 19
B sclass = 0
B block_length = 256
B max_objects = 2000
B max_obj_size = 843872
B pref_obj_size = 0
B est_large_obj_size = 16384
B free_vec_lg = 65
B hash_vec_size = 4001
B buffer_l = 4194304
B max_blocks = 13188
B free_blocks = 13188
B mutex_n = 4001
B max_mtx_wait_time = 17000
B recovery_delay = 500000
B tracing = 0
B force_checks = 0
B protect_shm = 0
B dbexpbuf[EXP_CUA]: buffer CUA installed with
B semkey = 30
B shmkey = 47
B wp_n = 19
B sclass = 10
B block_length = 512
B max_objects = 10000
B max_obj_size = 4098784
B pref_obj_size = 0
B est_large_obj_size = 98304
B free_vec_lg = 193
B hash_vec_size = 20011
B buffer_l = 20480000
B max_blocks = 32023
B free_blocks = 31833
B mutex_n = 20011
B max_mtx_wait_time = 17000
B recovery_delay = 500000
B tracing = 0
B force_checks = 0
B protect_shm = 0
B dbexpbuf[EXP_OTR]: buffer OTR installed with
B semkey = 55
B shmkey = 64
B wp_n = 19
B sclass = 13
B block_length = 256
B max_objects = 2000
B max_obj_size = 843872
B pref_obj_size = 0
B est_large_obj_size = 20480
B free_vec_lg = 81
B hash_vec_size = 4001
B buffer_l = 4194304
B max_blocks = 13188
B free_blocks = 13188
B mutex_n = 4001
B max_mtx_wait_time = 17000
B recovery_delay = 500000
B tracing = 0
B force_checks = 0
B protect_shm = 0
I MPI: dynamic quotas disabled.
I MPI init: pipes=4000 buffers=1279 reserved=383 quota=10%
M rdisp/thwpsf_critical_path : -1 -> 0
G RelWritePermissionForShm( pLocation = 120, pEnforce = 0 )
G GetWritePermissionForShm( pLocation = 99, pEnforce = 1 )
G RelWritePermissionForShm( pLocation = 100, pEnforce = 1 )
S *** init spool environment
S TSPEVJOB updates outside critical section: event_update_nocsec = 1
S initialize debug system
T Stack direction is downwards.
T debug control: prepare exclude for printer trace
T new memory block 681b370
S spool kernel/ddic check: Ok
S using table TSP02FX for frontend printing
S 1 spool work process(es) found
S frontend print via spool service enabled
S printer list size is 150
S printer type list size is 50
S queue size (profile) = 300
S hostspool list size = 3000
S option list size is 30
I *** INFO SHM 49 in POOL 40 2898 KB estimated 1632 KB real ( -1266 KB -44 %)
S found processing queue enabled
S found spool memory service RSPO-RCLOCKS at 7fdb046d6070
S doing lock recovery
S setting server cache root
S found spool memory service RSPO-SERVERCACHE at 7fdb046d6750
S using messages for server info
S size of spec char cache entry: 297032 bytes (timeout 100 sec)
S size of open spool request entry: 2512 bytes
S immediate print option for implicitely closed spool requests is disabled
C -> 'OCI_112, 11.2.0.3.0, V1, default build'
A ***GENER* Trace switched on ***
A
A ---PXA-------------------------------------------
A PXA INITIALIZATION
A PXA: Locked PXA-Semaphore.
A PXA: max_map_count = 1000000: ok
A System page size: 4kb, total admin_size: 149448kb, dir_size: 24680kb.
A Attached to PXA (address 7fda6da39000, size 2000000K, 6 fragments of 308428K )
A PXA allocated (address 7fda6da39000, size 2000000K)
A abap/pxa = shared protect gen_remote
A PXA: checking structure sizes: 752|272|8
A PXA INITIALIZATION FINISHED
A ---PXA-------------------------------------------
A
A ATRA: pfclock execution time = 0
A abap/force_local_update_task=0
A ABAP ShmAdm attached (addr=7fdb328d2000 leng=20955136 end=7fdb33cce000)
A >> Shm MMADM area (addr=7fdb32dd4b70 leng=241472 end=7fdb32e0fab0)
A >> Shm MMDAT area (addr=7fdb32e10000 leng=15454208 end=7fdb33ccd000)
A RFC rfc/signon_error_log = -1
A RFC rfc/dump_connection_info = 0
A RFC rfc/dump_client_info = 0
A RFC rfc/cp_convert/ignore_error = 1
A RFC rfc/cp_convert/conversion_char = 23
A RFC rfc/wan_compress/threshold = 251
A RFC rfc/recorder_pcs not set, use defaule value: 2
A RFC rfc/delta_trc_level not set, use default value: 0
A RFC rfc/no_uuid_check not set, use default value: 0
H HTTP> Parameter icf/ssocookie_mandatory set to 0
B dbtran INFO (init_connection '<DEFAULT>' [ORACLE:721.02]):
B max_blocking_factor = 5, min_blocking_factor = 5,
B max_in_blocking_factor = 5, min_in_blocking_factor = 5,
B max_union_blocking_factor = 5, min_union_blocking_factor = 5,
B prefer_union_all = 0, prefer_join = 0,
B prefer_fix_blocking = 0, prefer_in_itab_opt = 1,
B convert AVG = 0, alias table FUPD = 0,
B escape_as_literal = 1,
B select * =0x0f, character encoding = STD / <none>:-,
B use_hints = abap->1, dbif->0x1, upto->18446744073709551615
M ThrCreateShObjects allocated 39514 bytes at 7fe2a3152000
Y dyWpInit
Y ztta/dynpro_ara 800000
Y ztta/cua_ara 500000
Y ztta/diag_ara 250000
A *** ERROR => ab_newmode: EmSetMmxUsageStatRef() failed 7. [abinit.c 755]
A {root-id=60EB69BAE0681EE382E7FAE759A0136F}_{conn-id=00000000000000000000000000000000}_0
N SsfSapSecin: putenv(SECUDIR=/usr/sap/BQS/DVEBMGS07/sec): ok
N
N =================================================
N === SSF INITIALIZATION:
N ===...SSF Security Toolkit name SAPSECULIB .
N ===...SSF library is /usr/sap/BQS/DVEBMGS07/exe/libsapsecu.so .
N ===...SSF default hash algorithm is SHA1 .
N ===...SSF default symmetric encryption algorithm is DES-CBC .
N ===...SECUDIR="/usr/sap/BQS/DVEBMGS07/sec"
N ===...loading of Security Toolkit completed with rc 5 (SSF_SUP_NOTALLFUNCTIONS).
N === SAPSECULIB Version 5.4.28M-6
N =================================================
N
N Thu Aug 22 19:30:59 2013
N MskiInitLogonTicketCacheHandle: Logon Ticket cache pointer retrieved from shared memory.
N MskiInitLogonTicketCacheHandle: Workprocess runs with Logon Ticket cache.
M JrfcVmcRegisterNativesDriver o.k.
W =================================================
W === ipl_Init() called
W ITS Plugin: Path dw_gui
W ITS Plugin: Description ITS Plugin - ITS rendering DLL
W ITS Plugin: sizeof(SAP_UC) 2
W ITS Plugin: Release: 721, [7210.0.100.20020600]
W ITS Plugin: Int.version, [34]
W ITS Plugin: Feature set: [31]
W ===... Calling itsp_Init in external dll ===>
W PpioRecoverLocks, table: 7fdb33d08ed0
W PpioRecoverLocks, number of file locks 256
W PpioRecoverLocks: file lock set to: (nil)
W PpioRecoverLocks: directory lock set to: (nil)
W PpioRecoverLocks: global lock set to: (nil)
W PpioRecoverLocks() done
W PprcRecoverLocks, table: 7fdb33d09398
W PprcRecoverLocks: directory lock set to: (nil)
W PprcRecoverLocks() done
W === ipl_Init() returns 0, ITSPE_OK: OK
W =================================================
N SignInit: successfully obtained handle for Security Context cache
N SignInit: Not attempted to load Kerberos Library (ABAP parts missing, note TODO)
N VSI: WP init in ABAP VM completed with rc=0
E EnqLockTableSizeCalculate: session quota = 100%
E EnqLockTableAttach2: attach to lock table (size = 33554432)
E EnqLockTableMapToLocalContext: enque/use_pfclock2 = FALSE
E EnqId_Initialize: local EnqId initialization o.k.
M ThCheckPrevUser: previous user was T3/M0, clean counter 0
M ThCheckPrevUser: clean previous user T3/U4/M0/I0/no VM
M
M Modeinfo for User T3/M0
M
M tm state = 2
M uid = 4
M term type = 0x2
M display = 0x0
M cpic_no = 0
M cpic_idx = -1
M usr = >SAPSYS <
M terminal = > <
M client = >000<
M conversation_ID = > <
M appc_tm_conv_idx = -1
M its_plugin = NO
M allowCreateMode = YES
M blockSoftCanel = NO
M Session Resources:
M HEAD: adr/max_elems/act_elems/tbl = 7fe290952b10/0/0/(nil)
M imode = 0
M mode state = 0x42
M task_type = ZTTABTC
M lastThFc = THFCBTCH
M lastAction = TH_IACT_NO_ACTION
M th_errno = SAP commit failed, session terminated (9)
M rollout_reason = 0
M last_rollout_level = 7
M async_receives = 0
M cpic_receive = 0
M em handle = 2
M roll state = DP_ROLLED_OUT
M abap state = DP_ROLLED_OUT
M em state = DP_EM_DETACHED
M eg state = DP_EM_NO_CONTEXT
M spa state = DP_SPA_INITIALIZED
M enq state = 0
M softcancel = 0
M cancelInitiator = ?
M clean_state = DP_DEFAULT_CLEANING
M next hook = T-1/U-1/M255
M master hook = T-1/U-1/M255
M slave hook = T-1/U-1/M255
M debug_tid = -1
M debug_mode = 255
M mode type = 0x1
M debug = DP_DEBUGGING_OFF
M msg_count = 6
M tcode = > <
M act_wp = 3
M last_wp = 3
M client conversation_ID = > <
M server conversation_ID = > <
M lock = 0
M max enq infos = 9
M act enq infos = 2
M em_hyper_hdl = 7fdb33d10398
M plugin_info = NULL
M act_plugin_hdl = -1
M act_plugin_no = 0
M max_plugin_no = 0
M Context Resources:
M HEAD: adr/max_elems/act_elems/tbl = 7fe29094c4e8/0/0/(nil)
M
M ThCheckPrevUser: reset spa state for user T3/U4/M0
M DpLockWpBlkEx: lock wp ca_blk 1
M DpVmcGetVmByTmAdm: no VM found for T3/M0/I0 (locked VMs ignored)
M DpLockAppcBlk: lock appc ca_blk 260
M ThCheckPrevUser: th_step = TH_WORK_SYNC
M set task type ZTTADIA
M ThCleanPrevUser: clean U4 T3 M0 I0 no VM clean state DP_DEFAULT_CLEANING clean counter 1
M ThCleanPrevUser: saved MODE_REC = MODE_REC_SYS
M PfStatDisconnect: disconnect statistics
M ThCleanPrevUser: prv_action of W3: 0x0
M ThRollIn: roll in T3/U4/M0/I0 (level=0x7, abap_level=1, attach_em=1)
M level=ROLLIN_0,ROLLIN_1,ROLLIN_2
M abap level=TH_ABAP_ROLL_IN_STORE
M ThCheckEmState: check ATTACH for em hdl 2
M ThCheckEmState: call EmContextAttach (em_hdl=2)
M ThRollIn: U4 M0 I0 (Level 7) ok
M ThRollIn: roll in abap store
M DpVmcGetVmByTmAdm: no VM found for T3/M0/I0
M DpVmcGetVmByTmAdm: no VM found for T3/M0/I0 (locked VMs ignored)
M ThIAMDel: delete tid/mode 3/0 (th_errno 23, release 1)
M ThTSCancel: set T3/M0 in status MODE_CANCEL
M ThIDeleteMode (3, 0, 3, ><, 0, 255, TRUE)
M ThIDeleteMode: no modes found ..
M no sub modes
M ThSUsrDel: delete system user
M RstrNotifyUserChange: user/client = (SAPSYS /000)
M ThResFree: free resources of U4 M0 I0 (normal mode, complete free) at level 3, errno=23, db_action=TH_DB_NO_ACTION
M ThResFree: reset spa state for user T3/U4/M0
M ThCallHooks: call hook >abTpdaThHook_EModeEnded< for event BEFORE_SESSION_CANCEL
M ThCallHooks: hook >abTpdaThHook_EModeEnded< o.k.
M ThCallHooks: call hook >ITSP: EndOfSession< for event BEFORE_SESSION_CANCEL
M ThCallHooks: hook >ITSP: EndOfSession< o.k.
M ThCallHooks: call hook >abRtmClearSession< for event BEFORE_SESSION_CANCEL
M ThCallHooks: hook >abRtmClearSession< o.k.
M ThCallHooks: call hook >HttpClearSession< for event BEFORE_SESSION_CANCEL
M ThCallHooks: hook >HttpClearSession< o.k.
M ThCallHooks: call hook >SpoolHandleHook< for event BEFORE_SESSION_CANCEL
M ThCallHooks: hook >SpoolHandleHook< o.k.
M PfStatDisconnect: disconnect statistics
M ThDealComm: T3/U4/M0 has no cpic conns
M clean up all internal modes of T3/U4/M0
M call ab_endmode (END_MODE_CLEAR_ALL)
M RstrNotifyUserChange: user/client = (SAPSYS /000)
M ***LOG R47=> ThResFree, delete (001023) [thxxmode.c 1339]
M ThGetTransactionId: got trans id (SPA) >5216F34B2D764C6FE1000000AC175A0A< (32)
M ThEppGetRootContextIdAsUuid: ThEppGetRootContextIdAsXuuid for epp -2 failed (4/TH_EPP_BAD_HANDLE)
M ThEppGetConnectionIdAsUuid: ThEppGetConnectionIdAsXuuid for epp -2 failed (4/TH_EPP_BAD_HANDLE)
M ThFreeVBAndEnqueue: dequeue >20130822193057305671000307cibqs...........................</1
E Enqueue Info: enque/use_pfclock2 = FALSE
E Enqueue Info: row condense enabled
M ThDelEnqInfo: del enq_own >20130822193057305671000307cibqs...........................</1
M ThDelEnqInfo: act enq info: 1
M ThGetEnqInfo: no enq info found
M ThFreeVBAndEnqueue: dequeue >20130822193057305699000307cibqs...........................</2
M ThDelEnqInfo: del enq_own >20130822193057305699000307cibqs...........................</2
M ThDelEnqInfo: act enq info: 0
M ThDelEnqInfo: no enq infos
M ThGetEnqInfo: no enq info found
M ThVBIRollBack: initialize TH-hooks
M SosRegisterHook: add hook >ThVBICmRbHook(1622430)< (condition/order=0xf/0) for event AFTER_COMMIT
M SosRegisterHook: add hook >ThVBICmRbHook(1622430)< (condition/order=0xf/0) for event AFTER_ROLLBACK
M ThRmLocQueue: no async request found
M ThPageFree: free (4,0,0, mode = 3)
M ThRollFree: free (4,0,0, mode = 3)
M ThRmFree: cleanup resources for T3 M0
M RmCleanUpResources3: hdr/tbl/ext_tbl/free/keep = 7fe29094c4e8/(nil)/0/1/0
M RmCleanUpResources3: no resources registered
M ThRmFree: reset eg state of T3 M0
M ThRmFree cleanup resources for T3
M RmCleanUpResources3: hdr/tbl/ext_tbl/free/keep = 7fe290952b10/(nil)/1/1/0
M RmCleanUpResources3: no resources registered
M ThRmFree: reset eg state of T3
M ThInvalidateEnqMem: reset enq memory 7fdb33d0ccb0 of T3/M0
M ThIEmFree: delete hyper context (hyperHdl=7fdb33d10398)
M ThIEmFree: call EmContextDelete (em_hdl=2)
M ThResFree: save spa pointer 7fe2860ec1c0 and install dummy spa
M ThCheckComOrRb (event=1, full_commit=0)
M ThCallHooks: skip hook >ab_SosRfcBeforeCommit< for event BEFORE_COMMIT, (condition IF_ROLLED_IN not true)
M ThCallHooks: skip hook >ASTAT-collect commit handling< for event BEFORE_COMMIT, (condition 0xf not true)
M ThCallHooks: call hook >ASTAT-collect commit handling< for event BEFORE_COMMIT
M ThCallHooks: hook >ASTAT-collect commit handling< o.k.
M ThCallHooks: call hook >rstshpc_hook_prepare_for_commit< for event BEFORE_COMMIT
M ThCallHooks: hook >rstshpc_hook_prepare_for_commit< o.k.
M ThCheckComOrRb (event=3, full_commit=0)
M ThCallHooks: call hook >ThVBICmRbHook< for event AFTER_COMMIT
M ThVBICmRbHook: called for commit
M ThCallHooks: hook >ThVBICmRbHook< o.k.
M ThCallHooks: call hook >ThNoClearPrevErr< for event AFTER_COMMIT
M ThNoClearPrevErr: clear prev no err
M ThCallHooks: hook >ThNoClearPrevErr< o.k.
M ThCallHooks: call hook >dyKeyTableRest< for event AFTER_COMMIT
M ThCallHooks: hook >dyKeyTableRest< o.k.
M ThCallHooks: call hook >rstshwc_hook_was_commit< for event AFTER_COMMIT
M ThCallHooks: hook >rstshwc_hook_was_commit< o.k.
M ThCallHooks: call hook >SpoolHandleHook< for event AFTER_COMMIT
M ThCallHooks: hook >SpoolHandleHook< o.k.
M ThSetThParam : rdisp/thsend_order=0
M rdisp/thsend_order : -1 -> 0
M ThISend: set thsend_order to 0
M ThISend: (T3/M0, user=SAPSYS , type=0x41, info=0x0, mode_deleted=1)
M type=TASK_SWITCH,DISP
M ThCheckAbapDebugging: no valid user or ABAP not no stack, skip check
M ThJCheckJavaDebugging: return 0
M ThrtGetStrategy: abap strategy ROLL / O.K.
M ThRqOutCheck: check output for T3/M0
M ThRqOutCheck: o.k.
M ThISend: allowed rq_type of T3/M0 = TH_ALL_RQ
M ThNewWpStat (type=0x41, task_switch=1, inline_hold=0, hand_shake=0, debug=0, ..)
M ThNewWpStat: new MODE_REC = MODE_REC_SYS
M ThNewWpStat: new state of T3/M0 = MODE_WAIT,MODE_CANCEL,MODE_REC_SYS
M ThNewWpStat: new wp stat: WP_WAIT
M rdisp/wp_auto_restart = 0 sec
M rdisp/wp_abap_restart = 0
M ThSetThToolParam : restartable_wp[0] = FALSE
M ThSetThToolParam : restartable_wp[1] = TRUE
M ThSetThToolParam : restartable_wp[2] = TRUE
M ThSetThToolParam : restartable_wp[3] = FALSE
M ThSetThToolParam : restartable_wp[4] = TRUE
M ThSetThToolParam : restartable_wp[5] = TRUE
M ThSetThToolParam : restartable_wp[6] = TRUE
M ThMkReq: send output to canceled mode
M ThMkReq: detach wp_ca_blk 1
M ThDtWpBlk: detach WP ca_blk 1
M ThISend: complete stat record
M ThCallHooks: call hook >TrThHookFunc< for event COMPLETE_STAT_RECORD
M TrThHookFunc: called for complete stat rec
M ThGetTransactionId: no transaction id found
M TrIGetTransactionId: no transaction-ID received (3)
M ThCallHooks: hook >TrThHookFunc< o.k.
M ThISend: stat_state = TH_STAT_WRITE
M ThSysUsrCheck (1,1): check system user T3/U4/M0
M ThIEmFree: em state of T3/M0 (em_hdl=-1) is DP_EM_NO_CONTEXT
M ThSysUsrCheck: clear T3
M DpITmSlotClear: clear slot T3
M ThISend: th_wp_waits_for_rq = TH_WP_WAITS_FOR_RQ
M make DISP owner of wp_ca_blk 1
M DpRqIPutIntoQ: put elem in queue NOWP, elems=1
M DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 168)
M -OUT- sender_id WORK_PROCESS tid 3 wp_ca_blk 1 wp_id 3
M -OUT- action SEND_TO_DP uid 4 appc_ca_blk -1 type NOWP
M -OUT- new_stat WP_WAIT mode 0 len 8 rq_id 168
M -OUT- req_info CANCELMODE
M ThCheckBlks: th_step = TH_WORK_NOSYNC
M ThCheckBlks: release appc_ca_blk 260
M REL APPC ca_blk 260
M ThDtAppcBlk: detach APPC ca_blk 260
M PfClearAllRec: clear statistic area
M PfStatDisconnect: disconnect statistics
M ThISend: set inPrivMode = 0 for T3/M0
M ThResetActWp: reset act_wp for T3/M0
M ThCallHooks: call hook >TrThHookFunc< for event BEFORE_TASK_SWITCH
M TrThHookFunc: called for task switch
M ThCallHooks: hook >TrThHookFunc< o.k.
M ThCallHooks: call hook >ThPCleanZombiesCallback< for event BEFORE_TASK_SWITCH
M ThCallHooks: hook >ThPCleanZombiesCallback< o.k.
M ThCallHooks: call hook >ImcResetPtr< for event BEFORE_TASK_SWITCH
M ThCallHooks: hook >ImcResetPtr< o.k.
M ThCallHooks: call hook >HttpResetPtr< for event BEFORE_TASK_SWITCH
M ThCallHooks: hook >HttpResetPtr< o.k.
M ThCallHooks: call hook >ThIDbgCallbackBeforeTaskSwitch< for event BEFORE_TASK_SWITCH
M ThCallHooks: hook >ThIDbgCallbackBeforeTaskSwitch< o.k.
M saved task type/act rqtype ZTTADIA/1 of T3/M0
M ThISend: jump back with rc TH_WAIT_FOR_REQUEST
M TskhLoop: switch back to normal tracel level 1
M
M Thu Aug 22 19:31:57 2013
M extStatHook: This process does not report performance statistics
A UpdateProfile (new settings): on,krn_impl,(no dyn check),(no logging),(no stat err),(local generation),(no commit)
A UpdateProfile (new exceptions): tmp_off,(home_err),(local_err)
A UpdateProfile (new version): 0
A UpdateProfile (new maximal defenv size): 10000
A ***GENER* Trace switched off ***
S found spool memory service RSPO-ACTIONS at 7fdb046e0498
B dbrda: Redirect database access is disabled via rsdb/rda profile parameter setting.
C OCIStmtExecute() failed with -1=OCI_ERROR
C SQL error 2289:
C *** ERROR => Error 2289 in stmt_execute() from oci_execute_stmt(), orpc=0
[dbsloci.c 17300]
C {root-id=60EB69BAE0681EE382E7FF5F6984B36F}_{conn-id=00000000000000000000000000000000}_0
C *** ERROR => ORA-02289 occurred at SQL stmt (parse error offset=79)
[dbsloci.c 17301]
C {root-id=60EB69BAE0681EE382E7FF5F6984B36F}_{conn-id=00000000000000000000000000000000}_0
C Dump statement cache:
C sc_p=66978c0,no=16,idc_p=66b25a8,con=0,act=1,slen=121,smax=256,#vars=4,stmt=69bbd20,table=DDLOG
C INSERT INTO DDLOG (SEQNUMBER, TIMESTAMP, SYSTEMID, NBLENGTH, NOTEBOOK) VALUES (DDLOG_SEQ.NEXTVAL, :A\
C 0 , :A1 , :A2 , :A3 );
C Dump statement cache:
C sc_p=66978c0,no=16,idc_p=66b25a8,con=0,act=1,slen=121,smax=256,#vars=4,stmt=69bbd20,table=DDLOG
C Dumping stmt. cache (DBSL private attributes):
C sch=66978c0, scp=66a1630, ups_sch=0000NULL, stp=69b64c8, r_c=0
C prep=0, lit=0, nsql=0, lobret_cnt=0, fae_cnt=0, xop=1, dbcount=0
C IN : col_cnt=4, row_max=1, row_xcnt=1, row_pcnt=0, row_i=140733193388032, row_total=1,
C row_upto=4294967295, row_size=32078, vda_max=32, bound=1, itp=6642780, vda_arr=69bd080
C lob_cnt=0, lob_max=0, lob_pw_cnt=0, lob_arr=0000NULL, rows_ret=0
C OUT: col_cnt=0, row_max=0, row_xcnt=0, row_pcnt=0, row_i=140574279598080, row_total=0,
C row_upto=0, row_size=0, vda_max=0, bound=0, itp=0000NULL, vda_arr=0000NULL
C lob_cnt=0, lob_max=0, lob_pw_cnt=0, lob_arr=0000NULL, rows_ret=0
C INSERT INTO DDLOG (SEQNUMBER, TIMESTAMP, SYSTEMID, NBLENGTH, NOTEBOOK) VALUES (DDLOG_SEQ.NEXTVAL, :A\
C 0 , :A1 , :A2 , :A3 );
B ***LOG BY4=> sql error 2289 performing INS on table DDLOG [dbsynseq 586]
B ***LOG BY0=> ORA-02289: sequence does not exist [dbsynseq 586]
B ***LOG BZY=> unexpected return code 2 calling ins_ddlog [dbsync 1398]
B db_syflush (TRUE) failed
B db_con_commit received error 1024 in before-commit action, returning 8
M ***LOG R38=> ThICommit3, db_commit98 ( 001024) [thxxhead.c 14369]
M ***LOG R18=> ThPrivCommit, ThICommit () [thxxhead.c 15272]
M in_ThErrHandle: 1
M *** ERROR => ThPrivCommit: ThICommit (step 4, th_errno 9, action 2, level 1) [thxxhead.c 11348]
M {root-id=60EB69BAE0681EE382E7FF5F6984B36F}_{conn-id=00000000000000000000000000000000}_0
M DpVmcGetVmByTmAdm: no VM found for T3/M0/I0 (locked VMs ignored)
M ThResetEmMagic: reset em magic for T3/M0/I0
M
M Info for wp 3
M
M pid = 20864
M severity = 0
M status = 0
M stat = WP_RUN
M waiting_for = NO_WAITING
M reqtype = DP_RQ_DIAWP
M act_reqtype = DP_RQ_DIAWP
M req.req_info = BTC_SCHEDULER,SET_SYSTEM_USER
M req.tid = 3
M req.uid = 4
M req.mode = 0
M req.len = 24
M req.rq_id = 179
M req.rq_source = FROM_WP_CA
M last_tid = 3
M last_uid = 4
M last_mode = 0
M act_cs_count = 0
M csTrack = 0
M csTrackRwExcl = 0
M csTrackRwShrd = 0
M mode_cleaned_counter = 0
M control_flag = 0
M int_checked_resource(RFC) = 0
M ext_checked_resource(RFC) = 0
M int_checked_resource(HTTP) = 0
M ext_checked_resource(HTTP) = 0
M report = >SAPMSSY2 <
M action = 0
M tab_name = > <
M attachedVm = no VM
M
M Modeinfo for User T3/M0
M
M tm state = 2
M uid = 4
M term type = 0x2
M display = 0x0
M cpic_no = 0
M cpic_idx = -1
M usr = >SAPSYS <
M terminal = > <
M client = >000<
M conversation_ID = > <
M appc_tm_conv_idx = -1
M its_plugin = NO
M allowCreateMode = YES
M blockSoftCanel = NO
M Session Resources:
M HEAD: adr/max_elems/act_elems/tbl = 7fe290952b10/0/0/(nil)
M imode = 0
M mode state = 0x42
M task_type = ZTTABTC
M lastThFc = THFCBTCH
M lastAction = TH_IACT_NO_ACTION
M th_errno = SAP commit failed, session terminated (9)
M rollout_reason = 0
M last_rollout_level = 0
M async_receives = 0
M cpic_receive = 0
M em handle = 0
M roll state = DP_ROLL_INITIALIZED
M abap state = DP_ROLL_INITIALIZED
M em state = DP_EM_ATTACHED
M eg state = DP_EM_NO_CONTEXT
M spa state = DP_SPA_INITIALIZED
M enq state = 0
M softcancel = 0
M cancelInitiator = ?
M clean_state = DP_DEFAULT_CLEANING
M next hook = T-1/U-1/M255
M master hook = T-1/U-1/M255
M slave hook = T-1/U-1/M255