client_logs.txt

Muralidhara, 08/05/2026 08:58 PM

Download (75.7 KB)

 
1 
158.234.207.101:/home/nagaraju/MQ_Simulator/>N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329137976:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=1024
2 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329138065:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=1024 allocated=0x14793060
3 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329138213:lloc_tm_call:autils.c:0612:Call buffer setup OK
4 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329138264:ndrx_tpbegin:tmi/xa.c:1106:ndrx_tpbegin enter
5 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329138307:ndrx_tpbegin:tmi/xa.c:1135:About to call TM
6 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329138362:m_generic_fb:autils.c:0791:About to call TM, service: [@TM-1]
7 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329138452:bug_dump_UBF:/utils.c:0253:Request buffer:
8 
TMCALLERRM      1
9 
TMTXTOUT        10
10 
TMTXFLAGS       0
11 
TMCMD   b
12 
TMPROCESSID     clt,hotput,3298755,1,1
13 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139099:ndrx_tpcall :tpcall.c:1113:ndrx_tpcall: enter flags=8 tx=(nil) xa_flags_sys=0
14 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139166:ndrx_tpacall:tpcall.c:0436:ndrx_tpacall enter
15 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139231:_ddr_grp_get:r_atmi.c:0603:returns 0 [@TM-1]
16 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139297:_shm_get_svc:mi/shm.c:0759:Key for [@TM-1] is 15268, shm is: 0x1487374c2000
17 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139360:_shm_get_svc:mi/shm.c:0826:ndrx_shm_get_svc [@TM-1] - result: 1, iterations: 0, pos: 15268, install: 0
18 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139385:_shm_get_svc:mi/shm.c:0378:use_cluster=0 srvs=1 csrvs=0
19 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139417:_shm_get_svc:mi/shm.c:0408:use_cluster=0 srvs=1 csrvs=0
20 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139448:_shm_get_svc:mi/shm.c:0593:ndrx_shm_get_svc returns 0
21 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139484:_mbuf_tlv_do:ltibuf.c:0427:Prep tag: 0 (ttag 0, type 0). Src 0x14793060, dst 0x148045b0 olen_max=65016 new_used=16 pad=0 buffer_left=65000
22 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139514:_mbuf_tlv_do:ltibuf.c:0443:tag=0 loaded new_used=144
23 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139547:are_outgoing:ltibuf.c:0631:Post-processing (vptr mapping) tag: 0 typed: 0 callinfo: 0 offset: 0
24 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139567:are_outgoing:ltibuf.c:0658:144 data bytes ret=0
25 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139591:tor_and_lock:tpcall.c:0324:Got free call descriptor 16382, callseq: 1
26 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139608:tor_and_lock:tpcall.c:0327:cd 16382 locked to 1785951209 timestamp (id: 163821785951209) callseq: 1 tout_eff: 90
27 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139628:ndrx_tpacall:tpcall.c:0648:Sending request to: [/test1,svc,@TM-1] my_id=[clt,hotput,3298755,1,1] reply_to=[/test1,clt,reply,hotput,3298755,1] cd=16382 callseq=1 (user1=0, user2=0, user3=0, user4=0)
28 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139660:ric_q_send_2:iutils.c:0473:len: 680 use timeout: 1 config: 90 prio: 50 snd_prio: 50
29 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139704:ndrx_tpacall:tpcall.c:0686:ndrx_tpacall return 16382
30 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139752:rx_tpgetrply:tpcall.c:0812:ndrx_tpgetrply enter, flags 8 cd_exp 16382
31 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329139771:rx_tpgetrply:tpcall.c:0851:Waiting on OS Q mqd_t=5...
32 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140694:ic_q_receive:iutils.c:0578:ndrx_generic_q_receive: 808
33 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140760:rx_tpgetrply:tpcall.c:0917:accept any: no, cd=16382 (name: [], my_id: []) atmi_tls=0x148737f5d010 cmd=2 rplybuf=0x14804398 rply_len=808
34 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140780:rx_tpgetrply:tpcall.c:0948:Reply cd: 16382, timestamp :1785951209 callseq: 1 from /test1,clt,reply,hotput,3298755,1 - expected OK!
35 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140801:are_incoming:ltibuf.c:0239:Parse incoming buffer TLV
36 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140817:are_incoming:ltibuf.c:0252:Received buffer tag: 0 type: 0 callinfo: 0 len: 256
37 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140833:are_incoming:ed_ubf.c:0121:Entering UBF_prepare_incoming
38 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140853:are_incoming:ed_ubf.c:0171:UBF_prepare_incoming: Output buffer exists
39 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140880:are_incoming:ed_ubf.c:0180:UBF_prepare_incoming: Output buffer size: 1024, received 260
40 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140911:are_incoming:ed_ubf.c:0186:UBF_prepare_incoming: Using existing buffer
41 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140950:are_incoming:ltibuf.c:0341:Remap the vptrs (tags) to real pointers
42 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329140987:rx_tpgetrply:tpcall.c:1065:ndrx_tpgetrply return 0 tpurcode=0 tperror=0
43 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141015:ndrx_tpcall :tpcall.c:1215:ndrx_tpcall: return 0 cd 16382
44 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141036:m_generic_fb:autils.c:0803:got response from [@TM-1]
45 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141063:bug_dump_UBF:/utils.c:0253:Response buffer:
46 
TMNODEID        1
47 
TMRMID  1
48 
TMSRVID 40
49 
TMERR_CODE      0
50 
TMERR_REASON    0
51 
TMCALLERRM      1
52 
TMTXTOUT        10
53 
TMTXFLAGS       0
54 
TMTXBTID        0
55 
TMCMD   b
56 
TMXID   YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo
57 
TMKNOWNRMS      \01
58 
TMERR_MSG       Success
59 
TMPROCESSID     clt,hotput,3298755,1,1
60 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141344:m_generic_fb:autils.c:0851:atmi_xa_call_tm_generic returns 0x14793060
61 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141389:ndrx_tpbegin:tmi/xa.c:1182:About to load tx info
62 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141431:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo]
63 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141466:erialize_xid:autils.c:0216:xid deserialization total len: 27
64 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141513:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
65 
  0000  61 94 f7 a1 40 40 01 00 32 51 6b 46 17 a3 af 60  a...@@..2QkF...`
66 
  0010  6a 73 73 e9 57 a3 01 00 01 00 28                 jss.W.....(
67 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141554:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
68 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
69 
  0010  40 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  @.........2QkF..
70 
  0020  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
71 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
72 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
73 
  0050  00 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  ..........2QkF..
74 
  0060  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
75 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
76 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
77 
  0090  00 00 00 00 00 00 00 00                          ........
78 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141705:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
79 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141722:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
80 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
81 
  0010  40 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  @.........2QkF..
82 
  0020  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
83 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
84 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
85 
  0050  00 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  ..........2QkF..
86 
  0060  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
87 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
88 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
89 
  0090  00 00 00 00 00 00 00 00                          ........
90 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329141869:_start_entry:tmi/xa.c:0732:atmi_xa_start_entry
91 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329142216:ndrx_tpbegin:tmi/xa.c:1218:Process joined to transaction [YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo] OK
92 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329142252:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x14793060
93 
Successfully began XA trns::
94 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151306:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=2048
95 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151361:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=2048 allocated=0x14819be0
96 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151392:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=2048
97 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151423:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=2048 allocated=0x1481a3f0
98 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151460:ndrx_tpcall :tpcall.c:1113:ndrx_tpcall: enter flags=0 tx=0x147b40c0 xa_flags_sys=0
99 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151497:ndrx_tpacall:tpcall.c:0436:ndrx_tpacall enter
100 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151517:_ddr_grp_get:r_atmi.c:0603:returns 0 [UPDATE_HSUFTRNS]
101 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151557:int_knownrms:autils.c:0430:Known RMs before call: : 1
102 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151601:_shm_get_svc:mi/shm.c:0759:Key for [UPDATE_HSUFTRNS] is 5028, shm is: 0x1487374c2000
103 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151655:_shm_get_svc:mi/shm.c:0826:ndrx_shm_get_svc [UPDATE_HSUFTRNS] - result: 1, iterations: 0, pos: 5028, install: 0
104 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151713:_shm_get_svc:mi/shm.c:0378:use_cluster=0 srvs=1 csrvs=0
105 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151792:_shm_get_svc:mi/shm.c:0408:use_cluster=0 srvs=1 csrvs=0
106 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151836:_shm_get_svc:mi/shm.c:0593:ndrx_shm_get_svc returns 0
107 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151864:_mbuf_tlv_do:ltibuf.c:0427:Prep tag: 0 (ttag 0, type 0). Src 0x14819be0, dst 0x148045b0 olen_max=65016 new_used=16 pad=0 buffer_left=65000
108 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151882:_mbuf_tlv_do:ltibuf.c:0443:tag=0 loaded new_used=320
109 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151908:are_outgoing:ltibuf.c:0631:Post-processing (vptr mapping) tag: 0 typed: 0 callinfo: 0 offset: 0
110 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151937:are_outgoing:ltibuf.c:0658:320 data bytes ret=0
111 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329151965:ndrx_tpacall:tpcall.c:0600:Current process in global transaction (YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo) - prepare call
112 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329152002:rx_tpsuspend:tmi/xa.c:1604:Suspending global transaction: atmi flags 200
113 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329152038:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo]
114 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329152080:erialize_xid:autils.c:0216:xid deserialization total len: 27
115 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329152109:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
116 
  0000  61 94 f7 a1 40 40 01 00 32 51 6b 46 17 a3 af 60  a...@@..2QkF...`
