Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250707220007\orcl_j003_1220_bucket.trc Oracle Database 11g Enterprise Edition Release 11.2.0.1.0 - 64bit Production With the Partitioning, OLAP, Data Mining and Real Application Testing options Windows NT Version V6.2 CPU : 32 - type 8664, 16 Physical Cores Process Affinity : 0x0x0000000000000000 Memory (Avail/Total): Ph:36639M/63366M, Ph+PgF:42679M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 1220, image: ORACLE.EXE (J003) *** 2025-07-07 22:00:07.259 *** SESSION ID:(233.28273) 2025-07-07 22:00:07.259 *** 2025-07-07 22:00:07.259 Process diagnostic dump for ORACLE.EXE (J003), OS id=1220, pid: 29, proc_ser: 64, sid: 233, sess_ser: 28273 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 1220 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J003) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_12720, hash value=1864633256 Current Wait Stack: Not in wait; last wait ended 0.718039 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.718065 sec since last wait 0: waited for 'Disk file operations I/O' FileOperation=0x5, fileno=0x0, filetype=0x3 wait_id=149 seq_num=150 snap_id=1 wait times: snap=0.000332 sec, exc=0.000332 sec, total=0.000332 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000006 sec of elapsed time 1: waited for 'log file sequential read' log#=0x28e7, block#=0x0, blocks=0x0 wait_id=148 seq_num=149 snap_id=1 wait times: snap=0.000004 sec, exc=0.000004 sec, total=0.000004 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.026732 sec of elapsed time 2: waited for 'log file sequential read' log#=0x28e7, block#=0x0, blocks=0x0 wait_id=147 seq_num=148 snap_id=1 wait times: snap=0.000016 sec, exc=0.000016 sec, total=0.000016 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000011 sec of elapsed time 3: waited for 'log file sequential read' log#=0x0, block#=0x6000, blocks=0x800 wait_id=146 seq_num=147 snap_id=1 wait times: snap=0.000311 sec, exc=0.000311 sec, total=0.000311 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time 4: waited for 'log file sequential read' log#=0x0, block#=0x5800, blocks=0x800 wait_id=145 seq_num=146 snap_id=1 wait times: snap=0.000323 sec, exc=0.000323 sec, total=0.000323 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000015 sec of elapsed time 5: waited for 'log file sequential read' log#=0x0, block#=0x5000, blocks=0x800 wait_id=144 seq_num=145 snap_id=1 wait times: snap=0.003422 sec, exc=0.003422 sec, total=0.003422 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000012 sec of elapsed time 6: waited for 'log file sequential read' log#=0x0, block#=0x4800, blocks=0x800 wait_id=143 seq_num=144 snap_id=1 wait times: snap=0.001214 sec, exc=0.001214 sec, total=0.001214 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000016 sec of elapsed time 7: waited for 'log file sequential read' log#=0x0, block#=0x4000, blocks=0x800 wait_id=142 seq_num=143 snap_id=1 wait times: snap=0.005147 sec, exc=0.005147 sec, total=0.005147 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000083 sec of elapsed time 8: waited for 'log file sequential read' log#=0x0, block#=0x3800, blocks=0x800 wait_id=141 seq_num=142 snap_id=1 wait times: snap=0.004031 sec, exc=0.004031 sec, total=0.004031 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.492133 sec of elapsed time 9: waited for 'log file sequential read' log#=0x28e7, block#=0x800, blocks=0x800 wait_id=140 seq_num=141 snap_id=1 wait times: snap=0.000216 sec, exc=0.000216 sec, total=0.000216 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.001817 sec of elapsed time Sampled Session History of session 233 serial 28273 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [7 samples, 22:00:00 - 22:00:06] not in wait at each sample [1 sample, 21:59:59] idle wait at each sample [session created at: 22:00:00] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-07 22:00:07.259 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 1220, J003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-06 22:02:09.258176 :AE7B9D2F:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 22:02:09.258176 :AE7B9D30:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=108 time=520105158 2025-07-06 22:02:09.258177 :AE7B9D31:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 22:02:09.258177 :AE7B9D32:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 22:02:09.258178 :AE7B9D33:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 22:02:09.258178 :AE7B9D34:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 22:02:09.258178 :AE7B9D35:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 22:02:09.258943 :AE7B9D36:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-06 22:02:39.355674 :AE7BAB01:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 23:59:07.930770 :AE8587FE:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 23:59:07.921 2025-07-06 23:59:07.930772 :AE8587FF:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=8336 pso_num=29 pso_serial#=54 2025-07-06 23:59:07.930909 :AE858800:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=8336 (legacy spawn) 2025-07-06 23:59:07.957228 :AE858801:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 23:59:07.957400 :AE85880A:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-06 23:59:07.958219 :AE85880B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 23:59:11.548735 :AE858983:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 23:59:11.547 2025-07-06 23:59:11.548738 :AE858984:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15280 pso_num=29 pso_serial#=55 2025-07-06 23:59:11.548889 :AE858985:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=15280 (legacy spawn) 2025-07-06 23:59:11.565817 :AE858986:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 23:59:14.826956 :AE858A9D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 23:59:14.827129 :AE858AA6:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-06 23:59:14.828462 :AE858AA7:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 23:59:15.089006 :AE858AF7:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 23:59:15.079 2025-07-06 23:59:15.089008 :AE858AF8:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14828 pso_num=29 pso_serial#=56 2025-07-06 23:59:15.089146 :AE858AF9:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14828 (legacy spawn) 2025-07-06 23:59:15.103870 :AE858AFA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 23:59:48.230711 :AE85975E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 23:59:48.316740 :AE859761:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 23:59:48.306 2025-07-06 23:59:48.316742 :AE859762:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13012 pso_num=29 pso_serial#=57 2025-07-06 23:59:48.316882 :AE859763:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13012 (legacy spawn) 2025-07-06 23:59:48.330952 :AE859764:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 23:59:51.606670 :AE8598A6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 23:59:51.606698 :AE8598A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 23:59:51.606857 :AE8598AC:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-06 23:59:51.608076 :AE8598BD:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 23:59:51.860779 :AE8598C0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 23:59:51.856 2025-07-06 23:59:51.860781 :AE8598C1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=2960 pso_num=29 pso_serial#=58 2025-07-06 23:59:51.860912 :AE8598C2:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=2960 (legacy spawn) 2025-07-06 23:59:51.875563 :AE8598C4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 00:00:25.019405 :AE85A694:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-07 01:00:07.438344 :AE8A7360:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-07 01:00:07.433 2025-07-07 01:00:07.438346 :AE8A7361:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17968 pso_num=29 pso_serial#=59 2025-07-07 01:00:07.438486 :AE8A7362:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=17968 osp_idx=27 osp_ver=14083 osp_pg=0 (spawn #359598) 2025-07-07 01:00:07.438487 :AE8A7363:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-07 01:00:07.438487 :AE8A7364:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=109 time=530783329 2025-07-07 01:00:07.438488 :AE8A7365:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-07 01:00:07.438488 :AE8A7366:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-07 01:00:07.438488 :AE8A7367:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-07 01:00:07.438489 :AE8A7368:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-07 01:00:07.438489 :AE8A7369:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-07 01:00:07.438986 :AE8A736A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.439031 :AE8A7370:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-07 01:00:07.443486 :AE8A7383:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.467794 :AE8A738B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.482132 :AE8A7393:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.511300 :AE8A739B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.514907 :AE8A73A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.515291 :AE8A73AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.519058 :AE8A73B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.521698 :AE8A73BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.523530 :AE8A73C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.524665 :AE8A73CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:07.528188 :AE8A73D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:08.791019 :AE8A743C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:08.826388 :AE8A7444:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:08.826799 :AE8A744C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:08.827142 :AE8A7454:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:08.827164 :AE8A7457:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:08.827224 :AE8A7463:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-07 01:00:08.830678 :AE8A7471:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-07 01:00:24.915567 :AE8A79C3:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-07 01:00:24.904 2025-07-07 01:00:24.915568 :AE8A79C4:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=4904 pso_num=29 pso_serial#=60 2025-07-07 01:00:24.915701 :AE8A79C5:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=4904 (legacy spawn) 2025-07-07 01:00:24.922204 :AE8A79C6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:24.922385 :AE8A79CB:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-07 01:00:24.923183 :AE8A79D0:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-07 01:00:29.307734 :AE8A7C64:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-07 01:00:29.293 2025-07-07 01:00:29.307736 :AE8A7C65:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=6844 pso_num=29 pso_serial#=61 2025-07-07 01:00:29.307873 :AE8A7C66:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=6844 (legacy spawn) 2025-07-07 01:00:29.314383 :AE8A7C8F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:29.314546 :AE8A7C96:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-07 01:00:29.315404 :AE8A7C99:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-07 01:00:29.332577 :AE8A7C9C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-07 01:00:29.325 2025-07-07 01:00:29.332579 :AE8A7C9D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=4660 pso_num=29 pso_serial#=62 2025-07-07 01:00:29.332728 :AE8A7C9E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=4660 (legacy spawn) 2025-07-07 01:00:29.339252 :AE8A7C9F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 01:00:29.339420 :AE8A7CA8:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-07 01:00:29.340284 :AE8A7CA9:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-07 16:00:02.458904 :AED29730:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-07 16:00:02.446 2025-07-07 16:00:02.458906 :AED29731:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13084 pso_num=29 pso_serial#=63 2025-07-07 16:00:02.459030 :AED29732:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13084 osp_idx=27 osp_ver=14087 osp_pg=0 (spawn #361678) 2025-07-07 16:00:02.459030 :AED29733:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-07 16:00:02.459031 :AED29734:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=110 time=584778345 2025-07-07 16:00:02.459031 :AED29735:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-07 16:00:02.459031 :AED29736:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-07 16:00:02.459032 :AED29737:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-07 16:00:02.459032 :AED29738:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-07 16:00:02.459032 :AED29739:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-07 16:00:02.459476 :AED2973A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.459510 :AED29740:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-07 16:00:02.469691 :AED2974E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.471116 :AED29756:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.471879 :AED2975E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.472466 :AED29766:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.473039 :AED2976E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.476225 :AED29776:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.477751 :AED297A6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.546890 :AED297AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.547774 :AED297B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.548023 :AED297BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.548236 :AED297C6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 16:00:02.550071 :AED297CE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-07 22:00:00.748519 :AEEF6048:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-07 22:00:00.740 2025-07-07 22:00:00.748519 :AEEF6049:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=1220 pso_num=29 pso_serial#=64 2025-07-07 22:00:00.748649 :AEEF604F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=1220 osp_idx=27 osp_ver=14088 osp_pg=0 (spawn #362512) 2025-07-07 22:00:00.748650 :AEEF6050:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-07 22:00:00.748650 :AEEF6051:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=111 time=606376642 2025-07-07 22:00:00.748651 :AEEF6052:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-07 22:00:00.748651 :AEEF6053:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-07 22:00:00.748652 :AEEF6054:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-07 22:00:00.748653 :AEEF6055:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-07 22:00:00.748653 :AEEF6056:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-07 22:00:00.749237 :AEEF605F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.754411 :AEEF607C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.754439 :AEEF607F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-07-07 22:00:00.772697 :AEEF6102:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.772914 :AEEF610A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.773087 :AEEF6112:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.773246 :AEEF611A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.773407 :AEEF6122:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.773578 :AEEF612A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.773752 :AEEF6132:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.773901 :AEEF613A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.774068 :AEEF6142:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.774317 :AEEF614A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.774493 :AEEF6152:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.774646 :AEEF615A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.774807 :AEEF6162:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.774993 :AEEF616A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.775168 :AEEF6172:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.775327 :AEEF617A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.775491 :AEEF6182:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.775645 :AEEF618A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.775796 :AEEF6192:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.775953 :AEEF619A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.776115 :AEEF61A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.776266 :AEEF61AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.776419 :AEEF61B2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.777268 :AEEF61BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.777522 :AEEF61C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:00.805502 :AEEF61CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:02.099801*:AEEF65D7:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000030183AD0 estart=1751896802 eid=20185698 ctx=0x0000000777968158 cwh=0x000000004C380158 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-07-07 22:00:02.099801*:AEEF65D8:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000030183AD0 curCtx=0x000000004C281BF8 pubTabIdxCnt=0 2025-07-07 22:00:02.099801*:AEEF65D9:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000030183AD0 2025-07-07 22:00:02.099801*:AEEF65DA:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000030183AD0 2025-07-07 22:00:02.099801*:AEEF65DB:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000301FB6F0 estart=1751896800 eid=16777441 ctx=0x000000077B54EAC8 cwh=0x00000000301F0068 cpu=1078125 buffg=58898 interb=196608 r=24 rb=196608 w=0 wb=0 2025-07-07 22:00:02.099801*:AEEF65DC:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000301FB6F0 curCtx=0x000000004AE77FD8 pubTabIdxCnt=0 2025-07-07 22:00:02.099801*:AEEF65DD:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000301FB6F0 2025-07-07 22:00:02.099801*:AEEF65DE:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000301FB6F0 2025-07-07 22:00:02.099801*:AEEF65DF:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000030183AD0 curCtx=0x000000004C281BF8 xsc->flg4=65792 flags=1 2025-07-07 22:00:02.099801*:AEEF65E0:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000030183AD0 2025-07-07 22:00:02.522351 :AEEF669C:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 9, ext 2, nex 3 2025-07-07 22:00:02.522361 :AEEF669D:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00815e06 where: kdiwh22: kdifind 2025-07-07 22:00:02.522361*:AEEF66A7:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000301FB6F0 curCtx=0x000000004AE77FD8 xsc->flg4=65792 flags=2 2025-07-07 22:00:02.522361*:AEEF66A8:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000301FB6F0 2025-07-07 22:00:02.525784 :AEEF66A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:02.548436 :AEEF66C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:02.550705 :AEEF66D3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.550965 :AEEF66D4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.552189 :AEEF66DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:02.552315 :AEEF66E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:02.553372 :AEEF66F6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:02.555384 :AEEF66FE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:02.555788 :AEEF6706:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:02.615433*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-07-07 22:00:02.615433*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-07-07 22:00:02.615433*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-07-07 22:00:02.631063*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-07-07 22:00:02.631063*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-07-07 22:00:02.631063*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-07-07 22:00:02.631063*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-07-07 22:00:02.709970 :AEEF6775:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:04.622209 :AEEF689E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:04.622220 :AEEF689F:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0009.010.0001d187 2025-07-07 22:00:07.016352 :AEEF6A3E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:07.018082 :AEEF6A46:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:07.029461 :AEEF6A4E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-07 22:00:07.056364 :AEEF6A56:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 1220, J003)