[Search for users] [Overall Top Noters] [List of all Conferences] [Download this site]

Conference pamsrc::decmessageq

Title:NAS Message Queuing Bus
Notice:KITS/DOC, see 4.*; Entering QARs, see 9.1; Register in 10
Moderator:PAMSRC::MARCUSEN
Created:Wed Feb 27 1991
Last Modified:Fri Jun 06 1997
Last Successful Update:Fri Jun 06 1997
Number of topics:2898
Total number of notes:12363

2882.0. "Sending failure to DQF when using UMA=SAF, XGroup on Unix/HP" by IRNBRU::MACKENZIE () Fri May 16 1997 10:10

Hi,

My customer is having a problem sending messages as follows:

Sending System: Digital Unix
DMQ Version : 3.20
DIP: WF_DQF
UMA: SAF

Target System: HP UX
DMQ Version : 3.2A

The receiving side never acknowledges that any messages are there on the get
call. The messages succeed if I change the UMA to DISC or DLQ. The only clue I
can see is an extra line in the trace :

PAMS 10489:PAMS-XGROUP Msg, XGROUP Queue, 1003 (3EB)

during the send.

Below is the trace from the dmqtestc utility used to send and then attempt to
receive the messages, first with UMA=SAF and then UMA=DISC

Thanks in advance for any pointers,
Dave M.

--------------------

Sending System:

PAMS 10489:PAMS-****** sending message ******
PAMS 10489:PAMS-Source        :, 29950182 (1C900E6)
PAMS 10489:PAMS-Destination   :, 3211267 (310003)
PAMS 10489:PAMS-Redirected to :, 1009 (3F1)
PAMS 10489:PAMS-Type / Class  :, -6553599 (FF9C0001)
PAMS 10489:PAMS-Delivery      :, 26 (1A)
PAMS 10489:PAMS-UMA           :, 4 (4)
PAMS 10489:PAMS-Resp Q      :
PAMS 10489:PAMS-******************************
PAMS 10489:PAMS-****** sent    message ******
PAMS 10489:PAMS-Msg Seq High:, 363 (16B)
PAMS 10489:PAMS-Msg Seq Low :, 29950965 (1C903F5)
PAMS 10489:PAMS-******************************
PAMS 10489:PAMS-Received unblocking msg
PAMS 10489:PAMS-PAMS_put_cleanup
put message to queue 49.3

--------------------

Receiving System:

PAMS 24403:PAMS-flow interval is, 250 (FA)
PAMS 24403:PAMS-flow maximum  is, 1000 (3E8)
PAMS 24403:PAMS-flow minimum  is, 10 (A)
PAMS 24403:PAMS-flow increase is, 10 (A)
PAMS 24403:PAMS-flow decrease percentage is, 25 (19)
PAMS 24403:PAMS-pams_attach_q
PAMS 24403:PAMS-Locking Q Info on Attach
PAMS 24403:PAMS-Unlocking Q Info after Attach
attached to queue 49.3


Actions Menu

 1 Attach Queue
 2 Detach Queue
 3 Locate Queue
 4 Put Message
 5 Get Message
 6 Set Timer
 7 Cancel Timer
 8 View Current Parameters
 9 Previous Menu

 Enter Menu Selection >> 5
PAMS 24403:PAMS-PAMS_deq
PAMS 24403:IPI-Dequeue Message failed, -48 (FFFFFFD0)
PAMS 24403:PAMS-PAMS_get_cleanup
PAMS__NOMOREMSG, No messages available

-------

Sending System : UMA = DISC

 Enter Menu Selection >> 4
PAMS 10489:PAMS-XGROUP Msg, XGROUP Queue, 1003 (3EB)
PAMS 10489:PAMS-****** sending message ******
PAMS 10489:PAMS-Source        :, 29950182 (1C900E6)
PAMS 10489:PAMS-Destination   :, 3211267 (310003)
PAMS 10489:PAMS-Redirected to :, 3211267 (310003)
PAMS 10489:PAMS-Type / Class  :, -6553599 (FF9C0001)
PAMS 10489:PAMS-Delivery      :, 26 (1A)
PAMS 10489:PAMS-UMA           :, 5 (5)
PAMS 10489:PAMS-Resp Q      :
PAMS 10489:PAMS-******************************
PAMS 10489:PAMS-****** sent    message ******
PAMS 10489:PAMS-Msg Seq High:, 619 (26B)
PAMS 10489:PAMS-Msg Seq Low :, 29950965 (1C903F5)
PAMS 10489:PAMS-******************************
PAMS 10489:PAMS-Received unblocking msg
PAMS 10489:PAMS-PAMS_put_cleanup
put message to queue 49.3
                                                                                                                                          
------

Receiving System

