[Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 347bfbdb57b5f4736a20ef5e5541a741@192.168.10.5 [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.110:5060 [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Stopping retransmission on '347bfbdb57b5f4736a20ef5e5541a741@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 548c5aaa445ef7315532e87d45df8d63@192.168.10.5 [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.140:5092 [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Stopping retransmission on '548c5aaa445ef7315532e87d45df8d63@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 54444d772a3251d37467de2e74ed5976@192.168.10.5 [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5084 [Feb 19 18:07:20] DEBUG[3413] chan_sip.c: Stopping retransmission on '54444d772a3251d37467de2e74ed5976@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'SIP/2.0 40' onto UDP socket destined for 91.147.96.175:17889 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 127e46bd0d9db4f408d4eb0c63acb2c7@192.168.10.5 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.140:5094 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '127e46bd0d9db4f408d4eb0c63acb2c7@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 2a84466d7fadabb65f63cb645878a712@192.168.10.5 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.100:5094 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '2a84466d7fadabb65f63cb645878a712@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Acked pending invite 102 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '3ecded8322a027715372554976ff27ce@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: We're settling with these formats: 0xc (ulaw|alaw) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: build_route: Contact hop: [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'ACK sip:96' onto UDP socket destined for 192.168.10.140:5086 [Feb 19 18:07:21] VERBOSE[32087] logger.c: -- SIP/965-e00bf070 answered DAHDI/22-1 [Feb 19 18:07:21] DEBUG[32087] chan_dahdi.c: Requested indication -1 on channel DAHDI/22-1 [Feb 19 18:07:21] DEBUG[3407] channel.c: Avoiding initial deadlock for channel '0x7fd9c461a1b0' [Feb 19 18:07:21] DEBUG[3407] channel.c: Avoiding initial deadlock for channel '0x7fd9c461a1b0' [Feb 19 18:07:21] DEBUG[3407] channel.c: Avoiding initial deadlock for channel '0x7fd9c461a1b0' [Feb 19 18:07:21] DEBUG[3407] channel.c: Avoiding initial deadlock for channel '0x7fd9c461a1b0' [Feb 19 18:07:21] DEBUG[3407] channel.c: Avoiding initial deadlock for channel '0x7fd9c461a1b0' [Feb 19 18:07:21] DEBUG[32087] chan_dahdi.c: Requested indication 20 on channel DAHDI/22-1 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 35e963b41c1dacba3e6b886627a6ac52@192.168.10.5 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5086 [Feb 19 18:07:21] DEBUG[32087] rtp.c: Ooh, format changed from unknown to alaw [Feb 19 18:07:21] DEBUG[32087] rtp.c: Created smoother: format: 8 ms: 20 len: 160 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '35e963b41c1dacba3e6b886627a6ac52@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 15355faf1ac29bba179ac47e1d2ddeb1@192.168.10.5 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5088 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '15355faf1ac29bba179ac47e1d2ddeb1@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 7114678b0bb5f9d54d1a7ff77f14081a@192.168.10.5 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5090 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '7114678b0bb5f9d54d1a7ff77f14081a@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 3ab7f8a5186815322d5a1e6e2f94896c@192.168.10.5 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5092 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '3ab7f8a5186815322d5a1e6e2f94896c@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 0dc651933d85f48d4988c3950525fcce@192.168.10.5 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5094 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '0dc651933d85f48d4988c3950525fcce@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 645571a22685731d7dec113c26aa6bd4@192.168.10.5 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5096 [Feb 19 18:07:21] DEBUG[3413] chan_sip.c: Stopping retransmission on '645571a22685731d7dec113c26aa6bd4@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 47a17caf0f334fa30c4a73da02ebaa5f@192.168.10.5 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.40:5076 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Stopping retransmission on '47a17caf0f334fa30c4a73da02ebaa5f@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 72d57cca656e49320238b3f8500178fa@192.168.10.5 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.110:5062 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 00258d154e4d4adf33c383b71fa97d60@192.168.10.5 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.140:5060 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 3518365a3c04766d4c935f1566eec212@192.168.10.5 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.30:5078 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Stopping retransmission on '72d57cca656e49320238b3f8500178fa@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Stopping retransmission on '00258d154e4d4adf33c383b71fa97d60@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Stopping retransmission on '3518365a3c04766d4c935f1566eec212@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 3edfc9c45bc8e675394073082a3bc491@192.168.10.5 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5098 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 69e8fb4b7650a9094a2a7c8840ca859a@192.168.10.5 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.40:5078 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Stopping retransmission on '3edfc9c45bc8e675394073082a3bc491@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Stopping retransmission on '69e8fb4b7650a9094a2a7c8840ca859a@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 312ef5d21f45d493104c0b0303cb3ba2@192.168.10.5 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.40:5080 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 72e60d005550c3b42edddae509b922d8@192.168.10.5 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.70:5100 [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Stopping retransmission on '312ef5d21f45d493104c0b0303cb3ba2@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:22] DEBUG[3413] chan_sip.c: Stopping retransmission on '72e60d005550c3b42edddae509b922d8@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 4b126c352d75245f08201e515c79880b@192.168.10.5 [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.100:5096 [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 625134cc1ed5b72140fa195a7856b25c@192.168.10.5 [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.100:5098 [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Stopping retransmission on '4b126c352d75245f08201e515c79880b@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Stopping retransmission on '625134cc1ed5b72140fa195a7856b25c@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 7926926c22973b0c248dfa6239566ec5@192.168.10.5 [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.100:5100 [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Stopping retransmission on '7926926c22973b0c248dfa6239566ec5@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 7558d4b96736b2c037db430f2517c032@192.168.10.5 [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.110:5064 [Feb 19 18:07:23] DEBUG[3413] chan_sip.c: Stopping retransmission on '7558d4b96736b2c037db430f2517c032@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:24] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:24] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 48b221321d8d9af82997942c03f14073@192.168.10.5 [Feb 19 18:07:24] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.100:5102 [Feb 19 18:07:24] DEBUG[3413] chan_sip.c: Stopping retransmission on '48b221321d8d9af82997942c03f14073@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:24] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:24] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 76f2856437634252022175556421d673@192.168.10.5 [Feb 19 18:07:24] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.140:5062 [Feb 19 18:07:24] DEBUG[3413] chan_sip.c: Stopping retransmission on '76f2856437634252022175556421d673@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 53af30da623aa884362147f45216c61f@192.168.10.5 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.40:5082 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Stopping retransmission on '53af30da623aa884362147f45216c61f@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 77c8f165430bff4809b88c94199b3d2b@192.168.10.5 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.30:5080 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Stopping retransmission on '77c8f165430bff4809b88c94199b3d2b@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'SIP/2.0 40' onto UDP socket destined for 91.147.96.175:17889 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 13fa8b215c1c0b085bc845451cc0d5bc@192.168.10.5 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.100:5104 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Stopping retransmission on '13fa8b215c1c0b085bc845451cc0d5bc@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 555c98f40ce23c642ac669a22551c411@192.168.10.5 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.110:5066 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Stopping retransmission on '555c98f40ce23c642ac669a22551c411@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 643dce7b1a913aa348cdc1384ec91479@192.168.10.5 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.140:5064 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Stopping retransmission on '643dce7b1a913aa348cdc1384ec91479@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 112862b177fe6cdf34250661224e7e6b@92.46.121.226 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 91.147.96.175:17889 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'SIP/2.0 20' onto UDP socket destined for 91.147.96.175:17889 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 6ed73be33f828a7b0ae886a258b8153f@192.168.10.5 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.80:5106 [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Stopping retransmission on '112862b177fe6cdf34250661224e7e6b@92.46.121.226' of Request 102: Match Found [Feb 19 18:07:25] DEBUG[3413] chan_sip.c: Stopping retransmission on '6ed73be33f828a7b0ae886a258b8153f@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 6cad73bb172a05c04cc32c213b5fd599@192.168.10.5 [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.30:5082 [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Stopping retransmission on '6cad73bb172a05c04cc32c213b5fd599@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 09f796c73835172a28a7ed352d249a0b@192.168.10.5 [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.30:5084 [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Stopping retransmission on '09f796c73835172a28a7ed352d249a0b@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 476e27b21c2cb0833a7db7cd5b586a17@192.168.10.5 [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.100:5064 [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Stopping retransmission on '476e27b21c2cb0833a7db7cd5b586a17@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Initializing initreq for method OPTIONS - callid 15a06d8001e649787672cf6d3df66428@192.168.10.5 [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Trying to put 'OPTIONS si' onto UDP socket destined for 192.168.10.110:5068 [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Stopping retransmission on '15a06d8001e649787672cf6d3df66428@192.168.10.5' of Request 102: Match Found [Feb 19 18:07:26] DEBUG[3413] chan_sip.c: Trying to put 'SIP/2.0 20' onto UDP socket destined for 192.168.10.30:5082 [Feb 19 18:07:26] DEBUG[32015] channel.c: Didn't get a frame from channel: SIP/111-e01cb820 [Feb 19 18:07:26] DEBUG[32015] chan_dahdi.c: Requested indication 20 on channel DAHDI/4-1 [Feb 19 18:07:26] DEBUG[32015] channel.c: Bridge stops bridging channels SIP/111-e01cb820 and DAHDI/4-1 [Feb 19 18:07:26] DEBUG[32015] pbx.c: Launching 'Macro' [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/111-e01cb820", "hangupcall,") in new stack [Feb 19 18:07:26] DEBUG[32015] pbx.c: Launching 'ResetCDR' [Feb 19 18:07:26] WARNING[30185] file.c: Failed to write frame [Feb 19 18:07:26] DEBUG[30185] channel.c: Scheduling timer at 0 sample intervals [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/111-e01cb820", "w") in new stack [Feb 19 18:07:26] VERBOSE[30185] logger.c: -- Playing 'vm-goodbye.ulaw' (language 'en') [Feb 19 18:07:26] DEBUG[30185] app_macro.c: Spawn extension (macro-hangupcall,s,1) exited non-zero on 'SIP/111-e01cb820' in macro 'dialout-trunk' [Feb 19 18:07:26] VERBOSE[30185] logger.c: == Spawn extension (macro-hangupcall, s, 1) exited non-zero on 'SIP/111-e01cb820' in macro 'dialout-trunk' [Feb 19 18:07:26] DEBUG[30185] pbx.c: Spawn extension (macro-hangupcall,s,1) exited non-zero on 'SIP/111-e01cb820' [Feb 19 18:07:26] VERBOSE[30185] logger.c: == Spawn extension (macro-hangupcall, s, 1) exited non-zero on 'SIP/111-e01cb820' [Feb 19 18:07:26] DEBUG[30185] channel.c: Soft-Hanging up channel 'SIP/111-e01cb820' [Feb 19 18:07:26] DEBUG[30185] channel.c: Scheduling timer at 0 sample intervals [Feb 19 18:07:26] DEBUG[30185] channel.c: Hanging up channel 'SIP/111-e01cb820' [Feb 19 18:07:26] DEBUG[30185] chan_sip.c: Hangup call SIP/111-e01cb820, SIP callid 1373557653-5082-245@192.168.10.30 [Feb 19 18:07:26] DEBUG[32015] cdr_addon_mysql.c: Inserting a CDR record. [Feb 19 18:07:26] DEBUG[32015] cdr_addon_mysql.c: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES ('2009-02-19 18:06:11','550111','550111','550034','outcall-city','SIP/111-e01cb820','DAHDI/4-1','Dial','DAHDI/g1/550034,300,','75','68','ANSWERED','3','','1235045171.28667','') [Feb 19 18:07:26] DEBUG[32015] app_macro.c: Executed application: ResetCDR [Feb 19 18:07:26] DEBUG[32015] pbx.c: Launching 'NoCDR' [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Executing [s@macro-hangupcall:2] NoCDR("SIP/111-e01cb820", "") in new stack [Feb 19 18:07:26] DEBUG[32015] app_macro.c: Executed application: NoCDR [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] DEBUG[32015] pbx.c: Expression result is '1' [Feb 19 18:07:26] DEBUG[32015] pbx.c: Launching 'GotoIf' [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Executing [s@macro-hangupcall:3] GotoIf("(null)", "1?skiprg") in new stack [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 6424 (ast_explicit_goto): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 6437 (ast_explicit_goto): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 6437 (ast_explicit_goto): Error releasing mutex: Invalid argument [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Goto (macro-hangupcall,s,7) [Feb 19 18:07:26] DEBUG[32015] app_macro.c: Executed application: GotoIf [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] DEBUG[32015] pbx.c: Launching 'NoOp' [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Executing [s@macro-hangupcall:7] NoOp("(null)", "Cleaning Up Block VM Flag: ") in new stack [Feb 19 18:07:26] DEBUG[32015] app_macro.c: Executed application: Noop [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] DEBUG[32015] pbx.c: Launching 'DBdel' [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Executing [s@macro-hangupcall:8] DBdel("(null)", "") in new stack [Feb 19 18:07:26] WARNING[32015] app_db.c: The DBdel application has been deprecated in favor of the DB_DELETE dialplan function! [Feb 19 18:07:26] DEBUG[32015] app_db.c: Ignoring, no parameters [Feb 19 18:07:26] DEBUG[32015] app_macro.c: Executed application: DBDel [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2376 (pbx_retrieve_variable): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): mutex '&c->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 2476 (pbx_retrieve_variable): Error releasing mutex: Invalid argument [Feb 19 18:07:26] DEBUG[32015] pbx.c: Expression result is '1' [Feb 19 18:07:26] DEBUG[32015] pbx.c: Launching 'GotoIf' [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Executing [s@macro-hangupcall:9] GotoIf("(null)", "1?theend") in new stack [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 6424 (ast_explicit_goto): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 6437 (ast_explicit_goto): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 6437 (ast_explicit_goto): Error releasing mutex: Invalid argument [Feb 19 18:07:26] VERBOSE[32015] logger.c: -- Goto (macro-hangupcall,s,12) [Feb 19 18:07:26] DEBUG[32015] app_macro.c: Executed application: GotoIf [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 7945 (pbx_builtin_getvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 7967 (pbx_builtin_getvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 7967 (pbx_builtin_getvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8020 (pbx_builtin_setvar_helper): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: pbx.c line 8058 (pbx_builtin_setvar_helper): Error releasing mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: features.c line 2223 (ast_bridge_call): Error obtaining mutex: Invalid argument [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: features.c line 2229 (ast_bridge_call): mutex '&chan->lock_dont_use' freed more times than we've locked! [Feb 19 18:07:26] ERROR[32015] /root/dev/pbx/asterisk-1.6.0.5/include/asterisk/lock.h: features.c line 2229 (ast_bridge_call): Error releasing mutex: Invalid argument