freeswitch@internal> freeswitch@internal> 2012-08-20 13:16:51.223514 [INFO] libdingaling.c:1743 SecRECV: ------------------------------------------------------------------------------- 2012-08-20 13:16:51.223514 [INFO] libdingaling.c:1743 SecRECV: ------------------------------------------------------------------------------- 2012-08-20 13:16:51.223514 [INFO] libdingaling.c:1743 SecRECV: ------------------------------------------------------------------------------- 2747399142 2012-08-20 13:16:51.223514 [INFO] libdingaling.c:1743 SecRECV: ------------------------------------------------------------------------------- 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:363 Created Session c403880385 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:391 Message for Session c403880385 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [ISAC] id='103' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [ISAC] id='104' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [speex] id='107' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [G722] id='9' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [ILBC] id='102' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [speex] id='108' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [PCMU] id='0' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [PCMA] id='8' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [red] id='127' 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:462 Add Payload [telephone-event] id='126' 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:4204 Creating an identity for c403880385 2vys6x0b7wc1u2mu5wwcmalewq@public.talk.google.com/gmail.3AF62E0A <2vys6x0b7wc1u2mu5wwcmalewq@public.talk.google.com/gmail.3AF62E0A> 5555 2012-08-20 13:16:51.223514 [NOTICE] switch_channel.c:930 New Channel dingaling/5555 [b9e700dd-4124-41da-9a7e-46235f7482e5] 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:4232 Creating a session for c403880385 2012-08-20 13:16:51.223514 [NOTICE] switch_channel.c:928 Rename Channel dingaling/5555->DingaLing/new [b9e700dd-4124-41da-9a7e-46235f7482e5] 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:4236 (DingaLing/new) State Change CS_NEW -> CS_INIT 2012-08-20 13:16:51.223514 [DEBUG] switch_core_session.c:1229 Send signal DingaLing/new [BREAK] 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:2019 DingaLing/new CHANNEL KILL 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3696 10 payloads 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3698 Available Payload ISAC 103 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3711 compare ISAC 103/16000 to PCMU 0/8000 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3698 Available Payload ISAC 104 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3711 compare ISAC 104/32000 to PCMU 0/8000 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3698 Available Payload speex 107 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3711 compare speex 107/16000 to PCMU 0/8000 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3698 Available Payload G722 9 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3711 compare G722 9/16000 to PCMU 0/8000 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3698 Available Payload ILBC 102 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3711 compare ILBC 102/8000 to PCMU 0/8000 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3698 Available Payload speex 108 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3711 compare speex 108/8000 to PCMU 0/8000 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3698 Available Payload PCMU 0 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3711 compare PCMU 0/8000 to PCMU 0/8000 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:3723 Choosing rtp Payload index 0 PCMU 0 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:1670 Don't have video codec. 2012-08-20 13:16:51.223514 [DEBUG] mod_dingaling.c:1681 Send Describe [PCMU@8000] 2012-08-20 13:16:51.223514 [NOTICE] libdingaling.c:1745 SecSEND: ------------------------------------------------------------------------------- 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:16:51.223514 [CRIT] libdingaling.c:1847 Sending packet 312 (2 left) 2012-08-20 13:16:51.223514 [NOTICE] libdingaling.c:1745 SecSEND: ------------------------------------------------------------------------------- 2012-08-20 13:16:51.223514 [DEBUG] switch_core_state_machine.c:385 (DingaLing/new) Running State Change CS_INIT 2012-08-20 13:16:51.223514 [DEBUG] switch_core_state_machine.c:424 (DingaLing/new) State INIT 2012-08-20 13:16:51.223514 [NOTICE] mod_dingaling.c:1748 Ring-Ready DingaLing/new! 2012-08-20 13:16:52.323477 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:16:53.423481 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:16:54.523557 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:16:55.623496 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:16:56.723481 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:16:56.723481 [CRIT] libdingaling.c:1847 Sending packet 312 (1 left) 2012-08-20 13:16:56.723481 [NOTICE] libdingaling.c:1745 SecSEND: ------------------------------------------------------------------------------- 2012-08-20 13:16:57.143480 [INFO] libdingaling.c:1743 SecRECV: ------------------------------------------------------------------------------- 2012-08-20 13:16:57.143480 [CRIT] libdingaling.c:1305 Cancel packet 312 2012-08-20 13:16:57.143480 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:16:57.143480 [CRIT] libdingaling.c:1856 Discarding packet 312 2012-08-20 13:17:01.243460 [DEBUG] mod_dingaling.c:1496 Stun Lookup Local 192.168.122.121:24294 2012-08-20 13:17:02.403478 [INFO] mod_dingaling.c:1506 Stun Success 196.44.184.138:24294 2012-08-20 13:17:02.423533 [DEBUG] mod_dingaling.c:1520 Send rtp Candidate 196.44.184.138:24294 [LHrfCI0Jp6gNld6x] 2012-08-20 13:17:02.423533 [DEBUG] mod_dingaling.c:1496 Stun Lookup Local 192.168.122.121:24295 2012-08-20 13:17:02.703468 [INFO] mod_dingaling.c:1506 Stun Success 196.44.184.138:24295 2012-08-20 13:17:02.703468 [DEBUG] mod_dingaling.c:1520 Send rtcp Candidate 196.44.184.138:24295 [lhHB2Wam6U6KOPru] 2012-08-20 13:17:02.703468 [DEBUG] mod_dingaling.c:1496 Stun Lookup Local 192.168.122.121:24296 2012-08-20 13:17:03.003441 [INFO] mod_dingaling.c:1506 Stun Success 196.44.184.138:24296 2012-08-20 13:17:03.003441 [DEBUG] mod_dingaling.c:1520 Send video_rtp Candidate 196.44.184.138:24296 [3bukkQnujVKIexCk] 2012-08-20 13:17:03.003441 [DEBUG] mod_dingaling.c:1496 Stun Lookup Local 192.168.122.121:24297 2012-08-20 13:17:03.303466 [INFO] mod_dingaling.c:1506 Stun Success 196.44.184.138:24297 2012-08-20 13:17:03.303466 [DEBUG] mod_dingaling.c:1520 Send video_rtcp Candidate 196.44.184.138:24297 [UWeSQTBFMScNn9ej] 2012-08-20 13:17:03.303466 [DEBUG] mod_dingaling.c:1560 Accepted 0 of 0 rtp candidates. 2012-08-20 13:17:03.303466 [DEBUG] mod_dingaling.c:1562 Accepted 0 of 0 rtcp candidates. 2012-08-20 13:17:03.303466 [DEBUG] mod_dingaling.c:1565 Accepted 0 of 0 video_rtp candidates 2012-08-20 13:17:03.303466 [DEBUG] mod_dingaling.c:1568 Accepted 0 of 0 video_rctp candidates 2012-08-20 13:17:03.743474 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:03.743474 [CRIT] libdingaling.c:1847 Sending packet 313 (2 left) 2012-08-20 13:17:03.743474 [NOTICE] libdingaling.c:1745 SecSEND: ------------------------------------------------------------------------------- 2012-08-20 13:17:04.843477 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:05.943479 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:07.043454 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:08.163469 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:09.263454 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:09.263454 [CRIT] libdingaling.c:1847 Sending packet 313 (1 left) 2012-08-20 13:17:09.263454 [NOTICE] libdingaling.c:1745 SecSEND: ------------------------------------------------------------------------------- 2012-08-20 13:17:10.363471 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:11.243449 [DEBUG] mod_dingaling.c:1560 Accepted 0 of 0 rtp candidates. 2012-08-20 13:17:11.243449 [DEBUG] mod_dingaling.c:1562 Accepted 0 of 0 rtcp candidates. 2012-08-20 13:17:11.243449 [DEBUG] mod_dingaling.c:1565 Accepted 0 of 0 video_rtp candidates 2012-08-20 13:17:11.243449 [DEBUG] mod_dingaling.c:1568 Accepted 0 of 0 video_rctp candidates 2012-08-20 13:17:11.463467 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:12.563463 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:13.663446 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:14.763484 [CRIT] libdingaling.c:1830 Processing 1 packets in retry queue 2012-08-20 13:17:14.763484 [CRIT] libdingaling.c:1847 Sending packet 313 (0 left) 2012-08-20 13:17:14.763484 [NOTICE] libdingaling.c:1745 SecSEND: ------------------------------------------------------------------------------- 2012-08-20 13:17:14.763484 [CRIT] libdingaling.c:1856 Discarding packet 313 2012-08-20 13:17:21.243474 [DEBUG] mod_dingaling.c:1560 Accepted 0 of 0 rtp candidates. 2012-08-20 13:17:21.243474 [DEBUG] mod_dingaling.c:1562 Accepted 0 of 0 rtcp candidates. 2012-08-20 13:17:21.243474 [DEBUG] mod_dingaling.c:1565 Accepted 0 of 0 video_rtp candidates 2012-08-20 13:17:21.243474 [DEBUG] mod_dingaling.c:1568 Accepted 0 of 0 video_rctp candidates 2012-08-20 13:17:31.243462 [DEBUG] mod_dingaling.c:1560 Accepted 0 of 0 rtp candidates. 2012-08-20 13:17:31.243462 [DEBUG] mod_dingaling.c:1562 Accepted 0 of 0 rtcp candidates. 2012-08-20 13:17:31.243462 [DEBUG] mod_dingaling.c:1565 Accepted 0 of 0 video_rtp candidates 2012-08-20 13:17:31.243462 [DEBUG] mod_dingaling.c:1568 Accepted 0 of 0 video_rctp candidates 2012-08-20 13:17:41.243490 [DEBUG] mod_dingaling.c:1560 Accepted 0 of 0 rtp candidates. 2012-08-20 13:17:41.243490 [DEBUG] mod_dingaling.c:1562 Accepted 0 of 0 rtcp candidates. 2012-08-20 13:17:41.243490 [DEBUG] mod_dingaling.c:1565 Accepted 0 of 0 video_rtp candidates 2012-08-20 13:17:41.243490 [DEBUG] mod_dingaling.c:1568 Accepted 0 of 0 video_rctp candidates 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:1560 Accepted 0 of 0 rtp candidates. 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:1562 Accepted 0 of 0 rtcp candidates. 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:1565 Accepted 0 of 0 video_rtp candidates 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:1568 Accepted 0 of 0 video_rctp candidates 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:801 Terminate called from line 1783 state=CS_INIT 2012-08-20 13:17:51.243480 [DEBUG] switch_channel.c:2903 (DingaLing/new) Callstate Change DOWN -> HANGUP 2012-08-20 13:17:51.243480 [NOTICE] mod_dingaling.c:826 Hangup DingaLing/new [CS_INIT] [NORMAL_CLEARING] 2012-08-20 13:17:51.243480 [DEBUG] switch_channel.c:2926 Send signal DingaLing/new [KILL] 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:2019 DingaLing/new CHANNEL KILL 2012-08-20 13:17:51.243480 [DEBUG] switch_core_session.c:1229 Send signal DingaLing/new [BREAK] 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:2019 DingaLing/new CHANNEL KILL 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:424 (DingaLing/new) State INIT going to sleep 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:385 (DingaLing/new) Running State Change CS_HANGUP 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:625 (DingaLing/new) State HANGUP 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:1988 DingaLing/new CHANNEL HANGUP 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:47 DingaLing/new Standard HANGUP, cause: NORMAL_CLEARING 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:625 (DingaLing/new) State HANGUP going to sleep 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:416 (DingaLing/new) State Change CS_HANGUP -> CS_REPORTING 2012-08-20 13:17:51.243480 [DEBUG] switch_core_session.c:1229 Send signal DingaLing/new [BREAK] 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:2019 DingaLing/new CHANNEL KILL 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:385 (DingaLing/new) Running State Change CS_REPORTING 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:685 (DingaLing/new) State REPORTING 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:79 DingaLing/new Standard REPORTING, cause: NORMAL_CLEARING 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:685 (DingaLing/new) State REPORTING going to sleep 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:410 (DingaLing/new) State Change CS_REPORTING -> CS_DESTROY 2012-08-20 13:17:51.243480 [DEBUG] switch_core_session.c:1229 Send signal DingaLing/new [BREAK] 2012-08-20 13:17:51.243480 [DEBUG] mod_dingaling.c:2019 DingaLing/new CHANNEL KILL 2012-08-20 13:17:51.243480 [DEBUG] switch_core_session.c:1429 Session 7 (DingaLing/new) Locked, Waiting on external entities 2012-08-20 13:17:51.243480 [NOTICE] switch_core_session.c:1447 Session 7 (DingaLing/new) Ended 2012-08-20 13:17:51.243480 [NOTICE] switch_core_session.c:1449 Close Channel DingaLing/new [CS_DESTROY] 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:514 (DingaLing/new) Callstate Change HANGUP -> DOWN 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:517 (DingaLing/new) Running State Change CS_DESTROY 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:527 (DingaLing/new) State DESTROY 2012-08-20 13:17:51.243480 [CRIT] libdingaling.c:307 Destroyed Session c403880385 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:86 DingaLing/new Standard DESTROY 2012-08-20 13:17:51.243480 [DEBUG] switch_core_state_machine.c:527 (DingaLing/new) State DESTROY going to sleep freeswitch@internal>