[2016-11-17 17:47:52] DEBUG[3688]: res_pjsip_session.c:2463 handle_incoming: Received request
[2016-11-17 17:47:52] DEBUG[3688]: res_pjsip_session.c:2430 handle_incoming_request: Method is ACK
[2016-11-17 17:47:52] DEBUG[4438][C-00000001]: res_rtp_asterisk.c:4519 ast_rtp_read: 0x7fa560018280 -- Probation learning mode pass with source address 217.0.4.166:24650
[2016-11-17 17:47:52] DEBUG[4438][C-00000001]: chan_pjsip.c:743 chan_pjsip_read: Oooh, got a frame with format of g722 on channel 'PJSIP/0619390405950-00000001' when we're sending 'alaw', switching to match
[2016-11-17 17:47:52] DEBUG[4438][C-00000001]: channel.c:5464 ast_set_write_format_path: Channel PJSIP/0619390405950-00000001 setting write format path: gsm -> g722
[2016-11-17 17:47:52] DEBUG[4438][C-00000001]: res_rtp_asterisk.c:3601 ast_rtp_write: Ooh, format changed from alaw to g722
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: channel.c:5664 set_format: Channel PJSIP/0619390405950-00000001 setting write format path: g722 -> g722
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: channel.c:5664 set_format: Channel PJSIP/0619390405950-00000001 setting write format path: gsm -> alaw
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: res_rtp_asterisk.c:3601 ast_rtp_write: Ooh, format changed from g722 to alaw
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (50 requested / 50 actual) timer ticks per second
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: chan_pjsip.c:743 chan_pjsip_read: Oooh, got a frame with format of g722 on channel 'PJSIP/0619390405950-00000001' when we're sending 'alaw', switching to match
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: channel.c:5464 ast_set_write_format_path: Channel PJSIP/0619390405950-00000001 setting write format path: gsm -> g722
[2016-11-17 17:47:53] DEBUG[4438][C-00000001]: res_rtp_asterisk.c:3601 ast_rtp_write: Ooh, format changed from alaw to g722
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: channel.c:5664 set_format: Channel PJSIP/0619390405950-00000001 setting write format path: g722 -> g722
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: channel.c:5664 set_format: Channel PJSIP/0619390405950-00000001 setting write format path: gsm -> alaw
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: res_rtp_asterisk.c:3601 ast_rtp_write: Ooh, format changed from g722 to alaw
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (50 requested / 50 actual) timer ticks per second
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: chan_pjsip.c:743 chan_pjsip_read: Oooh, got a frame with format of g722 on channel 'PJSIP/0619390405950-00000001' when we're sending 'alaw', switching to match
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: channel.c:5464 ast_set_write_format_path: Channel PJSIP/0619390405950-00000001 setting write format path: gsm -> g722
[2016-11-17 17:47:54] DEBUG[4438][C-00000001]: res_rtp_asterisk.c:3601 ast_rtp_write: Ooh, format changed from alaw to g722
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: channel.c:5664 set_format: Channel PJSIP/0619390405950-00000001 setting write format path: g722 -> g722
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: channel.c:5664 set_format: Channel PJSIP/0619390405950-00000001 setting write format path: gsm -> alaw
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: res_rtp_asterisk.c:3601 ast_rtp_write: Ooh, format changed from g722 to alaw
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: channel.c:3462 ast_settimeout_full: Scheduling timer at (50 requested / 50 actual) timer ticks per second
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: chan_pjsip.c:743 chan_pjsip_read: Oooh, got a frame with format of g722 on channel 'PJSIP/0619390405950-00000001' when we're sending 'alaw', switching to match
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: channel.c:5464 ast_set_write_format_path: Channel PJSIP/0619390405950-00000001 setting write format path: gsm -> g722
[2016-11-17 17:47:55] DEBUG[4438][C-00000001]: res_rtp_asterisk.c:3601 ast_rtp_write: Ooh, format changed from alaw to g722
[2016-11-17 17:47:55] DEBUG[3687]: res_pjsip/pjsip_distributor.c:390 distributor: Searching for serializer on dialog dlg0x7fa560011f88 for Request msg BYE/cseq=2 (rdata0x7fa5a40023a8)
[2016-11-17 17:47:55] DEBUG[3687]: res_pjsip/pjsip_distributor.c:396 distributor: Found serializer pjsip/distributor-0000002b on dialog dlg0x7fa560011f88
[2016-11-17 17:47:55] DEBUG[3688]: res_pjsip_session.c:2595 session_inv_on_state_changed: Source of transaction state change is RX_MSG
[2016-11-17 17:47:55] DEBUG[3688]: res_pjsip_session.c:2463 handle_incoming: Received request
[2016-11-17 17:47:55] DEBUG[3688]: res_pjsip_session.c:2430 handle_incoming_request: Method is BYE