117 
  0010  6a 73 73 e9 57 a3 01 00 01 00 28                 jss.W.....(
118 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329152176:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
119 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
120 
  0010  40 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  @.........2QkF..
121 
  0020  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
122 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
123 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
124 
  0050  00 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  ..........2QkF..
125 
  0060  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
126 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
127 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
128 
  0090  00 00 00 00 00 00 00 00                          ........
129 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329152375:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
130 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329152407:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
131 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
132 
  0010  40 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  @.........2QkF..
133 
  0020  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
134 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
135 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
136 
  0050  00 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  ..........2QkF..
137 
  0060  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
138 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
139 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
140 
  0090  00 00 00 00 00 00 00 00                          ........
141 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329152772:xa_end_entry:tmi/xa.c:0808:atmi_xa_end_entry flags 33554432
142 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329153059:rx_tpsuspend:tmi/xa.c:1715:Suspend ok xid: [YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo] xa flags: 2000000
143 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329153095:tor_and_lock:tpcall.c:0324:Got free call descriptor 16382, callseq: 2
144 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329153135:tor_and_lock:tpcall.c:0327:cd 16382 locked to 1785951209 timestamp (id: 163821785951209) callseq: 2 tout_eff: 90
145 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329153178:ndrx_tpacall:tpcall.c:0648:Sending request to: [/test1,svc,UPDATE_HSUFTRNS] my_id=[clt,hotput,3298755,1,1] reply_to=[/test1,clt,reply,hotput,3298755,1] cd=16382 callseq=2 (user1=0, user2=0, user3=0, user4=0)
146 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329153212:ric_q_send_2:iutils.c:0473:len: 856 use timeout: 1 config: 90 prio: 50 snd_prio: 50
147 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329153254:ndrx_tpacall:tpcall.c:0686:ndrx_tpacall return 16382
148 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329153294:rx_tpgetrply:tpcall.c:0812:ndrx_tpgetrply enter, flags 262144 cd_exp 16382
149 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329153323:rx_tpgetrply:tpcall.c:0851:Waiting on OS Q mqd_t=5...
150 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329222980:ic_q_receive:iutils.c:0578:ndrx_generic_q_receive: 856
151 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223032:rx_tpgetrply:tpcall.c:0917:accept any: no, cd=16382 (name: [], my_id: []) atmi_tls=0x148737f5d010 cmd=2 rplybuf=0x14804398 rply_len=856
152 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223065:rx_tpgetrply:tpcall.c:0948:Reply cd: 16382, timestamp :1785951209 callseq: 2 from /test1,clt,reply,hotput,3298755,1 - expected OK!
153 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223086:are_incoming:ltibuf.c:0239:Parse incoming buffer TLV
154 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223101:are_incoming:ltibuf.c:0252:Received buffer tag: 0 type: 0 callinfo: 0 len: 304
155 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223117:are_incoming:ed_ubf.c:0121:Entering UBF_prepare_incoming
156 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223134:are_incoming:ed_ubf.c:0171:UBF_prepare_incoming: Output buffer exists
157 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223149:are_incoming:ed_ubf.c:0180:UBF_prepare_incoming: Output buffer size: 2048, received 308
158 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223173:are_incoming:ed_ubf.c:0186:UBF_prepare_incoming: Using existing buffer
159 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223190:are_incoming:ltibuf.c:0341:Remap the vptrs (tags) to real pointers
160 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223210:drx_tpresume:tmi/xa.c:1736:Resuming global transaction...
161 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223242:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo]
162 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223287:erialize_xid:autils.c:0216:xid deserialization total len: 27
163 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223315:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
164 
  0000  61 94 f7 a1 40 40 01 00 32 51 6b 46 17 a3 af 60  a...@@..2QkF...`
165 
  0010  6a 73 73 e9 57 a3 01 00 01 00 28                 jss.W.....(
166 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223357:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
167 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
168 
  0010  40 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  @.........2QkF..
169 
  0020  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
170 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
171 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
172 
  0050  00 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  ..........2QkF..
173 
  0060  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
174 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
175 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
176 
  0090  00 00 00 00 00 00 00 00                          ........
177 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223612:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
178 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223630:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
179 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
180 
  0010  40 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  @.........2QkF..
181 
  0020  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
182 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
183 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
184 
  0050  00 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  ..........2QkF..
185 
  0060  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
186 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
187 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
188 
  0090  00 00 00 00 00 00 00 00                          ........
189 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329223815:_start_entry:tmi/xa.c:0732:atmi_xa_start_entry
190 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224160:_join_or_new:tmi/xa.c:2038:tx join ok!
191 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224199:drx_tpresume:tmi/xa.c:1785:Resume ok xid: [YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo] is_tx_initiator: 2 abort_only: 0
192 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224218:te_known_rms:autils.c:0475:src len: 2
193 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224232:te_known_rms:autils.c:0482:len2=1
194 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224246:te_known_rms:autils.c:0489:1--> 0x0
195 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224259:te_known_rms:autils.c:0490:2--> 0x2
196 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224273:rx_tpgetrply:tpcall.c:1065:ndrx_tpgetrply return 0 tpurcode=0 tperror=0
197 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224288:ndrx_tpcall :tpcall.c:1215:ndrx_tpcall: return 0 cd 16382
198 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224324:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x14819be0
199 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230329224344:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x1481a3f0
200 
 SSSSSleeping before tp commit() for 8 seconds..
201 
calling tpcommit() after 8 seconds sleep
202 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335224685:drx_tpcommit:tmi/xa.c:1299:ndrx_tpcommit enter
203 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335224762:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo]
204 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335224880:erialize_xid:autils.c:0216:xid deserialization total len: 27
205 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335224913:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
206 
  0000  61 94 f7 a1 40 40 01 00 32 51 6b 46 17 a3 af 60  a...@@..2QkF...`
