tpopen_tpbegin_tpcommit_clientlogs.txt

Muralidhara, 07/20/2026 08:22 PM

Download (30.4 KB)

 
1
[PrometheusMetrics] Metrics available at http://0.0.0.0:9455/metrics
2
N:NDRX:4:00000000:00000:1465b1dfdb40:000:20260717:183821911090:plugins_load:inbase.c:0217:No plugins defined by NDRX_PLUGINS env variable
3
N:NDRX:5:00000000:00000:1465b1dfdb40:000:20260717:183821911115:cconfig_load:config.c:0488:CC tag set to: [MQ_TAG]
4
N:NDRX:5:00000000:00000:1465b1dfdb40:000:20260717:183821911147:x_inicfg_new:inicfg.c:0115:_ndrx_inicfg_new: load_global_env: 1
5
N:NDRX:5:00000000:00000:1465b1dfdb40:000:20260717:183821911150:ig_load_pass:config.c:0327:have config at slot [0] [/home/nagaraju/test_prog/conf]
6
N:NDRX:5:00000000:00000:1465b1dfdb40:000:20260717:183821911393:ig_load_pass:config.c:0401:_ndrx_cconfig_load_pass: ret: 0 is_internal: 1 G_tried_to_load: 1
7
N:NDRX:5:00000000:00000:1465b1dfdb40:000:20260717:183821911409:x_inicfg_new:inicfg.c:0115:_ndrx_inicfg_new: load_global_env: 1
8
N:NDRX:5:00000000:00000:1465b1dfdb40:000:20260717:183821911415:ig_load_pass:config.c:0327:have config at slot [0] [/home/nagaraju/test_prog/conf]
9
N:NDRX:5:00000000:00000:1465b1dfdb40:000:20260717:183821911654:ig_load_pass:config.c:0401:_ndrx_cconfig_load_pass: ret: 0 is_internal: 1 G_tried_to_load: 1
10
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911717:systest_init:s_test.c:0093:sys_test off
11
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911726:drx_lcf_init:td/lcf.c:0279:NDRX_QPREFIX set to /test1
12
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911731:drx_lcf_init:td/lcf.c:0300:NDRX_PGMAX set to 64
13
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911735:drx_lcf_init:td/lcf.c:0314:NDRX_SGREFRESH set to 30
14
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911739:drx_lcf_init:td/lcf.c:0327:NDRX_SVQREADERSMAX set to 50
15
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911743:drx_lcf_init:td/lcf.c:0340:NDRX_LCFREADERSMAX set to 1000
16
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911748:drx_lcf_init:td/lcf.c:0353:NDRX_LCFMAX set to 20
17
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911752:drx_lcf_init:td/lcf.c:0361:Missing config key NDRX_MSGQUEUESMAX - defaulting to 20000
18
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911756:drx_lcf_init:td/lcf.c:0368:NDRX_MSGQUEUESMAX set to 20000
19
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911764:drx_lcf_init:td/lcf.c:0386:(sysv queues): SystemV IPC Key set to: [44000]
20
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911770:drx_lcf_init:td/lcf.c:0400:NDRX_LCFCMDEXP set to 60
21
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911774:drx_lcf_init:td/lcf.c:0405:Opening LCF shared memory...
22
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911783:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,lcf]/44006 - attaching
23
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911809:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,lcf] 32927/44006 attach size: 98096 mem: 0x1465a1e6b000
24
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911822:x_shm_attach:_shmsv.c:0243:return 0
25
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911830:drx_sem_open:td_sem.c:0259:Semaphore exists [44003] - attaching
26
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911835:x_sem_attach:td_sem.c:0349:enter
27
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911841:x_sem_attach:td_sem.c:0369:sem: [44] attached
28
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911845:x_sem_attach:td_sem.c:0373:return 0
29
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911851:func_add_int:td/lcf.c:0212:Adding [1] func lcf command [logrotate]
30
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821911855:func_add_int:td/lcf.c:0212:Adding [2] func lcf command [logchg]
31
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912169:d_common_env:i/init.c:0225:Max servers set to 10000
32
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912203:d_common_env:i/init.c:0241:Max services set to 10000
33
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912220:d_common_env:i/init.c:0255:Max services set to 20000
34
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912238:d_common_env:i/init.c:0270:Random key set to: [0myWI5nu]
35
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912261:d_common_env:i/init.c:0285:Posix queue msg_max set to: [100]
36
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912277:d_common_env:i/init.c:0301:Posix queue msgsize_max set to: [56000]
37
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912301:d_common_env:i/init.c:0321:Posix queue prefix set to: [/test1], match string: [/test1,] (len: 7)
38
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912320:d_common_env:i/init.c:0340:Posix queue queue path set to: [/dev/mqueue]
39
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912354:d_common_env:i/init.c:0361:SystemV SEM IPC Key set to: [44000]
40
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912370:d_common_env:i/init.c:0369:Using comms timeout: 90
41
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912417:d_common_env:i/init.c:0386:Cluster node id=1
42
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912447:d_common_env:i/init.c:0403:NDRX_LDBAL set to 0
43
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912486:d_common_env:i/init.c:0412:[NDRX_CLUSTERISED] says: We run in cluster mode
44
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912514:d_common_env:i/init.c:0429:`ndrxd' pid file set to: [/home/nagaraju/test_prog/tmp/ndrxd.pid]
45
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912540:d_common_env:i/init.c:0445:ndrxd normal wait set to: 60 attempts
46
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912570:d_common_env:i/init.c:0482:NDRX_SGLOCKINC set to 3600
47
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912586:d_common_env:i/init.c:0491:[NDRX_XA_RES_ID]: XA Resource ID: 1
48
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912602:d_common_env:i/init.c:0500:[NDRX_XA_OPEN_STR]: XA Open String: [QMNAME=MNDBV105]
49
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912623:d_common_env:i/init.c:0509:[NDRX_XA_CLOSE_STR]: XA Close String: [$NDRX_XA_OPEN_STR]
50
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912643:d_common_env:i/init.c:0525:[NDRX_XA_DRIVERLIB]: Enduro/X XA Driver lib (.so): [/usr/lib64/libndrxxawsmqs.so]
51
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912664:d_common_env:i/init.c:0534:[NDRX_XA_RMLIB]: Resource manager lib (.so): [/opt/mqm/lib64/libmqmxa64_r.so]
52
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912686:d_common_env:i/init.c:0558:[NDRX_XA_LAZY_INIT]: Lazy XA Init: FALSE
53
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912701:d_common_env:i/init.c:0581:XA config ok
54
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912717:d_common_env:i/init.c:0586:Loading XA driver...
55
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912739:atmi_xa_init:tmi/xa.c:0317:Loading XA driver: [/usr/lib64/libndrxxawsmqs.so]
56
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912949:atmi_xa_init:tmi/xa.c:0356:About to call ndrx_get_xa_switch()
57
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821912988:a_switch_int:common.c:0070:Loading IBM Websphere MQ Static reg XA driver
58
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821913020:a_switch_int:common.c:0075:MQRMIXASwitch symbol not found in process address space - loading .so!
59
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914640:atmi_xa_init:tmi/xa.c:0369:Using XA static registration
60
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914671:atmi_xa_init:tmi/xa.c:0387:xa_flags = []
61
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914691:atmi_xa_init:tmi/xa.c:0546:XA lib initialized.
62
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914708: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)
63
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914725: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)
64
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914742:d_common_env:i/init.c:0683:routing criterion space: 102400 bytes, max services: 1000
65
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914758:d_common_env:i/init.c:0706:Routing group not used
66
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914788:d_common_env:i/init.c:0726:env loaded ok
67
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914814:tpinit      :i/init.c:1057:Got prefix [/test1]
68
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914832:tpinit      :i/init.c:1065:Got PROGNAME [hotput]
69
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914905:drx_ctxid_op:i/init.c:0135:Got free context id=0 (0 base)
70
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:000:20260717:183821914925:drx_ctxid_op:i/init.c:0146:Returning context id=1
71
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821914944:tpinit      :i/init.c:1102:my_id=[clt,hotput,2185001,1,1]
72
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821914968:tpinit      :i/init.c:1112:About to open client queue [/test1,clt,reply,hotput,2185001,1]
73
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915001:tpinit      :i/init.c:1114:After client Q open: 5
74
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915019:tpinit      :i/init.c:1122:Client queue [/test1,clt,reply,hotput,2185001,1] opened mqd_t=5.
75
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915040:nternal_init:i/init.c:0920:NDRXD queue: [/test1,sys,bg,ndrxd]
76
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915062:rxd_sem_init:mi/sem.c:0087:Using service semaphore key: [278528]
77
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915082:drx_sem_open:td_sem.c:0259:Semaphore exists [44000] - attaching
78
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915117:x_sem_attach:td_sem.c:0349:enter
79
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915135:x_sem_attach:td_sem.c:0369:sem: [45] attached
80
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915151:x_sem_attach:td_sem.c:0373:return 0
81
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915170:drx_shm_init:mi/shm.c:0136:G_srvinfo.size = 12440000 (1244 * 10000)
82
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915186:drx_shm_init:mi/shm.c:0140:G_svcinfo.size = 11120000 (556 * 20000)
83
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915202:drx_shm_init:mi/shm.c:0144:G_brinfo.size = 11120000 (4 * 32)
84
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915263:drx_shm_init:mi/shm.c:0148:ndrx_G_routcrit.size = 204800 bytes (102400 * 2)
85
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915282:drx_shm_init:mi/shm.c:0152:ndrx_G_routsvc.size = 176000 (1000 * 88 * 2)
86
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915302:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,svcinfo]/44001 - attaching
87
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915332:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,svcinfo] 32928/44001 attach size: 11120000 mem: 0x146579d65000
88
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915356:x_shm_attach:_shmsv.c:0243:return 0
89
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915432:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,routcrit]/44007 - attaching
90
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915484:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,routcrit] 32929/44007 attach size: 204800 mem: 0x1465a1e39000
91
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915582:x_shm_attach:_shmsv.c:0243:return 0
92
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915600:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,routsvc]/44008 - attaching
93
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915624:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,routsvc] 32930/44008 attach size: 176000 mem: 0x1465a1e0e000
94
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915643:x_shm_attach:_shmsv.c:0243:return 0
95
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915659:drx_shm_open:_shmsv.c:0149:Shared memory exists [/test1,shm,brinfo]/44002 - attaching
96
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915681:x_shm_attach:_shmsv.c:0230:Shm: [/test1,shm,brinfo] 32932/44002 attach size: 128 mem: 0x1465b8104000
97
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915707:x_shm_attach:_shmsv.c:0243:return 0
98
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821915740:a_open_entry:tmi/xa.c:0584:atmi_xa_open_entry RMID=1
99
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183821920855:a_open_entry:tmi/xa.c:0622:XA interface open
100
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833787965:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=1024
101
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788040:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=1024 allocated=0x14e43e20
102
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788128:lloc_tm_call:autils.c:0612:Call buffer setup OK
103
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788159:ndrx_tpbegin:tmi/xa.c:1106:ndrx_tpbegin enter
104
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788177:ndrx_tpbegin:tmi/xa.c:1135:About to call TM
105
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788196:m_generic_fb:autils.c:0791:About to call TM, service: [@TM-1]
106
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788220:bug_dump_UBF:/utils.c:0253:Request buffer:
107
TMCALLERRM      1
108
TMTXTOUT        5
109
TMTXFLAGS       0
110
TMCMD   b
111
TMPROCESSID     clt,hotput,2185001,1,1
112
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788757:ndrx_tpcall :tpcall.c:1113:ndrx_tpcall: enter flags=8 tx=(nil) xa_flags_sys=0
113
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788798:ndrx_tpacall:tpcall.c:0436:ndrx_tpacall enter
114
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788836:_ddr_grp_get:r_atmi.c:0603:returns 0 [@TM-1]
115
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788865:_shm_get_svc:mi/shm.c:0759:Key for [@TM-1] is 15268, shm is: 0x146579d65000
116
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788890:_shm_get_svc:mi/shm.c:0826:ndrx_shm_get_svc [@TM-1] - result: 1, iterations: 0, pos: 15268, install: 0
117
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788917:_shm_get_svc:mi/shm.c:0378:use_cluster=0 srvs=3 csrvs=0
118
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788933:_shm_get_svc:mi/shm.c:0408:use_cluster=0 srvs=3 csrvs=0
119
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788949:_shm_get_svc:mi/shm.c:0593:ndrx_shm_get_svc returns 0
120
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788968:_mbuf_tlv_do:ltibuf.c:0427:Prep tag: 0 (ttag 0, type 0). Src 0x14e43e20, dst 0x14eb2ca0 olen_max=65016 new_used=16 pad=0 buffer_left=65000
121
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833788989:_mbuf_tlv_do:ltibuf.c:0443:tag=0 loaded new_used=144
122
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789006:are_outgoing:ltibuf.c:0631:Post-processing (vptr mapping) tag: 0 typed: 0 callinfo: 0 offset: 0
123
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789025:are_outgoing:ltibuf.c:0658:144 data bytes ret=0
124
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789048:tor_and_lock:tpcall.c:0324:Got free call descriptor 16382, callseq: 1
125
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789065:tor_and_lock:tpcall.c:0327:cd 16382 locked to 1784293713 timestamp (id: 163821784293713) callseq: 1 tout_eff: 90
126
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789085:ndrx_tpacall:tpcall.c:0648:Sending request to: [/test1,svc,@TM-1] my_id=[clt,hotput,2185001,1,1] reply_to=[/test1,clt,reply,hotput,2185001,1] cd=16382 callseq=1 (user1=0, user2=0, user3=0, user4=0)
127
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789116:ric_q_send_2:iutils.c:0473:len: 680 use timeout: 1 config: 90 prio: 50 snd_prio: 50
128
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789156:ndrx_tpacall:tpcall.c:0686:ndrx_tpacall return 16382
129
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789183:rx_tpgetrply:tpcall.c:0812:ndrx_tpgetrply enter, flags 8 cd_exp 16382
130
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789200:rx_tpgetrply:tpcall.c:0851:Waiting on OS Q mqd_t=5...
131
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789945:ic_q_receive:iutils.c:0578:ndrx_generic_q_receive: 808
132
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789977:rx_tpgetrply:tpcall.c:0917:accept any: no, cd=16382 (name: [], my_id: []) atmi_tls=0x1465a0017010 cmd=2 rplybuf=0x14eb2a88 rply_len=808
133
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833789995:rx_tpgetrply:tpcall.c:0948:Reply cd: 16382, timestamp :1784293713 callseq: 1 from /test1,clt,reply,hotput,2185001,1 - expected OK!
134
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790015:are_incoming:ltibuf.c:0239:Parse incoming buffer TLV
135
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790032:are_incoming:ltibuf.c:0252:Received buffer tag: 0 type: 0 callinfo: 0 len: 256
136
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790048:are_incoming:ed_ubf.c:0121:Entering UBF_prepare_incoming
137
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790066:are_incoming:ed_ubf.c:0171:UBF_prepare_incoming: Output buffer exists
138
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790083:are_incoming:ed_ubf.c:0180:UBF_prepare_incoming: Output buffer size: 1024, received 260
139
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790101:are_incoming:ed_ubf.c:0186:UBF_prepare_incoming: Using existing buffer
140
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790123:are_incoming:ltibuf.c:0341:Remap the vptrs (tags) to real pointers
141
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790143:rx_tpgetrply:tpcall.c:1065:ndrx_tpgetrply return 0 tpurcode=0 tperror=0
142
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790160:ndrx_tpcall :tpcall.c:1215:ndrx_tpcall: return 0 cd 16382
143
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790176:m_generic_fb:autils.c:0803:got response from [@TM-1]
144
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790191:bug_dump_UBF:/utils.c:0253:Response buffer:
145
TMNODEID        1
146
TMRMID  1
147
TMSRVID 40
148
TMERR_CODE      0
149
TMERR_REASON    0
150
TMCALLERRM      1
151
TMTXTOUT        5
152
TMTXFLAGS       0
153
TMTXBTID        0
154
TMCMD   b
155
TMXID   YZT3oUBAAQAhDd4YJiqsCGpaKVEPcAEAAQAo
156
TMKNOWNRMS      \01
157
TMERR_MSG       Success
158
TMPROCESSID     clt,hotput,2185001,1,1
159
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790367:m_generic_fb:autils.c:0851:atmi_xa_call_tm_generic returns 0x14e43e20
160
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790389:ndrx_tpbegin:tmi/xa.c:1182:About to load tx info
161
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790414:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAhDd4YJiqsCGpaKVEPcAEAAQAo]
162
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790433:erialize_xid:autils.c:0216:xid deserialization total len: 27
163
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790489:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
164
  0000  61 94 f7 a1 40 40 01 00 21 0d de 18 26 2a ac 08  a...@@..!...&*..
165
  0010  6a 5a 29 51 0f 70 01 00 01 00 28                 jZ)Q.p....(
166
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790549: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 21 0d de 18 26 2a  @.........!...&*
169
  0020  ac 08 6a 5a 29 51 0f 70 01 00 01 00 28 00 00 00  ..jZ)Q.p....(...
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 21 0d de 18 26 2a  ..........!...&*
173
  0060  ac 08 6a 5a 29 51 0f 70 01 00 01 00 28 00 00 00  ..jZ)Q.p....(...
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:2185001:1465b1dfdb40:001:20260717:183833790680:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
178
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790697: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 21 0d de 18 26 2a  @.........!...&*
181
  0020  ac 08 6a 5a 29 51 0f 70 01 00 01 00 28 00 00 00  ..jZ)Q.p....(...
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 21 0d de 18 26 2a  ..........!...&*
185
  0060  ac 08 6a 5a 29 51 0f 70 01 00 01 00 28 00 00 00  ..jZ)Q.p....(...
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:2185001:1465b1dfdb40:001:20260717:183833790824:_start_entry:tmi/xa.c:0732:atmi_xa_start_entry
190
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790954:ndrx_tpbegin:tmi/xa.c:1218:Process joined to transaction [YZT3oUBAAQAhDd4YJiqsCGpaKVEPcAEAAQAo] OK
191
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833790985:tpfree_inner:ed_buf.c:0440:_tpfree buf=0x14e43e20
192
Successfully began XA 2 trns
193
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833792795:drx_tpcommit:tmi/xa.c:1299:ndrx_tpcommit enter
194
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833792844:erialize_xid:autils.c:0208:atmi_xa_deserialize_xid enter (xid_str): [YZT3oUBAAQAhDd4YJiqsCGpaKVEPcAEAAQAo]
195
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833792862:erialize_xid:autils.c:0216:xid deserialization total len: 27
196
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833792877:erialize_xid:autils.c:0217:XID data for deserialization (nr bytes: 27)
197
  0000  61 94 f7 a1 40 40 01 00 21 0d de 18 26 2a ac 08  a...@@..!...&*..
198
  0010  6a 5a 29 51 0f 70 01 00 01 00 28                 jZ)Q.p....(
199
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833792930:erialize_xid:autils.c:0248:Original XID restored  (nr bytes: 152)
200
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
201
  0010  40 00 00 00 00 00 00 00 01 00 21 0d de 18 26 2a  @.........!...&*
202
  0020  ac 08 6a 5a 29 51 0f 70 01 00 01 00 28 00 00 00  ..jZ)Q.p....(...
203
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
204
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
205
  0050  00 00 00 00 00 00 00 00 01 00 21 0d de 18 26 2a  ..........!...&*
206
  0060  ac 08 6a 5a 29 51 0f 70 01 00 01 00 28 00 00 00  ..jZ)Q.p....(...
207
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
208
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
209
  0090  00 00 00 00 00 00 00 00                          ........
210
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793057:t_branch_xid:autils.c:0914:BTID=0/0 rmid=1
211
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793072:t_branch_xid:autils.c:0915:Branch XID (nr bytes: 152)
212
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
213
  0010  40 00 00 00 00 00 00 00 01 00 21 0d de 18 26 2a  @.........!...&*
214
  0020  ac 08 6a 5a 29 51 0f 70 01 00 01 00 28 00 00 00  ..jZ)Q.p....(...
215
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
216
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
217
  0050  00 00 00 00 00 00 00 00 01 00 21 0d de 18 26 2a  ..........!...&*
218
  0060  ac 08 6a 5a 29 51 0f 70 01 00 01 00 28 00 00 00  ..jZ)Q.p....(...
219
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
220
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
221
  0090  00 00 00 00 00 00 00 00                          ........
222
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793198:xa_end_entry:tmi/xa.c:0808:atmi_xa_end_entry flags 67108864
223
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793275:drx_tpcommit:tmi/xa.c:1402:About to call TM flags=0
224
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793307:ndrx_tpalloc:ed_buf.c:0237:ndrx_tpalloc: type=UBF, subtype=NULL len=1024
225
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793335:ndrx_tpalloc:ed_buf.c:0278:ndrx_tpalloc: type=UBF subtype=NULL len=1024 allocated=0x14e43e20
226
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793354:lloc_tm_call:autils.c:0612:Call buffer setup OK
227
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793374:m_generic_fb:autils.c:0791:About to call TM, service: [@TM-1-1-40]
228
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793395:bug_dump_UBF:/utils.c:0253:Request buffer:
229
TMNODEID        1
230
TMRMID  1
231
TMSRVID 40
232
TMCALLERRM      1
233
TMTXFLAGS       0
234
TMCMD   c
235
TMXID   YZT3oUBAAQAhDd4YJiqsCGpaKVEPcAEAAQAo
236
TMKNOWNRMS      \01
237
TMPROCESSID     clt,hotput,2185001,1,1
238
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793544:ndrx_tpcall :tpcall.c:1113:ndrx_tpcall: enter flags=8 tx=0x14e588a0 xa_flags_sys=0
239
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793563:ndrx_tpacall:tpcall.c:0436:ndrx_tpacall enter
240
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793580:_ddr_grp_get:r_atmi.c:0603:returns 0 [@TM-1-1-40]
241
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793600:int_knownrms:autils.c:0430:Known RMs before call: : 1
242
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793617:_shm_get_svc:mi/shm.c:0759:Key for [@TM-1-1-40] is 563, shm is: 0x146579d65000
243
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793641:_shm_get_svc:mi/shm.c:0826:ndrx_shm_get_svc [@TM-1-1-40] - result: 1, iterations: 0, pos: 563, install: 0
244
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793658:_shm_get_svc:mi/shm.c:0378:use_cluster=0 srvs=1 csrvs=0
245
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793674:_shm_get_svc:mi/shm.c:0408:use_cluster=0 srvs=1 csrvs=0
246
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793689:_shm_get_svc:mi/shm.c:0593:ndrx_shm_get_svc returns 0
247
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793705:_mbuf_tlv_do:ltibuf.c:0427:Prep tag: 0 (ttag 0, type 0). Src 0x14e43e20, dst 0x14eb2ca0 olen_max=65016 new_used=16 pad=0 buffer_left=65000
248
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793723:_mbuf_tlv_do:ltibuf.c:0443:tag=0 loaded new_used=216
249
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793739:are_outgoing:ltibuf.c:0631:Post-processing (vptr mapping) tag: 0 typed: 0 callinfo: 0 offset: 0
250
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793755:are_outgoing:ltibuf.c:0658:216 data bytes ret=0
251
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793771:tor_and_lock:tpcall.c:0324:Got free call descriptor 16382, callseq: 2
252
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793788:tor_and_lock:tpcall.c:0327:cd 16382 locked to 1784293713 timestamp (id: 163821784293713) callseq: 2 tout_eff: 90
253
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793805:ndrx_tpacall:tpcall.c:0648:Sending request to: [/test1,svc,@TM-1-1-40] my_id=[clt,hotput,2185001,1,1] reply_to=[/test1,clt,reply,hotput,2185001,1] cd=16382 callseq=2 (user1=0, user2=0, user3=0, user4=0)
254
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793834:ric_q_send_2:iutils.c:0473:len: 752 use timeout: 1 config: 90 prio: 50 snd_prio: 50
255
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793869:ndrx_tpacall:tpcall.c:0686:ndrx_tpacall return 16382
256
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793895:rx_tpgetrply:tpcall.c:0812:ndrx_tpgetrply enter, flags 8 cd_exp 16382
257
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833793912:rx_tpgetrply:tpcall.c:0851:Waiting on OS Q mqd_t=5...
258
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795245:ic_q_receive:iutils.c:0578:ndrx_generic_q_receive: 784
259
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795277:rx_tpgetrply:tpcall.c:0917:accept any: no, cd=16382 (name: [], my_id: []) atmi_tls=0x1465a0017010 cmd=2 rplybuf=0x14eb2a88 rply_len=784
260
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795295:rx_tpgetrply:tpcall.c:0948:Reply cd: 16382, timestamp :1784293713 callseq: 2 from /test1,clt,reply,hotput,2185001,1 - expected OK!
261
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795311:are_incoming:ltibuf.c:0239:Parse incoming buffer TLV
262
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795327:are_incoming:ltibuf.c:0252:Received buffer tag: 0 type: 0 callinfo: 0 len: 232
263
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795342:are_incoming:ed_ubf.c:0121:Entering UBF_prepare_incoming
264
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795359:are_incoming:ed_ubf.c:0171:UBF_prepare_incoming: Output buffer exists
265
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795376:are_incoming:ed_ubf.c:0180:UBF_prepare_incoming: Output buffer size: 1024, received 236
266
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795391:are_incoming:ed_ubf.c:0186:UBF_prepare_incoming: Using existing buffer
267
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795407:are_incoming:ltibuf.c:0341:Remap the vptrs (tags) to real pointers
268
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795424:rx_tpgetrply:tpcall.c:1065:ndrx_tpgetrply return 0 tpurcode=0 tperror=0
269
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795440:ndrx_tpcall :tpcall.c:1215:ndrx_tpcall: return 0 cd 16382
270
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795476:m_generic_fb:autils.c:0803:got response from [@TM-1-1-40]
271
N:NDRX:4:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795496:bug_dump_UBF:/utils.c:0253:Response buffer:
272
TMNODEID        1
273
TMRMID  1
274
TMSRVID 40
275
TMERR_CODE      0
276
TMERR_REASON    0
277
TMCALLERRM      1
278
TMTXFLAGS       0
279
TMCMD   c
280
TMXID   YZT3oUBAAQAhDd4YJiqsCGpaKVEPcAEAAQAo
281
TMKNOWNRMS      \01
282
TMERR_MSG       Success
283
TMPROCESSID     clt,hotput,2185001,1,1
284
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795646:m_generic_fb:autils.c:0851:atmi_xa_call_tm_generic returns 0x14e43e20
285
N:NDRX:5:ad4c0b65:2185001:1465b1dfdb40:001:20260717:183833795662:drx_tpcommit:tmi/xa.c:1417:Transaction [YZT3oUBAAQAhDd4YJiqsCGpaKVEPcAEAAQAo] commit OK