Bug #417

tpcall in distributed transaction does not return correct tperrno using TPTRANSUSPEND

Added by Madars almost 5 years ago. Updated over 4 years ago.

Status:ClosedStart date:06/07/2019
Priority:Normal (Code 4)Due date:
Assignee:-% Done:

100%

Category:-
Target version:-

Description

N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000022736:xa_end_entry:tmi/xa.c:0569:atmi_xa_end_entry flags 67108864
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000022736:rx_tpsuspend:tmi/xa.c:1328:Suspend ok xid: [YZT3oUBAsg21Ckr7RlacokIvdjASKgEAAQAy]
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000022736:tor_and_lock:tpcall.c:0308:Got free call descriptor 16382, callseq: 1403
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000022736:tor_and_lock:tpcall.c:0311:cd 16382 locked to 1559941222 timestamp (id: 163821559941222) callseq: 1403
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000022736:ndrx_tpacall:tpcall.c:0612:Sending request to: [/dom1,svc,ACCOPEN] my_id=[clt,atmiclt47,18567,1,1] reply_to=[/dom1,clt,reply,atmiclt47,18567,1] cd=16382 callseq=1403 (user1=0, us
er2=0, user3=0, user4=0)
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000022736:ndrx_tpacall:tpcall.c:0641:ndrx_tpacall return 16382
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000022736:rx_tpgetrply:tpcall.c:0674:ndrx_tpgetrply enter, flags 262144 pbuf 0x26c4630 cd_exp 16382
N:NDRX:4:d5d3db3a:18567:7f3628c448c0:001:20190608:000022736:rx_tpgetrply:tpcall.c:0723:Waiting on OS Q mqd_t=4...
N:NDRX:3:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:et_error_fmt:perror.c:0291:ndrx_TPset_error_fmt: 13 (TPETIME) [ndrx_mq_receive failed for 4 (110): Connection timed out]
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:_descriptors:tpcall.c:0159:***List of call descriptors waiting for answer***
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:_descriptors:tpcall.c:0161:timeout(system wide): 10 curr_tstamp: 1559941232
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:_descriptors:tpcall.c:0162:cd       callseq locked_at       diff
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:_descriptors:tpcall.c:0171:16382    1403    1559941222      10
N:NDRX:3:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:_descriptors:tpcall.c:0176:cds waiting for answer: 1
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:_descriptors:tpcall.c:0177:*************************************************
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:rx_tpgetrply:tpcall.c:0770:ndrx_tpgetrply failed to receive answer
N:NDRX:4:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:drx_tpresume:tmi/xa.c:1347:Resuming global transaction...
N:NDRX:4:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:_join_or_new:tmi/xa.c:1539:RM not aware of this transaction
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:ndrx_tpalloc:ed_buf.c:0252:ndrx_tpalloc: type=UBF, subtype=NULL len=1024
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:ndrx_tpalloc:ed_buf.c:0296:ndrx_tpalloc: type=UBF subtype=NULL len=1024 allocated=0x2678a30
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:lloc_tm_call:autils.c:0552:Call buffer setup OK
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032736:m_generic_fb:autils.c:0691:About to call TM, service: [@TM-1-1-50]
N:NDRX:4:d5d3db3a:18567:7f3628c448c0:001:20190608:000032737:bug_dump_UBF:/utils.c:0249:Request buffer:
...