207 
  0010  6a 73 73 e9 57 a3 01 00 01 00 28                 jss.W.....(
208 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335224982:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
209 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
210 
  0010  40 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  @.........2QkF..
211 
  0020  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
212 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
213 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
214 
  0050  00 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  ..........2QkF..
215 
  0060  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
216 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
217 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
218 
  0090  00 00 00 00 00 00 00 00                          ........
219 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335225231:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
220 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335225260:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
221 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
222 
  0010  40 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  @.........2QkF..
223 
  0020  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
224 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
225 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
226 
  0050  00 00 00 00 00 00 00 00 01 00 32 51 6b 46 17 a3  ..........2QkF..
227 
  0060  af 60 6a 73 73 e9 57 a3 01 00 01 00 28 00 00 00  .`jss.W.....(...
228 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
229 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
230 
  0090  00 00 00 00 00 00 00 00                          ........
231 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335225470:xa_end_entry:tmi/xa.c:0808:atmi_xa_end_entry flags 67108864
232 
N:NDRX:2:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226297:xa_end_entry:tmi/xa.c:0817:finally atmi_xa_end_entry - fail: -3 [a resource manager error occurred in the transaction branch]
233 
N:NDRX:3:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226352:rror_fmt_rsn:perror.c:0402:ndrx_TPset_error_fmt_rsn: 16 (TPERMERR) reason: -3 [finally atmi_xa_end_entry - fail: -3 [a resource manager error occurred in the transaction branch]]
234 
N:NDRX:2:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226383:drx_tpcommit:tmi/xa.c:1373:Failed to end XA api: -3 [a resource manager error occurred in the transaction branch] - aborting
235 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226545:ndrx_tpabort:tmi/xa.c:1456:_tpabort enter
236 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226590:ndrx_tpabort:tmi/xa.c:1509:About to call TM
237 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226621:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=1024
238 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226655:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=1024 allocated=0x14793060
239 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226692:lloc_tm_call:autils.c:0612:Call buffer setup OK
240 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226757:m_generic_fb:autils.c:0791:About to call TM, service: [@TM-1-1-40]
241 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230335226792:bug_dump_UBF:/utils.c:0253:Request buffer:
242 
TMNODEID        1
243 
TMRMID  1
244 
TMSRVID 40
245 
TMCALLERRM      1
246 
TMTXFLAGS       0
247 
TMCMD   a
248 
TMXID   YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo
249 
TMKNOWNRMS      \01\02
250 
TMPROCESSID     clt,hotput,3298755,1,1
251 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227009:ndrx_tpcall :tpcall.c:1113:ndrx_tpcall: enter flags=8 tx=0x1481ac00 xa_flags_sys=0
252 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227044:ndrx_tpacall:tpcall.c:0436:ndrx_tpacall enter
253 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227079:_ddr_grp_get:r_atmi.c:0603:returns 0 [@TM-1-1-40]
254 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227109:int_knownrms:autils.c:0430:Known RMs before call: : 1 2
255 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227139:_shm_get_svc:mi/shm.c:0759:Key for [@TM-1-1-40] is 563, shm is: 0x1487374c2000
256 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227175:_shm_get_svc:mi/shm.c:0826:ndrx_shm_get_svc [@TM-1-1-40] - result: 1, iterations: 0, pos: 563, install: 0
257 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227207:_shm_get_svc:mi/shm.c:0378:use_cluster=0 srvs=1 csrvs=0
258 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227235:_shm_get_svc:mi/shm.c:0408:use_cluster=0 srvs=1 csrvs=0
259 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227263:_shm_get_svc:mi/shm.c:0593:ndrx_shm_get_svc returns 0
260 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227292:_mbuf_tlv_do:ltibuf.c:0427:Prep tag: 0 (ttag 0, type 0). Src 0x14793060, dst 0x148045b0 olen_max=65016 new_used=16 pad=0 buffer_left=65000
261 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227325:_mbuf_tlv_do:ltibuf.c:0443:tag=0 loaded new_used=216
262 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227353:are_outgoing:ltibuf.c:0631:Post-processing (vptr mapping) tag: 0 typed: 0 callinfo: 0 offset: 0
263 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227382:are_outgoing:ltibuf.c:0658:216 data bytes ret=0
264 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227413:tor_and_lock:tpcall.c:0324:Got free call descriptor 16382, callseq: 3
265 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227440:tor_and_lock:tpcall.c:0327:cd 16382 locked to 1785951215 timestamp (id: 163821785951215) callseq: 3 tout_eff: 90
266 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227472:ndrx_tpacall:tpcall.c:0648:Sending request to: [/test1,svc,@TM-1-1-40] my_id=[clt,hotput,3298755,1,1] reply_to=[/test1,clt,reply,hotput,3298755,1] cd=16382 callseq=3 (user1=0, user2=0, user3=0, user4=0)
267 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227513:ric_q_send_2:iutils.c:0473:len: 752 use timeout: 1 config: 90 prio: 50 snd_prio: 50
268 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227584:ndrx_tpacall:tpcall.c:0686:ndrx_tpacall return 16382
269 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227620:rx_tpgetrply:tpcall.c:0812:ndrx_tpgetrply enter, flags 8 cd_exp 16382
270 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230335227665:rx_tpgetrply:tpcall.c:0851:Waiting on OS Q mqd_t=5...
271 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335233363:ic_q_receive:iutils.c:0578:ndrx_generic_q_receive: 836
272 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335233630:rx_tpgetrply:tpcall.c:0917:accept any: no, cd=16382 (name: [], my_id: []) atmi_tls=0x148737f5d010 cmd=2 rplybuf=0x14804398 rply_len=836
273 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230335233851:rx_tpgetrply:tpcall.c:0948:Reply cd: 16382, timestamp :1785951215 callseq: 3 from /test1,clt,reply,hotput,3298755,1 - expected OK!
274 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234008:are_incoming:ltibuf.c:0239:Parse incoming buffer TLV
275 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234075:are_incoming:ltibuf.c:0252:Received buffer tag: 0 type: 0 callinfo: 0 len: 284
276 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234094:are_incoming:ed_ubf.c:0121:Entering UBF_prepare_incoming
277 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234155:are_incoming:ed_ubf.c:0171:UBF_prepare_incoming: Output buffer exists
278 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234173:are_incoming:ed_ubf.c:0180:UBF_prepare_incoming: Output buffer size: 1024, received 288
279 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234232:are_incoming:ed_ubf.c:0186:UBF_prepare_incoming: Using existing buffer
280 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234252:are_incoming:ltibuf.c:0341:Remap the vptrs (tags) to real pointers
281 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234268:rx_tpgetrply:tpcall.c:1065:ndrx_tpgetrply return 0 tpurcode=0 tperror=0
282 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234329:ndrx_tpcall :tpcall.c:1215:ndrx_tpcall: return 0 cd 16382
283 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234347:m_generic_fb:autils.c:0803:got response from [@TM-1-1-40]
284 
N:NDRX:4:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234401:bug_dump_UBF:/utils.c:0253:Response buffer:
285 
TMNODEID        1
286 
TMRMID  1
287 
TMSRVID 40
288 
TMERR_CODE      20
289 
TMERR_REASON    2006
290 
TMCALLERRM      1
291 
TMTXFLAGS       0
292 
TMCMD   a
293 
TMXID   YZT3oUBAAQAyUWtGF6OvYGpzc+lXowEAAQAo
294 
TMKNOWNRMS      \01\02
295 
TMERR_MSG       Distributed transaction process did not finish completely
296 
TMPROCESSID     clt,hotput,3298755,1,1
297 
N:NDRX:3:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234780:et_error_msg:perror.c:0298:_TPset_error_msg: 20 (TPEHAZARD) [Distributed transaction process did not finish completely]
298 
N:NDRX:2:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234858:m_generic_fb:autils.c:0816:Failed to call RM: 20:[20:TPEHAZARD (last error 20: Distributed transaction process did not finish completely)]
299 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234937:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x14793060
300 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335234958:m_generic_fb:autils.c:0851:atmi_xa_call_tm_generic returns (nil)
301 
N:NDRX:2:ad4c0b65:3298755:14876f24bb40:001:20260805:230335235021:ndrx_tpabort:tmi/xa.c:1514:Failed to execute TM command [b]
302 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230335235074:ndrx_tpabort:tmi/xa.c:1456:_tpabort enter
303 
N:NDRX:2:ad4c0b65:3298755:14876f24bb40:001:20260805:230335235164:ndrx_tpabort:tmi/xa.c:1476:tpabort: Not in global TX
304 
N:NDRX:3:ad4c0b65:3298755:14876f24bb40:001:20260805:230335235185:et_error_msg:perror.c:0298:_TPset_error_msg: 9 (TPEPROTO) [tpabort: Not in global TX]
305 
[PrometheusMetrics] Initialized for hotget on port 9455
306 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
307 
[PrometheusMetrics] Initialized for hotget on port 9455
308 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
309 
[PrometheusMetrics] Initialized for hotget on port 9455
310 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
311 
[PrometheusMetrics] Initialized for hotget on port 9455
312 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
313 
[PrometheusMetrics] Initialized for hotget on port 9455
314 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
315 
[PrometheusMetrics] Initialized for hotget on port 9455
316 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
317 
[PrometheusMetrics] Initialized for hotget on port 9455
318 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
319 
[PrometheusMetrics] Initialized for hotget on port 9455
320 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
321 
[PrometheusMetrics] Initialized for hotget on port 9455
322 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
323 
[PrometheusMetrics] Initialized for hotget on port 9455
324 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
325 
[PrometheusMetrics] Initialized for hotget on port 9455
326 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
327 
[PrometheusMetrics] Initialized for hotget on port 9455
328 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
329 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695282:_close_entry:tmi/xa.c:0639:atmi_xa_close_entry
330 
N:NDRX:2:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695354:_close_entry:tmi/xa.c:0668:atmi_xa_close_entry - fail: -7 [resource manager unavailable]
331 
N:NDRX:3:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695376:rror_fmt_rsn:perror.c:0402:ndrx_TPset_error_fmt_rsn: 16 (TPERMERR) reason: -7 [atmi_xa_close_entry - fail: -7 [resource manager unavailable]]
332 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695411:ndrx_tpterm :i/init.c:0743:_tpterm called
333 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695440:ndrx_tpterm :i/init.c:0788:Unlinking [/test1,clt,reply,hotput,3298755,1]
334 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695473:drx_ctxid_op:i/init.c:0125:Marking context 1 as free
335 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695491:drx_ctxid_op:i/init.c:0146:Returning context id=0
336 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695506:ndrx_tpterm :i/init.c:0809:_tpterm: ATMI library un-initialized
337 
N:NDRX:5:ad4c0b65:3298755:14876f24bb40:001:20260805:230905695521:ndrx_tpterm :i/init.c:0813:_tpterm returns 0
338 
N:NDRX:4:00000000:00000:15485f852b40:000:20260805:230913915694:plugins_load:inbase.c:0217:No plugins defined by NDRX_PLUGINS env variable
339 
N:NDRX:5:00000000:00000:15485f852b40:000:20260805:230913915722:cconfig_load:config.c:0488:CC tag set to: [MQ_TAG]
340 
N:NDRX:5:00000000:00000:15485f852b40:000:20260805:230913915784:x_inicfg_new:inicfg.c:0115:_ndrx_inicfg_new: load_global_env: 1
341 
N:NDRX:5:00000000:00000:15485f852b40:000:20260805:230913915788:ig_load_pass:config.c:0327:have config at slot [0] [/home/nagaraju/test_prog/conf]
342 
N:NDRX:5:00000000:00000:15485f852b40:000:20260805:230913916079:ig_load_pass:config.c:0401:_ndrx_cconfig_load_pass: ret: 0 is_internal: 1 G_tried_to_load: 1
343 
N:NDRX:5:00000000:00000:15485f852b40:000:20260805:230913916097:x_inicfg_new:inicfg.c:0115:_ndrx_inicfg_new: load_global_env: 1
344 
N:NDRX:5:00000000:00000:15485f852b40:000:20260805:230913916102:ig_load_pass:config.c:0327:have config at slot [0] [/home/nagaraju/test_prog/conf]
345 
N:NDRX:5:00000000:00000:15485f852b40:000:20260805:230913916296:ig_load_pass:config.c:0401:_ndrx_cconfig_load_pass: ret: 0 is_internal: 1 G_tried_to_load: 1
346 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916357:systest_init:s_test.c:0093:sys_test off
347 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916366:drx_lcf_init:td/lcf.c:0279:NDRX_QPREFIX set to /test1
348 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916371:drx_lcf_init:td/lcf.c:0300:NDRX_PGMAX set to 64
349 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916376:drx_lcf_init:td/lcf.c:0314:NDRX_SGREFRESH set to 30
350 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916380:drx_lcf_init:td/lcf.c:0327:NDRX_SVQREADERSMAX set to 50
351 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916385:drx_lcf_init:td/lcf.c:0340:NDRX_LCFREADERSMAX set to 1000
352 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916389:drx_lcf_init:td/lcf.c:0353:NDRX_LCFMAX set to 20
353 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916394:drx_lcf_init:td/lcf.c:0361:Missing config key NDRX_MSGQUEUESMAX - defaulting to 20000
354 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916400:drx_lcf_init:td/lcf.c:0368:NDRX_MSGQUEUESMAX set to 20000
355 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916407:drx_lcf_init:td/lcf.c:0386:(sysv queues): SystemV IPC Key set to: [44000]
356 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916412:drx_lcf_init:td/lcf.c:0400:NDRX_LCFCMDEXP set to 60
357 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916416:drx_lcf_init:td/lcf.c:0405:Opening LCF shared memory...
358 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916425:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,lcf]/44006 - attaching
359 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916448:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,lcf] 688348/44006 attach size: 98096 mem: 0x15485c355000
360 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916454:x_shm_attach:_shmsv.c:0243:return 0
361 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:000:20260805:230913916462:drx_sem_open:td_sem.c:0259:Semaphore exists [44003] - attaching
362 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916468:x_sem_attach:td_sem.c:0349:enter
363 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916473:x_sem_attach:td_sem.c:0369:sem: [196608] attached
364 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916477:x_sem_attach:td_sem.c:0373:return 0
365 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916484:func_add_int:td/lcf.c:0212:Adding [1] func lcf command [logrotate]
366 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916489:func_add_int:td/lcf.c:0212:Adding [2] func lcf command [logchg]
367 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916888:d_common_env:i/init.c:0225:Max servers set to 10000
368 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916921:d_common_env:i/init.c:0241:Max services set to 10000
369 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916952:d_common_env:i/init.c:0255:Max services set to 20000
370 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913916996:d_common_env:i/init.c:0270:Random key set to: [0myWI5nu]
371 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917039:d_common_env:i/init.c:0285:Posix queue msg_max set to: [100]
372 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917067:d_common_env:i/init.c:0301:Posix queue msgsize_max set to: [56000]
373 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917105:d_common_env:i/init.c:0321:Posix queue prefix set to: [/test1], match string: [/test1,] (len: 7)
374 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917134:d_common_env:i/init.c:0340:Posix queue queue path set to: [/dev/mqueue]
375 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917152:d_common_env:i/init.c:0361:SystemV SEM IPC Key set to: [44000]
376 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917168:d_common_env:i/init.c:0369:Using comms timeout: 90
377 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917184:d_common_env:i/init.c:0386:Cluster node id=1
378 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917228:d_common_env:i/init.c:0403:NDRX_LDBAL set to 0
379 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917244:d_common_env:i/init.c:0412:[NDRX_CLUSTERISED] says: We run in cluster mode
380 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917268:d_common_env:i/init.c:0429:`ndrxd' pid file set to: [/home/nagaraju/test_prog/tmp/ndrxd.pid]
381 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917305:d_common_env:i/init.c:0445:ndrxd normal wait set to: 60 attempts
382 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917333:d_common_env:i/init.c:0482:NDRX_SGLOCKINC set to 3600
383 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917348:d_common_env:i/init.c:0491:[NDRX_XA_RES_ID]: XA Resource ID: 1
384 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917363:d_common_env:i/init.c:0500:[NDRX_XA_OPEN_STR]: XA Open String: [QMNAME=MNDBV105]
385 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917396:d_common_env:i/init.c:0509:[NDRX_XA_CLOSE_STR]: XA Close String: [$NDRX_XA_OPEN_STR]
386 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917423:d_common_env:i/init.c:0525:[NDRX_XA_DRIVERLIB]: Enduro/X XA Driver lib (.so): [/usr/lib64/libndrxxawsmqs.so]
387 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917453:d_common_env:i/init.c:0534:[NDRX_XA_RMLIB]: Resource manager lib (.so): [/opt/mqm/lib64/libmqcxa64_r.so]
388 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917477:d_common_env:i/init.c:0558:[NDRX_XA_LAZY_INIT]: Lazy XA Init: TRUE
389 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917495:d_common_env:i/init.c:0581:XA config ok
390 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917511:d_common_env:i/init.c:0624:[NDRX_NRSEMS]: Number of services shared memory semaphores set to: 30 (used only for poll() mode) (default: 30)
391 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917527:d_common_env:i/init.c:0645:[NDRX_MAXSVCSRVS]: Max number of local servers per service set to: 30 (used only for poll() mode) (default: 30)
392 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917544:d_common_env:i/init.c:0683:routing criterion space: 102400 bytes, max services: 1000
393 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917563:d_common_env:i/init.c:0706:Routing group not used
394 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917594:d_common_env:i/init.c:0726:env loaded ok
395 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917612:tpinit      :i/init.c:1057:Got prefix [/test1]
396 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917630:tpinit      :i/init.c:1065:Got PROGNAME [hotput]
397 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917650:drx_ctxid_op:i/init.c:0135:Got free context id=0 (0 base)
398 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:000:20260805:230913917684:drx_ctxid_op:i/init.c:0146:Returning context id=1
399 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917717:tpinit      :i/init.c:1102:my_id=[clt,hotput,3302574,1,1]
400 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917789:tpinit      :i/init.c:1112:About to open client queue [/test1,clt,reply,hotput,3302574,1]
401 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917824:tpinit      :i/init.c:1114:After client Q open: 5
402 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917849:tpinit      :i/init.c:1122:Client queue [/test1,clt,reply,hotput,3302574,1] opened mqd_t=5.
403 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917870:nternal_init:i/init.c:0920:NDRXD queue: [/test1,sys,bg,ndrxd]
404 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917893:rxd_sem_init:mi/sem.c:0087:Using service semaphore key: [278528]
405 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913917913:drx_sem_open:td_sem.c:0259:Semaphore exists [44000] - attaching
406 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917942:x_sem_attach:td_sem.c:0349:enter
407 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917958:x_sem_attach:td_sem.c:0369:sem: [196609] attached
408 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917973:x_sem_attach:td_sem.c:0373:return 0
409 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913917990:drx_shm_init:mi/shm.c:0136:G_srvinfo.size = 12440000 (1244 * 10000)
410 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918006:drx_shm_init:mi/shm.c:0140:G_svcinfo.size = 11120000 (556 * 20000)
411 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918020:drx_shm_init:mi/shm.c:0144:G_brinfo.size = 11120000 (4 * 32)
412 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918035:drx_shm_init:mi/shm.c:0148:ndrx_G_routcrit.size = 204800 bytes (102400 * 2)
413 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918050:drx_shm_init:mi/shm.c:0152:ndrx_G_routsvc.size = 176000 (1000 * 88 * 2)
414 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913918067:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,svcinfo]/44001 - attaching
415 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918095:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,svcinfo] 688349/44001 attach size: 11120000 mem: 0x154827565000
416 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918175:x_shm_attach:_shmsv.c:0243:return 0
417 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913918195:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,routcrit]/44007 - attaching
418 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918220:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,routcrit] 688350/44007 attach size: 204800 mem: 0x15484c497000
419 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918317:x_shm_attach:_shmsv.c:0243:return 0
420 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913918336:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,routsvc]/44008 - attaching
421 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918360:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,routsvc] 688351/44008 attach size: 176000 mem: 0x15484c46c000
422 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918377:x_shm_attach:_shmsv.c:0243:return 0
423 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913918392:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,brinfo]/44002 - attaching
424 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918413:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,brinfo] 688353/44002 attach size: 128 mem: 0x15486591b000
425 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918429:x_shm_attach:_shmsv.c:0243:return 0
426 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913918464:atmi_xa_init:tmi/xa.c:0317:Loading XA driver: [/usr/lib64/libndrxxawsmqs.so]
427 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913918640:atmi_xa_init:tmi/xa.c:0356:About to call ndrx_get_xa_switch()
428 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918677:a_switch_int:common.c:0070:Loading IBM Websphere MQ Static reg XA driver
429 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913918696:atmi_xa_init:tmi/xa.c:0369:Using XA static registration
430 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918711:atmi_xa_init:tmi/xa.c:0387:xa_flags = []
431 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913918751:atmi_xa_init:tmi/xa.c:0546:XA lib initialized.
432 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230913918784:a_open_entry:tmi/xa.c:0584:atmi_xa_open_entry RMID=1
433 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230913925450:a_open_entry:tmi/xa.c:0622:XA interface open
434 
Successfully connected to Enduro/X XA environment.
435 
[PrometheusMetrics] Initialized for hotput on port 9466
436 
[PrometheusMetrics] Metrics available at http://0.0.0.0:9466/metrics
437 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949246920:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=1024
438 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247007:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=1024 allocated=0x153b3060
439 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247090:lloc_tm_call:autils.c:0612:Call buffer setup OK
440 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247118:ndrx_tpbegin:tmi/xa.c:1106:ndrx_tpbegin enter
441 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247146:ndrx_tpbegin:tmi/xa.c:1135:About to call TM
442 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247165:m_generic_fb:autils.c:0791:About to call TM, service: [@TM-1]
443 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949247185:bug_dump_UBF:/utils.c:0253:Request buffer:
444 
TMCALLERRM      1
445 
TMTXTOUT        10
446 
TMTXFLAGS       0
447 
TMCMD   b
448 
TMPROCESSID     clt,hotput,3302574,1,1
449 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247718:ndrx_tpcall :tpcall.c:1113:ndrx_tpcall: enter flags=8 tx=(nil) xa_flags_sys=0
450 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247829:ndrx_tpacall:tpcall.c:0436:ndrx_tpacall enter
451 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247861:_ddr_grp_get:r_atmi.c:0603:returns 0 [@TM-1]
452 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247905:_shm_get_svc:mi/shm.c:0759:Key for [@TM-1] is 15268, shm is: 0x154827565000
453 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247929:_shm_get_svc:mi/shm.c:0826:ndrx_shm_get_svc [@TM-1] - result: 1, iterations: 0, pos: 15268, install: 0
454 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247958:_shm_get_svc:mi/shm.c:0378:use_cluster=0 srvs=1 csrvs=0
455 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247973:_shm_get_svc:mi/shm.c:0408:use_cluster=0 srvs=1 csrvs=0
456 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949247987:_shm_get_svc:mi/shm.c:0593:ndrx_shm_get_svc returns 0
457 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248004:_mbuf_tlv_do:ltibuf.c:0427:Prep tag: 0 (ttag 0, type 0). Src 0x153b3060, dst 0x15423490 olen_max=65016 new_used=16 pad=0 buffer_left=65000
458 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248024:_mbuf_tlv_do:ltibuf.c:0443:tag=0 loaded new_used=144
459 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248038:are_outgoing:ltibuf.c:0631:Post-processing (vptr mapping) tag: 0 typed: 0 callinfo: 0 offset: 0
460 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248055:are_outgoing:ltibuf.c:0658:144 data bytes ret=0
461 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248076:tor_and_lock:tpcall.c:0324:Got free call descriptor 16382, callseq: 1
462 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248090:tor_and_lock:tpcall.c:0327:cd 16382 locked to 1785951589 timestamp (id: 163821785951589) callseq: 1 tout_eff: 90
463 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248110:ndrx_tpacall:tpcall.c:0648:Sending request to: [/test1,svc,@TM-1] my_id=[clt,hotput,3302574,1,1] reply_to=[/test1,clt,reply,hotput,3302574,1] cd=16382 callseq=1 (user1=0, user2=0, user3=0, user4=0)
464 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248139:ric_q_send_2:iutils.c:0473:len: 680 use timeout: 1 config: 90 prio: 50 snd_prio: 50
465 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248179:ndrx_tpacall:tpcall.c:0686:ndrx_tpacall return 16382
466 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949248205:rx_tpgetrply:tpcall.c:0812:ndrx_tpgetrply enter, flags 8 cd_exp 16382
467 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949248220:rx_tpgetrply:tpcall.c:0851:Waiting on OS Q mqd_t=5...
468 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249273:ic_q_receive:iutils.c:0578:ndrx_generic_q_receive: 808
469 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249304:rx_tpgetrply:tpcall.c:0917:accept any: no, cd=16382 (name: [], my_id: []) atmi_tls=0x15484c4c9010 cmd=2 rplybuf=0x15423278 rply_len=808
470 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949249320:rx_tpgetrply:tpcall.c:0948:Reply cd: 16382, timestamp :1785951589 callseq: 1 from /test1,clt,reply,hotput,3302574,1 - expected OK!
471 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249339:are_incoming:ltibuf.c:0239:Parse incoming buffer TLV
472 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249354:are_incoming:ltibuf.c:0252:Received buffer tag: 0 type: 0 callinfo: 0 len: 256
473 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249368:are_incoming:ed_ubf.c:0121:Entering UBF_prepare_incoming
474 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249384:are_incoming:ed_ubf.c:0171:UBF_prepare_incoming: Output buffer exists
475 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249399:are_incoming:ed_ubf.c:0180:UBF_prepare_incoming: Output buffer size: 1024, received 260
476 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249414:are_incoming:ed_ubf.c:0186:UBF_prepare_incoming: Using existing buffer
477 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249432:are_incoming:ltibuf.c:0341:Remap the vptrs (tags) to real pointers
478 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249449:rx_tpgetrply:tpcall.c:1065:ndrx_tpgetrply return 0 tpurcode=0 tperror=0
479 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249464:ndrx_tpcall :tpcall.c:1215:ndrx_tpcall: return 0 cd 16382
480 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249479:m_generic_fb:autils.c:0803:got response from [@TM-1]
481 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949249493:bug_dump_UBF:/utils.c:0253:Response buffer:
482 
TMNODEID        1
483 
TMRMID  1
484 
TMSRVID 40
485 
TMERR_CODE      0
486 
TMERR_REASON    0
487 
TMCALLERRM      1
488 
TMTXTOUT        10
489 
TMTXFLAGS       0
490 
TMTXBTID        0
491 
TMCMD   b
492 
TMXID   YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo
493 
TMKNOWNRMS      \01
494 
TMERR_MSG       Success
495 
TMPROCESSID     clt,hotput,3302574,1,1
496 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249656:m_generic_fb:autils.c:0851:atmi_xa_call_tm_generic returns 0x153b3060
497 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249675:ndrx_tpbegin:tmi/xa.c:1182:About to load tx info
498 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249698:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo]
499 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249715:erialize_xid:autils.c:0216:xid deserialization total len: 27
500 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249759:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
501 
  0000  61 94 f7 a1 40 40 01 00 32 64 67 95 c9 6b 61 e0  a...@@..2dg..ka.
