rendered paste body[[2011-04-22 05:59:36.412529] VERBOSE[10144] file.c: -- <DAHDI/35-1> Playing 'beep.gsm' (language 'en')
[2011-04-22 05:59:36.413230] DEBUG[10062] devicestate.c: No provider found, checking channel drivers for DAHDI - 35
[2011-04-22 05:59:36.413617] DEBUG[10062] devicestate.c: Changing state for DAHDI/35 - state 2 (In use)
[2011-04-22 05:59:36.413775] DEBUG[10062] devicestate.c: device 'DAHDI/35' state '2'
[2011-04-22 05:59:36.414035] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.414510] DEBUG[10099] app_queue.c: Device 'DAHDI/35' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[2011-04-22 05:59:36.414851] DEBUG[10082] chan_iax2.c: ip callno count incremented to 16 for 192.168.124.41
[2011-04-22 05:59:36.423483] VERBOSE[10143] app_dial.c: -- DAHDI/35-1 answered SIP/gxp823-00000003
[2011-04-22 05:59:36.424619] DEBUG[10143] channel.c: Set channel DAHDI/35-1 to write format slin
[2011-04-22 05:59:36.425013] DEBUG[10143] chan_sip.c: SIP answering channel: SIP/gxp823-00000003
[2011-04-22 05:59:36.425050] DEBUG[10062] devicestate.c: No provider found, checking channel drivers for SIP - gxp823
[2011-04-22 05:59:36.425215] DEBUG[10062] chan_sip.c: Checking device state for peer gxp823
[2011-04-22 05:59:36.425103] DEBUG[10143] res_rtp_asterisk.c: Setting the marker bit due to a source update
[2011-04-22 05:59:36.425313] DEBUG[10062] devicestate.c: Changing state for SIP/gxp823 - state 2 (In use)
[2011-04-22 05:59:36.425376] DEBUG[10062] devicestate.c: device 'SIP/gxp823' state '2'
[2011-04-22 05:59:36.425806] DEBUG[10143] chan_sip.c: Setting framing from config on incoming call
[2011-04-22 05:59:36.425994] DEBUG[10099] app_queue.c: Device 'SIP/gxp823' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[2011-04-22 05:59:36.426505] DEBUG[10143] chan_sip.c: ** Our capability: (gsm|ulaw|alaw) Video flag: True Text flag: True
[2011-04-22 05:59:36.426612] DEBUG[10143] chan_sip.c: ** Our prefcodec: (nothing)
[2011-04-22 05:59:36.427271] DEBUG[10143] chan_sip.c: -- Done with adding codecs to SDP
[2011-04-22 05:59:36.428384] DEBUG[10143] chan_sip.c: Done building SDP. Settling with this capability: (gsm|ulaw|alaw)
[2011-04-22 05:59:36.428787] DEBUG[10143] chan_sip.c: Trying to put 'SIP/2.0 200' onto UDP socket destined for 192.168.124.68:5060
[2011-04-22 05:59:36.429136] DEBUG[10143] features.c: bridge answer set, chan answer set
[2011-04-22 05:59:36.429367] DEBUG[10143] res_rtp_asterisk.c: Setting the marker bit due to a source update
[2011-04-22 05:59:36.429515] DEBUG[10143] chan_dahdi.c: Requested indication 20 on channel DAHDI/35-1
[2011-04-22 05:59:36.430054] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.453854] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.463789] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.475067] DEBUG[10072] chan_sip.c: = Looking for Call ID: 5242133ec9a7339e@192.168.124.68 (Checking From) --From tag 6d585e215d218268 --To-tag as058f1e84
[2011-04-22 05:59:36.475297] DEBUG[10072] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
[2011-04-22 05:59:36.475540] DEBUG[10072] chan_sip.c: Stopping retransmission on '5242133ec9a7339e@192.168.124.68' of Response 6477: Match Found
[2011-04-22 05:59:36.483795] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.503836] DEBUG[10143] res_rtp_asterisk.c: Ooh, format changed from unknown to gsm
[2011-04-22 05:59:36.503992] DEBUG[10143] res_rtp_asterisk.c: Created smoother: format: gsm ms: 20 len: 33
[2011-04-22 05:59:36.504243] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.523775] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.540085] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.543812] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.560083] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.563966] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.583773] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.600068] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.604059] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.620081] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.624060] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.640098] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.643828] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.660067] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.663874] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.680092] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.684042] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.700084] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.703765] DEBUG[10143] chan_dahdi.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1264764048 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.720073] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.724050] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.740097] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.743831] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.760062] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.763833] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.780091] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.783835] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.800089] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.803825] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.820069] DEBUG[10143] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[2011-04-22 05:59:36.823834] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.843791] DEBUG[10143] channel.c: Thread -1264764048 Blocking 'DAHDI/35-1', already blocked by thread -1265009808 in procedure ast_waitfor_nandfds
[2011-04-22 05:59:36.853670] DEBUG[10143] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2011-04-22 05:59:36.863769] DEBUG[10144] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2011-04-22 05:59:36.864045] DEBUG[10144] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2011-04-22 05:59:36.864593] DEBUG[10144] channel.c: Hanging up zombie 'DAHDI/33-1<ZOMBIE>'
[2011-04-22 05:59:36.864915] DEBUG[10062] devicestate.c: No provider found, checking channel drivers for DAHDI - 33
[2011-04-22 05:59:36.865120] DEBUG[10062] devicestate.c: Changing state for DAHDI/33 - state 0 (Unknown)
[2011-04-22 05:59:36.865152] DEBUG[10062] devicestate.c: device 'DAHDI/33' state '0'
[2011-04-22 05:59:36.865606] DEBUG[10099] app_queue.c: Device 'DAHDI/33' changed to state '0' (Unknown) but we don't care because they're not a member of any queue.
[2011-04-22 05:59:36.883746] DEBUG[10143] res_rtp_asterisk.c: Difference is 1112, ms is 159
[2011-04-22 05:59:38.413235] DEBUG[10074] chan_iax2.c: ip callno count decremented to 15 for 192.168.124.41
[2011-04-22 05:59:38.415021] DEBUG[10084] chan_iax2.c: schedule decrement of callno used for 192.168.124.41 in 60 seconds
[2011-04-22 05:59:39.510510] DEBUG[10143] sig_analog.c: analog_exception 35
[2011-04-22 05:59:39.510568] DEBUG[10143] sig_analog.c: Exception on 44, channel 35
[2011-04-22 05:59:39.510652] DEBUG[10143] sig_analog.c: __analog_handle_event 35
[2011-04-22 05:59:39.510702] DEBUG[10143] sig_analog.c: Got event ANALOG_EVENT_ONHOOK(1) on channel 35 (index 0)
[2011-04-22 05:59:39.510883] DEBUG[10143] chan_dahdi.c: Disabled echo cancellation on channel 35
[2011-04-22 05:59:39.510964] DEBUG[10143] channel.c: Didn't get a frame from channel: DAHDI/35-1
[2011-04-22 05:59:39.511110] DEBUG[10143] res_rtp_asterisk.c: Setting the marker bit due to a source update
[2011-04-22 05:59:39.511180] DEBUG[10143] channel.c: Bridge stops bridging channels SIP/gxp823-00000003 and DAHDI/35-1
[2011-04-22 05:59:39.511922] DEBUG[10143] channel.c: Hanging up channel 'DAHDI/35-1'
[2011-04-22 05:59:39.511967] DEBUG[10143] chan_dahdi.c: dahdi_hangup(DAHDI/35-1)
[2011-04-22 05:59:39.512086] DEBUG[10143] sig_analog.c: analog_hangup 35
[2011-04-22 05:59:39.512187] DEBUG[10143] sig_analog.c: Hangup: channel: 35 index = 0, normal = 1, callwait = 0, thirdcall = 0