N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032737:m_generic_fb:autils.c:0734:atmi_xa_call_tm_generic returns 0x2678a30
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032737:erialize_xid:autils.c:0172:atmi_xa_deserialize_xid - enter
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032737:erialize_xid:autils.c:0173:Serialized xid: [YZT3oUBAsg21Ckr7RlacokIvdjASKgEAAQAy]
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032737:erialize_xid:autils.c:0177:xid deserialization total len: 27
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032737:erialize_xid:autils.c:0178:XID data for deserialization (nr bytes: 27)
  0000  61 94 f7 a1 40 40 b2 0d b5 0a 4a fb 46 56 9c a2  a...@@....J.FV..
  0010  42 2f 76 30 12 2a 01 00 01 00 32                 B/v0.*....2
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032737:erialize_xid:autils.c:0209:Original XID restored  (nr bytes: 152)
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
  0010  40 00 00 00 00 00 00 00 b2 0d b5 0a 4a fb 46 56  @...........J.FV
  0020  9c a2 42 2f 76 30 12 2a 01 00 01 00 32 00 00 00  ..B/v0.*....2...
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
  0050  00 00 00 00 00 00 00 00 b2 0d b5 0a 4a fb 46 56  ............J.FV
  0060  9c a2 42 2f 76 30 12 2a 01 00 01 00 32 00 00 00  ..B/v0.*....2...
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
  0090  00 00 00 00 00 00 00 00                          ........
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:t_branch_xid:autils.c:0790:YOPT BTID=398/-8214284245347074048 rmid=1
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:t_branch_xid:autils.c:0791:Branch XID (nr bytes: 152)
  0000  a1 f7 94 61 00 00 00 00 40 00 00 00 00 00 00 00  ...a....@.......
  0010  40 00 00 00 00 00 00 00 b2 0d b5 0a 4a fb 46 56  @...........J.FV
  0020  9c a2 42 2f 76 30 12 2a 01 00 01 00 32 00 00 00  ..B/v0.*....2...
  0030  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
  0040  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
  0050  00 00 00 00 00 00 01 8e b2 0d b5 0a 4a fb 46 56  ............J.FV
  0060  9c a2 42 2f 76 30 12 2a 01 00 01 00 32 00 00 00  ..B/v0.*....2...
  0070  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
  0080  00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01  ................
  0090  00 00 00 00 00 00 01 8e                          ........
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:_start_entry:tmi/xa.c:0468:atmi_xa_start_entry
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:ndrx_tpfree :ed_buf.c:0405:_tpfree buf=0x2678a30
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:drx_tpresume:tmi/xa.c:1380:Resume ok xid: [YZT3oUBAsg21Ckr7RlacokIvdjASKgEAAQAy] is_tx_initiator: 1
N:NDRX:2:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:te_known_rms:autils.c:0446:src len: 1
N:NDRX:3:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:rx_tpgetrply:tpcall.c:0905:Marking current transaction as abort only!
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:rx_tpgetrply:tpcall.c:0918:ndrx_tpgetrply return -1 tpurcode=0 tperror=0
N:NDRX:2:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:ndrx_tpcall :tpcall.c:1028:_tpgetrply to ACCOPEN failed
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:ndrx_tpcall :tpcall.c:1045:ndrx_tpcall: return -1 cd 0
N:NDRX:2:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:main        :iclt47.c:0270:ACCOPEN failed: 0:TPMINVAL <<<<<<<<<<<<<<<<<< Why not TPETIME ?
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:ndrx_tpabort:tmi/xa.c:1103:_tpabort enter
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:erialize_xid:autils.c:0172:atmi_xa_deserialize_xid - enter
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:erialize_xid:autils.c:0173:Serialized xid: [YZT3oUBAsg21Ckr7RlacokIvdjASKgEAAQAy]
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:erialize_xid:autils.c:0177:xid deserialization total len: 27
N:NDRX:5:d5d3db3a:18567:7f3628c448c0:001:20190608:000032738:erialize_xid:autils.c:0178:XID data for deserialization (nr bytes: 27)
  0000  61 94 f7 a1 40 40 b2 0d b5 0a 4a fb 46 56 9c a2  a...@@....J.FV..

History

#1 Updated by Madars almost 5 years ago

  • Subject changed from tpcall in distributed transaction does not return correct tperrno to tpcall in distributed transaction does not return correct tperrno using TPTRANSUSPEND

#2 Updated by Madars over 4 years ago

  • Status changed from New to Resolved

#3 Updated by Madars over 4 years ago

  • Status changed from Resolved to Closed
  • % Done changed from 0 to 100

Also available in: Atom PDF