502 
  0010  6a 73 75 65 0a 4b 01 00 01 00 28                 jsue.K....(
503 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249810:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
504 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
505 
  0010  40 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  @.........2dg..k
506 
  0020  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
507 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
508 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
509 
  0050  00 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  ..........2dg..k
510 
  0060  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
511 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
512 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
513 
  0090  00 00 00 00 00 00 00 00                          ........
514 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249932:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
515 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949249947:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
516 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
517 
  0010  40 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  @.........2dg..k
518 
  0020  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
519 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
520 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
521 
  0050  00 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  ..........2dg..k
522 
  0060  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
523 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
524 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
525 
  0090  00 00 00 00 00 00 00 00                          ........
526 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949250057:_start_entry:tmi/xa.c:0732:atmi_xa_start_entry
527 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949250389:ndrx_tpbegin:tmi/xa.c:1218:Process joined to transaction [YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo] OK
528 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949250427:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x153b3060
529 
Successfully began XA trns::
530 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255415:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=2048
531 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255456:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=2048 allocated=0x15439a20
532 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255474:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=2048
533 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255491:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=2048 allocated=0x1543a230
534 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255528:ndrx_tpcall :tpcall.c:1113:ndrx_tpcall: enter flags=0 tx=0x153d4940 xa_flags_sys=0
535 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255547:ndrx_tpacall:tpcall.c:0436:ndrx_tpacall enter
536 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255564:_ddr_grp_get:r_atmi.c:0603:returns 0 [UPDATE_HSUFTRNS]
537 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949255581:int_knownrms:autils.c:0430:Known RMs before call: : 1
538 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255598:_shm_get_svc:mi/shm.c:0759:Key for [UPDATE_HSUFTRNS] is 5028, shm is: 0x154827565000
539 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255623:_shm_get_svc:mi/shm.c:0826:ndrx_shm_get_svc [UPDATE_HSUFTRNS] - result: 1, iterations: 0, pos: 5028, install: 0
540 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255641:_shm_get_svc:mi/shm.c:0378:use_cluster=0 srvs=1 csrvs=0
541 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255669:_shm_get_svc:mi/shm.c:0408:use_cluster=0 srvs=1 csrvs=0
542 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255684:_shm_get_svc:mi/shm.c:0593:ndrx_shm_get_svc returns 0
543 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255700:_mbuf_tlv_do:ltibuf.c:0427:Prep tag: 0 (ttag 0, type 0). Src 0x15439a20, dst 0x15423490 olen_max=65016 new_used=16 pad=0 buffer_left=65000
544 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255717:_mbuf_tlv_do:ltibuf.c:0443:tag=0 loaded new_used=320
545 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255759:are_outgoing:ltibuf.c:0631:Post-processing (vptr mapping) tag: 0 typed: 0 callinfo: 0 offset: 0
546 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255776:are_outgoing:ltibuf.c:0658:320 data bytes ret=0
547 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949255806:ndrx_tpacall:tpcall.c:0600:Current process in global transaction (YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo) - prepare call
548 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949255841:rx_tpsuspend:tmi/xa.c:1604:Suspending global transaction: atmi flags 200
549 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255860:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo]
550 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255876:erialize_xid:autils.c:0216:xid deserialization total len: 27
551 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255892:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
552 
  0000  61 94 f7 a1 40 40 01 00 32 64 67 95 c9 6b 61 e0  a...@@..2dg..ka.