PAMS 24403:PAMS-PAMS_deq
PAMS 24403:PAMS-****** received message ******
PAMS 24403:PAMS-IPI Type    :, 19 (13)
PAMS 24403:PAMS-Source      :, 15073737 (E601C9)
PAMS 24403:PAMS-Target      :, 196657 (30031)
PAMS 24403:PAMS-Type / Class:, 130972 (1FF9C)
PAMS 24403:PAMS-Priority    :
PAMS 24403:PAMS-Length      :, 15 (F)
PAMS 24403:PAMS-IPI Del Opt :, 262 (106)
PAMS 24403:PAMS-IPI UMA     :, 256 (100)
PAMS 24403:PAMS-Msg Seq High:, 619 (26B)
PAMS 24403:PAMS-Msg Seq Low :, 29950965 (1C903F5)
PAMS 24403:PAMS-******************************
PAMS 24403:PAMS-PAMS_send_ack
PAMS 24403:PAMS-PAMS_get_cleanup
received message from 457.230, class:1, type:-100 : testwithoutSAF
T.RTitleUserPersonal
Name		DateLines
2882.1XHOST::SJZKick Butt In Your Face Messaging !Fri May 16 1997 10:5312
    
    I am not sure what is going on here and haven't looked at it that
    closely.  But you say you are running V3.2 on Digital UNIX. There
    is a V3.2A on Digital UNIX.  It is a MUP (as in MANDATORY upgrade).
    In edition there is an ECO (#1) which needs to be applied to  the
    MUP.
    
    Such being the case,  my advice is to upgrade  both  machines  to
    V3.2A-1 and try your test again.  You may also want  to  consider
    upgrading to V4.0.
    
    _sjz.
2882.2Does 3.2A fix a known problem surrounding this ?IRNBRU::MACKENZIEFri May 16 1997 11:1510
The customer has stayed with DMQ 3.2 because to upgrade to 3.2a will involve a 
relink of all of his applications. If the MUP contains a specific fix to this
problem then that is an option otherwise it seems unrealistic to ask him to 
upgrade if the problem then persists.

Is there any specific areas he could check on either HP or DUnix to confirm
whether the problem is his configuration. I guess this is the most likely as I
expect the DQF/SAF sending style combination is very common.

Dave M.
2882.3XHOST::SJZKick Butt In Your Face Messaging !Fri May 16 1997 11:5516
    
    The V3.2A release was an MRS release.  There was other stuff involved,
    but the main focus was fixing problems in MRS (it was rewritten  from
    scratch).  The ECO fixed some other MRS problems.
    
    The release notes contains a rather lengthy list of MRS related fixes,
    but I am certain that there were numerous other  problems  that  were
    fixed.  Said problems were never reported by customers or even detect-
    ed by us,  but I know they were there and that is why we have a V3.2A.
    
    I don't know if this will correct the problem reported by the  custom-
    er,  but it definitely is worth a shot.  Furthermore, if for some rea-
    son the upgrade does not resolve the problem,  then the odds of  them
    getting a fix against the current release are much higher.
    
    _sjz.
2882.4Upgraded to ECO , now failing all DQF callsIRNBRU::MACKENZIEMon May 19 1997 10:59256
Well, half successful.

I've upgraded to 3.2A on the Unix machine and applied the ECO. I now get the 
dmqtest program to work, but the users application was timing out  when 
attempting to send to the DQF. This did not happen before, he used to get
PAMS__ENQUEUED back as the status.

To replicate the problem I took the s_client.c program and set the sending
style to be WF_DQF with UMA of SAF. It now fails, returning a timeout instead 
of PAMS__ENQUEUED when sending locally or cross group. The PAMS_TRACE and 
DMQIPI_TRACE are almost identical for the send performed by the dmqtestc 
(which works) and the s_client program. The only line that is noticably different
is the following:

IPI  01297:IPI-User Msg ident   , -6553599 (FF9C0001) - from the dmqtest program
IPI  01427:IPI-User Msg ident   , 67536 (000107D0)
 - on the failing program

I've copied the full traces below. Any ideas ? What does the User Msg ident
mean and is it a problem? 

Dave M.

--

DMQ Successful Trace
--------------------
PAMS 01297:PAMS-****** sending message ******
PAMS 01297:PAMS-Source        :, 29950173 (1C900DD)
PAMS 01297:PAMS-Destination   :, 3211265 (310001)
PAMS 01297:PAMS-Redirected to :, 1007 (3EF)
PAMS 01297:PAMS-Type / Class  :, -6553599 (FF9C0001)
PAMS 01297:PAMS-Delivery      :, 26 (1A)
PAMS 01297:PAMS-UMA           :, 4 (4)
PAMS 01297:PAMS-Resp Q      :
PAMS 01297:PAMS-******************************
IPI  01297:IPI-IPIenqueue_message
IPI  01297:IPI-IPI_enq_dmq_qe
IPI  01297:IPI-message size : , 222 (000000DE)
IPI  01297:IPI-IPI_build_header
IPI  01297:IPI-enqueue request for queue, 1007 (000003EF)
IPI  01297:IPI-******* Enqueue IPI Message *******
IPI  01297:IPI-Msg Type         , 19 (00000013)
IPI  01297:IPI-Ipi Hdr Version  , 65538 (00010002)
IPI  01297:IPI-Ipi Hdr Length   , 128 (00000080)
IPI  01297:IPI-Msg Seq Low      , 29950963 (01C903F3)
IPI  01297:IPI-Msg Seq High     , 366 (0000016E)
IPI  01297:IPI-Timestamp secs   , 864051200 (33806000)
IPI  01297:IPI-Timestamp nsecs  , 292800000 (1173C600)
IPI  01297:IPI-Msg Priority     , 0 (00000000)
IPI  01297:IPI-Msg Source       , 457.221 (01C900DD)
IPI  01297:IPI-Msg Dest         , 49.1 (00310001)
IPI  01297:IPI-Msg Orig Source  , 457.221 (01C900DD)
IPI  01297:IPI-Msg Orig Dest    , 49.1 (00310001)
IPI  01297:IPI-Msg Routethrough , 0 (00000000)
IPI  01297:IPI-Msg Notif Target , 457.1011 (01C903F3)
IPI  01297:IPI-Msg Alt Target   , 0.0 (00000000)
IPI  01297:IPI-Msg Jrn Target   , 0.0 (00000000)
IPI  01297:IPI-Deliv Action     , 267 (0000010B)
IPI  01297:IPI-Undeliv Action   , 4 (00000004)
IPI  01297:IPI-Notify Action    , 8 (00000008)
IPI  01297:IPI-Status           , 0 (00000000)
IPI  01297:IPI-Undel Status     , 3 (00000003)
IPI  01297:IPI-User Msg ident   , -6553599 (FF9C0001)
IPI  01297:IPI-User Hdr len     , 0 (00000000)
IPI  01297:IPI-User Msg len     , 6 (00000006)
IPI  01297:IPI-Data Format      , 1 (00000001)
IPI  01297:IPI-Visit Count      , 16 (00000010)
IPI  01297:IPI-Rosn Time        , 864051200 (33806000)
IPI  01297:IPI-Rosn Seq         , 13 (0000000D)
IPI  01297:IPI-Lra lsl          , 0 (00000000)
IPI  01297:IPI-Lra msl          , 0 (00000000)
IPI  01297:IPI-Expire secs      , 0 (00000000)
IPI  01297:IPI-Expire nsecs     , 0 (00000000)
IPI  01297:IPI-***********************************
IPI  01297:IPI-IPI_ipcdeq entered
IPI  01297:IPI-QE Enqueue Status : , 0 (00000000)
IPI  01297:IPI-IPI_dispose_of_message with status, 0 (00000000)
PAMS 01297:PAMS-****** sent    message ******
PAMS 01297:PAMS-Msg Seq High:, 366 (16E)
PAMS 01297:PAMS-Msg Seq Low :, 29950963 (1C903F3)
PAMS 01297:PAMS-******************************
IPI  01297:IPI-IPIdequeue_message
IPI  01297:IPI-IPI_deq_dmq_qe
IPI  01297:IPI-IPI_ipcdeq entered
IPI  01297:IPI-******* Dequeue IPI Message *******
IPI  01297:IPI-Msg Type         , 48 (00000030)
IPI  01297:IPI-Ipi Hdr Version  , 65538 (00010002)
IPI  01297:IPI-Ipi Hdr Length   , 128 (00000080)
IPI  01297:IPI-Msg Seq Low      , 29950963 (01C903F3)
IPI  01297:IPI-Msg Seq High     , 366 (0000016E)
IPI  01297:IPI-Timestamp secs   , 864051200 (33806000)
IPI  01297:IPI-Timestamp nsecs  , 292800000 (1173C600)
IPI  01297:IPI-Msg Priority     , 2 (00000002)
IPI  01297:IPI-Msg Source       , 49.1 (00310001)
IPI  01297:IPI-Msg Dest         , 457.1011 (01C903F3)
IPI  01297:IPI-Msg Orig Source  , 457.221 (01C900DD)
IPI  01297:IPI-Msg Orig Dest    , 49.1 (00310001)
IPI  01297:IPI-Msg Routethrough , 457 (000001C9)
IPI  01297:IPI-Msg Notif Target , 457.1011 (01C903F3)
IPI  01297:IPI-Msg Alt Target   , 0.0 (00000000)
IPI  01297:IPI-Msg Jrn Target   , 0.0 (00000000)
IPI  01297:IPI-Deliv Action     , 260 (00000104)
IPI  01297:IPI-Undeliv Action   , 1 (00000001)
IPI  01297:IPI-Notify Action    , 0 (00000000)
IPI  01297:IPI-Status           , 0 (00000000)
IPI  01297:IPI-Undel Status     , 3 (00000003)
IPI  01297:IPI-User Msg ident   , -6553599 (FF9C0001)
IPI  01297:IPI-User Hdr len     , 0 (00000000)
IPI  01297:IPI-User Msg len     , 0 (00000000)
IPI  01297:IPI-Data Format      , 1 (00000001)
IPI  01297:IPI-Visit Count      , 16 (00000010)
IPI  01297:IPI-Rosn Time        , 864051200 (33806000)
IPI  01297:IPI-Rosn Seq         , 29949952 (01C90000)
IPI  01297:IPI-Lra lsl          , 0 (00000000)
IPI  01297:IPI-Lra msl          , 0 (00000000)
IPI  01297:IPI-Expire secs      , 0 (00000000)
IPI  01297:IPI-Expire nsecs     , 0 (00000000)
IPI  01297:IPI-***********************************
PAMS 01297:PAMS-Received unblocking msg
PAMS 01297:PAMS-PAMS_put_cleanup
put message to queue 49.1

----

s_client.c program failing with WF_DQF and UMA of SAF


PAMS 01435:PAMS-Timeout was ZERO, using 30 seconds
PAMS 01435:PAMS-****** sending message ******
PAMS 01435:PAMS-Source        :, 29950186 (1C900EA)
PAMS 01435:PAMS-Destination   :, 29949962 (1C9000A)
PAMS 01435:PAMS-Redirected to :, 1007 (3EF)
PAMS 01435:PAMS-Type / Class  :, 67536 (107D0)
PAMS 01435:PAMS-Delivery      :, 26 (1A)
PAMS 01435:PAMS-UMA           :, 4 (4)
PAMS 01435:PAMS-Resp Q      :, 29950186 (1C900EA)
PAMS 01435:PAMS-******************************
IPI  01435:IPI-IPIenqueue_message
IPI  01435:IPI-IPI_enq_dmq_qe
IPI  01435:IPI-message size : , 256 (00000100)
IPI  01435:IPI-IPI_build_header
IPI  01435:IPI-enqueue request for queue, 1007 (000003EF)
IPI  01435:IPI-******* Enqueue IPI Message *******
IPI  01435:IPI-Msg Type         , 19 (00000013)
IPI  01435:IPI-Ipi Hdr Version  , 65538 (00010002)
IPI  01435:IPI-Ipi Hdr Length   , 128 (00000080)
IPI  01435:IPI-Msg Seq Low      , 29950964 (01C903F4)
IPI  01435:IPI-Msg Seq High     , 485 (000001E5)
IPI  01435:IPI-Timestamp secs   , 864054749 (33806DDD)
IPI  01435:IPI-Timestamp nsecs  , 690032000 (29210D80)
IPI  01435:IPI-Msg Priority     , 0 (00000000)
IPI  01435:IPI-Msg Source       , 457.234 (01C900EA)
IPI  01435:IPI-Msg Dest         , 457.10 (01C9000A)
IPI  01435:IPI-Msg Orig Source  , 457.234 (01C900EA)
IPI  01435:IPI-Msg Orig Dest    , 457.10 (01C9000A)
IPI  01435:IPI-Msg Routethrough , 0 (00000000)
IPI  01435:IPI-Msg Notif Target , 457.1012 (01C903F4)
IPI  01435:IPI-Msg Alt Target   , 0.0 (00000000)
IPI  01435:IPI-Msg Jrn Target   , 0.0 (00000000)
IPI  01435:IPI-Deliv Action     , 267 (0000010B)
IPI  01435:IPI-Undeliv Action   , 4 (00000004)
IPI  01435:IPI-Notify Action    , 8 (00000008)
IPI  01435:IPI-Status           , 0 (00000000)
IPI  01435:IPI-Undel Status     , 3 (00000003)
IPI  01435:IPI-User Msg ident   , 67536 (000107D0)
IPI  01435:IPI-User Hdr len     , 0 (00000000)
IPI  01435:IPI-User Msg len     , 40 (00000028)
IPI  01435:IPI-Data Format      , 1 (00000001)
IPI  01435:IPI-Visit Count      , 16 (00000010)
IPI  01435:IPI-Rosn Time        , 864054749 (33806DDD)
IPI  01435:IPI-Rosn Seq         , 24 (00000018)
IPI  01435:IPI-Lra lsl          , 0 (00000000)
IPI  01435:IPI-Lra msl          , 0 (00000000)
IPI  01435:IPI-Expire secs      , 0 (00000000)
IPI  01435:IPI-Expire nsecs     , 0 (00000000)
IPI  01435:IPI-***********************************
IPI  01435:IPI-IPI_ipcdeq entered
IPI  01435:IPI-QE Enqueue Status : , 0 (00000000)
IPI  01435:IPI-IPI_dispose_of_message with status, 0 (00000000)
PAMS 01435:PAMS-****** sent    message ******
PAMS 01435:PAMS-Msg Seq High:, 485 (1E5)
PAMS 01435:PAMS-Msg Seq Low :, 29950964 (1C903F4)
PAMS 01435:PAMS-******************************
IPI  01435:IPI-IPIdequeue_message
IPI  01435:IPI-IPI_deq_dmq_qe
IPI  01435:IPI-IPI_ipcdeq entered
IPI  01435:IPI-******* Dequeue IPI Message *******
IPI  01435:IPI-Msg Type         , 48 (00000030)
IPI  01435:IPI-Ipi Hdr Version  , 65538 (00010002)
IPI  01435:IPI-Ipi Hdr Length   , 128 (00000080)
IPI  01435:IPI-Msg Seq Low      , 29950964 (01C903F4)
IPI  01435:IPI-Msg Seq High     , 485 (000001E5)
IPI  01435:IPI-Timestamp secs   , 864054749 (33806DDD)
IPI  01435:IPI-Timestamp nsecs  , 690032000 (29210D80)
IPI  01435:IPI-Msg Priority     , 2 (00000002)
IPI  01435:IPI-Msg Source       , 457.10 (01C9000A)
IPI  01435:IPI-Msg Dest         , 457.1012 (01C903F4)
IPI  01435:IPI-Msg Orig Source  , 457.234 (01C900EA)
IPI  01435:IPI-Msg Orig Dest    , 457.10 (01C9000A)
IPI  01435:IPI-Msg Routethrough , 457 (000001C9)
IPI  01435:IPI-Msg Notif Target , 457.1012 (01C903F4)
IPI  01435:IPI-Msg Alt Target   , 0.0 (00000000)
IPI  01435:IPI-Msg Jrn Target   , 0.0 (00000000)
IPI  01435:IPI-Deliv Action     , 260 (00000104)
IPI  01435:IPI-Undeliv Action   , 1 (00000001)
IPI  01435:IPI-Notify Action    , 0 (00000000)
IPI  01435:IPI-Status           , 0 (00000000)
IPI  01435:IPI-Undel Status     , 3 (00000003)
IPI  01435:IPI-User Msg ident   , 67536 (000107D0)
IPI  01435:IPI-User Hdr len     , 0 (00000000)
IPI  01435:IPI-User Msg len     , 0 (00000000)
IPI  01435:IPI-Data Format      , 1 (00000001)
IPI  01435:IPI-Visit Count      , 16 (00000010)
IPI  01435:IPI-Rosn Time        , 864054749 (33806DDD)
IPI  01435:IPI-Rosn Seq         , 29949952 (01C90000)
IPI  01435:IPI-Lra lsl          , 0 (00000000)
IPI  01435:IPI-Lra msl          , 0 (00000000)
IPI  01435:IPI-Expire secs      , 0 (00000000)
IPI  01435:IPI-Expire nsecs     , 0 (00000000)
IPI  01435:IPI-***********************************
PAMS 01435:PAMS-Received unblocking msg
PAMS 01435:PAMS-PAMS_put_cleanup

s_client : Sent Message to 457.10.
s_client : Message class = 2000, Message type = 1
s_client : Message = 'HHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHH'
PAMS 01435:PAMS-PAMS_deq
IPI  01435:IPI-IPIdequeue_message
IPI  01435:IPI-IPI_deq_dmq_qe
IPI  01435:IPI-IPI_ipcdeq entered
IPI  01435:IPI-QE DEQ failed, -16 (FFFFFFF0)
PAMS 01435:IPI-Dequeue Message failed, -42 (FFFFFFD6)
PAMS 01435:PAMS-PAMS_get_cleanup
s_client : Error returned by PAMS_GET_MSGW -> -14.
Function timed out.
PAMS 01435:PAMS-pams_exit
PAMS 01435:PAMS-deleting pams context
PAMS 01435:PAMS-Locking Q Info on Exit
PAMS 01435:PAMS-Unlocking Q Info after Exit
IPI  01435:IPI-IPIdelete_context_entity
IPI  01435:IPI-IPI_disconnect_q
IPI  01435:IPI-IPI_disconnect_dmq_qe
IPI  01435:IPI-IPI_ipcdeq entered
IPI  01435:IPI-IPI_detach_timestamp
IPI  01435:IPI-IPIget_attributes
IPI  01435:IPI-IPIdelete_context_entity
IPI  01435:IPI-IPI_disconnect_q
IPI  01435:IPI-IPI_disconnect_dmq_qe
IPI  01435:IPI-IPI_ipcdeq entered
IPI  01435:IPI-IPI_detach_timestamp
IPI  01435:IPI-IPIget_attributes
IPI  01435:IPI-detaching shared resources
IPI  01435:IPI-deleting ipi context
IPI  01435:IPI-deleting security cache
IPI  01435:IPI-detaching from qe
2882.5PAMSRC::MILLERMon May 19 1997 18:408
    What is the receiver program doing?  The s_client is expecting a reply message and it only
    waits ten seconds.

    The User Msg ident is just the api type and class.


    tm
2882.6Problem persists since upgrade to ECO 1IRNBRU::MACKENZIETue May 20 1997 12:56174
The problem in .4 was a red herring. The problem still exists when sending 
xgroup from Unix to HP. It can be reproduced using the dmqtest program. The
traces are below but the problem is basically that the messages appear to get
enqueued on the HP side but are never read off. I can actually see the DQF 
files but the program does not appear to read them off.

Both systems are on v3.2 ECO 1.

Thanks for any pointers. The customer is getting very disgruntled - this is
the functionality he bought DMQ for.

Dave M.

--

Sending System (unix)

 Enter Menu Selection >> 4
PAMS 03398:PAMS-****** sending message ******
PAMS 03398:PAMS-Source        :, 29950184 (1C900E8)
PAMS 03398:PAMS-Destination   :, 3211267 (310003)
PAMS 03398:PAMS-Redirected to :, 1001 (3E9)
PAMS 03398:PAMS-Type / Class  :, -6553599 (FF9C0001)
PAMS 03398:PAMS-Delivery      :, 26 (1A)
PAMS 03398:PAMS-UMA           :, 4 (4)
PAMS 03398:PAMS-Resp Q      :
PAMS 03398:PAMS-******************************
IPI  03398:IPI-IPIenqueue_message
IPI  03398:IPI-IPI_enq_dmq_qe
IPI  03398:IPI-message size : , 228 (000000E4)
IPI  03398:IPI-IPI_build_header
IPI  03398:IPI-enqueue request for queue, 1001 (000003E9)
IPI  03398:IPI-******* Enqueue IPI Message *******
IPI  03398:IPI-Msg Type         , 19 (00000013)
IPI  03398:IPI-Ipi Hdr Version  , 65538 (00010002)
IPI  03398:IPI-Ipi Hdr Length   , 128 (00000080)
IPI  03398:IPI-Msg Seq Low      , 29950962 (01C903F2)
IPI  03398:IPI-Msg Seq High     , 342 (00000156)
IPI  03398:IPI-Timestamp secs   , 864147859 (3381D993)
IPI  03398:IPI-Timestamp nsecs  , 376736000 (16748900)
IPI  03398:IPI-Msg Priority     , 0 (00000000)
IPI  03398:IPI-Msg Source       , 457.232 (01C900E8)
IPI  03398:IPI-Msg Dest         , 49.3 (00310003)
IPI  03398:IPI-Msg Orig Source  , 457.232 (01C900E8)
IPI  03398:IPI-Msg Orig Dest    , 49.3 (00310003)
IPI  03398:IPI-Msg Routethrough , 0 (00000000)
IPI  03398:IPI-Msg Notif Target , 457.1010 (01C903F2)
IPI  03398:IPI-Msg Alt Target   , 0.0 (00000000)
IPI  03398:IPI-Msg Jrn Target   , 0.0 (00000000)
IPI  03398:IPI-Deliv Action     , 267 (0000010B)
IPI  03398:IPI-Undeliv Action   , 4 (00000004)
IPI  03398:IPI-Notify Action    , 8 (00000008)
IPI  03398:IPI-Status           , 0 (00000000)
IPI  03398:IPI-Undel Status     , 3 (00000003)
IPI  03398:IPI-User Msg ident   , -6553599 (FF9C0001)
IPI  03398:IPI-User Hdr len     , 0 (00000000)
IPI  03398:IPI-User Msg len     , 12 (0000000C)
IPI  03398:IPI-Data Format      , 1 (00000001)
IPI  03398:IPI-Visit Count      , 16 (00000010)
IPI  03398:IPI-Rosn Time        , 864147859 (3381D993)
IPI  03398:IPI-Rosn Seq         , 41 (00000029)
IPI  03398:IPI-Lra lsl          , 0 (00000000)
IPI  03398:IPI-Lra msl          , 0 (00000000)
IPI  03398:IPI-Expire secs      , 0 (00000000)
IPI  03398:IPI-Expire nsecs     , 0 (00000000)
IPI  03398:IPI-***********************************
IPI  03398:IPI-IPI_ipcdeq entered
IPI  03398:IPI-QE Enqueue Status : , 0 (00000000)
IPI  03398:IPI-IPI_dispose_of_message with status, 0 (00000000)
PAMS 03398:PAMS-****** sent    message ******
PAMS 03398:PAMS-Msg Seq High:, 342 (156)
PAMS 03398:PAMS-Msg Seq Low :, 29950962 (1C903F2)
PAMS 03398:PAMS-******************************
IPI  03398:IPI-IPIdequeue_message
IPI  03398:IPI-IPI_deq_dmq_qe
IPI  03398:IPI-IPI_ipcdeq entered
IPI  03398:IPI-******* Dequeue IPI Message *******
IPI  03398:IPI-Msg Type         , 48 (00000030)
IPI  03398:IPI-Ipi Hdr Version  , 65538 (00010002)
IPI  03398:IPI-Ipi Hdr Length   , 128 (00000080)
IPI  03398:IPI-Msg Seq Low      , 29950962 (01C903F2)
IPI  03398:IPI-Msg Seq High     , 342 (00000156)
IPI  03398:IPI-Timestamp secs   , 864147859 (3381D993)
IPI  03398:IPI-Timestamp nsecs  , 376736000 (16748900)
IPI  03398:IPI-Msg Priority     , 2 (00000002)
IPI  03398:IPI-Msg Source       , 49.3 (00310003)
IPI  03398:IPI-Msg Dest         , 457.1010 (01C903F2)
IPI  03398:IPI-Msg Orig Source  , 457.232 (01C900E8)
IPI  03398:IPI-Msg Orig Dest    , 49.3 (00310003)
IPI  03398:IPI-Msg Routethrough , 457 (000001C9)
IPI  03398:IPI-Msg Notif Target , 457.1010 (01C903F2)
IPI  03398:IPI-Msg Alt Target   , 0.0 (00000000)
IPI  03398:IPI-Msg Jrn Target   , 0.0 (00000000)
IPI  03398:IPI-Deliv Action     , 260 (00000104)
IPI  03398:IPI-Undeliv Action   , 1 (00000001)
IPI  03398:IPI-Notify Action    , 0 (00000000)
IPI  03398:IPI-Status           , 0 (00000000)
IPI  03398:IPI-Undel Status     , 3 (00000003)
IPI  03398:IPI-User Msg ident   , -6553599 (FF9C0001)
IPI  03398:IPI-User Hdr len     , 0 (00000000)
IPI  03398:IPI-User Msg len     , 0 (00000000)
IPI  03398:IPI-Data Format      , 1 (00000001)
IPI  03398:IPI-Visit Count      , 16 (00000010)
IPI  03398:IPI-Rosn Time        , 864147859 (3381D993)
IPI  03398:IPI-Rosn Seq         , 29949952 (01C90000)
IPI  03398:IPI-Lra lsl          , 0 (00000000)
IPI  03398:IPI-Lra msl          , 0 (00000000)
IPI  03398:IPI-Expire secs      , 0 (00000000)
IPI  03398:IPI-Expire nsecs     , 0 (00000000)
IPI  03398:IPI-***********************************
PAMS 03398:PAMS-Received unblocking msg
PAMS 03398:PAMS-PAMS_put_cleanup
put message to queue 49.3

---

Receiving System (HP) 

PAMS 07204:PAMS-flow interval is, 250 (FA)
PAMS 07204:PAMS-flow maximum  is, 1000 (3E8)
PAMS 07204:PAMS-flow minimum  is, 10 (A)
PAMS 07204:PAMS-flow increase is, 10 (A)
PAMS 07204:PAMS-flow decrease percentage is, 25 (19)
PAMS 07204:PAMS-pams_attach_q
IPI  07204:IPI-initializing
IPI  07204:IPI-using bus id 113,  group id 49
IPI  07204:IPI-attaching ipc queues
IPI  07204:IPI-IPIcreate_entity
IPI  07204:IPI-IPI_create_q
IPI  07204:IPI-IPIset_attributes
IPI  07204:IPI-IPI_queue_attach
IPI  07204:IPI-attaching queue : , 0 (00000000)
IPI  07204:IPI-attached to queue :, 1008 (000003F0)
IPI  07204:IPI-IPI_attach_timestamp
IPI  07204:IPI-IPIget_attributes
IPI  07204:IPI-IPI_set_default_quota
IPI  07204:IPI-IPIget_attributes
IPI  07204:IPI-IPIcreate_entity
IPI  07204:IPI-IPI_create_q
IPI  07204:IPI-IPIset_attributes
IPI  07204:IPI-IPI_queue_attach
IPI  07204:IPI-attaching queue : , 3 (00000003)
IPI  07204:IPI-attached to queue :, 3 (00000003)
IPI  07204:IPI-IPI_attach_timestamp
IPI  07204:IPI-IPIget_attributes
IPI  07204:IPI-IPI_set_default_quota
IPI  07204:IPI-IPIget_attributes
PAMS 07204:PAMS-Locking Q Info on Attach
PAMS 07204:PAMS-Unlocking Q Info after Attach
attached to queue 49.3


Actions Menu

 1 Attach Queue
 2 Detach Queue
 3 Locate Queue
 4 Put Message
 5 Get Message
 6 Set Timer
 7 Cancel Timer
 8 View Current Parameters
 9 Previous Menu

 Enter Menu Selection >> 5
PAMS 07204:PAMS-PAMS_deq
IPI  07204:IPI-IPIdequeue_message
IPI  07204:IPI-IPI_deq_dmq_qe
IPI  07204:IPI-IPI_ipcdeq entered
IPI  07204:IPI-QE DEQ failed, -18 (FFFFFFEE)
PAMS 07204:IPI-Dequeue Message failed, -48 (FFFFFFD0)
PAMS 07204:PAMS-PAMS_get_cleanup
PAMS__NOMOREMSG, No messages available
2882.7XHOST::SJZKick Butt In Your Face Messaging !Tue May 20 1997 23:435
    
    have them move their journal files to another directory and
    start fresh.
    
    _sjz.
2882.8Even more traceIRNBRU::MACKENZIEWed May 21 1997 05:34169
Moved the journal file location but no different.

What I have noticed is that the DQF files are only created if I send WF_DQF with
UMA of DISC. As soon as I set it to UMA of SAF then it fails. In fact everything
works fine with UMA of DISC, and sending the otherway - HP to Unix with WF_DQF and
UMA of SAF is ok. I can't figure out if the problem is on the Unix or HP side.

I started the dmqjourn processes with the DMQJRN_TRACE enabled to see if there 
was any more information. When I sent the message with UMA of SAF then nothing 
happened on the HP trace, below is the output of the Unix (sending side) trace. 
It didn't make much sense to my untrained eye but it appears to be attempting to 
send the message every few seconds -

JRN-03532, entering JRN_message_send
JRN-03532, entering JRN_message_push, address 49.3
JRN-03532, entering JRN_queue_remote
JRN-03532, entering JRN_queue_is_connected_remote
JRN-03532, entering JRN_message_enqueue, queue, 1012

The full trace is below. 

Thanks again for any help.

Dave M.


--

Unix Trace - periodically recreated

JRN-03532, exiting JRN_message_dequeue, -16
JRN-03532, dequeue operation timed out
JRN-03532, entering JRN_timer
JRN-03532, timer is expired
JRN-03532, processing restart timer, timestamp 864208017.929152
JRN-03532, entering JRN_stream_restart, stream 49.0
SM -03532, entering SMstream_seek, stream 49.0
SM -03532, entering SM_area_open, area 49.0:0
SM -03532, exiting SM_area_open, SM_ALREADY
SM -03532, exiting SMstream_seek, SM_SUCCESS
JRN-03532, exiting JRN_stream_restart, 0
JRN-03532, entering JRN_message_read, stream 49.0
JRN-03532, entering JRN_stream_read, stream 49.0
SM -03532, entering SMstream_read, stream 49.0
SM -03532, entering SM_stream_read_apc, stream 49.0
SM -03532, entering SM_area_open, area 49.0:0
SM -03532, exiting SM_area_open, SM_ALREADY
SM -03532, entering SM_page_touch, page 49.0:0.1
SM -03532, exiting SM_page_touch, SM_SUCCESS
SM -03532, entering SM_page_touch, page 49.0:0.2
SM -03532, exiting SM_page_touch, SM_SUCCESS
SM -03532, exiting SM_stream_read_apc, SM_ALREADY
SM -03532, exiting SMstream_read, SM_ALREADY
JRN-03532, read message from disk
JRN-03532, exiting JRN_stream_read, 1
JRN-03532, entering JRN_timer_add
JRN-03532, adding an ack timer
JRN-03532, exiting JRN_timer_add, 0
JRN-03532, exiting JRN_message_read, 0
JRN-03532, entering JRN_message_send
JRN-03532, entering JRN_message_push, address 49.3
JRN-03532, entering JRN_queue_remote
JRN-03532, entering JRN_queue_is_connected_remote
JRN-03532, entering JRN_message_enqueue, queue, 1012
JRN-03532, exiting JRN_message_enqueue, 0
JRN-03532, exiting JRN_message_push, 0
JRN-03532, exiting JRN_message_send, 0
JRN-03532, entering JRN_timer_remove
JRN-03532, exiting JRN_timer_remove, 0
JRN-03532, exiting JRN_timer, 0
JRN-03532, timer is set
JRN-03532, entering JRN_message_dequeue


--                                                                            
Unix Trace - when message sent originally

SM -03532, entering SM_page_touch, page 49.0:0.2
SM -03532, exiting SM_page_touch, SM_SUCCESS
SM -03532, exiting SM_stream_read_apc, SM_ALREADY
SM -03532, exiting SMstream_read, SM_ALREADY
JRN-03532, read message from disk
JRN-03532, exiting JRN_stream_read, 1
JRN-03532, entering JRN_timer_add
JRN-03532, adding an ack timer
JRN-03532, exiting JRN_timer_add, 0
JRN-03532, exiting JRN_message_read, 0
JRN-03532, entering JRN_message_send
JRN-03532, entering JRN_message_push, address 49.3
JRN-03532, entering JRN_queue_remote
JRN-03532, exiting JRN_message_dequeue, 0
JRN-03532, setting micro sleep
JRN-03532, dequeued user message, sequence 2350.29950962
JRN-03532, entering JRN_stream_create, stream 49.0
JRN-03532, exiting JRN_stream_create, 0
JRN-03532, entering JRN_context_timestamp
JRN-03532, exiting JRN_context_timestamp
JRN-03532, entering JRN_message_write, stream 49.0
JRN-03532, entering JRN_stream_write, stream 49.0
JRN-03532, entering JRN_stream_modify, stream 49.0
JRN-03532, entering JRN_timer_add
JRN-03532, adding a flush timer
JRN-03532, exiting JRN_timer_add, 0
JRN-03532, exiting JRN_stream_modify, 0
JRN-03532, exiting JRN_stream_write, 2
JRN-03532, exiting JRN_message_write, 2
JRN-03532, entering JRN_notify_create
JRN-03532, exiting JRN_notify_create
JRN-03532, inserting notification of type, 2
JRN-03532, and, timestamp 864208050.633424
JRN-03532, entering JRN_timer
JRN-03532, exiting JRN_timer, 0
JRN-03532, entering JRN_message_dequeue
JRN-03532, exiting JRN_message_dequeue, -16
JRN-03532, dequeue operation timed out
JRN-03532, entering JRN_stream_flush, stream 49.0
SM -03532, entering SMstream_write, stream 49.0
SM -03532, entering SM_io_create
SM -03532, exiting SM_io_create
SM -03532, entering SM_area_open, area 49.0:0
SM -03532, exiting SM_area_open, SM_ALREADY
SM -03532, entering SM_page_touch, page 49.0:0.6
SM -03532, exiting SM_page_touch, SM_SUCCESS
SM -03532, entering SM_page_modify, page 49.0:0.6
SM -03532, entering SM_area_modify, area 49.0:0
SM -03532, inserted modified area, area 49.0:0
SM -03532, entering SM_stream_modify, stream 49.0
SM -03532, exiting SM_stream_modify
SM -03532, exiting SM_area_modify, SM_SUCCESS
SM -03532, exiting SM_page_modify, SM_SUCCESS
SM -03532, exiting SMwrite_stream, SM_SUCCESS
SM -03532, entering SMstream_flush, stream 49.0
SM -03532, entering SM_area_flush, area 49.0:0
SM -03532, entering SM_page_flush, page 49.0:0.6
SM -03532, entering SM_page_seal, page 49.0:0.6
SM -03532, exiting SM_page_seal
SM -03532, entering SM_page_unseal, page 49.0:0.6
SM -03532, exiting SM_page_unseal, SM_SUCCESS
SM -03532, entering SM_area_unmodify, area 49.0:0
SM -03532, entering SM_stream_unmodify, stream 49.0
SM -03532, exiting SM_stream_unmodify, SM_SUCCESS
SM -03532, exiting SM_area_unmodify, SM_SUCCESS
SM -03532, exiting SM_page_flush, SM_SUCCESS
SM -03532, exiting SM_area_flush, SM_SUCCESS
SM -03532, exiting SMstream_flush, SM_SUCCESS
JRN-03532, entering JRN_stream_unmodify, stream 49.0
JRN-03532, exiting JRN_stream_unmodify
SM -03532, entering SMstream_completion, stream 49.0
SM -03532, entering SM_io_destroy
SM -03532, exiting SM_io_destroy
SM -03532, exiting SMstream_completion, SM_SUCCESS
JRN-03532, write completed, sequence 2350.29950962
SM -03532, entering SMstream_completion, stream 49.0
SM -03532, exiting SMstream_completion, -22
JRN-03532, exiting JRN_stream_flush, 0
JRN-03532, entering JRN_timer_remove
JRN-03532, exiting JRN_timer_remove, 0
JRN-03532, entering JRN_notify_send, 14000c480
JRN-03532, sending notification to, address 457.1010
JRN-03532, entering JRN_message_push, address 457.1010
JRN-03532, entering JRN_message_enqueue, queue, 1010
JRN-03532, exiting JRN_message_enqueue, 0
JRN-03532, exiting JRN_message_push, 0
JRN-03532, exiting JRN_notify_send, 0
JRN-03532, entering JRN_timer
JRN-03532, exiting JRN_timer, 0
JRN-03532, timer is set
JRN-03532, entering JRN_message_dequeue
2882.9Anybody there ?IRNBRU::MACKENZIEThu May 22 1997 16:358
    The customer is very concerned about this - they've already had
    considerable problems getting the HP DMQ group started, this is just
    confirming their doubts.
    
    Any help would be great.
    
    Dave M.
2882.10PAMSRC::MILLERThu May 22 1997 19:1315
    You need to try and isolate where the messages are failing along
    its path.  I would start with fresh journals on both sides. 
    Use the dmqtest{c|m} to send about three messages with WF_DQF/SAF
    from UNIX to HP with no receiver.  Then bring down the groups
    and use dmqjdump to dump the journals on both systems.  The
    messages should be on the HP side.  If they are not then it
    may be a connectivity problem.  If they are on the HP side then
    bring up the group and a test program to read them.  If you do
    not receive the messages then you will have to reproduce this
    scenario and save the journals, full JRN/SM/IPI tracing, and
    init files for both systems and send us a pointer to the files.


    tm
2882.11XHOST::SJZKick Butt In Your Face Messaging !Fri May 23 1997 00:0514
    
    it sounds like you don't have MRS enabled on the Digital UNIX
    side.  You say can't do UMA_SAF from UNIX->HP.  When you spec-
    ify a UMA of SAF it always flows through the SAF and requires
    a local journal process and journals even if you are  sending
    xx_DQF and the remote target/journal is reachable  and  avail-
    able.   when you change the UMA to DISCard  then  it  doesn't
    need local journaling and it works just fine.
    
    verify that MRS is enabled on the Digital UNIX  machine, that
    the journal process is running,  and that it  has  access  to
    and sufficient room on the disk defined in the  journal  path.
    
    _sjz.