It looks like mod_skypopen is answering the Skype call and opening the channel before any
2010-07-27 18:07:28.553971 [DEBUG] skypopen_protocol.c:176 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 176 ][interface1][-1, 0, 0] READING: |||CALL 2114 CONF_ID 0|||
2010-07-27 18:07:28.563966 [DEBUG] skypopen_protocol.c:176 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 176 ][interface1][-1, 0, 0] READING: |||USER
jjeffords.com TIMEZONE 72000|||
2010-07-27 18:07:28.633980 [DEBUG] skypopen_protocol.c:176 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 176 ][interface1][-1, 0, 0] READING: |||CALL 2114 STATUS RINGING|||
2010-07-27 18:07:28.633980 [DEBUG] skypopen_protocol.c:556 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 556 ][interface1][-1, 0, 0] NO ACTIVE calls in this moment, skype_call 2114 is RINGING, to ask PARTNER_HANDLE
2010-07-27 18:07:28.633980 [DEBUG] skypopen_protocol.c:1498 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 1498 ][interface1][-1, 0, 0] SENDING: |||GET CALL 2114 PARTNER_HANDLE||||
2010-07-27 18:07:28.663964 [DEBUG] skypopen_protocol.c:176 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 176 ][interface1][-1, 0, 0] READING: |||CALL 2114 PARTNER_HANDLE
jjeffords.com|||
2010-07-27 18:07:28.663964 [DEBUG] skypopen_protocol.c:481 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 481 ][interface1][-1, 0, 0] Call 2114 TRY ANSWER
2010-07-27 18:07:28.663964 [DEBUG] mod_skypopen.c:2301 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 2301 ][interface1][-1, 0, 0] NOT FOUND
2010-07-27 18:07:28.663964 [DEBUG] skypopen_protocol.c:1498 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 1498 ][interface1][-1, 0, 0] SENDING: |||GET CALL 2114 PARTNER_DISPNAME||||
2010-07-27 18:07:28.683968 [DEBUG] skypopen_protocol.c:1498 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 1498 ][interface1][-1,11, 0] SENDING: |||ALTER CALL 2114 ANSWER||||
2010-07-27 18:07:28.703965 [DEBUG] mod_skypopen.c:2314 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 2314 ][interface1][-1,11, 0] We answered a Skype RING on skype_call 2114
2010-07-27 18:07:28.703965 [DEBUG] mod_skypopen.c:2322 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 2322 ][interface1][-1,11, 0] NEW! name: interface1, state: 11, value=
jjeffords.com, tech_pvt->callid_number=
jjeffords.com, tech_pvt->skype_user=cloud-tree-admin
2010-07-27 18:07:28.703965 [DEBUG] skypopen_protocol.c:176 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 176 ][interface1][-1,11, 0] READING: |||CALL 2114 PARTNER_DISPNAME Jason Jeffords|||
2010-07-27 18:07:28.714033 [DEBUG] skypopen_protocol.c:176 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 176 ][interface1][-1,11, 0] READING: |||ALTER CALL 2114 ANSWER|||
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:176 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 176 ][interface1][-1,11, 0] READING: |||CALL 2114 STATUS INPROGRESS|||
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:660 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 660 ][interface1][-1,11, 0] no tech_pvt->session_uuid_str
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:666 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 666 ][interface1][-1,11, 0] skype_call: 2114 is now active
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:673 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 673 ][interface1][-1, 5,21] START start_audio_threads
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:83 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 83 ][interface1][-1, 5,21] Binded! *which_port=32769, tech_pvt->tcp_cli_port=32770, tech_pvt->tcp_srv_port=32769
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:88 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 88 ][interface1][-1, 5,21] 1 SO_RCVBUF is 87380, size is 4
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:92 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 92 ][interface1][-1, 5,21] 1 SO_SNDBUF is 16384, size is 4
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:113 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 113 ][interface1][-1, 5,21] 2 SO_RCVBUF is 87380, size is 4
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:132 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 132 ][interface1][-1, 5,21] 2 SO_SNDBUF is 16384, size is 4
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:136 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 136 ][interface1][-1, 5,21] TCP_NODELAY is 0
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:143 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 143 ][interface1][-1, 5,21] TCP_NODELAY is 0
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:773 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 773 ][interface1][-1, 5,21] started tcp_srv_thread thread.
2010-07-27 18:07:28.733950 [DEBUG] mod_skypopen.c:1889 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 1889 ][interface1][-1, 5,21] started tcp_srv_thread thread.
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:83 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 83 ][interface1][-1, 5,21] Binded! *which_port=32770, tech_pvt->tcp_cli_port=32770, tech_pvt->tcp_srv_port=32769
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:88 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 88 ][interface1][-1, 5,21] 1 SO_RCVBUF is 87380, size is 4
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:92 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 92 ][interface1][-1, 5,21] 1 SO_SNDBUF is 16384, size is 4
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:113 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 113 ][interface1][-1, 5,21] 2 SO_RCVBUF is 87380, size is 4
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:132 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 132 ][interface1][-1, 5,21] 2 SO_SNDBUF is 16384, size is 4
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:136 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 136 ][interface1][-1, 5,21] TCP_NODELAY is 0
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:143 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 143 ][interface1][-1, 5,21] TCP_NODELAY is 0
2010-07-27 18:07:28.733950 [DEBUG] skypopen_protocol.c:924 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 924 ][interface1][-1, 5,21] started tcp_cli_thread thread.
2010-07-27 18:07:28.733950 [DEBUG] mod_skypopen.c:1899 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 1899 ][interface1][-1, 5,21] started tcp_cli_thread thread.
2010-07-27 18:07:28.853968 [DEBUG] skypopen_protocol.c:1498 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 1498 ][interface1][-1, 5,21] SENDING: |||ALTER CALL 2114 SET_INPUT PORT="32770"||||
2010-07-27 18:07:28.864023 [DEBUG] skypopen_protocol.c:953 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 953 ][interface1][-1, 5,21] ACCEPTED here you send me 32770
2010-07-27 18:07:28.864023 [DEBUG] skypopen_protocol.c:958 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 958 ][interface1][-1, 5,21] 4 SO_RCVBUF is 87380, size is 4
2010-07-27 18:07:28.864023 [DEBUG] skypopen_protocol.c:962 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 962 ][interface1][-1, 5,21] 4 SO_SNDBUF is 16384, size is 4
2010-07-27 18:07:28.873942 [DEBUG] skypopen_protocol.c:1498 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 1498 ][interface1][-1, 5,21] SENDING: |||#output ALTER CALL 2114 SET_OUTPUT PORT="32769"||||
2010-07-27 18:07:28.883950 [DEBUG] skypopen_protocol.c:688 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 688 ][interface1][-1, 5,21] New Inbound Channel!
2010-07-27 18:07:28.883950 [DEBUG] mod_skypopen.c:1920 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 1920 ][interface1][-1, 5,21] 2 SESSION_REQUEST d18a03ae-99a9-11df-9273-dfe9044f32b8
2010-07-27 18:07:28.883950 [DEBUG] mod_skypopen.c:258 rev git2svn-syncpoint-master-132-g91a87e9[(nil)|37 ][DEBUG_SKYPE 258 ][interface1][-1, 5,21] skypopen_tech_init SUCCESS
2010-07-27 18:07:28.883950 [NOTICE] switch_channel.c:776 New Channel skypopen/interface1 [d18a03ae-99a9-11df-9273-dfe9044f32b8]
2010-07-27 18:07:28.883950 [DEBUG] mod_skypopen.c:1944 (skypopen/interface1) State Change CS_NEW -> CS_INIT