553 
  0010  6a 73 75 65 0a 4b 01 00 01 00 28                 jsue.K....(
554 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949255928:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
555 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
556 
  0010  40 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  @.........2dg..k
557 
  0020  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
558 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
559 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
560 
  0050  00 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  ..........2dg..k
561 
  0060  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
562 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
563 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
564 
  0090  00 00 00 00 00 00 00 00                          ........
565 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949256056:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
566 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949256072:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
567 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
568 
  0010  40 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  @.........2dg..k
569 
  0020  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
570 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
571 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
572 
  0050  00 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  ..........2dg..k
573 
  0060  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
574 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
575 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
576 
  0090  00 00 00 00 00 00 00 00                          ........
577 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949256193:xa_end_entry:tmi/xa.c:0808:atmi_xa_end_entry flags 33554432
578 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949256539:rx_tpsuspend:tmi/xa.c:1715:Suspend ok xid: [YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo] xa flags: 2000000
579 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949256589:tor_and_lock:tpcall.c:0324:Got free call descriptor 16382, callseq: 2
580 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949256607:tor_and_lock:tpcall.c:0327:cd 16382 locked to 1785951589 timestamp (id: 163821785951589) callseq: 2 tout_eff: 90
581 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949256624:ndrx_tpacall:tpcall.c:0648:Sending request to: [/test1,svc,UPDATE_HSUFTRNS] my_id=[clt,hotput,3302574,1,1] reply_to=[/test1,clt,reply,hotput,3302574,1] cd=16382 callseq=2 (user1=0, user2=0, user3=0, user4=0)
582 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949256649:ric_q_send_2:iutils.c:0473:len: 856 use timeout: 1 config: 90 prio: 50 snd_prio: 50
583 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949257236:ndrx_tpacall:tpcall.c:0686:ndrx_tpacall return 16382
584 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949257280:rx_tpgetrply:tpcall.c:0812:ndrx_tpgetrply enter, flags 262144 cd_exp 16382
585 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949257298:rx_tpgetrply:tpcall.c:0851:Waiting on OS Q mqd_t=5...
586 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949263991:ic_q_receive:iutils.c:0578:ndrx_generic_q_receive: 856
587 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264025:rx_tpgetrply:tpcall.c:0917:accept any: no, cd=16382 (name: [], my_id: []) atmi_tls=0x15484c4c9010 cmd=2 rplybuf=0x15423278 rply_len=856
588 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949264041:rx_tpgetrply:tpcall.c:0948:Reply cd: 16382, timestamp :1785951589 callseq: 2 from /test1,clt,reply,hotput,3302574,1 - expected OK!
589 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264055:are_incoming:ltibuf.c:0239:Parse incoming buffer TLV
590 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264070:are_incoming:ltibuf.c:0252:Received buffer tag: 0 type: 0 callinfo: 0 len: 304
591 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264084:are_incoming:ed_ubf.c:0121:Entering UBF_prepare_incoming
592 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264099:are_incoming:ed_ubf.c:0171:UBF_prepare_incoming: Output buffer exists
593 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264113:are_incoming:ed_ubf.c:0180:UBF_prepare_incoming: Output buffer size: 2048, received 308
594 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264127:are_incoming:ed_ubf.c:0186:UBF_prepare_incoming: Using existing buffer
595 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264141:are_incoming:ltibuf.c:0341:Remap the vptrs (tags) to real pointers
596 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949264160:drx_tpresume:tmi/xa.c:1736:Resuming global transaction...
597 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264179:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo]
598 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264200:erialize_xid:autils.c:0216:xid deserialization total len: 27
599 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264214:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
600 
  0000  61 94 f7 a1 40 40 01 00 32 64 67 95 c9 6b 61 e0  a...@@..2dg..ka.
