[2025-12-02 10:16:57.867] CHAT libpncs CLRPC_LOWER <<< CLRPC_REQ_LOWER DONE --- lower(accbd3a0) opc(15) rsp(1), user_id(acadb0a8)
[2025-12-02 10:16:57.867] CHAT libpncs CLRPC_SV h(0) rsp(1) lower(accbd3a0) opcode(15)
[2025-12-02 10:16:57.867] CHAT libpncs CLRPC_SV recv.ind: lower(accbd3a0) lower.sock_fd(1)  server.sock_fd(1)
[2025-12-02 10:16:57.867] NOTE libpncs CLRPC_SV <<< server_id(0) --- RECV.ind --- lower(accbd3a0)  ip_addr(c0a80019:49349)  len(164)
[2025-12-02 10:16:57.867] NOTE libpncs CLRPC_SV need swap! pkt.drep(0x0) != (0x10)
[2025-12-02 10:16:57.867] NOTE_HIGH libpncs CLRPC_SV_PKT === RECV --- ip(c0a80019) port(49349)  server_boot(0)  serial(0)  fragnum(0)  drep0_1_2(0 0 0)
[2025-12-02 10:16:57.867] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ptype(0)  opnum(5)  len(84)  flags(0x28:--N-i-)  flags2(0)
[2025-12-02 10:16:57.867] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV actuid(8384c89e-cf70-11f0-bcf9-a8bbcc000001)  actseq(0)
[2025-12-02 10:16:57.867] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ifuuid(dea00001-6c97-11d1-8271-00a02442df7d) vers=0x00000001
[2025-12-02 10:16:57.867] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV objuid(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.867] CHAT libpncs CLRPC_SV sid(0) if_uuid(e1af8308-5d1f-11c9-91a4-08002b14a0fa) != 
[2025-12-02 10:16:57.867] CHAT libpncs CLRPC_SV pkt.if_id(dea00001-6c97-11d1-8271-00a02442df7d)
[2025-12-02 10:16:57.867] CHAT libpncs CLRPC_SV epm_lookup_server found with find_method(1) sid(1)
[2025-12-02 10:16:57.867] NOTE libpncs CLRPC_SV FORWARDING from sid(0) to sid(1)
[2025-12-02 10:16:57.867] CHAT libpncs CLRPC_SV sid(1) scall_cnt(0) max_scalls(123)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV sid(1) actuid(8384c89e-cf70-11f0-bcf9-a8bbcc000001)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV sid(1) new cid(1)(accc6680)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_UPPER hash(acadae98) entry(accc66b0) user_ptr(accc6680)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(0)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_UPPER starting LSA timer
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV cid(1) DISPATCH: busy(0) in_queue(0)  upper(00000000) lower(accbd3a0) oneshot(0) send(00000000)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV cid(1) REQUEST: state(1) seq:pkt(0)sc(4294967295) op(5) sem(1) fragnum:pkt(0)sc(0) flags(40) len(84)
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV cid(1) curr-state(1) new-state(CST_INIT)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(1)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV cid(1) curr-state(1) new-state(CST_RECV) seq(4294967295) fragnum(0)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV  pkt.opnum(5).seq(0).sem(1).fragnum(0).flags(0x28).len(84)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV current running read-implicit(0), maximum(2)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV sid(1) upper(0xaccc0200)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV pkt.len(84)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV alloc_size(66432)
[2025-12-02 10:16:57.868] UNEXP libpncs CLRPC_SV resize call.alloc_len(66432) to server.alloc_len(8084)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV cid(1) from.ip(0xc0a80019) from.port(49349) opnum(5) drep(0) sem(1) alloc_len(8084)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV cid(1) obj_id(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(1)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV copy pktlen(84) to offset(0) 
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV cid(1) curr-state(2) new-state(CST_WF_WAY) way.state(0)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_UPPER user_ptr(accc6680) running(1) ticks(76)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_UPPER no more oneshots and LSA timer running, stopping LSA timer
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV cid(1) curr-state(4) new-state(CST_WF_ANSWER) upper_wf(0) upper_drop(0)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_UPPER user_ptr(accc6680) running(0) ticks(0)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV ndr_len(84)
[2025-12-02 10:16:57.868] NOTE libpncs CLRPC_UPPER <<< rqb(0xaccc0200) h(1) opc(37) rsp(1)  h-to(2)in module(11), line(1263)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV recv.provide: lower(accbd3a0) lower.sock_fd(1)  server.sock_fd(2)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV clrpc_sc_dispatch:cid(1) sending(0) done.
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_LOWER <<< CLRPC_REQ_LOWER DONE --- lower(accbda30) opc(15) rsp(1), user_id(acadb0a8)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV h(0) rsp(1) lower(accbda30) opcode(15)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV recv.ind: lower(accbda30) lower.sock_fd(1)  server.sock_fd(1)
[2025-12-02 10:16:57.868] NOTE libpncs CLRPC_SV <<< server_id(0) --- RECV.ind --- lower(accbda30)  ip_addr(c0a80019:49349)  len(164)
[2025-12-02 10:16:57.868] NOTE libpncs CLRPC_SV need swap! pkt.drep(0x0) != (0x10)
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV_PKT === RECV --- ip(c0a80019) port(49349)  server_boot(0)  serial(0)  fragnum(0)  drep0_1_2(0 0 0)
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ptype(0)  opnum(5)  len(84)  flags(0x28:--N-i-)  flags2(0)
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV actuid(8384c89e-cf70-11f0-bcf9-a8bbcc000001)  actseq(0)
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ifuuid(dea00001-6c97-11d1-8271-00a02442df7d) vers=0x00000001
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV objuid(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.868] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ifuuid scall(dea00001-6c97-11d1-8271-00a02442df7d) 
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV cid(1) DISPATCH: busy(0) in_queue(0)  upper(00000000) lower(accbda30) oneshot(0) send(00000000)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV cid(1) REQUEST: state(8) seq:pkt(0)sc(0) op(5) sem(1) fragnum:pkt(0)sc(0) flags(40) len(84)
[2025-12-02 10:16:57.868] WARN libpncs CLRPC_SV cid(1), equal seq, state(8), ignore pkt
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV recv.provide: lower(accbda30) lower.sock_fd(1)  server.sock_fd(2)
[2025-12-02 10:16:57.868] CHAT libpncs CLRPC_SV clrpc_sc_dispatch:cid(1) sending(0) done.
[2025-12-02 10:16:57.869] NOTE libpncs CLRPC_UPPER >>> rqb(0xaccc0200) h(1) opc(38)
[2025-12-02 10:16:57.869] NOTE libpncs CLRPC_SV rsp(1) opnum(5) len(152) semantics(1)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV ndr_len(152)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV cid(1) DISPATCH: busy(0) in_queue(0)  upper(accc0200) lower(00000000) oneshot(0) send(00000000)
[2025-12-02 10:16:57.869] NOTE_HIGH libpncs CLRPC_SV cid(1) curr-state(8) new-state(CST_SEND) upper.rsp(1)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV one pkt, len(152)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV cid(1) state(16)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV sid(1) scall(accc6680) ptype(2)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV dequeue cid(1)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV cid(1) DISPATCH: busy(1) in_queue(1)  upper(00000000) lower(00000000) oneshot(0) send(accc32a0)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV cid(1) => busy.queueing
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV clrpc_sc_dispatch:cid(1) sending(1) loop again: upper(00000000) lower(00000000) oneshot(0) send(accc32a0)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV cid(1) SEND_PREPARE: state(16) ptype(2)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV cid(1) state(16) fragnum(0)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(0)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_UPPER starting LSA timer
[2025-12-02 10:16:57.869] NOTE libpncs CLRPC_SV >>> server_id(1) --- SEND.req --- lower(accc32a0) ip_addr(c0a80019:49349) len(232) ptype(2)
[2025-12-02 10:16:57.869] NOTE_HIGH libpncs CLRPC_SV_PKT === SEND --- ip(c0a80019) port(49349)  server_boot(2)  serial(0)  fragnum(0)  drep0_1_2(0x10 0 0)
[2025-12-02 10:16:57.869] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND ptype(2)  opnum(5)  len(152)  flags(0xa:-LN---)  flags2(0)
[2025-12-02 10:16:57.869] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND actuid(8384c89e-cf70-11f0-bcf9-a8bbcc000001)  actseq(0)
[2025-12-02 10:16:57.869] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND ifuuid(dea00001-6c97-11d1-8271-00a02442df7d) vers=0x00000001
[2025-12-02 10:16:57.869] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND objuid(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV cid(1) state(16) next_state(32)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV cid(1) curr-state(16) new-state(CST_WF_ACK) semantics(1) frag_flags(0x0)
[2025-12-02 10:16:57.869] NOTE_HIGH libpncs CLRPC_SV cid(1) curr-state(16) new-state(CST_INIT)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(1)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV sid(1) upper(0xaccc0200)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV clrpc_sc_dispatch:cid(1) sending(0) done.
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_LOWER <<< CLRPC_REQ_LOWER DONE --- lower(accc32a0) opc(14) rsp(1), user_id(acadb1b0)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV h(0) rsp(1) lower(accc32a0) opcode(14)
[2025-12-02 10:16:57.869] NOTE libpncs CLRPC_SV <<< server_id(1) --- SEND.cnf --- lower(accc32a0)  rsp(1)
[2025-12-02 10:16:57.869] CHAT libpncs CLRPC_SV sid(1) scall(00000000) ptype(4294967295)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_LOWER <<< CLRPC_REQ_LOWER DONE --- lower(accbe0c0) opc(15) rsp(1), user_id(acadb0a8)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_SV h(0) rsp(1) lower(accbe0c0) opcode(15)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_SV recv.ind: lower(accbe0c0) lower.sock_fd(1)  server.sock_fd(1)
[2025-12-02 10:16:57.966] NOTE libpncs CLRPC_SV <<< server_id(0) --- RECV.ind --- lower(accbe0c0)  ip_addr(c0a80019:49351)  len(1464)
[2025-12-02 10:16:57.966] NOTE_HIGH libpncs CLRPC_SV_PKT === RECV --- ip(c0a80019) port(49351)  server_boot(0)  serial(0)  fragnum(0)  drep0_1_2(0x10 0 0)
[2025-12-02 10:16:57.966] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ptype(0)  opnum(0)  len(1384)  flags(0x24:F---i-)  flags2(0)
[2025-12-02 10:16:57.966] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV actuid(855ff737-cf70-11f0-91a8-a8bbcc000001)  actseq(0)
[2025-12-02 10:16:57.966] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ifuuid(dea00001-6c97-11d1-8271-00a02442df7d) vers=0x00000001
[2025-12-02 10:16:57.966] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV objuid(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_SV sid(0) if_uuid(e1af8308-5d1f-11c9-91a4-08002b14a0fa) != 
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_SV pkt.if_id(dea00001-6c97-11d1-8271-00a02442df7d)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_SV epm_lookup_server found with find_method(1) sid(1)
[2025-12-02 10:16:57.966] NOTE libpncs CLRPC_SV FORWARDING from sid(0) to sid(1)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_SV sid(1) scall_cnt(1) max_scalls(123)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_SV sid(1) actuid(855ff737-cf70-11f0-91a8-a8bbcc000001)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_SV sid(1) new cid(2)(accc67c0)
[2025-12-02 10:16:57.966] CHAT libpncs CLRPC_UPPER hash(acadae98) entry(accc67f0) user_ptr(accc67c0)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(0)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) DISPATCH: busy(0) in_queue(0)  upper(00000000) lower(accbe0c0) oneshot(0) send(00000000)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) REQUEST: state(1) seq:pkt(0)sc(4294967295) op(0) sem(1) fragnum:pkt(0)sc(0) flags(36) len(1384)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV cid(2) curr-state(1) new-state(CST_INIT)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(1)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) curr-state(1) new-state(CST_RECV) seq(4294967295) fragnum(0)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV  pkt.opnum(0).seq(0).sem(1).fragnum(0).flags(0x24).len(1384)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV sid(1) upper(0xaccc1420)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV pkt.len(1384)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV alloc_size(66432)
[2025-12-02 10:16:57.967] UNEXP libpncs CLRPC_SV resize call.alloc_len(66432) to server.alloc_len(8084)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) from.ip(0xc0a80019) from.port(49351) opnum(0) drep(0) sem(1) alloc_len(8084)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) obj_id(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(1)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) send.ptype = PT_FACK  fack_serial(0)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) state(2)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV sid(1) scall(accc67c0) ptype(9)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV dequeue cid(2)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) DISPATCH: busy(1) in_queue(1)  upper(00000000) lower(00000000) oneshot(0) send(accc3fc0)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) => busy.queueing
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV copy pktlen(1384) to offset(0) 
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV recv.provide: lower(accbe0c0) lower.sock_fd(1)  server.sock_fd(2)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV clrpc_sc_dispatch:cid(2) sending(1) loop again: upper(00000000) lower(00000000) oneshot(0) send(accc3fc0)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) SEND_PREPARE: state(2) ptype(9)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV window_size(1) serial_num(0)
[2025-12-02 10:16:57.967] NOTE libpncs CLRPC_SV >>> server_id(1) --- SEND.req --- lower(accc3fc0) ip_addr(c0a80019:49351) len(100) ptype(9)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT === SEND --- ip(c0a80019) port(49351)  server_boot(2)  serial(0)  fragnum(0)  drep0_1_2(0x10 0 0)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND ptype(9)  opnum(0)  len(20)  flags(0:------)  flags2(0)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND actuid(855ff737-cf70-11f0-91a8-a8bbcc000001)  actseq(0)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND ifuuid(dea00001-6c97-11d1-8271-00a02442df7d) vers=0x00000001
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND objuid(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) state(2) next_state(2)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV clrpc_sc_dispatch:cid(2) sending(0) done.
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_LOWER <<< CLRPC_REQ_LOWER DONE --- lower(accbe750) opc(15) rsp(1), user_id(acadb0a8)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV h(0) rsp(1) lower(accbe750) opcode(15)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV recv.ind: lower(accbe750) lower.sock_fd(1)  server.sock_fd(1)
[2025-12-02 10:16:57.967] NOTE libpncs CLRPC_SV <<< server_id(0) --- RECV.ind --- lower(accbe750)  ip_addr(c0a80019:49351)  len(1464)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT === RECV --- ip(c0a80019) port(49351)  server_boot(0)  serial(0)  fragnum(0)  drep0_1_2(0x10 0 0)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ptype(0)  opnum(0)  len(1384)  flags(0x24:F---i-)  flags2(0)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV actuid(855ff737-cf70-11f0-91a8-a8bbcc000001)  actseq(0)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ifuuid(dea00001-6c97-11d1-8271-00a02442df7d) vers=0x00000001
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV objuid(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.967] NOTE_HIGH libpncs CLRPC_SV_PKT .RECV ifuuid scall(dea00001-6c97-11d1-8271-00a02442df7d) 
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) DISPATCH: busy(0) in_queue(0)  upper(00000000) lower(accbe750) oneshot(0) send(00000000)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) REQUEST: state(2) seq:pkt(0)sc(0) op(0) sem(1) fragnum:pkt(0)sc(0) flags(36) len(1384)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV cid(2) curr-state(2) new-state(CST_RECV) seq(0) fragnum(0)
[2025-12-02 10:16:57.967] CHAT libpncs CLRPC_SV  pkt.opnum(0).seq(0).sem(1).fragnum(0).flags(0x24).len(1384)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_UPPER timeout(7500 msec), running(1)
[2025-12-02 10:16:57.968] UNEXP libpncs CLRPC_SV frags out of order scall.fragnr(0) + 1 != pkt.fragnr(0), drop pkt
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV cid(2) send.ptype = PT_FACK  fack_serial(0)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV cid(2) state(2)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV sid(1) scall(accc67c0) ptype(9)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV dequeue cid(2)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV cid(2) DISPATCH: busy(1) in_queue(1)  upper(00000000) lower(00000000) oneshot(0) send(accc32a0)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV cid(2) => busy.queueing
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV recv.provide: lower(accbe750) lower.sock_fd(1)  server.sock_fd(2)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV clrpc_sc_dispatch:cid(2) sending(1) loop again: upper(00000000) lower(00000000) oneshot(0) send(accc32a0)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV cid(2) SEND_PREPARE: state(2) ptype(9)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV window_size(1) serial_num(0)
[2025-12-02 10:16:57.968] NOTE libpncs CLRPC_SV >>> server_id(1) --- SEND.req --- lower(accc32a0) ip_addr(c0a80019:49351) len(100) ptype(9)
[2025-12-02 10:16:57.968] NOTE_HIGH libpncs CLRPC_SV_PKT === SEND --- ip(c0a80019) port(49351)  server_boot(2)  serial(0)  fragnum(0)  drep0_1_2(0x10 0 0)
[2025-12-02 10:16:57.968] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND ptype(9)  opnum(0)  len(20)  flags(0:------)  flags2(0)
[2025-12-02 10:16:57.968] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND actuid(855ff737-cf70-11f0-91a8-a8bbcc000001)  actseq(0)
[2025-12-02 10:16:57.968] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND ifuuid(dea00001-6c97-11d1-8271-00a02442df7d) vers=0x00000001
[2025-12-02 10:16:57.968] NOTE_HIGH libpncs CLRPC_SV_PKT .SEND objuid(dea00000-6c97-11d1-8271-0001004102b3)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV cid(2) state(2) next_state(2)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV clrpc_sc_dispatch:cid(2) sending(0) done.
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_LOWER <<< CLRPC_REQ_LOWER DONE --- lower(accc3fc0) opc(14) rsp(1), user_id(acadb1b0)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV h(0) rsp(1) lower(accc3fc0) opcode(14)
[2025-12-02 10:16:57.968] NOTE libpncs CLRPC_SV <<< server_id(1) --- SEND.cnf --- lower(accc3fc0)  rsp(1)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV sid(1) scall(00000000) ptype(4294967295)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_LOWER <<< CLRPC_REQ_LOWER DONE --- lower(accc32a0) opc(14) rsp(1), user_id(acadb1b0)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV h(0) rsp(1) lower(accc32a0) opcode(14)
[2025-12-02 10:16:57.968] NOTE libpncs CLRPC_SV <<< server_id(1) --- SEND.cnf --- lower(accc32a0)  rsp(1)
[2025-12-02 10:16:57.968] CHAT libpncs CLRPC_SV sid(1) scall(00000000) ptype(4294967295)
[2025-12-02 10:16:57.969] NOTE libpncs CLRPC_UPPER >>> rqb(0xacaca248) h(255) opc(5)