Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250803180911\orcl_j002_18604_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:35775M/63366M, Ph+PgF:41408M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 18604, image: ORACLE.EXE (J002) *** 2025-08-03 18:09:11.997 *** SESSION ID:(225.5059) 2025-08-03 18:09:11.997 *** 2025-08-03 18:09:11.997 Process diagnostic dump for ORACLE.EXE (J002), OS id=18604, pid: 28, proc_ser: 46, sid: 225, sess_ser: 5059 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 18604 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.240841 sec, exc=0.240841 sec, total=0.240841 sec wait times: max=0.500000 sec, heur=4.238699 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000010 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499985 sec, exc=0.499985 sec, total=0.499985 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.500008 sec, exc=0.500008 sec, total=0.500008 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.502924 sec, exc=0.502924 sec, total=0.502924 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.501076 sec, exc=0.501076 sec, total=0.501076 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500006 sec, exc=0.500006 sec, total=0.500006 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.493796 sec, exc=0.493796 sec, total=0.493796 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 225 serial 5059 --------------------------------------------------- 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 --------------------------------------------------- [5 samples, 18:09:07 - 18:09:11] idle wait at each sample [session created at: 18:09:07] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-03 18:09:11.997 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 18604, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-03 18:04:49.696472 :BAE0535D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=15000 (legacy spawn) 2025-08-03 18:04:49.702978 :BAE0535E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:04:49.703151 :BAE05363:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:04:49.703959 :BAE05368:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:04:49.712691 :BAE0536B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:04:49.699 2025-08-03 18:04:49.712693 :BAE0536C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=7960 pso_num=28 pso_serial#=19 2025-08-03 18:04:49.712826 :BAE0536D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=7960 (legacy spawn) 2025-08-03 18:04:49.719349 :BAE0536E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:04:49.719522 :BAE05377:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:04:49.720384 :BAE05378:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:04:54.705194 :BAE0551E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:04:54.704 2025-08-03 18:04:54.705197 :BAE0551F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19556 pso_num=28 pso_serial#=20 2025-08-03 18:04:54.705330 :BAE05520:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19556 (legacy spawn) 2025-08-03 18:04:54.711779 :BAE05521:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:04:54.711959 :BAE05526:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:04:54.712766 :BAE0552B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:04:54.721454 :BAE0552E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:04:54.719 2025-08-03 18:04:54.721456 :BAE0552F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19760 pso_num=28 pso_serial#=21 2025-08-03 18:04:54.721585 :BAE05530:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19760 (legacy spawn) 2025-08-03 18:04:54.728011 :BAE05531:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:04:54.728168 :BAE0553A:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:04:54.728979 :BAE0553B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:05:41.134307 :BAE0658D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:05:41.125 2025-08-03 18:05:41.134310 :BAE0658E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20152 pso_num=28 pso_serial#=22 2025-08-03 18:05:41.134454 :BAE0658F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20152 (legacy spawn) 2025-08-03 18:05:41.140984 :BAE06590:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:05:41.141145 :BAE06595:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:05:41.141954 :BAE0659A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:05:41.649322 :BAE065B0:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:05:41.645 2025-08-03 18:05:41.649324 :BAE065B1:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20420 pso_num=28 pso_serial#=23 2025-08-03 18:05:41.649459 :BAE065B2:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20420 (legacy spawn) 2025-08-03 18:05:41.655922 :BAE065B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:05:41.656097 :BAE065B8:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:05:41.656939 :BAE065BD:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:05:59.202474 :BAE070D7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:05:59.198 2025-08-03 18:05:59.202476 :BAE070D8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10620 pso_num=28 pso_serial#=24 2025-08-03 18:05:59.202602 :BAE070D9:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=10620 (legacy spawn) 2025-08-03 18:05:59.208783 :BAE070DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:05:59.208949 :BAE070DF:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:05:59.211458 :BAE070E4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:05:59.219311 :BAE070E7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:05:59.214 2025-08-03 18:05:59.219313 :BAE070E8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18208 pso_num=28 pso_serial#=25 2025-08-03 18:05:59.219459 :BAE070E9:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18208 (legacy spawn) 2025-08-03 18:05:59.234326 :BAE070EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:05:59.234515 :BAE070F3:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:05:59.235349 :BAE070F4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:05:59.566213 :BAE070F7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:05:59.558 2025-08-03 18:05:59.566215 :BAE070F8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19700 pso_num=28 pso_serial#=26 2025-08-03 18:05:59.566368 :BAE070F9:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19700 (legacy spawn) 2025-08-03 18:05:59.572843 :BAE070FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:05:59.573028 :BAE07103:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:05:59.573822 :BAE07112:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:06:02.378222 :BAE071F8:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:06:02.365 2025-08-03 18:06:02.378224 :BAE071F9:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11076 pso_num=28 pso_serial#=27 2025-08-03 18:06:02.378362 :BAE071FA:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11076 (legacy spawn) 2025-08-03 18:06:02.384887 :BAE071FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:06:02.385049 :BAE07200:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:06:02.385865 :BAE07205:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:06:02.394497 :BAE07208:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:06:02.380 2025-08-03 18:06:02.394499 :BAE07209:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=3328 pso_num=28 pso_serial#=28 2025-08-03 18:06:02.394634 :BAE0720A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=3328 (legacy spawn) 2025-08-03 18:06:02.401105 :BAE0720B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:06:02.401275 :BAE07214:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:06:02.402123 :BAE07215:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:06:12.736575 :BAE07561:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:06:12.728 2025-08-03 18:06:12.736577 :BAE07562:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19340 pso_num=28 pso_serial#=29 2025-08-03 18:06:12.736712 :BAE07563:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19340 (legacy spawn) 2025-08-03 18:06:12.743213 :BAE07564:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:06:12.743391 :BAE07569:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:06:12.744209 :BAE0756E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:06:15.054099 :BAE07625:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:06:15.045 2025-08-03 18:06:15.054101 :BAE07626:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=4556 pso_num=28 pso_serial#=30 2025-08-03 18:06:15.054238 :BAE07627:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=4556 (legacy spawn) 2025-08-03 18:06:15.060734 :BAE07628:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:06:15.060921 :BAE0762D:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:06:15.061712 :BAE07632:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:06:38.777379 :BAE07E3E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:06:38.764 2025-08-03 18:06:38.777381 :BAE07E3F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18404 pso_num=28 pso_serial#=31 2025-08-03 18:06:38.777516 :BAE07E40:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18404 (legacy spawn) 2025-08-03 18:06:38.784107 :BAE07E69:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:06:38.784283 :BAE07E6E:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:06:38.785089 :BAE07E73:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:06:38.793757 :BAE07E76:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:06:38.780 2025-08-03 18:06:38.793758 :BAE07E77:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20144 pso_num=28 pso_serial#=32 2025-08-03 18:06:38.793901 :BAE07E78:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20144 (legacy spawn) 2025-08-03 18:06:38.800402 :BAE07E79:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:06:38.800580 :BAE07E82:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:06:38.801377 :BAE07E83:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:06:43.793005 :BAE0800E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:06:43.785 2025-08-03 18:06:43.793007 :BAE0800F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19624 pso_num=28 pso_serial#=33 2025-08-03 18:06:43.793141 :BAE08010:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19624 (legacy spawn) 2025-08-03 18:06:43.799602 :BAE08011:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:06:43.799785 :BAE08016:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:06:43.800657 :BAE0801B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:06:49.324068 :BAE08202:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:06:49.315 2025-08-03 18:06:49.324069 :BAE08203:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=15304 pso_num=28 pso_serial#=34 2025-08-03 18:06:49.324211 :BAE08204:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=15304 (legacy spawn) 2025-08-03 18:06:49.330794 :BAE08205:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:06:49.330957 :BAE0820A:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:06:49.331780 :BAE0820F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:07:45.925139 :BAE09463:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:07:45.916 2025-08-03 18:07:45.925141 :BAE09464:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19680 pso_num=28 pso_serial#=35 2025-08-03 18:07:45.925283 :BAE09465:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19680 (legacy spawn) 2025-08-03 18:07:45.932001 :BAE09466:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:07:45.932183 :BAE0946B:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:07:45.933046 :BAE09470:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:07:48.190873 :BAE09532:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:07:48.176 2025-08-03 18:07:48.190875 :BAE09533:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18920 pso_num=28 pso_serial#=36 2025-08-03 18:07:48.191017 :BAE09534:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18920 (legacy spawn) 2025-08-03 18:07:48.197700 :BAE09541:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:07:48.197879 :BAE09546:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:07:48.198684 :BAE0954B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:07:48.207700 :BAE0954E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:07:48.208 2025-08-03 18:07:48.207702 :BAE0954F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19764 pso_num=28 pso_serial#=37 2025-08-03 18:07:48.207844 :BAE09550:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19764 (legacy spawn) 2025-08-03 18:07:48.214672 :BAE09551:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:07:48.214860 :BAE0955A:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:07:48.215740 :BAE0955B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:07:51.321655 :BAE09648:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:07:51.311 2025-08-03 18:07:51.321657 :BAE09649:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=5196 pso_num=28 pso_serial#=38 2025-08-03 18:07:51.321794 :BAE0964A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=5196 (legacy spawn) 2025-08-03 18:07:51.328363 :BAE0964B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:07:51.328549 :BAE09650:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:07:51.329380 :BAE09655:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:07:51.338014 :BAE09658:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:07:51.327 2025-08-03 18:07:51.338016 :BAE09659:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18648 pso_num=28 pso_serial#=39 2025-08-03 18:07:51.338157 :BAE0965A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18648 (legacy spawn) 2025-08-03 18:07:51.344759 :BAE0965B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:07:51.344922 :BAE09663:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:07:51.345747 :BAE09665:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:07:57.356376 :BAE09856:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:07:57.341 2025-08-03 18:07:57.356378 :BAE09857:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=15644 pso_num=28 pso_serial#=40 2025-08-03 18:07:57.356526 :BAE09858:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=15644 (legacy spawn) 2025-08-03 18:07:57.363232 :BAE09859:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:07:57.363418 :BAE09862:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:07:57.364238 :BAE09863:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:09:01.200937 :BAE0B0FB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:09:01.197 2025-08-03 18:09:01.200939 :BAE0B0FC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=3292 pso_num=28 pso_serial#=41 2025-08-03 18:09:01.201081 :BAE0B0FD:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=3292 (legacy spawn) 2025-08-03 18:09:01.207539 :BAE0B0FE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:09:01.207715 :BAE0B103:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:09:01.208511 :BAE0B108:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:09:01.217330 :BAE0B10B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:09:01.213 2025-08-03 18:09:01.217333 :BAE0B10C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18956 pso_num=28 pso_serial#=42 2025-08-03 18:09:01.217477 :BAE0B10D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18956 (legacy spawn) 2025-08-03 18:09:01.224066 :BAE0B10E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:09:01.224222 :BAE0B117:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:09:01.225017 :BAE0B118:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:09:04.584059 :BAE0B249:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:09:04.571 2025-08-03 18:09:04.584061 :BAE0B24A:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19348 pso_num=28 pso_serial#=43 2025-08-03 18:09:04.584200 :BAE0B24B:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19348 (legacy spawn) 2025-08-03 18:09:04.590662 :BAE0B24C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:09:04.590841 :BAE0B251:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:09:04.591675 :BAE0B256:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:09:04.600333 :BAE0B259:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:09:04.586 2025-08-03 18:09:04.600335 :BAE0B25A:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=1400 pso_num=28 pso_serial#=44 2025-08-03 18:09:04.600477 :BAE0B25B:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=1400 (legacy spawn) 2025-08-03 18:09:04.606984 :BAE0B25C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:09:04.607154 :BAE0B264:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:09:04.607968 :BAE0B265:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:09:05.720370 :BAE0B28F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:09:05.711 2025-08-03 18:09:05.720372 :BAE0B290:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18796 pso_num=28 pso_serial#=45 2025-08-03 18:09:05.720505 :BAE0B291:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18796 (legacy spawn) 2025-08-03 18:09:05.726978 :BAE0B292:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 18:09:05.727144 :BAE0B29B:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-03 18:09:05.727939 :BAE0B29C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-03 18:09:07.763588 :BAE0B5A6:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-03 18:09:07.758 2025-08-03 18:09:07.763590 :BAE0B5A7:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18604 pso_num=28 pso_serial#=46 2025-08-03 18:09:07.763725 :BAE0B5A8:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=18604 osp_idx=26 osp_ver=198994 osp_pg=0 (spawn #451960) 2025-08-03 18:09:07.763727 :BAE0B5A9:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 18:09:07.763727 :BAE0B5AA:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=37 time=2925217064 2025-08-03 18:09:07.763728 :BAE0B5AB:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 18:09:07.763728 :BAE0B5AC:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 18:09:07.763728 :BAE0B5AD:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 18:09:07.763729 :BAE0B5AE:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 18:09:07.763729 :BAE0B5AF:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 18:09:07.764232 :BAE0B5B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 28 (osid: 18604, J002)