601 
  0010  6a 73 75 65 0a 4b 01 00 01 00 28                 jsue.K....(
602 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264248:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
603 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
604 
  0010  40 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  @.........2dg..k
605 
  0020  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
606 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
607 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
608 
  0050  00 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  ..........2dg..k
609 
  0060  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
610 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
611 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
612 
  0090  00 00 00 00 00 00 00 00                          ........
613 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264358:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
614 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264373:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
615 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
616 
  0010  40 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  @.........2dg..k
617 
  0020  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
618 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
619 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
620 
  0050  00 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  ..........2dg..k
621 
  0060  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
622 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
623 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
624 
  0090  00 00 00 00 00 00 00 00                          ........
625 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264483:_start_entry:tmi/xa.c:0732:atmi_xa_start_entry
626 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264799:_join_or_new:tmi/xa.c:2038:tx join ok!
627 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264837:drx_tpresume:tmi/xa.c:1785:Resume ok xid: [YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo] is_tx_initiator: 2 abort_only: 0
628 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264872:te_known_rms:autils.c:0475:src len: 2
629 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264901:te_known_rms:autils.c:0482:len2=1
630 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949264915:te_known_rms:autils.c:0489:1--> 0x0
631 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230949264929:te_known_rms:autils.c:0490:2--> 0x2
632 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264943:rx_tpgetrply:tpcall.c:1065:ndrx_tpgetrply return 0 tpurcode=0 tperror=0
633 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949264959:ndrx_tpcall :tpcall.c:1215:ndrx_tpcall: return 0 cd 16382
634 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949265001:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x15439a20
635 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230949265030:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x1543a230
636 
 SSSSSleeping before tp commit() for 8 seconds..
637 
calling tpcommit() after 8 seconds sleep
638 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955265480:drx_tpcommit:tmi/xa.c:1299:ndrx_tpcommit enter
639 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955265535:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo]
640 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955265553:erialize_xid:autils.c:0216:xid deserialization total len: 27
641 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955265582:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
642 
  0000  61 94 f7 a1 40 40 01 00 32 64 67 95 c9 6b 61 e0  a...@@..2dg..ka.
