Clovertech

The ‘time’ case of switch in tps

› Clovertech Forums › Read Only Archives › Cloverleaf › Cloverleaf › The ‘time’ case of switch in tps

  • Creator
    Topic
  • January 26, 2013 at 7:47 pm #53488
    Benny Chirackal
    Participant

      Can anybody explain me what the ‘time’ case of the switch in a tps is used for? Can this be used for doing a specific action at a specific time (like a cron job)?

    • Creator
      Topic
    Viewing 5 reply threads
    • Author
      Replies
      • January 28, 2013 at 3:43 pm #77852
        Levy Lazarre
        Participant

          Benny,

          Indeed the “time” case is used to execute some actions at a specific time.

          The way I use it: I have several threads using the PROTOCOL:upoc.  In UPoC Protocol properties,  Read TPS –> Advanced Scheduling, I specify the tps procedure and the “time” portion of the script is triggered by the scheduler at the specified times.

          Typically, I use the “time” case to batch HL7 files, add headers/trailers, and move the modified files to a designated location for ftp processing.

          Comment:

          Code:



          time {
             # The proc will enter here if it is configured as a Read TPS
                # and an interval or advanced scheduling configured

          I hope this helps.

        • January 28, 2013 at 7:55 pm #77853
          Benny Chirackal
          Participant

            Thanks!, Levy. I will try that out.

          • June 3, 2013 at 10:13 pm #77854
            Luke Anderson
            Participant

              Have either of you seen where using this UPOC thread with Advanced Scheduling causes the process it’s in to panic if you turn off this thread and then turn it back on?

              Thanks.

            • June 4, 2013 at 1:48 pm #77855
              Levy Lazarre
              Participant

                Luke,

                I have never seen this happen or heard anyone mentioning it.

              • June 24, 2013 at 7:15 pm #77856
                Dale Powers
                Participant

                  I’m experiencing this on 5.8.5, but am hoping it is a coding error in my proc. If the process is down, starting the thread is successful and advanced scheduling works as I need. If I stop the thread and start it, or use a restart command while leaving the process up, I get a panic. This protocol:upoc thread is the only one configured in this process. My schedule, for testing purposes was 0 0,5,10,15,20,25,30,35,40,45,50,55 * * * *.

                  Here is the log from the stopping the thread:

                  Code:

                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:56:46] Receiving a command
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:56:46] Received command: ‘dales_upoc_thread pstop’
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:56:46] Doing ‘pstop’ command on thread ‘dales_upoc_thread’
                  [pti :sche:DBUG/2:dales_upoc_thread:06/24/2013 11:56:46] Thread 2 has been enabled
                  [pti :sche:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Thread has 1 ready events.
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] Processing PTHREADS () event 0x3178add8
                  [pti :msg :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] Processing pthread message queues.
                  [pti :msg :DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] Processing PTHREAD msg que 0x31507bb8
                  [pti :msg :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] Processing pthreads message
                  [pti :msg :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] Processing PTHREAD Control Message from tid 0
                  [pti :msg :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] Thread 2 has been told to commit suicide
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ptm free  0x317dab38
                  [pti :sche:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Thread has 0 ready events left.
                  [pti :sche:INFO/0:dales_upoc_thread:06/24/2013 11:56:46] PTI Sched Thread 2 has been killed
                  [pti :thre:DBUG/3:dales_upoc_thread:06/24/2013 11:56:46] Thread after callback
                  [pd  :thrd:INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Shutting down protocol thread dales_upoc_thread.
                  [icl :serv:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] ICL Shutting down server dales_upoc_thread
                  [icl :conn:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] ICL Closing connection cache entry for dales_upoc_thread
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag itd free  0x31786d98
                  [dbi :dbi :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] (10000) ‘cl_reclock: About to lock record’
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ite alloc 0x317e4068
                  [dbi :dbi :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] (0) ‘cl_recfree: Succeeded in freeing record lock’
                  [dbi :dbi :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] (10000) ‘cl_reclock: About to lock record’
                  [dbi :icl :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] dbiIclDeregister: deregistered ‘dales_upoc_thread’
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ite free 0x317e4068
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shutting down ACK Control TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shutting down data prewrite TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shutting down reply prewrite TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shutting down data send OK TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shutting down reply send OK TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shutting down data send fail TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shutting down reply send fail TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shutting down reply generation TPS
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] SMS Shuting down the SMS module
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Shutdown the IB data SMS stack
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] [midNULL] Driver processing msg
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Shutdown the IB reply SMS stack
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] [midNULL] Driver processing msg
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Shutdown the OB data SMS stack
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] [midNULL] Driver processing msg
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Shutdown the OB reply SMS stack
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:56:46] [midNULL] Driver processing msg
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tc free  0x317da908
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag sms free  0x317b7318
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tc free  0x317daa18
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag sms free  0x317b8988
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tc free  0x317dab98
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag sms free  0x317b89b8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tc free  0x317db8f8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag sms free  0x317b89e8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag std free  0x317b61c8
                  [pd  :pdtd:INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Shuting down Protocol Driver upoc
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Set driver status to PD_STATUS_CLOSING
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:56:46] *** Next Interval = 194, Event(1) time = Mon Jun 24 12:00:00 2013
                  [tps :tps :INFO/1:dales_upoc_thread:06/24/2013 11:56:46] tds.string = tps_dales_testproc {CONTEXT pdupoc_read} {ARGS {{MYTHREAD dales_upoc_thread} {UPOCPOINT adv_sched} {TARGETDIR ../../../data/dales_out} {TARGETFILE dalesOutFile}}} {MODE shutdown} {VERSION 3.0}
                  tps_dales_testproc/dales_upoc_thread/pdupoc_read: 201306241156 Mode before switch: shutdown
                  tps_dales_testproc/dales_upoc_thread/pdupoc_read: 201306241156 Expecting mode of shutdown, got: shutdown
                  tps_dales_testproc/dales_upoc_thread/pdupoc_read: In ‘Shutdown’ timestamp is 201306241153 thread is dales_upoc_thread attached at adv_sched myTime is 201306241156
                  tps_dales_testproc/dales_upoc_thread/pdupoc_read: closing ../../../data/dales_in/dalesTestFile
                  tps_dales_testproc/dales_upoc_thread/pdupoc_read: open channels are stderr file24 stdin stdout
                  tps_dales_testproc/dales_upoc_thread/pdupoc_read: In ‘Shutdown’ closing ../../../data/dales_in/dalesTestFile on channel file24
                  [tps :tps :INFO/1:dales_upoc_thread:06/24/2013 11:56:46] tds.string = tps_dales_testproc {CONTEXT pdupoc_write} {ARGS {{MYTHREAD dales_upoc_thread} {UPOCPOINT write_tps}  {WRITEDIR ../../../data/dales_in} {WRITEFILE dalesTestFile}}} {MODE shutdown} {VERSION 3.0}
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: 201306241156 Mode before switch: shutdown
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: 201306241156 Expecting mode of shutdown, got: shutdown
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: In ‘Shutdown’ timestamp is 201306241153 thread is dales_upoc_thread attached at write_tps myTime is 201306241156
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: closing ../../../data/dales_in/dalesTestFile
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: open channels are stderr stdin stdout
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] tiUnregistering TIMER (upoc adv sched) event 0x317daaf8 for tid 2
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] evUnregister TIMER (upoc adv sched) event 0x317daaf8 for tid 2
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag dqe free  0x317b8a18
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ev free  0x317daaf8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tc free  0x31415598
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tc free  0x317b5f58
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag pu free  0x317b5f18
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Set driver status to PD_STATUS_DOWN
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag pd free  0x317b5ec8
                  [prod:prod:INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Checking for leaked handles in the General interpreter…

                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tclinterp free 0x3155ce38
                  [prod:prod:INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Checking for leaked handles in the TPS interpreter…

                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tclinterp free 0x315d4af8
                  [tii :tii :INFO/1:dales_upoc_thread:06/24/2013 11:56:46] Shuting down Tcl interps
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tii free  0x3152d6b8
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] tiUnregistering ACTIVE_TIMER () event 0x31786e48 for tid 2
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] evUnregister ACTIVE_TIMER () event 0x31786e48 for tid 2
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag dqe free  0x317d7988
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ev free  0x31786e48
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag timeval free  0x3169d808
                  [msi :msi :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] msiExportStats: export for thread: dales_upoc_thread
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag mtd free  0x3177aac8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag mts free 0x317b5db8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag mis free 0x317b9e38
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag dtd free  0x3178ccd8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ptd free  0x316bed88
                  [icl :cb  :DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] ICL shutdown callback
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] tiUnregistering UNKNOWN () event 0x3178acf8 for tid 2
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] evUnregister UNKNOWN () event 0x3178acf8 for tid -1
                  [icl :tcpi:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] Tcpip shutting down socket 22
                  [icl :tcpi:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] Shutdown successful
                  [icl :tcpi:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] Tcpip closing socket 22
                  [icl :tcpi:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] Close successful
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag tcpip free  0x3178ac98
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag imh free  0x3178acd8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ev free  0x3178acf8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag conn free  0x3178ad38
                  [icl :cb  :DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] ICL shutdown callback
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag conn free  0x3178adb8
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] evUnregister SOCKET (ICL Server Listen) event 0x3178ad58 for tid 2
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] evUnregister PTHREADS () event 0x3178add8 for tid 2
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] evUnregister POLLED () event 0x31786dc8 for tid 2
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ev free  0x3178ad58
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ev free  0x3178add8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ev free  0x31786dc8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag el free  0x3144ee88
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag el free  0x315070f8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag el free  0x315055c8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag ptm alloc 0x30d2ca28
                  [pti :msg :DBUG/1:dales_upoc_thread:06/24/2013 11:56:46] Send PTM 0x30d2ca28 from 2 to 0: data 0x0
                  [pti :thre:INFO/0:dales_upoc_thread:06/24/2013 11:56:46] Thread exiting with status 0
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:56:46] diag eoc free  0x315a70a8
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:56:46] Receiving a command
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:56:46] Command client went away.  Closing connection.
                  Engine idle — 06/24/2013 11:56:56

                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:58:45] Receiving a command
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:58:45] Receiving a command
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:58:45] Received command: ‘dales_upoc_thread phold_obd’
                  [cmd :cmd :WARN/0:    dales_cmd:06/24/2013 11:58:45] Thread is not running ‘dales_upoc_thread’
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:58:45] Receiving a command
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:58:45] Command client went away.  Closing connection.
                  Engine idle — 06/24/2013 11:58:55

                  And here is the log from the attempt to start it with the process running:

                  Code:

                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:59:09] Receiving a command
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:59:09] Receiving a command
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:59:09] Received command: ‘dales_upoc_thread pstart’
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:59:09] Doing ‘pstart’ command on ‘dales_upoc_thread’
                  [prod:prod:INFO/0:dales_upoc_thread:06/24/2013 11:59:09] Starting protocol thread dales_upoc_thread as tid 2.
                  [prod:prod:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Applying EO config: ‘enable_all’
                  [msi :msi :INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing statistics for: dales_upoc_thread
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag mtd alloc 0x317958f8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag mts alloc 0x317aa478
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag mis alloc 0x317d8f98
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag timeval alloc 0x316b6d08
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag timeval alloc 0x316b6d18
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag ev alloc 0x317aa548
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag dqe alloc 0x317aa588
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] tiRegistering ACTIVE_TIMER () event 0x317aa548 for tid 2
                  [pti :even:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] evRegistering ACTIVE_TIMER () event 0x317aa548 for tid 2
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag timeval free  0x316b6d18
                  [msi :msi :DBUG/1:dales_upoc_thread:06/24/2013 11:59:10] msiSetExportTimer: 5 second timer event set
                  [pd  :thrd:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Performing database recovery
                  [dbi :log :INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Scanning Recovery DB for selected messages
                  [dbi :log :INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Messages limited to those owned by:
                  [dbi :log :INFO/1:dales_upoc_thread:06/24/2013 11:59:10] dales_upoc_thread
                  [dbi :dbi :DBUG/1:dales_upoc_thread:06/24/2013 11:59:10] (0) ‘cl_lock: Trying to lock database ‘
                  [dbi :dbi :DBUG/1:dales_upoc_thread:06/24/2013 11:59:10] (0) ‘ENGINE=r, rec=10001
                  ‘
                  [dbi :dbi :DBUG/1:dales_upoc_thread:06/24/2013 11:59:10] (1) ‘ENGINE=r, rec=10002
                  ‘
                  [dbi :dbi :DBUG/1:dales_upoc_thread:06/24/2013 11:59:10] (2) ‘ENGINE=r, rec=10003
                  ‘
                  [dbi :dbi :DBUG/1:dales_upoc_thread:06/24/2013 11:59:10] (0) ‘cl_lock: Succeeded in locking database ‘
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Checking msg [0.0.25027473], owner ‘alt_adt_out’, state 11
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Message not selected
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Checking msg [0.0.25027551], owner ‘alt_adt_out’, state 11
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Message not selected
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Checking msg [0.0.24760612], owner ‘pyx_mord_out’, state 11
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Message not selected
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Checking msg [0.0.24761976], owner ‘pyx_mord_out’, state 11
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Message not selected
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Checking msg [0.0.24761834], owner ‘pyx_mord_out’, state 11
                  [dbi :log :INFO/3:dales_upoc_thread:06/24/2013 11:59:10] Message not selected
                  [pd  :thrd:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Database recovery complete
                  [pd  :pdtd:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Initializing Protocol Driver
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag pd alloc 0x317aa5a8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag pu alloc 0x317aa5d8
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] *** Next Interval = 50, Event(1) time = Mon Jun 24 12:00:00 2013
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] SCHEDULE EVENT DATA for EVENT 0
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Seconds(count = 1, type = TYPE_SINGLE) = 0
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Minutes(count = 12, type = TYPE_LIST) = 0 5 10 15 20 25 30 35 40 45 50 55
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Hours = * = NULL
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Monthday = * = NULL
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Month = * = NULL
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Weekday * = NULL
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Number of procs = 0
                  [is  :ISEv:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Number of args = 0
                  [upoc:init:WARN/0:dales_upoc_thread:06/24/2013 11:59:10] Empty IB TPS configured — ignored
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag tc free  0x31415598
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag tc alloc 0x317aa5f8
                  [tps :tps :INFO/1:dales_upoc_thread:06/24/2013 11:59:10] tds.string = tps_dales_testproc {CONTEXT pdupoc_write} {ARGS {{MYTHREAD dales_upoc_thread} {UPOCPOINT write_tps}  {WRITEDIR ../../../data/dales_in} {WRITEFILE dalesTestFile}}} {MODE start} {VERSION 3.0}
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: 201306241159 Mode before switch: start
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: 201306241159 Expecting mode of start, got: start
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: At startup timestamp is 201306241159 thread is dales_upoc_thread attached at write_tps
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: out file is ../../../data/dales_in/dalesTestFile
                  tps_dales_testproc/dales_upoc_thread/pdupoc_write: writeDir and writeFile are ../../../data/dales_in dalesTestFile
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag ev alloc 0x317b5848
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Set driver status to PD_STATUS_UP
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing ACK Control TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing data prewrite TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing reply prewrite TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing data send OK TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing reply send OK TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing data send fail TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing reply send fail TPS
                  [pd  :pdtd:INFO/1:dales_upoc_thread:06/24/2013 11:59:10] Initializing reply generation TPS
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] SMS Initializing the SMS module for dales_upoc_thread
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag std alloc 0x317aa668
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag sms alloc 0x317b60a8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag sms alloc 0x317b7048
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag sms alloc 0x317e34e8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag sms alloc 0x317e3518
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Initialize the IB data SMS stack
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] [midNULL] Driver processing msg
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag tc alloc 0x317ed708
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Initialize the IB reply SMS stack
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] [midNULL] Driver processing msg
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag tc alloc 0x317eebc8
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Initialize the OB data SMS stack
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] [midNULL] Driver processing msg
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag tc alloc 0x317eedb8
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Initialize the OB reply SMS stack
                  [sms :sms :INFO/0:dales_upoc_thread:06/24/2013 11:59:10] [midNULL] Driver processing msg
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag tc alloc 0x317ef438
                  [pd  :pdtd:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Throwing startup control switches
                  [pd  :pdtd:INFO/0:dales_upoc_thread:06/24/2013 11:59:10] Throwing OB post-SMS dequeue switch
                  [icl :icl :DBUG/2:dales_upoc_thread:06/24/2013 11:59:10] Sending to thread ‘dales_xlate’, command ‘pstart dales_upoc_thread’
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag imh alloc 0x317aa6a8
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag ptm alloc 0x317b5dd8
                  [pti :msg :DBUG/1:dales_upoc_thread:06/24/2013 11:59:10] Send PTM 0x317b5dd8 from 2 to 1: data 0x317aa6a8
                  [xlt :thre:DBUG/1:dales_upoc_thread:06/24/2013 11:59:10] Notifying processes of new thread
                  [icl :tcpi:ERR /0:    dales_cmd:06/24/2013 11:59:10] write failed: Bad file number
                  [cmd :cmd :INFO/0:    dales_cmd:06/24/2013 11:59:10] Inrecoverable socket error.  Closing connection.
                  [icl :icl :ERR /0:    dales_cmd:06/24/2013 11:59:10] Shutdown failed: Bad file number
                  [icl :icl :ERR /0:    dales_cmd:06/24/2013 11:59:10] Close failed: Bad file number
                  [pti :sign:WARN/0:    dales_cmd:06/24/2013 11:59:10] Thread 0 ( dales_cmd ) received signal 11
                  [pti :sign:WARN/0:    dales_cmd:06/24/2013 11:59:10] PC = 0x1035990c
                  PANIC: “0”
                  PANIC: Calling “pti” for thread dales_cmd
                  —– Scheduler State —–
                  Thread Events     State      Priority Runnable  PT Msgs
                    0      0   SCHED_RUNNING      0       0       1,0,0
                    1      0   SCHED_IDLE         0       0       0,0,1
                    2      0   SCHED_IDLE         0       0       0,0,0

                  ————– Thread 0 (dales_cmd)————–
                  ti: 0x30ab0f58
                     tid           :    0
                     HostPthreadId : 0x1
                     EventList     : 0x30a85a08
                     PolledEvents  : 0x30ab0ca8
                     PthreadEvent  : 0x30ab1438
                     ReadyEvents   : 0x30ab0cc8
                     CtrlMsgs      : 0x30ab0d08
                     UserCtrlMsgs  : 0x30ab10a8
                     UserDataMsgs  : 0x30ab10c8
                     StartArgs     : 0x0
                     SchedState    : SCHED_RUNNING
                     SchedPriority : 0
                     Killed        : 1
                  —– Registered Events —–
                  el: 0x30a85a08
                     elCount : 3
                     elHead: 0x30ab1478
                     elTail: 0x3131a398
                  ele: 0x30ab1478
                     event: 0x30ab1438
                     prev : 0x0
                     next : 0x30ca89c8
                  ev: 0x30ab1438
                      evType     : PTHREADS
                      evStrDesc    :
                      evSocket     : 0
                      evMsgQue     : 0
                      evTid        : 0
                      evState      : 0
                      evPtMsg      : 0x30d2ca28
                      evUserData   : 0x0
                      evCallBack   : 0x0
                      evCbShutdown : 0x0
                      evRecurFreq  :
                  ele: 0x30ca89c8
                     event: 0x30cb1528
                     prev : 0x30ab1478
                     next : 0x3131a398
                  ev: 0x30cb1528
                      evType     : SOCKET
                      evStrDesc    : Command port listen
                      evSocket     : 10
                      evMsgQue     : 0
                      evTid        : 0
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x30c0ce38
                      evCallBack   : 0x300a66e4
                      evCbShutdown : 0x300a66f0
                      evRecurFreq  :
                  ele: 0x3131a398
                     event: 0x3144ee68
                     prev : 0x30ca89c8
                     next : 0x0
                  ev: 0x3144ee68
                      evType     : SOCKET
                      evStrDesc    : Command connection accept
                      evSocket     : 21
                      evMsgQue     : 0
                      evTid        : 0
                      evState      : 2
                      evPtMsg      : 0x0
                      evUserData   : 0x314107a8
                      evCallBack   : 0x300a66fc
                      evCbShutdown : 0x300a66f0
                      evRecurFreq  :
                  —– Polled Events —–
                  el: 0x30ab0ca8
                     elCount : 0
                     elHead: 0x0
                     elTail: 0x0
                  —– Ready Events —–
                  el: 0x30ab0cc8
                     elCount : 0
                     elHead: 0x0
                     elTail: 0x0
                  —– Outstanding Pthread Ctrl Msgs —–
                  pmq: 0x30ab0d08
                  Count   : 1
                  Head    : 0x315055c8
                  Tail    : 0x315055c8
                  PthreadMsg: 0x315055c8
                     ptmType   : 1
                     ptmSender : 0
                     ptmCtrl   : 3358
                     ptmNext   : 0x0
                     ptmDataPtr: 0x0
                     ptmDataInt: 0
                  —– Outstanding Pthread User Ctrl Msgs —–
                  pmq: 0x30ab10a8
                  Count   : 0
                  Head    : 0x0
                  Tail    : 0x0
                  —– Outstanding Pthread User Data Msgs —–
                  pmq: 0x30ab10c8
                  Count   : 0
                  Head    : 0x0
                  Tail    : 0x0

                  ————– Thread 1 (dales_xlate)————–
                  ti: 0x30cf0908
                     tid           :    1
                     HostPthreadId : 0x203
                     EventList     : 0x30ce2d48
                     PolledEvents  : 0x30ce4678
                     PthreadEvent  : 0x30e4a698
                     ReadyEvents   : 0x30ce4a08
                     CtrlMsgs      : 0x30ce4a28
                     UserCtrlMsgs  : 0x30ce5fc8
                     UserDataMsgs  : 0x30ce5fe8
                     StartArgs     : 0x30c66ab8
                     SchedState    : SCHED_IDLE
                     SchedPriority : 0
                     Killed        : 0
                  —– Registered Events —–
                  el: 0x30ce2d48
                     elCount : 4
                     elHead: 0x30e43c78
                     elTail: 0x310597e8
                  ele: 0x30e43c78
                     event: 0x30e4a4d8
                     prev : 0x0
                     next : 0x30e43fc8
                  ev: 0x30e4a4d8
                      evType     : SOCKET
                      evStrDesc    : ICL Server Listen
                      evSocket     : 15
                      evMsgQue     : 0
                      evTid        : 1
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x30e3dee8
                      evCallBack   : 0x300a5760
                      evCbShutdown : 0x300a56c4
                      evRecurFreq  :
                  ele: 0x30e43fc8
                     event: 0x30e4a698
                     prev : 0x30e43c78
                     next : 0x30e487d8
                  ev: 0x30e4a698
                      evType     : PTHREADS
                      evStrDesc    :
                      evSocket     : 0
                      evMsgQue     : 0
                      evTid        : 1
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x30e3f168
                      evCallBack   : 0x300a56d0
                      evCbShutdown : 0x300a56c4
                      evRecurFreq  :
                  ele: 0x30e487d8
                     event: 0x30e4c6a8
                     prev : 0x30e43fc8
                     next : 0x310597e8
                  ev: 0x30e4c6a8
                      evType     : POLLED
                      evStrDesc    :
                      evSocket     : 0
                      evMsgQue     : 0
                      evTid        : 1
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x30d2c8c8
                      evCallBack   : 0x300a5778
                      evCbShutdown : 0x0
                      evRecurFreq  :
                  ele: 0x310597e8
                     event: 0x312cc1b8
                     prev : 0x30e487d8
                     next : 0x0
                  ev: 0x312cc1b8
                      evType     : SOCKET
                      evStrDesc    : Xlate thread Eng Event
                      evSocket     : 18
                      evMsgQue     : 0
                      evTid        : 1
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x30d2c8c8
                      evCallBack   : 0x300a5598
                      evCbShutdown : 0x0
                      evRecurFreq  :
                  —– Polled Events —–
                  el: 0x30ce4678
                     elCount : 1
                     elHead: 0x30e48638
                     elTail: 0x30e48638
                  ele: 0x30e48638 — POLLED event: 0x30e4c6a8
                  —– Ready Events —–
                  el: 0x30ce4a08
                     elCount : 0
                     elHead: 0x0
                     elTail: 0x0
                  —– Outstanding Pthread Ctrl Msgs —–
                  pmq: 0x30ce4a28
                  Count   : 0
                  Head    : 0x0
                  Tail    : 0x0
                  —– Outstanding Pthread User Ctrl Msgs —–
                  pmq: 0x30ce5fc8
                  Count   : 0
                  Head    : 0x0
                  Tail    : 0x0
                  —– Outstanding Pthread User Data Msgs —–
                  pmq: 0x30ce5fe8
                  Count   : 1
                  Head    : 0x317b5dd8
                  Tail    : 0x317b5dd8
                  PthreadMsg: 0x317b5dd8
                     ptmType   : 3
                     ptmSender : 2
                     ptmCtrl   : 0
                     ptmNext   : 0x0
                     ptmDataPtr: 0x317aa6a8
                     ptmDataInt: 830121640

                  ————– Thread 2 (dales_upoc_thread)————–
                  ti: 0x3155c108
                     tid           :    2
                     HostPthreadId : 0x305
                     EventList     : 0x31522e28
                     PolledEvents  : 0x3152b5a8
                     PthreadEvent  : 0x317b5308
                     ReadyEvents   : 0x3152c1f8
                     CtrlMsgs      : 0x3152d6b8
                     UserCtrlMsgs  : 0x31530b68
                     UserDataMsgs  : 0x315319b8
                     StartArgs     : 0x315070f8
                     SchedState    : SCHED_IDLE
                     SchedPriority : 0
                     Killed        : 0
                  —– Registered Events —–
                  el: 0x31522e28
                     elCount : 4
                     elHead: 0x317b5ea8
                     elTail: 0x317da798
                  ele: 0x317b5ea8
                     event: 0x317b5288
                     prev : 0x0
                     next : 0x31786e08
                  ev: 0x317b5288
                      evType     : SOCKET
                      evStrDesc    : ICL Server Listen
                      evSocket     : 23
                      evMsgQue     : 0
                      evTid        : 2
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x317b5268
                      evCallBack   : 0x300a5760
                      evCbShutdown : 0x300a56c4
                      evRecurFreq  :
                  ele: 0x31786e08
                     event: 0x317b5308
                     prev : 0x317b5ea8
                     next : 0x31786e28
                  ev: 0x317b5308
                      evType     : PTHREADS
                      evStrDesc    :
                      evSocket     : 0
                      evMsgQue     : 0
                      evTid        : 2
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x317b52e8
                      evCallBack   : 0x300a56d0
                      evCbShutdown : 0x300a56c4
                      evRecurFreq  :
                  ele: 0x31786e28
                     event: 0x317aa438
                     prev : 0x31786e08
                     next : 0x317da798
                  ev: 0x317aa438
                      evType     : POLLED
                      evStrDesc    :
                      evSocket     : 0
                      evMsgQue     : 0
                      evTid        : 2
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x0
                      evCallBack   : 0x300a648c
                      evCbShutdown : 0x0
                      evRecurFreq  :
                  ele: 0x317da798
                     event: 0x317aa548
                     prev : 0x31786e28
                     next : 0x0
                  ev: 0x317aa548
                      evType     : ACTIVE_TIMER
                      evStrDesc    :
                      evSocket     : 0
                      evMsgQue     : 0
                      evTid        : 2
                      evState      : 0
                      evPtMsg      : 0x0
                      evUserData   : 0x317958f8
                      evCallBack   : 0x300a57c0
                      evCbShutdown : 0x0
                      evRecurFreq  : 5.0000
                  —– Polled Events —–
                  el: 0x3152b5a8
                     elCount : 1
                     elHead: 0x3178ae78
                     elTail: 0x3178ae78
                  ele: 0x3178ae78 — POLLED event: 0x317aa438
                  —– Ready Events —–
                  el: 0x3152c1f8
                     elCount : 0
                     elHead: 0x0
                     elTail: 0x0
                  —– Outstanding Pthread Ctrl Msgs —–
                  pmq: 0x3152d6b8
                  Count   : 0
                  Head    : 0x0
                  Tail    : 0x0
                  —– Outstanding Pthread User Ctrl Msgs —–
                  pmq: 0x31530b68
                  Count   : 0
                  Head    : 0x0
                  Tail    : 0x0
                  —– Outstanding Pthread User Data Msgs —–
                  pmq: 0x315319b8
                  Count   : 0
                  Head    : 0x0
                  Tail    : 0x0

                  PANIC: Calling “dbi shutdown” for thread dales_cmd
                  PANIC: Calling “dbi shutdown” for thread dales_xlate
                  PANIC: Calling “clean up ODBC” for thread dales_cmd
                  PANIC: Calling “dbi shutdown” for thread dales_upoc_thread
                  [diag:leak:DBUG/0:dales_upoc_thread:06/24/2013 11:59:10] diag dtd free  0x3179ffd8
                  PANIC: Calling “dbi shutdown” for thread dales_upoc_thread
                  [dbi :dbi :WARN/0:dales_upoc_thread:06/24/2013 11:59:10] NULL DTD when closing DBI
                  PANIC: Process panic—engine going down
                  PANIC: assertion ‘0’ failed at PthreadInterface.cpp/719

                • January 20, 2014 at 7:41 pm #77857
                  Hyunyoung Park
                  Participant

                    I’m experiencing the exactly same issue as Dale posted above. Same sequence of activities as he described crashes the process and gives the same error comments. PANIC: assertion ‘0’ failed at PthreadInterface.cpp/719

                    Does anyone have an idea what is causing the panic?

                • Author
                  Replies
                Viewing 5 reply threads
                • The forum ‘Cloverleaf’ is closed to new topics and replies.