[Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:395 ast_rtp_instance_new: Using engine 'asterisk' for RTP instance '0x9772b9c' [Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:404 ast_rtp_instance_new: RTP instance '0x9772b9c' is setup and ready to go [Mar 17 15:53:04] == Using SIP RTP CoS mark 5 [Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 9 based on m type on 0xb355f5d0 [Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355f5d0 [Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 8 based on m type on 0xb355f5d0 [Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 3 based on m type on 0xb355f5d0 [Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 99 based on m type on 0xb355f5d0 [Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 108 based on m type on 0xb355f5d0 [Mar 17 15:53:04] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 18 based on m type on 0xb355f5d0 [Mar 17 15:53:04] DEBUG[32757][C-00000024]: pbx.c:4875 pbx_extension_helper: Launching 'NoOp' [Mar 17 15:53:04] -- Executing [12@pcmdev:1] NoOp("SIP/tovawi-00000038", "") in new stack [Mar 17 15:53:04] DEBUG[32757][C-00000024]: pbx.c:4875 pbx_extension_helper: Launching 'Dial' [Mar 17 15:53:04] -- Executing [12@pcmdev:2] Dial("SIP/tovawi-00000038", "SIP/d49t0y") in new stack [Mar 17 15:53:04] DEBUG[32757][C-00000024]: rtp_engine.c:395 ast_rtp_instance_new: Using engine 'asterisk' for RTP instance '0x98d311c' [Mar 17 15:53:04] DEBUG[32757][C-00000024]: rtp_engine.c:404 ast_rtp_instance_new: RTP instance '0x98d311c' is setup and ready to go [Mar 17 15:53:04] == Using SIP RTP CoS mark 5 [Mar 17 15:53:04] DEBUG[32757][C-00000024]: rtp_engine.c:1144 ast_rtp_instance_early_bridge_make_compatible: Seeded SDP of 'SIP/d49t0y-00000039' with that of 'SIP/tovawi-00000038' [Mar 17 15:53:04] -- Called SIP/d49t0y [Mar 17 15:53:04] DEBUG[32757][C-00000024]: channel.c:4429 indicate_connected_line: SIP/tovawi-00000038: Dropping redundant connected line update "Carlos" <1003>. [Mar 17 15:53:04] == Extension Changed 1003[pcmdev] new state Ringing for Notify User tovawi [Mar 17 15:53:04] -- SIP/d49t0y-00000039 is ringing [Mar 17 15:53:04] DEBUG[32757][C-00000024]: rtp_engine.c:1238 ast_rtp_instance_early_bridge: Setting early bridge SDP of 'SIP/tovawi-00000038' with that of 'SIP/d49t0y-00000039' [Mar 17 15:53:06] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:06] DEBUG[32757][C-00000024]: channel.c:4429 indicate_connected_line: SIP/tovawi-00000038: Dropping redundant connected line update "Carlos" <1003>. [Mar 17 15:53:06] -- SIP/d49t0y-00000039 answered SIP/tovawi-00000038 [Mar 17 15:53:06] DEBUG[32757][C-00000024]: rtp_engine.c:1238 ast_rtp_instance_early_bridge: Setting early bridge SDP of 'SIP/tovawi-00000038' with that of 'SIP/d49t0y-00000039' [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_dahdi is not compatible with properties of existing bridge. [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:486 find_best_technology: Bridge technology holding_bridge does not have any capabilities we want. [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge_native_rtp.c:314 native_rtp_bridge_compatible: Bridge '3c0eb666-acb2-402f-925d-05e517a5323a' can not use native RTP bridge as two channels are required [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_rtp is not compatible with properties of existing bridge. [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:505 find_best_technology: Chose bridge technology simple_bridge [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:771 bridge_base_init: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling simple_bridge technology constructor [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:779 bridge_base_init: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling simple_bridge technology start [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge_channel.c:1977 bridge_channel_internal_join: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9673f4c(SIP/tovawi-00000038) is joining [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge_channel.c:1572 bridge_channel_internal_push: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: pushing 0x9673f4c(SIP/tovawi-00000038) [Mar 17 15:53:06] -- Channel SIP/tovawi-00000038 joined 'simple_bridge' basic-bridge <3c0eb666-acb2-402f-925d-05e517a5323a> [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_dahdi is not compatible with properties of existing bridge. [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:486 find_best_technology: Bridge technology holding_bridge does not have any capabilities we want. [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:486 find_best_technology: Bridge technology softmix does not have any capabilities we want. [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge_native_rtp.c:314 native_rtp_bridge_compatible: Bridge '3c0eb666-acb2-402f-925d-05e517a5323a' can not use native RTP bridge as two channels are required [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_rtp is not compatible with properties of existing bridge. [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:505 find_best_technology: Chose bridge technology simple_bridge [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:1064 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is already using the new technology. [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:958 bridge_make_compatible: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is happy that channel SIP/tovawi-00000038 already has read format ulaw [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:982 bridge_make_compatible: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is happy that channel SIP/tovawi-00000038 already has write format ulaw [Mar 17 15:53:06] DEBUG[32757][C-00000024]: bridge.c:424 bridge_channel_complete_join: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9673f4c(SIP/tovawi-00000038) is joining simple_bridge technology [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge_channel.c:1977 bridge_channel_internal_join: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9684c54(SIP/d49t0y-00000039) is joining [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge_channel.c:1572 bridge_channel_internal_push: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: pushing 0x9684c54(SIP/d49t0y-00000039) [Mar 17 15:53:06] -- Channel SIP/d49t0y-00000039 joined 'simple_bridge' basic-bridge <3c0eb666-acb2-402f-925d-05e517a5323a> [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_dahdi is not compatible with properties of existing bridge. [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:486 find_best_technology: Bridge technology holding_bridge does not have any capabilities we want. [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:486 find_best_technology: Bridge technology softmix does not have any capabilities we want. [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:491 find_best_technology: Bridge technology simple_bridge has less preference than native_rtp (50 <= 90). Skipping. [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:505 find_best_technology: Chose bridge technology native_rtp [Mar 17 15:53:06] > Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: switching from simple_bridge technology to native_rtp [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:1113 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling native_rtp technology constructor [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:1124 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling simple_bridge technology stop [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:1138 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9673f4c(SIP/tovawi-00000038) is leaving simple_bridge technology (dummy) [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:958 bridge_make_compatible: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is happy that channel SIP/tovawi-00000038 already has read format ulaw [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:982 bridge_make_compatible: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is happy that channel SIP/tovawi-00000038 already has write format ulaw [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:424 bridge_channel_complete_join: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9673f4c(SIP/tovawi-00000038) is joining native_rtp technology [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:958 bridge_make_compatible: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is happy that channel SIP/d49t0y-00000039 already has read format ulaw [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:982 bridge_make_compatible: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is happy that channel SIP/d49t0y-00000039 already has write format ulaw [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:424 bridge_channel_complete_join: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9684c54(SIP/d49t0y-00000039) is joining native_rtp technology [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:1149 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling native_rtp technology start [Mar 17 15:53:06] DEBUG[32759][C-00000024]: bridge.c:1166 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling simple_bridge technology destructor [Mar 17 15:53:06] == Extension Changed 1003[pcmdev] new state InUse for Notify User tovawi [Mar 17 15:53:06] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:06] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:06] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:08] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 9 based on m type on 0xb355f5d0 [Mar 17 15:53:08] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 8 based on m type on 0xb355f5d0 [Mar 17 15:53:08] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355f5d0 [Mar 17 15:53:08] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 18 based on m type on 0xb355f5d0 [Mar 17 15:53:08] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 101 based on m type on 0xb355f5d0 [Mar 17 15:53:08] -- Started music on hold, class 'default', on SIP/tovawi-00000038 [Mar 17 15:53:08] DEBUG[32757][C-00000024]: channel.c:3448 ast_settimeout_full: Scheduling timer at (50 requested / 50 actual) timer ticks per second [Mar 17 15:53:08] DEBUG[32757][C-00000024]: channel.c:5381 set_format: Set channel SIP/tovawi-00000038 to write format slin [Mar 17 15:53:08] > 0x99031f8 -- Probation passed - setting RTP source address to 10.37.0.131:64932 [Mar 17 15:53:08] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:08] > 0x99031f8 -- Probation passed - setting RTP source address to 10.37.0.131:64932 [Mar 17 15:53:09] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:09] > 0x99031f8 -- Probation passed - setting RTP source address to 10.37.0.131:64932 [Mar 17 15:53:10] DEBUG[16764][C-00000025]: rtp_engine.c:395 ast_rtp_instance_new: Using engine 'asterisk' for RTP instance '0x98a10f4' [Mar 17 15:53:10] DEBUG[16764][C-00000025]: rtp_engine.c:404 ast_rtp_instance_new: RTP instance '0x98a10f4' is setup and ready to go [Mar 17 15:53:10] == Using SIP RTP CoS mark 5 [Mar 17 15:53:10] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 9 based on m type on 0xb355f5d0 [Mar 17 15:53:10] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 8 based on m type on 0xb355f5d0 [Mar 17 15:53:10] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355f5d0 [Mar 17 15:53:10] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 18 based on m type on 0xb355f5d0 [Mar 17 15:53:10] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 101 based on m type on 0xb355f5d0 [Mar 17 15:53:10] DEBUG[32762][C-00000025]: pbx.c:4875 pbx_extension_helper: Launching 'NoOp' [Mar 17 15:53:10] -- Executing [11@pcmdev:1] NoOp("SIP/d49t0y-0000003a", "") in new stack [Mar 17 15:53:10] DEBUG[32762][C-00000025]: pbx.c:4875 pbx_extension_helper: Launching 'Dial' [Mar 17 15:53:10] -- Executing [11@pcmdev:2] Dial("SIP/d49t0y-0000003a", "SIP/1kgp3i") in new stack [Mar 17 15:53:10] DEBUG[32762][C-00000025]: rtp_engine.c:395 ast_rtp_instance_new: Using engine 'asterisk' for RTP instance '0x984dfd4' [Mar 17 15:53:10] DEBUG[32762][C-00000025]: rtp_engine.c:404 ast_rtp_instance_new: RTP instance '0x984dfd4' is setup and ready to go [Mar 17 15:53:10] == Using SIP RTP CoS mark 5 [Mar 17 15:53:10] DEBUG[32762][C-00000025]: rtp_engine.c:1144 ast_rtp_instance_early_bridge_make_compatible: Seeded SDP of 'SIP/1kgp3i-0000003b' with that of 'SIP/d49t0y-0000003a' [Mar 17 15:53:10] -- Called SIP/1kgp3i [Mar 17 15:53:10] DEBUG[32762][C-00000025]: channel.c:4429 indicate_connected_line: SIP/d49t0y-0000003a: Dropping redundant connected line update "Enriké-Louis Cadotte Michaud" <1005>. [Mar 17 15:53:10] -- SIP/1kgp3i-0000003b is ringing [Mar 17 15:53:10] DEBUG[32762][C-00000025]: rtp_engine.c:1238 ast_rtp_instance_early_bridge: Setting early bridge SDP of 'SIP/d49t0y-0000003a' with that of 'SIP/1kgp3i-0000003b' [Mar 17 15:53:11] -- SIP/1kgp3i-0000003b is ringing [Mar 17 15:53:11] DEBUG[32762][C-00000025]: rtp_engine.c:1238 ast_rtp_instance_early_bridge: Setting early bridge SDP of 'SIP/d49t0y-0000003a' with that of 'SIP/1kgp3i-0000003b' [Mar 17 15:53:12] -- SIP/1kgp3i-0000003b is ringing [Mar 17 15:53:12] DEBUG[32762][C-00000025]: rtp_engine.c:1238 ast_rtp_instance_early_bridge: Setting early bridge SDP of 'SIP/d49t0y-0000003a' with that of 'SIP/1kgp3i-0000003b' [Mar 17 15:53:13] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:13] DEBUG[32762][C-00000025]: channel.c:4429 indicate_connected_line: SIP/d49t0y-0000003a: Dropping redundant connected line update "Enriké-Louis Cadotte Michaud" <1005>. [Mar 17 15:53:13] -- SIP/1kgp3i-0000003b answered SIP/d49t0y-0000003a [Mar 17 15:53:13] DEBUG[32762][C-00000025]: rtp_engine.c:1238 ast_rtp_instance_early_bridge: Setting early bridge SDP of 'SIP/d49t0y-0000003a' with that of 'SIP/1kgp3i-0000003b' [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:496 find_best_technology: Bridge technology native_dahdi is not compatible with properties of existing bridge. [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:486 find_best_technology: Bridge technology holding_bridge does not have any capabilities we want. [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge_native_rtp.c:314 native_rtp_bridge_compatible: Bridge 'a87dd03f-a069-4eeb-8bfa-7371ca8a3292' can not use native RTP bridge as two channels are required [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:496 find_best_technology: Bridge technology native_rtp is not compatible with properties of existing bridge. [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:505 find_best_technology: Chose bridge technology simple_bridge [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:771 bridge_base_init: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling simple_bridge technology constructor [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:779 bridge_base_init: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling simple_bridge technology start [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge_channel.c:1977 bridge_channel_internal_join: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x94b9d84(SIP/d49t0y-0000003a) is joining [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge_channel.c:1572 bridge_channel_internal_push: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: pushing 0x94b9d84(SIP/d49t0y-0000003a) [Mar 17 15:53:13] -- Channel SIP/d49t0y-0000003a joined 'simple_bridge' basic-bridge [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:496 find_best_technology: Bridge technology native_dahdi is not compatible with properties of existing bridge. [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:486 find_best_technology: Bridge technology holding_bridge does not have any capabilities we want. [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:486 find_best_technology: Bridge technology softmix does not have any capabilities we want. [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge_native_rtp.c:314 native_rtp_bridge_compatible: Bridge 'a87dd03f-a069-4eeb-8bfa-7371ca8a3292' can not use native RTP bridge as two channels are required [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:496 find_best_technology: Bridge technology native_rtp is not compatible with properties of existing bridge. [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:505 find_best_technology: Chose bridge technology simple_bridge [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:1064 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is already using the new technology. [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:958 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/d49t0y-0000003a already has read format ulaw [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:982 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/d49t0y-0000003a already has write format ulaw [Mar 17 15:53:13] DEBUG[32762][C-00000025]: bridge.c:424 bridge_channel_complete_join: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x94b9d84(SIP/d49t0y-0000003a) is joining simple_bridge technology [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge_channel.c:1977 bridge_channel_internal_join: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x957a6d4(SIP/1kgp3i-0000003b) is joining [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge_channel.c:1572 bridge_channel_internal_push: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: pushing 0x957a6d4(SIP/1kgp3i-0000003b) [Mar 17 15:53:13] -- Channel SIP/1kgp3i-0000003b joined 'simple_bridge' basic-bridge [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:496 find_best_technology: Bridge technology native_dahdi is not compatible with properties of existing bridge. [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:486 find_best_technology: Bridge technology holding_bridge does not have any capabilities we want. [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:486 find_best_technology: Bridge technology softmix does not have any capabilities we want. [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:491 find_best_technology: Bridge technology simple_bridge has less preference than native_rtp (50 <= 90). Skipping. [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:505 find_best_technology: Chose bridge technology native_rtp [Mar 17 15:53:13] > Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: switching from simple_bridge technology to native_rtp [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:1113 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling native_rtp technology constructor [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:1124 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling simple_bridge technology stop [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:1138 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x94b9d84(SIP/d49t0y-0000003a) is leaving simple_bridge technology (dummy) [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:958 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/d49t0y-0000003a already has read format ulaw [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:982 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/d49t0y-0000003a already has write format ulaw [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:424 bridge_channel_complete_join: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x94b9d84(SIP/d49t0y-0000003a) is joining native_rtp technology [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:958 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/1kgp3i-0000003b already has read format ulaw [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:982 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/1kgp3i-0000003b already has write format ulaw [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:424 bridge_channel_complete_join: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x957a6d4(SIP/1kgp3i-0000003b) is joining native_rtp technology [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:1149 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling native_rtp technology start [Mar 17 15:53:13] DEBUG[32764][C-00000025]: bridge.c:1166 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling simple_bridge technology destructor [Mar 17 15:53:13] > 0x979ca68 -- Probation passed - setting RTP source address to 10.37.0.129:57750 [Mar 17 15:53:13] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:13] > 0x9884eb8 -- Probation passed - setting RTP source address to 10.37.0.143:3002 [Mar 17 15:53:13] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:13] > 0x9884eb8 -- Probation passed - setting RTP source address to 10.37.0.143:3002 [Mar 17 15:53:13] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:2085 bridge_do_move: Moving 0x9673f4c(SIP/tovawi-00000038) into bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 swapping with SIP/d49t0y-0000003a [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_channel.c:1509 bridge_channel_internal_pull: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: pulling 0x9673f4c(SIP/tovawi-00000038) [Mar 17 15:53:16] -- Channel SIP/tovawi-00000038 left 'native_rtp' basic-bridge <3c0eb666-acb2-402f-925d-05e517a5323a> [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_channel.c:1521 bridge_channel_internal_pull: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9673f4c(SIP/tovawi-00000038) is leaving native_rtp technology [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_channel.c:1569 bridge_channel_internal_push: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: pushing 0x9673f4c(SIP/tovawi-00000038) by swapping with 0x94b9d84(SIP/d49t0y-0000003a) [Mar 17 15:53:16] -- Channel SIP/tovawi-00000038 swapped with SIP/d49t0y-0000003a into 'native_rtp' basic-bridge [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_channel.c:151 ast_bridge_channel_leave_bridge_nolock: Setting 0x94b9d84(SIP/d49t0y-0000003a) state from:0 to:2 [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_channel.c:1509 bridge_channel_internal_pull: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: pulling 0x94b9d84(SIP/d49t0y-0000003a) [Mar 17 15:53:16] -- Channel SIP/d49t0y-0000003a left 'native_rtp' basic-bridge [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_channel.c:1521 bridge_channel_internal_pull: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x94b9d84(SIP/d49t0y-0000003a) is leaving native_rtp technology [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_dahdi is not compatible with properties of existing bridge. [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:486 find_best_technology: Bridge technology holding_bridge does not have any capabilities we want. [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:486 find_best_technology: Bridge technology softmix does not have any capabilities we want. [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_native_rtp.c:320 native_rtp_bridge_compatible: Bridge 'a87dd03f-a069-4eeb-8bfa-7371ca8a3292' can not use native RTP bridge as channel 'SIP/1kgp3i-0000003b' has features which prevent it [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_rtp is not compatible with properties of existing bridge. [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:505 find_best_technology: Chose bridge technology simple_bridge [Mar 17 15:53:16] > Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: switching from native_rtp technology to simple_bridge [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1113 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling simple_bridge technology constructor [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1124 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling native_rtp technology stop [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1138 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x957a6d4(SIP/1kgp3i-0000003b) is leaving native_rtp technology (dummy) [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:958 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/1kgp3i-0000003b already has read format ulaw [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:982 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/1kgp3i-0000003b already has write format ulaw [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:424 bridge_channel_complete_join: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x957a6d4(SIP/1kgp3i-0000003b) is joining simple_bridge technology [Mar 17 15:53:16] DEBUG[16764][C-00000024]: channel.c:5381 set_format: Set channel SIP/tovawi-00000038 to write format ulaw [Mar 17 15:53:16] DEBUG[16764][C-00000024]: channel.c:5381 set_format: Set channel SIP/tovawi-00000038 to write format slin [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:958 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/tovawi-00000038 already has read format ulaw [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:982 bridge_make_compatible: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292 is happy that channel SIP/tovawi-00000038 already has write format slin [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:424 bridge_channel_complete_join: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: 0x9673f4c(SIP/tovawi-00000038) is joining simple_bridge technology [Mar 17 15:53:16] DEBUG[16764][C-00000024]: channel.c:5381 set_format: Set channel SIP/tovawi-00000038 to write format ulaw [Mar 17 15:53:16] DEBUG[16764][C-00000024]: channel.c:5381 set_format: Set channel SIP/tovawi-00000038 to write format slin [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1149 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling simple_bridge technology start [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1166 smart_bridge_operation: Bridge a87dd03f-a069-4eeb-8bfa-7371ca8a3292: calling native_rtp technology destructor [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_dahdi is not compatible with properties of existing bridge. [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:486 find_best_technology: Bridge technology holding_bridge does not have any capabilities we want. [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:486 find_best_technology: Bridge technology softmix does not have any capabilities we want. [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_native_rtp.c:314 native_rtp_bridge_compatible: Bridge '3c0eb666-acb2-402f-925d-05e517a5323a' can not use native RTP bridge as two channels are required [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:496 find_best_technology: Bridge technology native_rtp is not compatible with properties of existing bridge. [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:505 find_best_technology: Chose bridge technology simple_bridge [Mar 17 15:53:16] > Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: switching from native_rtp technology to simple_bridge [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1113 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling simple_bridge technology constructor [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1124 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling native_rtp technology stop [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1138 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9684c54(SIP/d49t0y-00000039) is leaving native_rtp technology (dummy) [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:958 bridge_make_compatible: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is happy that channel SIP/d49t0y-00000039 already has read format ulaw [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:982 bridge_make_compatible: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is happy that channel SIP/d49t0y-00000039 already has write format ulaw [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:424 bridge_channel_complete_join: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9684c54(SIP/d49t0y-00000039) is joining simple_bridge technology [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1149 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling simple_bridge technology start [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge.c:1166 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling native_rtp technology destructor [Mar 17 15:53:16] DEBUG[16764][C-00000024]: bridge_channel.c:151 ast_bridge_channel_leave_bridge_nolock: Setting 0x9684c54(SIP/d49t0y-00000039) state from:0 to:2 [Mar 17 15:53:16] -- Stopped music on hold on SIP/tovawi-00000038 [Mar 17 15:53:16] DEBUG[32757][C-00000024]: channel.c:5381 set_format: Set channel SIP/tovawi-00000038 to write format ulaw [Mar 17 15:53:16] DEBUG[32757][C-00000024]: channel.c:3448 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second [Mar 17 15:53:16] DEBUG[32762][C-00000025]: pbx.c:6370 __ast_pbx_run: Spawn extension (pcmdev,11,2) exited non-zero on 'SIP/d49t0y-0000003a' [Mar 17 15:53:16] == Spawn extension (pcmdev, 11, 2) exited non-zero on 'SIP/d49t0y-0000003a' [Mar 17 15:53:16] DEBUG[32762][C-00000025]: channel.c:2593 ast_softhangup_nolock: Soft-Hanging up channel 'SIP/d49t0y-0000003a' [Mar 17 15:53:16] DEBUG[32762][C-00000025]: channel.c:2742 ast_hangup: Hanging up channel 'SIP/d49t0y-0000003a' [Mar 17 15:53:16] DEBUG[32759][C-00000024]: bridge_channel.c:1509 bridge_channel_internal_pull: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: pulling 0x9684c54(SIP/d49t0y-00000039) [Mar 17 15:53:16] -- Channel SIP/d49t0y-00000039 left 'simple_bridge' basic-bridge <3c0eb666-acb2-402f-925d-05e517a5323a> [Mar 17 15:53:16] DEBUG[32759][C-00000024]: bridge_channel.c:1521 bridge_channel_internal_pull: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: 0x9684c54(SIP/d49t0y-00000039) is leaving simple_bridge technology [Mar 17 15:53:16] DEBUG[32759][C-00000024]: bridge.c:311 bridge_dissolve: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: dissolving bridge with cause 16(Normal Clearing) [Mar 17 15:53:16] DEBUG[32759][C-00000024]: bridge.c:272 bridge_queue_action_nodup: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: queueing action type:13 sub:1001 [Mar 17 15:53:16] DEBUG[32759][C-00000024]: bridge.c:1021 smart_bridge_operation: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a is dissolved, not performing smart bridge operation. [Mar 17 15:53:16] DEBUG[32759][C-00000024]: channel.c:2742 ast_hangup: Hanging up channel 'SIP/d49t0y-00000039' [Mar 17 15:53:16] DEBUG[16589][C-00000024]: bridge.c:631 destroy_bridge: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: actually destroying basic bridge, nobody wants it anymore [Mar 17 15:53:16] DEBUG[16589][C-00000024]: bridge.c:656 destroy_bridge: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling basic bridge destructor [Mar 17 15:53:16] DEBUG[16589][C-00000024]: bridge.c:662 destroy_bridge: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling simple_bridge technology stop [Mar 17 15:53:16] DEBUG[16589][C-00000024]: bridge.c:669 destroy_bridge: Bridge 3c0eb666-acb2-402f-925d-05e517a5323a: calling simple_bridge technology destructor [Mar 17 15:53:16] == Extension Changed 1003[pcmdev] new state Idle for Notify User tovawi [Mar 17 15:53:16] > 0x979ca68 -- Probation passed - setting RTP source address to 10.37.0.129:57750 [Mar 17 15:53:16] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:16] > 0x979ca68 -- Probation passed - setting RTP source address to 10.37.0.129:57750 [Mar 17 15:53:17] DEBUG[16764][C-00000025]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e6b0 [Mar 17 15:53:17] DEBUG[16764][C-00000024]: rtp_engine.c:665 ast_rtp_codecs_payloads_set_m_type: Setting payload 0 based on m type on 0xb355e630 [Mar 17 15:53:17] > 0x99031f8 -- Probation passed - setting RTP source address to 10.37.0.131:64932 [Mar 17 15:53:17] DEBUG[16764]: rtp_engine.c:338 instance_destructor: Destroyed RTP instance '0x98a10f4' [Mar 17 15:53:18] NOTICE[16764]: chan_sip.c:27785 handle_request_subscribe: Received SIP subscribe for peer without mailbox: tovawi