[Freeswitch-users] different behaviour on uuid_bridge, doesn't really bridge

Tue Jan 6 10:25:44 PST 2009

One more info:
I have updated to the newest SVN version of FS.
A and B can actually hear each other (just a bit, some scratching) while
the announcement to A is very slow (~50% speed) and very choppy.

Best regards
peter

Peter P GMX schrieb:
> I have setup a test machine and a production machine. Since recently the
> production machine behaves differently in terms of uuid bridge.
>
> How it should work (and how it worked before)
>   1) call A comes in
>   2) I play some messages to A
>   3) In the meantime I originate a call to B and transfer to an
> extension, where also some messages are played
>   4) Then I bridge A and B, so they are dropped off the current
> announcements an speak to each other
>   5) when either A or B hangs up, both legs are terminated
>
> New behaviour
>   1) call A comes in
>   2) I play some messages to A
>   3) In the meantime I originate a call to B and transfer to an
> extension, where also some messages are played
>   4) Then I bridge A and B, A and B can hear each other for 1/2 sec,
> then A constinues to hear its messages, B does not hear anything
>   5) when either A or B hangs up, both legs are terminated
>
> 4) is different now!
>
> The FS console show some messages about unbridge
> (SWITCH_MESSAGE_INDICATE_UNBRIDGE), but somehow the calls are still
> connected until A or B hangs up.
>
> Anybody has a clue?
> Best regards
> Peter
>
> 3) is finished, 4) starts
> 2009-01-06 17:35:31 [DEBUG] ozmod_isdn.c:320 zap_isdn_931_34() Yay I got
> an event! Type:[62] Size:[103] CRV: 4 (0x4, CTX: Terminator)
> 2009-01-06 17:35:31 [DEBUG] ozmod_isdn.c:352 zap_isdn_931_34() zchan
> 783bc0 (2:3) source isdn_data->channels_local_crv[0x4]
> 2009-01-06 17:35:31 [CRIT] ozmod_isdn.c:760 zap_isdn_931_34() Received
> unhandled message 98 (0x62)
> 2009-01-06 17:35:34 [DEBUG] switch_ivr_play_say.c:1222
> switch_ivr_play_file() done playing file
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:1094
> switch_ivr_uuid_bridge() (OpenZAP/2:3/49171xxxxxxx) State Change
> CS_EXECUTE -> CS_RESET
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:779
> switch_core_session_signal_state_change() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:1095
> switch_ivr_uuid_bridge() (OpenZAP/2:1/216xxxxx) State Change CS_EXECUTE
> -> CS_RESET
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:779
> switch_core_session_signal_state_change() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_play_say.c:1222
> switch_ivr_play_file() done playing file
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:433
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) State EXECUTE going to
> sleep
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:375
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) Running State Change
> CS_RESET
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:429
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) State RESET
> 4) Start
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:527
> uuid_bridge_on_reset() OpenZAP/2:1/216xxxxx CUSTOM RESET
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:53
> switch_core_standard_on_reset() OpenZAP/2:1/216xxxxx Standard RESET
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:429
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) State RESET going to sleep
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:433
> switch_core_session_run() (OpenZAP/2:3/49171xxxxxxx) State EXECUTE going
> to sleep
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:375
> switch_core_session_run() (OpenZAP/2:3/49171xxxxxxx) Running State
> Change CS_RESET
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:429
> switch_core_session_run() (OpenZAP/2:3/49171xxxxxxx) State RESET
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:527
> uuid_bridge_on_reset() OpenZAP/2:3/49171xxxxxxx CUSTOM RESET
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:533
> uuid_bridge_on_reset() (OpenZAP/2:3/49171xxxxxxx) State Change CS_RESET
> -> CS_SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:779
> switch_core_session_signal_state_change() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:429
> switch_core_session_run() (OpenZAP/2:3/49171xxxxxxx) State RESET going
> to sleep
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:375
> switch_core_session_run() (OpenZAP/2:3/49171xxxxxxx) Running State
> Change CS_SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:439
> switch_core_session_run() (OpenZAP/2:3/49171xxxxxxx) State SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] mod_openzap.c:517 channel_on_soft_execute()
> CHANNEL SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:545
> uuid_bridge_on_soft_execute() OpenZAP/2:3/49171xxxxxxx CUSTOM TRANSMIT
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:571
> uuid_bridge_on_soft_execute() (OpenZAP/2:1/216xxxxx) State Change
> CS_RESET -> CS_SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:779
> switch_core_session_signal_state_change() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:375
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) Running State Change
> CS_SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:439
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) State SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] mod_openzap.c:517 channel_on_soft_execute()
> CHANNEL SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:545
> uuid_bridge_on_soft_execute() OpenZAP/2:1/216xxxxx CUSTOM TRANSMIT
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:181
> switch_core_standard_on_soft_execute() OpenZAP/2:1/216xxxxx Standard
> SOFT_EXECUTE
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:439
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) State SOFT_EXECUTE
> going to sleep
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:814
> switch_ivr_multi_threaded_bridge() (OpenZAP/2:1/216xxxxx) State Change
> CS_SOFT_EXECUTE -> CS_CONSUME_MEDIA
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:779
> switch_core_session_signal_state_change() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:856
> switch_ivr_multi_threaded_bridge() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_BRIDGE]
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:863
> switch_ivr_multi_threaded_bridge() OpenZAP/2:3/49171xxxxxxx receive
> message [SWITCH_MESSAGE_INDICATE_BRIDGE]
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:667
> switch_core_session_queue_private_event() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_ivr_bridge.c:907
> switch_ivr_multi_threaded_bridge() (OpenZAP/2:1/216xxxxx) State Change
> CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
> 2009-01-06 17:35:35 [DEBUG] switch_core_session.c:779
> switch_core_session_signal_state_change() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:375
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) Running State Change
> CS_EXCHANGE_MEDIA
> 2009-01-06 17:35:35 [DEBUG] switch_core_state_machine.c:436
> switch_core_session_run() (OpenZAP/2:1/216xxxxx) State EXCHANGE_MEDIA
> 2009-01-06 17:35:35 [DEBUG] mod_openzap.c:511
> channel_on_exchange_media() CHANNEL EXCHANGE_MEDIA
> 2009-01-06 17:35:36 [DEBUG] switch_core_session.c:667
> switch_core_session_queue_private_event() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:36 [DEBUG] switch_ivr_bridge.c:226
> audio_bridge_thread() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_UNBRIDGE]
> 2009-01-06 17:35:36 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:36 [DEBUG] switch_ivr.c:391 switch_ivr_parse_event()
> OpenZAP/2:1/216xxxxx Command Execute read(0 1
> custom/warteschleife_30.wav interrupt_digit 0 )
> 2009-01-06 17:35:36 [DEBUG] switch_ivr_play_say.c:932
> switch_ivr_play_file() Codec Activated L16 at 8000hz 1 channels 20ms
> 2009-01-06 17:35:36 [DEBUG] switch_core_io.c:610
> switch_core_session_write_frame() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_TRANSCODING_NECESSARY]
> 2009-01-06 17:35:36 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:36 [DEBUG] switch_ivr_bridge.c:226
> audio_bridge_thread() OpenZAP/2:3/49171xxxxxxx receive message
> [SWITCH_MESSAGE_INDICATE_UNBRIDGE]
> 2009-01-06 17:35:36 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:36 [DEBUG] switch_ivr.c:391 switch_ivr_parse_event()
> OpenZAP/2:3/49171xxxxxxx Command Execute stop_dtmf(true)
> 2009-01-06 17:35:36 [DEBUG] switch_ivr_bridge.c:229
> audio_bridge_thread() OpenZAP/2:3/49171xxxxxxx receive message
> [SWITCH_MESSAGE_INDICATE_BRIDGE]
> 2009-01-06 17:35:36 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:36 [DEBUG] switch_ivr_bridge.c:231
> audio_bridge_thread() Send signal OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:37 [DEBUG] switch_core_session.c:667
> switch_core_session_queue_private_event() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:37 [DEBUG] switch_ivr_bridge.c:226
> audio_bridge_thread() OpenZAP/2:3/49171xxxxxxx receive message
> [SWITCH_MESSAGE_INDICATE_UNBRIDGE]
> 2009-01-06 17:35:37 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:37 [DEBUG] switch_ivr_bridge.c:229
> audio_bridge_thread() OpenZAP/2:3/49171xxxxxxx receive message
> [SWITCH_MESSAGE_INDICATE_BRIDGE]
> 2009-01-06 17:35:37 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:35:37 [DEBUG] switch_ivr_bridge.c:231
> audio_bridge_thread() Send signal OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:35:46 [DEBUG] ozmod_isdn.c:777 zap_isdn_921_23() READ 31
> --------------------------------------------------------------------------------
> [08 02 80 04 62 1c 18 91 a1 15 02 01 7d 02 01 22 30 0d a1 05 30 03 02 01
> 08 82 01 00 83 01 00]
>
> 2009-01-06 17:35:46 [DEBUG] ozmod_isdn.c:320 zap_isdn_931_34() Yay I got
> an event! Type:[62] Size:[103] CRV: 4 (0x4, CTX: Terminator)
> 2009-01-06 17:35:46 [DEBUG] ozmod_isdn.c:352 zap_isdn_931_34() zchan
> 783bc0 (2:3) source isdn_data->channels_local_crv[0x4]
> 2009-01-06 17:35:46 [CRIT] ozmod_isdn.c:760 zap_isdn_931_34() Received
> unhandled message 98 (0x62)
> 2009-01-06 17:36:02 [DEBUG] ozmod_isdn.c:777 zap_isdn_921_23() READ 31
> --------------------------------------------------------------------------------
> [08 02 80 04 62 1c 18 91 a1 15 02 01 7e 02 01 22 30 0d a1 05 30 03 02 01
> 09 82 01 00 83 01 00]
>
> 2009-01-06 17:36:02 [DEBUG] ozmod_isdn.c:320 zap_isdn_931_34() Yay I got
> an event! Type:[62] Size:[103] CRV: 4 (0x4, CTX: Terminator)
> 2009-01-06 17:36:02 [DEBUG] ozmod_isdn.c:352 zap_isdn_931_34() zchan
> 783bc0 (2:3) source isdn_data->channels_local_crv[0x4]
> 2009-01-06 17:36:02 [CRIT] ozmod_isdn.c:760 zap_isdn_931_34() Received
> unhandled message 98 (0x62)
> 2009-01-06 17:36:06 [DEBUG] switch_ivr_play_say.c:1222
> switch_ivr_play_file() done playing file
> 2009-01-06 17:36:07 [DEBUG] switch_ivr_bridge.c:229
> audio_bridge_thread() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_BRIDGE]
> 2009-01-06 17:36:07 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:07 [DEBUG] switch_ivr_bridge.c:231
> audio_bridge_thread() Send signal OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:36:08 [DEBUG] switch_core_session.c:667
> switch_core_session_queue_private_event() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:08 [DEBUG] switch_ivr_bridge.c:226
> audio_bridge_thread() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_UNBRIDGE]
> 2009-01-06 17:36:08 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:08 [DEBUG] switch_ivr.c:391 switch_ivr_parse_event()
> OpenZAP/2:1/216xxxxx Command Execute read(0 1
> custom/warteschleife_30.wav interrupt_digit 0 )
> 2009-01-06 17:36:08 [DEBUG] switch_ivr_play_say.c:932
> switch_ivr_play_file() Codec Activated L16 at 8000hz 1 channels 20ms
> 2009-01-06 17:36:08 [DEBUG] switch_core_io.c:610
> switch_core_session_write_frame() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_TRANSCODING_NECESSARY]
> 2009-01-06 17:36:08 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:17 [DEBUG] ozmod_isdn.c:777 zap_isdn_921_23() READ 31
> --------------------------------------------------------------------------------
> [08 02 80 04 62 1c 18 91 a1 15 02 01 7f 02 01 22 30 0d a1 05 30 03 02 01
> 0a 82 01 00 83 01 00]
>
> 2009-01-06 17:36:17 [DEBUG] ozmod_isdn.c:320 zap_isdn_931_34() Yay I got
> an event! Type:[62] Size:[103] CRV: 4 (0x4, CTX: Terminator)
> 2009-01-06 17:36:17 [DEBUG] ozmod_isdn.c:352 zap_isdn_931_34() zchan
> 783bc0 (2:3) source isdn_data->channels_local_crv[0x4]
> 2009-01-06 17:36:17 [CRIT] ozmod_isdn.c:760 zap_isdn_931_34() Received
> unhandled message 98 (0x62)
> 2009-01-06 17:36:33 [DEBUG] ozmod_isdn.c:777 zap_isdn_921_23() READ 32
> --------------------------------------------------------------------------------
> [08 02 80 04 62 1c 19 91 a1 16 02 02 00 80 02 01 22 30 0d a1 05 30 03 02
> 01 0b 82 01 00 83 01 00]
>
> 2009-01-06 17:36:33 [DEBUG] ozmod_isdn.c:320 zap_isdn_931_34() Yay I got
> an event! Type:[62] Size:[103] CRV: 4 (0x4, CTX: Terminator)
> 2009-01-06 17:36:33 [DEBUG] ozmod_isdn.c:352 zap_isdn_931_34() zchan
> 783bc0 (2:3) source isdn_data->channels_local_crv[0x4]
> 2009-01-06 17:36:33 [CRIT] ozmod_isdn.c:760 zap_isdn_931_34() Received
> unhandled message 98 (0x62)
> 2009-01-06 17:36:38 [DEBUG] switch_ivr_play_say.c:1222
> switch_ivr_play_file() done playing file
> 2009-01-06 17:36:39 [DEBUG] switch_ivr_bridge.c:229
> audio_bridge_thread() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_BRIDGE]
> 2009-01-06 17:36:39 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:39 [DEBUG] switch_ivr_bridge.c:231
> audio_bridge_thread() Send signal OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:36:40 [DEBUG] switch_core_session.c:667
> switch_core_session_queue_private_event() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:40 [DEBUG] switch_ivr_bridge.c:226
> audio_bridge_thread() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_UNBRIDGE]
> 2009-01-06 17:36:40 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:40 [DEBUG] switch_ivr.c:391 switch_ivr_parse_event()
> OpenZAP/2:1/216xxxxx Command Execute read(0 1
> custom/dieser_berater_ist_leider_zur_zeit_nicht_erreichbar_bitte_waehlen_sie_einen_ande.wav
> interrupt_digit 0 )
> 2009-01-06 17:36:40 [DEBUG] switch_ivr_play_say.c:932
> switch_ivr_play_file() Codec Activated L16 at 8000hz 1 channels 20ms
> 2009-01-06 17:36:40 [DEBUG] switch_core_io.c:610
> switch_core_session_write_frame() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_TRANSCODING_NECESSARY]
> 2009-01-06 17:36:40 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:45 [DEBUG] switch_ivr_play_say.c:1222
> switch_ivr_play_file() done playing file
> 2009-01-06 17:36:46 [DEBUG] switch_ivr_bridge.c:229
> audio_bridge_thread() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_BRIDGE]
> 2009-01-06 17:36:46 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:46 [DEBUG] switch_ivr_bridge.c:231
> audio_bridge_thread() Send signal OpenZAP/2:3/49171xxxxxxx [BREAK]
> 2009-01-06 17:36:47 [DEBUG] switch_core_session.c:667
> switch_core_session_queue_private_event() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:47 [DEBUG] switch_ivr_bridge.c:226
> audio_bridge_thread() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_UNBRIDGE]
> 2009-01-06 17:36:47 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:47 [DEBUG] switch_ivr.c:391 switch_ivr_parse_event()
> OpenZAP/2:1/216xxxxx Command Execute read(0 4
> custom/geben_sie_bitte_nach_dem_signalton_die_kennung_des_gewuenschten_beraters_ein_sch2.wav
> dtmfdtmf 10000 #,*)
> 2009-01-06 17:36:47 [DEBUG] switch_ivr_play_say.c:932
> switch_ivr_play_file() Codec Activated L16 at 8000hz 1 channels 20ms
> 2009-01-06 17:36:47 [DEBUG] switch_core_io.c:610
> switch_core_session_write_frame() OpenZAP/2:1/216xxxxx receive message
> [SWITCH_MESSAGE_INDICATE_TRANSCODING_NECESSARY]
> 2009-01-06 17:36:47 [DEBUG] switch_core_session.c:489
> switch_core_session_perform_receive_message() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:36:48 [DEBUG] ozmod_isdn.c:777 zap_isdn_921_23() READ 32
> --------------------------------------------------------------------------------
> [08 02 80 04 62 1c 19 91 a1 16 02 02 00 81 02 01 22 30 0d a1 05 30 03 02
> 01 0c 82 01 00 83 01 00]
>
> 2009-01-06 17:36:48 [DEBUG] ozmod_isdn.c:320 zap_isdn_931_34() Yay I got
> an event! Type:[62] Size:[103] CRV: 4 (0x4, CTX: Terminator)
> 2009-01-06 17:36:48 [DEBUG] ozmod_isdn.c:352 zap_isdn_931_34() zchan
> 783bc0 (2:3) source isdn_data->channels_local_crv[0x4]
> 2009-01-06 17:36:48 [CRIT] ozmod_isdn.c:760 zap_isdn_931_34() Received
> unhandled message 98 (0x62)
> 2009-01-06 17:37:03 [DEBUG] switch_ivr_play_say.c:1222
> switch_ivr_play_file() done playing file
> 2009-01-06 17:37:04 [DEBUG] ozmod_isdn.c:777 zap_isdn_921_23() READ 32
> --------------------------------------------------------------------------------
> [08 02 80 04 62 1c 19 91 a1 16 02 02 00 82 02 01 22 30 0d a1 05 30 03 02
> 01 0d 82 01 00 83 01 00]
>
> 2009-01-06 17:37:04 [DEBUG] ozmod_isdn.c:320 zap_isdn_931_34() Yay I got
> an event! Type:[62] Size:[103] CRV: 4 (0x4, CTX: Terminator)
> 2009-01-06 17:37:04 [DEBUG] ozmod_isdn.c:352 zap_isdn_931_34() zchan
> 783bc0 (2:3) source isdn_data->channels_local_crv[0x4]
> 2009-01-06 17:37:04 [CRIT] ozmod_isdn.c:760 zap_isdn_931_34() Received
> unhandled message 98 (0x62)
> 2009-01-06 17:37:12 [DEBUG] ozmod_isdn.c:777 zap_isdn_921_23() READ 13
> --------------------------------------------------------------------------------
> [08 02 00 35 45 08 02 80 90 1e 02 82 88]
>
> 5) Hangup
> 2009-01-06 17:37:12 [DEBUG] ozmod_isdn.c:320 zap_isdn_931_34() Yay I got
> an event! Type:[45] Size:[115] CRV: 53 (0x35, CTX: Originator)
> 2009-01-06 17:37:12 [DEBUG] ozmod_isdn.c:352 zap_isdn_931_34() zchan
> 77df70 (2:1) source isdn_data->channels_remote_crv[0x35]
> 2009-01-06 17:37:12 [DEBUG] ozmod_isdn.c:455 zap_isdn_931_34() Changing
> state on 2:1 from UP to TERMINATING
> 2009-01-06 17:37:12 [DEBUG] ozmod_isdn.c:813 state_advance() 2:1 STATE
> [TERMINATING]
> 2009-01-06 17:37:12 [DEBUG] ozmod_isdn.c:1121 state_advance()
> Terminating: Direction Inbound
> 2009-01-06 17:37:12 [DEBUG] mod_openzap.c:1418 on_clear_channel_signal()
> got clear channel sig [STOP]
> 2009-01-06 17:37:12 [NOTICE] mod_openzap.c:1437
> on_clear_channel_signal() Hangup OpenZAP/2:1/216xxxxx
> [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
> 2009-01-06 17:37:12 [DEBUG] switch_channel.c:1441
> switch_channel_perform_hangup() Send signal OpenZAP/2:1/216xxxxx [KILL]
> 2009-01-06 17:37:12 [DEBUG] switch_core_session.c:779
> switch_core_session_signal_state_change() Send signal
> OpenZAP/2:1/216xxxxx [BREAK]
> 2009-01-06 17:37:12 [DEBUG] ozmod_isdn.c:1529 q931_rx_32() WRITE 5
>
>
>
>   