643 
  0010  6a 73 75 65 0a 4b 01 00 01 00 28                 jsue.K....(
644 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955265639:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
645 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
646 
  0010  40 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  @.........2dg..k
647 
  0020  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
648 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
649 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
650 
  0050  00 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  ..........2dg..k
651 
  0060  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
652 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
653 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
654 
  0090  00 00 00 00 00 00 00 00                          ........
655 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955265926:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
656 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955265971:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
657 
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
658 
  0010  40 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  @.........2dg..k
659 
  0020  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
660 
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
661 
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
662 
  0050  00 00 00 00 00 00 00 00 01 00 32 64 67 95 c9 6b  ..........2dg..k
663 
  0060  61 e0 6a 73 75 65 0a 4b 01 00 01 00 28 00 00 00  a.jsue.K....(...
664 
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
665 
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
666 
  0090  00 00 00 00 00 00 00 00                          ........
667 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955266150:xa_end_entry:tmi/xa.c:0808:atmi_xa_end_entry flags 67108864
668 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955266619:drx_tpcommit:tmi/xa.c:1402:About to call TM flags=0
669 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955266663:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=1024
670 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955266682:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=1024 allocated=0x153b3060
671 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955266718:lloc_tm_call:autils.c:0612:Call buffer setup OK
672 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955266834:m_generic_fb:autils.c:0791:About to call TM, service: [@TM-1-1-40]
673 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230955266870:bug_dump_UBF:/utils.c:0253:Request buffer:
674 
TMNODEID        1
675 
TMRMID  1
676 
TMSRVID 40
677 
TMCALLERRM      1
678 
TMTXFLAGS       0
679 
TMCMD   c
680 
TMXID   YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo
681 
TMKNOWNRMS      \01\02
682 
TMPROCESSID     clt,hotput,3302574,1,1
683 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267171:ndrx_tpcall :tpcall.c:1113:ndrx_tpcall: enter flags=8 tx=0x1543aa40 xa_flags_sys=0
684 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267202:ndrx_tpacall:tpcall.c:0436:ndrx_tpacall enter
685 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267220:_ddr_grp_get:r_atmi.c:0603:returns 0 [@TM-1-1-40]
686 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230955267240:int_knownrms:autils.c:0430:Known RMs before call: : 1 2
687 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267257:_shm_get_svc:mi/shm.c:0759:Key for [@TM-1-1-40] is 563, shm is: 0x154827565000
688 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267285:_shm_get_svc:mi/shm.c:0826:ndrx_shm_get_svc [@TM-1-1-40] - result: 1, iterations: 0, pos: 563, install: 0
689 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267315:_shm_get_svc:mi/shm.c:0378:use_cluster=0 srvs=1 csrvs=0
690 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267333:_shm_get_svc:mi/shm.c:0408:use_cluster=0 srvs=1 csrvs=0
691 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267346:_shm_get_svc:mi/shm.c:0593:ndrx_shm_get_svc returns 0
692 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267362:_mbuf_tlv_do:ltibuf.c:0427:Prep tag: 0 (ttag 0, type 0). Src 0x153b3060, dst 0x15423490 olen_max=65016 new_used=16 pad=0 buffer_left=65000
693 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267378:_mbuf_tlv_do:ltibuf.c:0443:tag=0 loaded new_used=216
694 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267393:are_outgoing:ltibuf.c:0631:Post-processing (vptr mapping) tag: 0 typed: 0 callinfo: 0 offset: 0
695 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267419:are_outgoing:ltibuf.c:0658:216 data bytes ret=0
696 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267450:tor_and_lock:tpcall.c:0324:Got free call descriptor 16382, callseq: 3
697 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267466:tor_and_lock:tpcall.c:0327:cd 16382 locked to 1785951595 timestamp (id: 163821785951595) callseq: 3 tout_eff: 90
698 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267482:ndrx_tpacall:tpcall.c:0648:Sending request to: [/test1,svc,@TM-1-1-40] my_id=[clt,hotput,3302574,1,1] reply_to=[/test1,clt,reply,hotput,3302574,1] cd=16382 callseq=3 (user1=0, user2=0, user3=0, user4=0)
699 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267507:ric_q_send_2:iutils.c:0473:len: 752 use timeout: 1 config: 90 prio: 50 snd_prio: 50
700 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267550:ndrx_tpacall:tpcall.c:0686:ndrx_tpacall return 16382
701 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955267586:rx_tpgetrply:tpcall.c:0812:ndrx_tpgetrply enter, flags 8 cd_exp 16382
702 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230955267615:rx_tpgetrply:tpcall.c:0851:Waiting on OS Q mqd_t=5...
703 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276037:ic_q_receive:iutils.c:0578:ndrx_generic_q_receive: 784
704 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276075:rx_tpgetrply:tpcall.c:0917:accept any: no, cd=16382 (name: [], my_id: []) atmi_tls=0x15484c4c9010 cmd=2 rplybuf=0x15423278 rply_len=784
705 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230955276241:rx_tpgetrply:tpcall.c:0948:Reply cd: 16382, timestamp :1785951595 callseq: 3 from /test1,clt,reply,hotput,3302574,1 - expected OK!
706 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276286:are_incoming:ltibuf.c:0239:Parse incoming buffer TLV
707 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276312:are_incoming:ltibuf.c:0252:Received buffer tag: 0 type: 0 callinfo: 0 len: 232
708 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276351:are_incoming:ed_ubf.c:0121:Entering UBF_prepare_incoming
709 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276367:are_incoming:ed_ubf.c:0171:UBF_prepare_incoming: Output buffer exists
710 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276394:are_incoming:ed_ubf.c:0180:UBF_prepare_incoming: Output buffer size: 1024, received 236
711 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276420:are_incoming:ed_ubf.c:0186:UBF_prepare_incoming: Using existing buffer
712 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276435:are_incoming:ltibuf.c:0341:Remap the vptrs (tags) to real pointers
713 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276462:rx_tpgetrply:tpcall.c:1065:ndrx_tpgetrply return 0 tpurcode=0 tperror=0
714 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276478:ndrx_tpcall :tpcall.c:1215:ndrx_tpcall: return 0 cd 16382
715 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276493:m_generic_fb:autils.c:0803:got response from [@TM-1-1-40]
716 
N:NDRX:4:ad4c0b65:3302574:15485f852b40:001:20260805:230955276508:bug_dump_UBF:/utils.c:0253:Response buffer:
717 
TMNODEID        1
718 
TMRMID  1
719 
TMSRVID 40
720 
TMERR_CODE      0
721 
TMERR_REASON    0
722 
TMCALLERRM      1
723 
TMTXFLAGS       0
724 
TMCMD   c
725 
TMXID   YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo
726 
TMKNOWNRMS      \01\02
727 
TMERR_MSG       Success
728 
TMPROCESSID     clt,hotput,3302574,1,1
729 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276696:m_generic_fb:autils.c:0851:atmi_xa_call_tm_generic returns 0x153b3060
730 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276756:drx_tpcommit:tmi/xa.c:1417:Transaction [YZT3oUBAAQAyZGeVyWth4GpzdWUKSwEAAQAo] commit OK
731 
N:NDRX:5:ad4c0b65:3302574:15485f852b40:001:20260805:230955276778:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x153b3060