Opened 6 years ago

Closed 3 years ago

#263 closed баг (не воспроизводится)

Не произошло снятие вызова

Reported by: alx Owned by: alx
Priority: средний Milestone: 1 очередь
Component: VE-01 Keywords:
Cc:

Description (last modified by alx)

Абонент канального окончания FXS набирает номер.
Вызов идет в окончание FXO.
Вызывающий абонент кладет трубку.
Окончание FXO не получает никакого сообщения и продолжает вызов.

Лог:

Apr 26 04:36:41 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Idle: CAS A activity detected, ts=15, flags=0000, data=0
Apr 26 04:36:41 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Idle: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:41 comcerto daemon.info sip_ua[363]: fxs.cpp:702: ==> ts 15: manual CAS event processing (abcd=15)
Apr 26 04:36:41 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:46 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: Tone completed, ts=15, flags=0000, data=3
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:47 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialtone: DTMF detected, ts=15, flags=0000, data=8
Apr 26 04:36:48 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:48 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:48 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:48 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:49 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=9
Apr 26 04:36:50 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:50 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:50 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=1
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:51 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:52 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=9
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:53 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=4
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:54 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:55 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=9
Apr 26 04:36:56 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:56 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:56 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=1
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:57 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:58 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=8
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:36:59 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:00 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:00 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:00 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=0
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:01 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:02 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:02 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=0
Apr 26 04:37:02 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:02 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:02 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:02 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:02 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:02 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:03 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:03 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:03 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:03 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:03 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:03 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: CAS event, ts=15, flags=0000, data=7
Apr 26 04:37:03 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Dialing: DTMF detected, ts=15, flags=0000, data=6
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:241: ts 15: dialing 89194918006
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: user_agent.cpp:3099: --> ua_dial_out() "Долженко А. П." <sip:323@192.168.0.4> -> sip:89194918006@192.168.0.4 ()...
Apr 26 04:37:08 comcerto daemon.info sip_ua[470]: repro.cpp:434: doSessionAccounting(): Session Created 'branch=z9hG4bK1831557310'
Apr 26 04:37:08 comcerto daemon.info sip_ua[387]: user_agent.cpp:1987: INVITE received: sip:89194918006@127.0.0.1:6060;transport=udp (Call-ID: 1809253754@(null))
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=11, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=13, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=14, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Calling: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=17, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=19, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=34, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=35, state=Idle: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: virtualChannel.cpp:135: ---> VirtualChannelManager: Incoming call, ts=-1, flags=0001, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=11, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=12, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=13, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=14, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Calling: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=17, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=19, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Idle: Incoming call, ts=-1, flags=0002, data=2799
Apr 26 04:37:08 comcerto daemon.info sip_ua[363]: user_agent.cpp:3484: Call 2799 routed to TS 33
Apr 26 04:37:12 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Call Progress detected, ts=33, flags=0000, data=50
Apr 26 04:37:13 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:15 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:15 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:15 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Call Progress detected, ts=33, flags=0000, data=53
Apr 26 04:37:15 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:15 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:15 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:15 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Calling: CAS event, ts=15, flags=0000, data=15
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Idle: Call disconnected, ts=15, flags=0000, data=2798
Apr 26 04:37:16 comcerto daemon.info sip_ua[470]: repro.cpp:551: doSessionAccounting(): Session Cancelled 'branch=z9hG4bK1831557310'
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Tone completed, ts=33, flags=0000, data=0
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: comcerto.cpp:5838: channel 33: answer
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: RTP parameters, ts=33, flags=0000, data=2799
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: comcerto.cpp:6606: --> ts 33: 192.168.0.4[10066] --> 192.168.0.4[10030]
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: comcerto.cpp:6607: --> ts 33: codec PCMA, VAD is off
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: comcerto.cpp:6723: ts 33: starting RTP stream to 02:ad:c3:00:00:b4
Apr 26 04:37:16 comcerto daemon.err sip_ua[470]: repro.cpp:569: doSessionAccounting(): session 1809253754 not found
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Idle: RTP parameters, ts=15, flags=0000, data=2798
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Idle: Call answered, ts=15, flags=0000, data=2798
Apr 26 04:37:16 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: ACK received, ts=33, flags=0000, data=2799
Apr 26 04:37:21 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:21 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:26 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:26 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:31 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:31 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:36 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:36 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:41 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:41 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:46 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0
Apr 26 04:37:46 comcerto daemon.info sip_ua[363]: fxo.cpp:336: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0

Change History (3)

comment:1 by alx, 6 years ago

Похоже на какие-то гонки: вызывающий положил трубку почти одновременно с окончанием набора номера и отправкой ответа окончанием FXO. Наверное описанный эффект можно воспроизвести "синтетическим" тестом (намеренным отбоем и ответом).

comment:2 by alx, 5 years ago

Description: modified (diff)

comment:3 by alx, 3 years ago

Resolution: не воспроизводится
Status: newclosed
Note: See TracTickets for help on using tickets.