Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250615180856\orcl_j002_14592_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:36634M/63366M, Ph+PgF:43117M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 14592, image: ORACLE.EXE (J002) *** 2025-06-15 18:08:56.113 *** SESSION ID:(219.17503) 2025-06-15 18:08:56.113 *** 2025-06-15 18:08:56.113 Process diagnostic dump for ORACLE.EXE (J002), OS id=14592, pid: 27, proc_ser: 30, sid: 219, sess_ser: 17503 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 14592 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.445211 sec, exc=0.445211 sec, total=0.445211 sec wait times: max=0.500000 sec, heur=4.449229 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.000009 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.500003 sec, exc=0.500003 sec, total=0.500003 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 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.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 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.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 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.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 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.499973 sec, exc=0.499973 sec, total=0.499973 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000020 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.510115 sec, exc=0.510115 sec, total=0.510115 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 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.499966 sec, exc=0.499966 sec, total=0.499966 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 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.493884 sec, exc=0.493884 sec, total=0.493884 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 219 serial 17503 --------------------------------------------------- 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:08:51 - 18:08:56] idle wait at each sample [session created at: 18:08:51] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-15 18:08:56.113 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 14592, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-15 18:03:16.126128 :A51D1364:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16692 (legacy spawn) 2025-06-15 18:03:16.132560 :A51D1365:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:03:16.132739 :A51D136D:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:03:16.133553 :A51D136F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:03:16.142281 :A51D1372:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:03:16.126 2025-06-15 18:03:16.142283 :A51D1373:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14540 pso_num=27 pso_serial#=3 2025-06-15 18:03:16.142448 :A51D1374:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14540 (legacy spawn) 2025-06-15 18:03:16.148914 :A51D1375:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:03:16.149075 :A51D137E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:03:16.149873 :A51D137F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:03:19.206858 :A51D147D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:03:19.194 2025-06-15 18:03:19.206859 :A51D147E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13924 pso_num=27 pso_serial#=4 2025-06-15 18:03:19.206997 :A51D147F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13924 (legacy spawn) 2025-06-15 18:03:19.213556 :A51D1480:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:03:19.213729 :A51D1488:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:03:19.214571 :A51D148A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:03:19.223337 :A51D148D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:03:19.209 2025-06-15 18:03:19.223340 :A51D148E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15596 pso_num=27 pso_serial#=5 2025-06-15 18:03:19.223478 :A51D148F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15596 (legacy spawn) 2025-06-15 18:03:19.229972 :A51D1490:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:03:19.230136 :A51D1498:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:03:19.230966 :A51D149A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:04:07.435970 :A51D24B3:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:04:07.428 2025-06-15 18:04:07.435972 :A51D24B4:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9964 pso_num=27 pso_serial#=6 2025-06-15 18:04:07.436108 :A51D24B5:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9964 (legacy spawn) 2025-06-15 18:04:07.442612 :A51D24B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:04:07.442788 :A51D24BF:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:04:07.443608 :A51D24C0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:04:11.014301 :A51D25D4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:04:11.006 2025-06-15 18:04:11.014304 :A51D25D5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15148 pso_num=27 pso_serial#=7 2025-06-15 18:04:11.014442 :A51D25D6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15148 (legacy spawn) 2025-06-15 18:04:11.020955 :A51D25D7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:04:11.021137 :A51D25DF:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:04:11.021952 :A51D25E1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:05:05.197848 :A51D3790:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:05:05.183 2025-06-15 18:05:05.197850 :A51D3791:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14620 pso_num=27 pso_serial#=8 2025-06-15 18:05:05.197994 :A51D3792:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14620 (legacy spawn) 2025-06-15 18:05:05.204375 :A51D379E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:05:05.204546 :A51D37A3:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:05:05.205372 :A51D37A8:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:05:05.214124 :A51D37AB:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:05:05.198 2025-06-15 18:05:05.214126 :A51D37AC:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15768 pso_num=27 pso_serial#=9 2025-06-15 18:05:05.214281 :A51D37AD:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15768 (legacy spawn) 2025-06-15 18:05:05.220774 :A51D37AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:05:05.220937 :A51D37B7:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:05:05.221750 :A51D37B8:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:05:08.414793 :A51D38D8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:05:08.401 2025-06-15 18:05:08.414795 :A51D38D9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15220 pso_num=27 pso_serial#=10 2025-06-15 18:05:08.414930 :A51D38DA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15220 (legacy spawn) 2025-06-15 18:05:08.421546 :A51D38DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:05:08.421714 :A51D38E0:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:05:08.422508 :A51D38E5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:05:08.431254 :A51D38E8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:05:08.417 2025-06-15 18:05:08.431256 :A51D38E9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15292 pso_num=27 pso_serial#=11 2025-06-15 18:05:08.431385 :A51D38EA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15292 (legacy spawn) 2025-06-15 18:05:08.438331 :A51D38EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:05:08.438500 :A51D38F4:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:05:08.439345 :A51D38F5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:05:09.565695 :A51D3978:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:05:09.557 2025-06-15 18:05:09.565698 :A51D3979:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16600 pso_num=27 pso_serial#=12 2025-06-15 18:05:09.565835 :A51D397A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16600 (legacy spawn) 2025-06-15 18:05:09.572278 :A51D397B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:05:09.572450 :A51D3984:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:05:09.573355 :A51D3985:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:05:19.341252 :A51D3C56:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:05:19.332 2025-06-15 18:05:19.341254 :A51D3C57:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14760 pso_num=27 pso_serial#=13 2025-06-15 18:05:19.341391 :A51D3C58:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14760 (legacy spawn) 2025-06-15 18:05:19.347907 :A51D3C59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:05:19.348112 :A51D3C5E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:05:19.348941 :A51D3C63:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:06:17.720273 :A51D5626:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:06:17.705 2025-06-15 18:06:17.720275 :A51D5627:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12152 pso_num=27 pso_serial#=14 2025-06-15 18:06:17.720416 :A51D5628:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12152 (legacy spawn) 2025-06-15 18:06:17.726964 :A51D5629:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:06:17.727144 :A51D562E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:06:17.727949 :A51D5633:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:06:17.736767 :A51D5636:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:06:17.736 2025-06-15 18:06:17.736769 :A51D5637:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13316 pso_num=27 pso_serial#=15 2025-06-15 18:06:17.736904 :A51D5638:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13316 (legacy spawn) 2025-06-15 18:06:17.743404 :A51D5639:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:06:17.743577 :A51D5642:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:06:17.744407 :A51D5643:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:06:20.806675 :A51D5737:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:06:20.794 2025-06-15 18:06:20.806677 :A51D5738:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14636 pso_num=27 pso_serial#=16 2025-06-15 18:06:20.806812 :A51D5739:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14636 (legacy spawn) 2025-06-15 18:06:20.827926 :A51D573A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:06:20.828101 :A51D573F:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:06:20.828931 :A51D5744:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:06:20.837689 :A51D5747:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:06:20.825 2025-06-15 18:06:20.837691 :A51D5748:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15152 pso_num=27 pso_serial#=17 2025-06-15 18:06:20.837824 :A51D5749:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15152 (legacy spawn) 2025-06-15 18:06:20.844375 :A51D574A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:06:20.844558 :A51D5753:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:06:20.845373 :A51D5754:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:06:57.116692 :A51D644D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:06:57.103 2025-06-15 18:06:57.116694 :A51D644E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12488 pso_num=27 pso_serial#=18 2025-06-15 18:06:57.116838 :A51D644F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12488 (legacy spawn) 2025-06-15 18:06:57.123313 :A51D6450:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:06:57.123473 :A51D6459:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:06:57.124273 :A51D645A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:06:57.133007 :A51D645D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:06:57.119 2025-06-15 18:06:57.133011 :A51D645E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16300 pso_num=27 pso_serial#=19 2025-06-15 18:06:57.133147 :A51D645F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16300 (legacy spawn) 2025-06-15 18:06:57.139700 :A51D6460:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:06:57.139867 :A51D6469:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:06:57.140673 :A51D646A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:07:01.471113 :A51D65C6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:07:01.462 2025-06-15 18:07:01.471116 :A51D65C7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16132 pso_num=27 pso_serial#=20 2025-06-15 18:07:01.471248 :A51D65C8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16132 (legacy spawn) 2025-06-15 18:07:01.477825 :A51D65D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:07:01.477994 :A51D65DA:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:07:01.478827 :A51D65DB:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:07:13.941415 :A51D69AF:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:07:13.933 2025-06-15 18:07:13.941417 :A51D69B0:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14996 pso_num=27 pso_serial#=21 2025-06-15 18:07:13.941556 :A51D69B1:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14996 (legacy spawn) 2025-06-15 18:07:13.948150 :A51D69B2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:07:13.948331 :A51D69B8:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:07:13.949180 :A51D69BC:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:06.497267 :A51D7AF3:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:06.482 2025-06-15 18:08:06.497269 :A51D7AF4:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14744 pso_num=27 pso_serial#=22 2025-06-15 18:08:06.497411 :A51D7AF5:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14744 (legacy spawn) 2025-06-15 18:08:06.503894 :A51D7AF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:08:06.504080 :A51D7AFB:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:08:06.504938 :A51D7B00:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:06.513636 :A51D7B03:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:06.498 2025-06-15 18:08:06.513638 :A51D7B04:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16832 pso_num=27 pso_serial#=23 2025-06-15 18:08:06.513781 :A51D7B05:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16832 (legacy spawn) 2025-06-15 18:08:06.520272 :A51D7B06:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:08:06.520459 :A51D7B0E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:08:06.521267 :A51D7B10:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:09.566982 :A51D7C09:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:09.553 2025-06-15 18:08:09.566983 :A51D7C0A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12276 pso_num=27 pso_serial#=24 2025-06-15 18:08:09.567132 :A51D7C0B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12276 (legacy spawn) 2025-06-15 18:08:09.574011 :A51D7C0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:08:09.574199 :A51D7C11:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:08:09.575097 :A51D7C16:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:09.583886 :A51D7C19:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:09.569 2025-06-15 18:08:09.583889 :A51D7C1A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16740 pso_num=27 pso_serial#=25 2025-06-15 18:08:09.584025 :A51D7C1B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16740 (legacy spawn) 2025-06-15 18:08:09.590521 :A51D7C1C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:08:09.590683 :A51D7C25:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:08:09.591485 :A51D7C26:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:09.747368 :A51D7C29:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:09.741 2025-06-15 18:08:09.747370 :A51D7C2A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12880 pso_num=27 pso_serial#=26 2025-06-15 18:08:09.747506 :A51D7C2B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12880 (legacy spawn) 2025-06-15 18:08:09.754073 :A51D7C2C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:08:09.754245 :A51D7C32:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:08:09.755136 :A51D7C36:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:10.896014 :A51D7C8D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:10.883 2025-06-15 18:08:10.896017 :A51D7C8E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14552 pso_num=27 pso_serial#=27 2025-06-15 18:08:10.896182 :A51D7C8F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14552 (legacy spawn) 2025-06-15 18:08:10.915649 :A51D7C90:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:08:10.915826 :A51D7C95:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:08:10.916694 :A51D7C9A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:10.925454 :A51D7C9D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:10.914 2025-06-15 18:08:10.925457 :A51D7C9E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=6832 pso_num=27 pso_serial#=28 2025-06-15 18:08:10.925602 :A51D7C9F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=6832 (legacy spawn) 2025-06-15 18:08:10.932245 :A51D7CA0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:08:10.932404 :A51D7CA9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:08:10.933226 :A51D7CAA:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:16.155714 :A51D7E71:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:16.147 2025-06-15 18:08:16.155716 :A51D7E72:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16976 pso_num=27 pso_serial#=29 2025-06-15 18:08:16.155860 :A51D7E73:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16976 (legacy spawn) 2025-06-15 18:08:16.162396 :A51D7E74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 18:08:16.162567 :A51D7E7D:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 18:08:16.163483 :A51D7E7E:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 18:08:51.676164 :A51D8E47:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 18:08:51.671 2025-06-15 18:08:51.676166 :A51D8E48:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14592 pso_num=27 pso_serial#=30 2025-06-15 18:08:51.676303 :A51D8E49:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=14592 osp_idx=25 osp_ver=74234 osp_pg=0 (spawn #288624) 2025-06-15 18:08:51.676304 :A51D8E4A:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-15 18:08:51.676305 :A51D8E4B:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=207 time=2986674860 2025-06-15 18:08:51.676305 :A51D8E4C:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-06-15 18:08:51.676306 :A51D8E4D:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-06-15 18:08:51.676306 :A51D8E4E:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-06-15 18:08:51.676307 :A51D8E4F:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-15 18:08:51.676307 :A51D8E50:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-15 18:08:51.676818 :A51D8E5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] 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 27 (osid: 14592, J002)