id summary reporter owner description type status priority milestone component resolution keywords cc 198 Односторонний обтой после разговора alx alx "На нашей АТС обнаружена следующая ситуация: 1. Пришел вызов в порт FXO, была вызвана группа 1002. 1. Вызов был перенаправлен членам группы 1002: 114, 115 и 116. 1. Абонент 115 ответил на вызов, состоялся разговор. 1. Абонент 115 положил трубку, но отбоя FXO не произошло. В логах сообщений об ошибках нет, но видно, что сразу после отбоя абоненту 115 пришло событие eMessageFailed. Вот лог: {{{ Nov 8 05:29:09 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Idle: CAS event, ts=34, flags=0000, data=7 Nov 8 05:29:10 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Ringing: CAS event, ts=34, flags=0000, data=15 Nov 8 05:29:10 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Call Progress detected, ts=33, flags=0000, data=53 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Ringing: CAS event, ts=34, flags=0000, data=7 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxo.cpp:302: ts 34: dialing 1002@192.168.0.4 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: user_agent.cpp:2473: --> ua_dial_out() ""223-20-42"" -> sip:1002@192.168.0.4 ()... Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:13 comcerto daemon.info sip_ua[1863]: user_agent.cpp:1477: INVITE received: sip:114@127.0.0.1:6060;transport=udp (Call-ID: 428766686@(null)) Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0001, data=470 Nov 8 05:29:13 comcerto daemon.info sip_ua[1863]: user_agent.cpp:1477: INVITE received: sip:115@127.0.0.1:6060;transport=udp (Call-ID: 428766686@(null)) Nov 8 05:29:13 comcerto daemon.info sip_ua[1863]: user_agent.cpp:1477: INVITE received: sip:116@127.0.0.1:6060;transport=udp (Call-ID: 428766686@(null)) Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:901: channel 9: ringing Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: user_agent.cpp:2841: Call 470 routed to TS 9 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=9, state=Ringing: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0001, data=472 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:901: channel 10: ringing Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: user_agent.cpp:2841: Call 472 routed to TS 10 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=9, state=Ringing: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Ringing: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=11, state=Idle: Incoming call, ts=-1, flags=0001, data=474 Nov 8 05:29:13 comcerto daemon.info sip_ua[1863]: user_agent.cpp:1604: ---> ringing with status code 180 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxs.cpp:901: channel 11: ringing Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: user_agent.cpp:2841: Call 474 routed to TS 11 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Calling: Remote is ringing, ts=34, flags=0000, data=469 Nov 8 05:29:13 comcerto daemon.info sip_ua[1863]: user_agent.cpp:1604: ---> ringing with status code 180 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Calling: Remote is ringing, ts=34, flags=0000, data=469 Nov 8 05:29:13 comcerto daemon.info sip_ua[1863]: user_agent.cpp:1604: ---> ringing with status code 180 Nov 8 05:29:13 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Calling: Remote is ringing, ts=34, flags=0000, data=469 Nov 8 05:29:14 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Calling: CAS event, ts=34, flags=0000, data=15 Nov 8 05:29:17 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Calling: CAS event, ts=34, flags=0000, data=7 Nov 8 05:29:18 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Calling: CAS event, ts=34, flags=0000, data=15 Nov 8 05:29:18 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:18 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:18 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:18 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Ringing: CAS event, ts=10, flags=0000, data=7 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4015: channel 10: answer Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: RTP parameters, ts=10, flags=0000, data=472 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4814: --> ts 10: 192.168.0.4[10020] --> 192.168.0.4[10068] Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4815: --> ts 10: codec PCMA, VAD is on Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4816: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4916: ts 10: starting RTP stream to 02:ad:c3:00:00:b4 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: Statistics received, ts=10, flags=0000, data=0 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: Statistics received, ts=10, flags=0000, data=0 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Calling: RTP parameters, ts=34, flags=0000, data=469 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4814: --> ts 34: 192.168.0.4[10068] --> 192.168.0.4[10020] Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4815: --> ts 34: codec PCMA, VAD is on Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4816: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: comcerto.cpp:4916: ts 34: starting RTP stream to 02:ad:c3:00:00:b4 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Calling: Call answered, ts=34, flags=0000, data=469 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:19 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:20 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=11, state=Ringing: Call disconnected, ts=11, flags=0000, data=474 Nov 8 05:29:20 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=11, state=Idle: Call disconnected, ts=11, flags=0000, data=474 Nov 8 05:29:20 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=9, state=Ringing: Call disconnected, ts=9, flags=0000, data=470 Nov 8 05:29:20 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=9, state=Idle: Call disconnected, ts=9, flags=0000, data=470 Nov 8 05:29:20 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: ACK received, ts=10, flags=0000, data=472 Nov 8 05:29:23 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:23 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:23 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:23 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:24 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: Statistics received, ts=10, flags=0000, data=0 Nov 8 05:29:24 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: Statistics received, ts=10, flags=0000, data=0 Nov 8 05:29:24 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:24 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:27 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Call Progress detected, ts=34, flags=0000, data=53 Nov 8 05:29:27 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Call Progress detected, ts=34, flags=0000, data=53 Nov 8 05:29:28 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:28 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:28 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:28 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:28 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Call Progress detected, ts=34, flags=0000, data=53 Nov 8 05:29:29 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: Statistics received, ts=10, flags=0000, data=0 Nov 8 05:29:29 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: Statistics received, ts=10, flags=0000, data=0 Nov 8 05:29:29 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:29 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:31 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Call Progress detected, ts=34, flags=0000, data=53 Nov 8 05:29:32 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Call Progress detected, ts=34, flags=0000, data=53 Nov 8 05:29:33 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:33 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:33 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:33 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:34 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: Statistics received, ts=10, flags=0000, data=0 Nov 8 05:29:34 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: Statistics received, ts=10, flags=0000, data=0 Nov 8 05:29:34 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:34 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:36 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Connected: CAS event, ts=10, flags=0000, data=15 Nov 8 05:29:37 comcerto daemon.info sip_ua[1959]: repro.cpp:510: --> duration=1478582977, []:@: ---> []:@: Nov 8 05:29:37 comcerto daemon.info sip_ua[1959]: repro.cpp:556: --> CDR: {""answer"":0,""duration"":1478582977,""hangup"":1478582977,""org-host"":"""",""org-scheme"":"""",""org-user"":"""",""to-host"":"""",""to-scheme"":"""",""to-user"":"""",""type"":""""} Nov 8 05:29:37 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Idle: Call disconnected, ts=10, flags=0000, data=472 Nov 8 05:29:37 comcerto daemon.info sip_ua[1959]: repro.cpp:510: --> duration=1478582977, []:@: ---> []:@: Nov 8 05:29:37 comcerto daemon.info sip_ua[1959]: repro.cpp:556: --> CDR: {""answer"":0,""duration"":1478582977,""hangup"":1478582977,""org-host"":"""",""org-scheme"":"""",""org-user"":"""",""to-host"":"""",""to-scheme"":"""",""to-user"":"""",""type"":""""} Nov 8 05:29:37 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=10, state=Idle: Message failed, ts=10, flags=0000, data=472 Nov 8 05:29:38 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:38 comcerto daemon.info sip_ua[1841]: fxs.cpp:399: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0 Nov 8 05:29:38 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:38 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=33, state=Connected: Statistics received, ts=33, flags=0000, data=0 Nov 8 05:29:39 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 Nov 8 05:29:39 comcerto daemon.info sip_ua[1841]: fxo.cpp:344: ---> ts=34, state=Connected: Statistics received, ts=34, flags=0000, data=0 }}}" баг closed средний 1 очередь VE-01 дубликат