[asterisk-bugs] [JIRA] (ASTERISK-26583) When using PJSIP transports in MariaDB table via ODBC; traffic from Asterisk is not seen on the network.

Jeff Clay (JIRA) noreply at issues.asterisk.org
Mon Nov 14 14:26:10 CST 2016


    [ https://issues.asterisk.org/jira/browse/ASTERISK-26583?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=233701#comment-233701 ] 

Jeff Clay commented on ASTERISK-26583:
--------------------------------------

I first added a new db and created the tables using alembic then tested with 13.12.2 and the issue persisted.

Using the same db created with alembic and the same configuration files, I tried versions 13.12.0, 13.11.1 and 13.9.1.

I switched between versions by doing the following:
{code}
rm -rf /usr/lib64/asterisk/modules
./configure --libdir=/usr/lib64 --with-pjproject-bundled
make menuselect.makeopts
menuselect/menuselect --enable streamplayer --enable stereorize --enable smsq --enable astman --enable aelparse --enable app_alarmreceiver --enable app_amd --enable app_chanisavail --enable res_fax --enable res_fax_spandsp --enable app_dictate --enable app_festival --enable app_image --enable app_morsecode --enable app_sms --enable app_url --enable app_waitforring --enable app_waitforsilence --enable app_ices --enable res_mwi_external --enable cdr_pgsql --enable cdr_csv --enable cdr_odbc --enable chan_alsa --enable chan_console --enable chan_mgcp --enable chan_oss --enable chan_phone --enable chan_sip --enable chan_skinny --enable chan_unistim --enable format_vox --enable pbx_realtime --enable pbx_lua --enable pbx_dundi --enable pbx_ael --enable res_mwi_external --enable odbc_storage  --enable res_mwi_external_ami --enable chan_mobile --enable chan_ooh323 --enable format_mp3 --enable app_meetme --enable res_config_mysql --enable res_corosync --enable res_endpoint_stats --enable ODBC_STORAGE --enable aelparse --enable astman --enable check_expr --enable check_expr2 --enable conf2ael --enable muted --enable smsq --enable stereorize --enable streamplayer --enable CORE-SOUNDS-EN-WAV --enable CORE-SOUNDS-EN-ULAW --enable CORE-SOUNDS-EN-ALAW --enable CORE-SOUNDS-EN-G729 --enable CORE-SOUNDS-EN-G722 --enable CORE-SOUNDS-EN-SLN16 --enable CORE-SOUNDS-EN-SIREN7 --enable CORE-SOUNDS-EN-SIREN14 --enable MOH-OPSOUND-ULAW --enable MOH-OPSOUND-ALAW --enable MOH-OPSOUND-GSM --enable MOH-OPSOUND-G729 --enable MOH-OPSOUND-G722 --enable MOH-OPSOUND-SLN16 --enable MOH-OPSOUND-SIREN7 --enable MOH-OPSOUND-SIREN14 --enable EXTRA-SOUNDS-EN-WAV --enable EXTRA-SOUNDS-EN-ULAW --enable EXTRA-SOUNDS-EN-ALAW --enable EXTRA-SOUNDS-EN-GSM --enable EXTRA-SOUNDS-EN-G729 --enable EXTRA-SOUNDS-EN-G722 --enable EXTRA-SOUNDS-EN-SLN16 --enable EXTRA-SOUNDS-EN-SIREN7 --enable EXTRA-SOUNDS-EN-SIREN14
./contrib/scripts/get_mp3_source.sh
make
make install
make config
{code}

{code:title=13.12.0}
pjsip show endpoints and show transports crashes *
attempting to register endpoint replicates registration issue
removed transports from extconfig and sorcery then restarted * service with a transport in the flat file.
	show transports now shows the flat file transport
	show endpoints does not crash *
	endpoint registers properly
{code}

{code:title=13.11.1}
pjsip show commands do not crash * as they did with 13.12.0
pjsip show transports properly shows the transport that is in the db.
same registration issue when using realtime transports
commenting out transport lines from extconfig and sorcery, allowing pjsip to load from flat file registers the endpoint fine.
{code}

{code:title=13.9.1}
pjsip show commands do not crash * as they did with 13.12.0
pjsip show transports properly shows the transport that is in the db.
same registration issue when using realtime transports
commenting out transport lines from extconfig and sorcery, allowing pjsip to load from flat file registers the endpoint fine.
{code}



> When using PJSIP transports in MariaDB table via ODBC; traffic from Asterisk is not seen on the network.
> --------------------------------------------------------------------------------------------------------
>
>                 Key: ASTERISK-26583
>                 URL: https://issues.asterisk.org/jira/browse/ASTERISK-26583
>             Project: Asterisk
>          Issue Type: Bug
>      Security Level: None
>          Components: pjproject/pjsip, Resources/res_config_odbc
>    Affects Versions: 13.12.2, 14.1.1
>         Environment: Centos 7.2.1511
> kernel 3.10.0-327.36.3.el7
>            Reporter: Jeff Clay
>            Assignee: Jeff Clay
>
> When using pjsip transports in mariadb table via odbc traffic from asterisk is not seen on the network. For example, when a phone attempts to register, the registration request is seen in pjsip debug as well as a tcpdump; then when asterisk replies with the 401 auth challenge that is only seen in the pjsip debug and is not seen in a tcpdump and the endpoint never receives the challenge. 
> Using transports within pjsip.conf works properly with the exact same transport settings that were failing when used in database.
> Full configs, db tables, tcpdump and debug logs below.
> *config files*
> {code:title=sorcery.conf}
> [res_pjsip]
> endpoint=realtime,ps_endpoints
> auth=realtime,ps_auths
> transport=realtime,ps_transports
> aor=realtime,ps_aors
> domain_alias=realtime,ps_domain_aliases
> [res_pjsip_endpoint_identifier_ip]
> identify=realtime,ps_endpoint_id_ips
> system=realtime,ps_systems
> {code}
> {code:title=extconfig.conf}
> [settings]
> iaxusers => odbc,asterisk,iaxfriends
> iaxpeers => odbc,asterisk,iaxfriends
> iaxfriends => odbc,asterisk
> ps_endpoints => odbc,asterisk
> ps_auths => odbc,asterisk
> ps_aors => odbc,asterisk
> ps_domain_aliases => odbc,asterisk
> ps_endpoint_id_ips => odbc,asterisk
> ps_globals => odbc,asterisk
> ps_transports => odbc,asterisk
> ps_systems => odbc,asterisk
> ps_subscription_persistence => odbc,asterisk
> ps_registrations => odbc,asterisk
> ps_contacts => odbc,asterisk
> voicemail => odbc,asterisk
> extensions => odbc,asterisk
> meetme => odbc,asterisk
> queues => odbc,asterisk
> queue_members => odbc,asterisk
> queue_rules => odbc,asterisk
> meetme => odbc,asterisk
> followme => odbc,asterisk,followme
> followme_numbers => odbc,asterisk,followme_numbers
> {code}
> *database tables*
> {code:title=ps_aors}
> INSERT INTO `ps_aors` (`id`, `contact`, `default_expiration`, `mailboxes`, `max_contacts`, `minimum_expiration`, `remove_existing`, `qualify_frequency`, `authenticate_qualify`, `maximum_expiration`, `outbound_proxy`, `support_path`, `qualify_timeout`, `voicemail_extension`)
> VALUES
> 	('1506', NULL, NULL, NULL, 3, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL);
> {code}
> {code:title=ps_auths}
> INSERT INTO `ps_auths` (`id`, `auth_type`, `nonce_lifetime`, `md5_cred`, `password`, `realm`, `username`)
> VALUES
> 	('phone', 'userpass', NULL, NULL, 'pass', NULL, '1506');
> {code}
> {code:title=ps_endpoints}
> INSERT INTO `ps_endpoints` (`id`, `transport`, `aors`, `auth`, `context`, `disallow`, `allow`, `direct_media`, `connected_line_method`, `direct_media_method`, `direct_media_glare_mitigation`, `disable_direct_media_on_nat`, `dtmf_mode`, `external_media_address`, `force_rport`, `ice_support`, `identify_by`, `mailboxes`, `moh_suggest`, `outbound_auth`, `outbound_proxy`, `rewrite_contact`, `rtp_ipv6`, `rtp_symmetric`, `send_diversion`, `send_pai`, `send_rpid`, `timers_min_se`, `timers`, `timers_sess_expires`, `callerid`, `callerid_privacy`, `callerid_tag`, `100rel`, `aggregate_mwi`, `trust_id_inbound`, `trust_id_outbound`, `use_ptime`, `use_avpf`, `media_encryption`, `inband_progress`, `call_group`, `pickup_group`, `named_call_group`, `named_pickup_group`, `device_state_busy_at`, `fax_detect`, `t38_udptl`, `t38_udptl_ec`, `t38_udptl_maxdatagram`, `t38_udptl_nat`, `t38_udptl_ipv6`, `tone_zone`, `language`, `one_touch_recording`, `record_on_feature`, `record_off_feature`, `rtp_engine`, `allow_transfer`, `allow_subscribe`, `sdp_owner`, `sdp_session`, `tos_audio`, `tos_video`, `sub_min_expiry`, `from_domain`, `from_user`, `mwi_from_user`, `dtls_verify`, `dtls_rekey`, `dtls_cert_file`, `dtls_private_key`, `dtls_cipher`, `dtls_ca_file`, `dtls_ca_path`, `dtls_setup`, `srtp_tag_32`, `media_address`, `redirect_method`, `set_var`, `cos_audio`, `cos_video`, `message_context`, `force_avp`, `media_use_received_transport`, `accountcode`, `media_encryption_optimistic`, `user_eq_phone`, `rpid_immediate`, `g726_non_standard`, `rtp_keepalive`, `rtp_timeout`, `rtp_timeout_hold`, `bind_rtp_to_media_address`, `voicemail_extension`, `mwi_subscribe_replaces_unsolicited`, `deny`, `permit`, `acl`, `contact_deny`, `contact_permit`, `contact_acl`, `subscribe_context`, `fax_detect_timeout`, `contact_user`)
> VALUES
> 	('1506', 'nat_udp', '1506', 'phone', 'ADMIN', 'all', 'ulaw', 'no', NULL, NULL, NULL, NULL, 'rfc4733', NULL, 'yes', NULL, 'username', '1506', NULL, NULL, NULL, 'yes', 'no', 'yes', NULL, NULL, NULL, NULL, NULL, NULL, '<1506> \"Jeff\"', NULL, NULL, NULL, 'yes', NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, '1506', NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL, NULL);
> {code}
> {code:title=ps_transports}
> INSERT INTO `ps_transports` (`id`, `async_operations`, `bind`, `ca_list_file`, `cert_file`, `cipher`, `domain`, `external_media_address`, `external_signaling_address`, `external_signaling_port`, `method`, `local_net`, `password`, `priv_key_file`, `protocol`, `require_client_cert`, `verify_client`, `verify_server`, `tos`, `cos`, `allow_reload`)
> VALUES
> 	('nat_udp', NULL, '0.0.0.0', NULL, NULL, NULL, NULL, '104.197.69.7', '104.197.69.7', NULL, NULL, '10.128.0.0/20', NULL, NULL, 'udp', NULL, NULL, NULL, NULL, NULL, 'yes');
> {code}
> *DEBUG*
> You can see here that asterisk receives the register request and sends the auth challenge.
> {code:title=asterisk debug with pjsip debug}
> devast*CLI> core set debug 5
> Core debug was OFF and is now 5.
> [Nov 11 16:34:50] DEBUG[18040]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:34:50] DEBUG[18028]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 2
> [Nov 11 16:34:53] DEBUG[18038]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:34:53] DEBUG[18039]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:34:53] DEBUG[18028]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 0
> [Nov 11 16:34:53] DEBUG[18028]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 1
> devast*CLI> pjsip set logger on
> PJSIP Logging enabled
> [Nov 11 16:35:00] DEBUG[18092]: res_pjsip_registrar_expire.c:78 check_expiration_thread: Woke up at 1478882100  Interval: 30
> [Nov 11 16:35:00] DEBUG[18092]: res_pjsip_registrar_expire.c:85 check_expiration_thread: Expiring 0 contacts
> [Nov 11 16:35:19] DEBUG[18090]: res_timing_timerfd.c:167 timerfd_timer_ack: Expected to acknowledge 1 ticks but got 3 instead
> [Nov 11 16:35:23] DEBUG[18090]: res_timing_timerfd.c:167 timerfd_timer_ack: Expected to acknowledge 1 ticks but got 3 instead
> [Nov 11 16:35:30] DEBUG[18057]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:30] DEBUG[18058]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:30] DEBUG[18051]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 8
> [Nov 11 16:35:30] DEBUG[18051]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 9
> [Nov 11 16:35:30] DEBUG[18060]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:30] DEBUG[18061]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:30] DEBUG[18062]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:30] DEBUG[18027]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 11
> [Nov 11 16:35:30] DEBUG[18027]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 12
> [Nov 11 16:35:30] DEBUG[18027]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 13
> [Nov 11 16:35:30] DEBUG[18092]: res_pjsip_registrar_expire.c:78 check_expiration_thread: Woke up at 1478882130  Interval: 30
> [Nov 11 16:35:30] DEBUG[18092]: res_pjsip_registrar_expire.c:85 check_expiration_thread: Expiring 0 contacts
> [Nov 11 16:35:30] DEBUG[18059]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:30] DEBUG[18027]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 10
> [Nov 11 16:35:33] DEBUG[18055]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:33] DEBUG[18056]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:33] DEBUG[18051]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 6
> [Nov 11 16:35:33] DEBUG[18051]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 7
> [Nov 11 16:35:33] DEBUG[18054]: threadpool.c:1137 worker_idle: Worker thread idle timeout reached. Dying.
> [Nov 11 16:35:33] DEBUG[18051]: threadpool.c:996 worker_thread_destroy: Destroying worker thread 5
> <--- Received SIP request (525 bytes) from UDP:12.49.160.131:58781 --->
> REGISTER sip:104.197.69.7 SIP/2.0
> Via: SIP/2.0/UDP 10.200.101.116:58781;branch=z9hG4bK-524287-1---510c701eed52f364;rport
> Max-Forwards: 70
> Contact: <sip:1506 at 10.200.101.116:58781;rinstance=1c7cb51d9f464ed3>
> To: <sip:1506 at 104.197.69.7>
> From: <sip:1506 at 104.197.69.7>;tag=bc201339
> Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> CSeq: 1 REGISTER
> Expires: 3600
> Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
> User-Agent: Bria 4 release 4.6.0 stamp 82162
> Content-Length: 0
> [Nov 11 16:35:47] DEBUG[18053]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131:58781' into...
> [Nov 11 16:35:47] DEBUG[18053]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port '58781'.
> [Nov 11 16:35:47] DEBUG[18053]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3:5060' into...
> [Nov 11 16:35:47] DEBUG[18053]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port '5060'.
> [Nov 11 16:35:47] DEBUG[18053]: res_pjsip/pjsip_distributor.c:267 find_dialog: Could not find matching transaction for Request msg REGISTER/cseq=1 (rdata0x1d09188)
> [Nov 11 16:35:47] DEBUG[18053]: res_pjsip/pjsip_distributor.c:359 ast_sip_get_distributor_serializer: Calculated serializer pjsip/distributor-0000002a to use for Request msg REGISTER/cseq=1 (rdata0x1d09188)
> [Nov 11 16:35:47] DEBUG[18051]: threadpool.c:517 grow: Increasing threadpool SIP's size by 5
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoint_id_ips WHERE id LIKE ? ORDER BY id
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id LIKE') = '%'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: res_pjsip_endpoint_identifier_ip.c:128 ip_identify: No identify sections to match against
> [Nov 11 16:35:47] DEBUG[18116]: res_pjsip_endpoint_identifier_user.c:133 username_identify: Attempting identify by From username '1506' domain '104.197.69.7'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '1506 at 104.197.69.7'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_domain_aliases WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '104.197.69.7'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_transports WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = 'nat_udp'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 65535] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3689 ast_parse_arg: extract int from [100] in [1, 2147483647] gives [100](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [1] in [0, 4294967295] gives [1](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.0' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.0' and port ''.
> [Nov 11 16:35:47] DEBUG[18116]: acl.c:661 ast_append_ha: 10.128.0.0:0/255.255.240.0:0 sense 0 appended to ACL
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '104.197.69.7' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '104.197.69.7' and port ''.
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '1506'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: res_sorcery_realtime.c:131 sorcery_realtime_filter_objectset: Filtering out realtime field 'disallow' from retrieval
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [1800] in [0, 4294967295] gives [1800](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [90] in [0, 4294967295] gives [90](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: res_pjsip_endpoint_identifier_user.c:145 username_identify: Identified by From username '1506' domain '104.197.69.7'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_auths WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = 'phone'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [32] in [0, 4294967295] gives [32](0)
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port ''.
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port ''.
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3:5060' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port '5060'.
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131:58781' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port '58781'.
> <--- Transmitting SIP response (531 bytes) to UDP:12.49.160.131:58781 --->
> SIP/2.0 401 Unauthorized
> Via: SIP/2.0/UDP 10.200.101.116:58781;rport=58781;received=12.49.160.131;branch=z9hG4bK-524287-1---510c701eed52f364
> Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> From: <sip:1506 at 104.197.69.7>;tag=bc201339
> To: <sip:1506 at 104.197.69.7>;tag=z9hG4bK-524287-1---510c701eed52f364
> CSeq: 1 REGISTER
> WWW-Authenticate: Digest  realm="asterisk",nonce="1478882147/8b845d8c881a2d5056e3cfeab5623a50",opaque="38df36b365ce5435",algorithm=md5,qop="auth"
> Server: Asterisk PBX 14.1.1
> Content-Length:  0
> <--- Received SIP request (525 bytes) from UDP:12.49.160.131:58781 --->
> REGISTER sip:104.197.69.7 SIP/2.0
> Via: SIP/2.0/UDP 10.200.101.116:58781;branch=z9hG4bK-524287-1---510c701eed52f364;rport
> Max-Forwards: 70
> Contact: <sip:1506 at 10.200.101.116:58781;rinstance=1c7cb51d9f464ed3>
> To: <sip:1506 at 104.197.69.7>
> From: <sip:1506 at 104.197.69.7>;tag=bc201339
> Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> CSeq: 1 REGISTER
> Expires: 3600
> Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
> User-Agent: Bria 4 release 4.6.0 stamp 82162
> Content-Length: 0
> [Nov 11 16:35:47] DEBUG[18053]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131:58781' into...
> [Nov 11 16:35:47] DEBUG[18053]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port '58781'.
> [Nov 11 16:35:47] DEBUG[18053]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3:5060' into...
> [Nov 11 16:35:47] DEBUG[18053]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port '5060'.
> [Nov 11 16:35:47] DEBUG[18053]: res_pjsip/pjsip_distributor.c:267 find_dialog: Could not find matching transaction for Request msg REGISTER/cseq=1 (rdata0x7f34940095b8)
> [Nov 11 16:35:47] DEBUG[18053]: res_pjsip/pjsip_distributor.c:359 ast_sip_get_distributor_serializer: Calculated serializer pjsip/distributor-0000002a to use for Request msg REGISTER/cseq=1 (rdata0x7f34940095b8)
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoint_id_ips WHERE id LIKE ? ORDER BY id
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id LIKE') = '%'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: res_pjsip_endpoint_identifier_ip.c:128 ip_identify: No identify sections to match against
> [Nov 11 16:35:47] DEBUG[18116]: res_pjsip_endpoint_identifier_user.c:133 username_identify: Attempting identify by From username '1506' domain '104.197.69.7'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '1506 at 104.197.69.7'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_domain_aliases WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '104.197.69.7'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_transports WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = 'nat_udp'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 65535] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3689 ast_parse_arg: extract int from [100] in [1, 2147483647] gives [100](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [1] in [0, 4294967295] gives [1](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.0' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.0' and port ''.
> [Nov 11 16:35:47] DEBUG[18116]: acl.c:661 ast_append_ha: 10.128.0.0:0/255.255.240.0:0 sense 0 appended to ACL
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '104.197.69.7' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '104.197.69.7' and port ''.
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '1506'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: res_sorcery_realtime.c:131 sorcery_realtime_filter_objectset: Filtering out realtime field 'disallow' from retrieval
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [1800] in [0, 4294967295] gives [1800](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [90] in [0, 4294967295] gives [90](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:47] DEBUG[18116]: res_pjsip_endpoint_identifier_user.c:145 username_identify: Identified by From username '1506' domain '104.197.69.7'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_auths WHERE id = ?
> [Nov 11 16:35:47] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = 'phone'
> [Nov 11 16:35:47] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:47] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [32] in [0, 4294967295] gives [32](0)
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port ''.
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port ''.
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3:5060' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port '5060'.
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131:58781' into...
> [Nov 11 16:35:47] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port '58781'.
> <--- Transmitting SIP response (531 bytes) to UDP:12.49.160.131:58781 --->
> SIP/2.0 401 Unauthorized
> Via: SIP/2.0/UDP 10.200.101.116:58781;rport=58781;received=12.49.160.131;branch=z9hG4bK-524287-1---510c701eed52f364
> Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> From: <sip:1506 at 104.197.69.7>;tag=bc201339
> To: <sip:1506 at 104.197.69.7>;tag=z9hG4bK-524287-1---510c701eed52f364
> CSeq: 1 REGISTER
> WWW-Authenticate: Digest  realm="asterisk",nonce="1478882147/8b845d8c881a2d5056e3cfeab5623a50",opaque="611806151c5b8d57",algorithm=md5,qop="auth"
> Server: Asterisk PBX 14.1.1
> Content-Length:  0
> <--- Received SIP request (525 bytes) from UDP:12.49.160.131:58781 --->
> REGISTER sip:104.197.69.7 SIP/2.0
> Via: SIP/2.0/UDP 10.200.101.116:58781;branch=z9hG4bK-524287-1---510c701eed52f364;rport
> Max-Forwards: 70
> Contact: <sip:1506 at 10.200.101.116:58781;rinstance=1c7cb51d9f464ed3>
> To: <sip:1506 at 104.197.69.7>
> From: <sip:1506 at 104.197.69.7>;tag=bc201339
> Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> CSeq: 1 REGISTER
> Expires: 3600
> Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
> User-Agent: Bria 4 release 4.6.0 stamp 82162
> Content-Length: 0
> [Nov 11 16:35:48] DEBUG[18053]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131:58781' into...
> [Nov 11 16:35:48] DEBUG[18053]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port '58781'.
> [Nov 11 16:35:48] DEBUG[18053]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3:5060' into...
> [Nov 11 16:35:48] DEBUG[18053]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port '5060'.
> [Nov 11 16:35:48] DEBUG[18053]: res_pjsip/pjsip_distributor.c:267 find_dialog: Could not find matching transaction for Request msg REGISTER/cseq=1 (rdata0x7f34940095b8)
> [Nov 11 16:35:48] DEBUG[18053]: res_pjsip/pjsip_distributor.c:359 ast_sip_get_distributor_serializer: Calculated serializer pjsip/distributor-0000002a to use for Request msg REGISTER/cseq=1 (rdata0x7f34940095b8)
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoint_id_ips WHERE id LIKE ? ORDER BY id
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id LIKE') = '%'
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:48] DEBUG[18116]: res_pjsip_endpoint_identifier_ip.c:128 ip_identify: No identify sections to match against
> [Nov 11 16:35:48] DEBUG[18116]: res_pjsip_endpoint_identifier_user.c:133 username_identify: Attempting identify by From username '1506' domain '104.197.69.7'
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ?
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '1506 at 104.197.69.7'
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_domain_aliases WHERE id = ?
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '104.197.69.7'
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_transports WHERE id = ?
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = 'nat_udp'
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 65535] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3689 ast_parse_arg: extract int from [100] in [1, 2147483647] gives [100](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [1] in [0, 4294967295] gives [1](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.0' into...
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.0' and port ''.
> [Nov 11 16:35:48] DEBUG[18116]: acl.c:661 ast_append_ha: 10.128.0.0:0/255.255.240.0:0 sense 0 appended to ACL
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '104.197.69.7' into...
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '104.197.69.7' and port ''.
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ?
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '1506'
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:48] DEBUG[18116]: res_sorcery_realtime.c:131 sorcery_realtime_filter_objectset: Filtering out realtime field 'disallow' from retrieval
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [1800] in [0, 4294967295] gives [1800](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [90] in [0, 4294967295] gives [90](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:48] DEBUG[18116]: res_pjsip_endpoint_identifier_user.c:145 username_identify: Identified by From username '1506' domain '104.197.69.7'
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_auths WHERE id = ?
> [Nov 11 16:35:48] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = 'phone'
> [Nov 11 16:35:48] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:48] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [32] in [0, 4294967295] gives [32](0)
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3' into...
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port ''.
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131' into...
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port ''.
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3:5060' into...
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port '5060'.
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131:58781' into...
> [Nov 11 16:35:48] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port '58781'.
> <--- Transmitting SIP response (531 bytes) to UDP:12.49.160.131:58781 --->
> SIP/2.0 401 Unauthorized
> Via: SIP/2.0/UDP 10.200.101.116:58781;rport=58781;received=12.49.160.131;branch=z9hG4bK-524287-1---510c701eed52f364
> Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> From: <sip:1506 at 104.197.69.7>;tag=bc201339
> To: <sip:1506 at 104.197.69.7>;tag=z9hG4bK-524287-1---510c701eed52f364
> CSeq: 1 REGISTER
> WWW-Authenticate: Digest  realm="asterisk",nonce="1478882148/653fbe68f2075d95afa47c426cc5968e",opaque="332b66cd0eb86fdf",algorithm=md5,qop="auth"
> Server: Asterisk PBX 14.1.1
> Content-Length:  0
> <--- Received SIP request (525 bytes) from UDP:12.49.160.131:58781 --->
> REGISTER sip:104.197.69.7 SIP/2.0
> Via: SIP/2.0/UDP 10.200.101.116:58781;branch=z9hG4bK-524287-1---510c701eed52f364;rport
> Max-Forwards: 70
> Contact: <sip:1506 at 10.200.101.116:58781;rinstance=1c7cb51d9f464ed3>
> To: <sip:1506 at 104.197.69.7>
> From: <sip:1506 at 104.197.69.7>;tag=bc201339
> Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> CSeq: 1 REGISTER
> Expires: 3600
> Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
> User-Agent: Bria 4 release 4.6.0 stamp 82162
> Content-Length: 0
> [Nov 11 16:35:50] DEBUG[18053]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131:58781' into...
> [Nov 11 16:35:50] DEBUG[18053]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port '58781'.
> [Nov 11 16:35:50] DEBUG[18053]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3:5060' into...
> [Nov 11 16:35:50] DEBUG[18053]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port '5060'.
> [Nov 11 16:35:50] DEBUG[18053]: res_pjsip/pjsip_distributor.c:267 find_dialog: Could not find matching transaction for Request msg REGISTER/cseq=1 (rdata0x7f34940095b8)
> [Nov 11 16:35:50] DEBUG[18053]: res_pjsip/pjsip_distributor.c:359 ast_sip_get_distributor_serializer: Calculated serializer pjsip/distributor-0000002a to use for Request msg REGISTER/cseq=1 (rdata0x7f34940095b8)
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoint_id_ips WHERE id LIKE ? ORDER BY id
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id LIKE') = '%'
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:50] DEBUG[18116]: res_pjsip_endpoint_identifier_ip.c:128 ip_identify: No identify sections to match against
> [Nov 11 16:35:50] DEBUG[18116]: res_pjsip_endpoint_identifier_user.c:133 username_identify: Attempting identify by From username '1506' domain '104.197.69.7'
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ?
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '1506 at 104.197.69.7'
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_domain_aliases WHERE id = ?
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '104.197.69.7'
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_transports WHERE id = ?
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = 'nat_udp'
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 65535] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3689 ast_parse_arg: extract int from [100] in [1, 2147483647] gives [100](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [1] in [0, 4294967295] gives [1](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.0' into...
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.0' and port ''.
> [Nov 11 16:35:50] DEBUG[18116]: acl.c:661 ast_append_ha: 10.128.0.0:0/255.255.240.0:0 sense 0 appended to ACL
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '104.197.69.7' into...
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '104.197.69.7' and port ''.
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ?
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = '1506'
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:50] DEBUG[18116]: res_sorcery_realtime.c:131 sorcery_realtime_filter_objectset: Filtering out realtime field 'disallow' from retrieval
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [1800] in [0, 4294967295] gives [1800](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [90] in [0, 4294967295] gives [90](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [0] in [0, 4294967295] gives [0](0)
> [Nov 11 16:35:50] DEBUG[18116]: res_pjsip_endpoint_identifier_user.c:145 username_identify: Identified by From username '1506' domain '104.197.69.7'
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:869 _ast_odbc_request_obj2: Reusing ODBC handle 0x253ae80 from class 'asterisk'
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:116 custom_prepare: Skip: 0; SQL: SELECT * FROM ps_auths WHERE id = ?
> [Nov 11 16:35:50] DEBUG[18116]: res_config_odbc.c:132 custom_prepare: Parameter 1 ('id') = 'phone'
> [Nov 11 16:35:50] DEBUG[18116]: res_odbc.c:718 ast_odbc_release_obj: Releasing ODBC handle 0x253ae80 into pool
> [Nov 11 16:35:50] DEBUG[18116]: config.c:3742 ast_parse_arg: extract uint from [32] in [0, 4294967295] gives [32](0)
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3' into...
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port ''.
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131' into...
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port ''.
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '10.128.0.3:5060' into...
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '10.128.0.3' and port '5060'.
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '12.49.160.131:58781' into...
> [Nov 11 16:35:50] DEBUG[18116]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '12.49.160.131' and port '58781'.
> <--- Transmitting SIP response (531 bytes) to UDP:12.49.160.131:58781 --->
> SIP/2.0 401 Unauthorized
> Via: SIP/2.0/UDP 10.200.101.116:58781;rport=58781;received=12.49.160.131;branch=z9hG4bK-524287-1---510c701eed52f364
> Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> From: <sip:1506 at 104.197.69.7>;tag=bc201339
> To: <sip:1506 at 104.197.69.7>;tag=z9hG4bK-524287-1---510c701eed52f364
> CSeq: 1 REGISTER
> WWW-Authenticate: Digest  realm="asterisk",nonce="1478882150/cc54c3c70bf899a0db1ec63be86a0597",opaque="0f7b7b9136d9bd05",algorithm=md5,qop="auth"
> Server: Asterisk PBX 14.1.1
> Content-Length:  0
> devast*CLI> pjsip set logger off
> PJSIP Logging disabled
> [Nov 11 16:36:00] DEBUG[18092]: res_pjsip_registrar_expire.c:78 check_expiration_thread: Woke up at 1478882160  Interval: 30
> [Nov 11 16:36:00] DEBUG[18092]: res_pjsip_registrar_expire.c:85 check_expiration_thread: Expiring 0 contacts
> devast*CLI> core set debug off
> Core debug was 5 and is now OFF.
> devast*CLI> 
> {code}
> And you can see here that the auth challenge sent by Asterisk is never actually seen on the network.
> {code:title=tcpdump}
> [root at devast asterisk]# tcpdump -i any udp -vvvvv
> tcpdump: listening on any, link-type LINUX_SLL (Linux cooked), capture size 65535 bytes
> 16:35:47.369178 IP (tos 0x0, ttl 53, id 46691, offset 0, flags [none], proto UDP (17), length 553)
>     12.49.160.131.58781 > devast.c.cnp1-143601.internal.sip: [udp sum ok] SIP, length: 525
> 	REGISTER sip:104.197.69.7 SIP/2.0
> 	Via: SIP/2.0/UDP 10.200.101.116:58781;branch=z9hG4bK-524287-1---510c701eed52f364;rport
> 	Max-Forwards: 70
> 	Contact: <sip:1506 at 10.200.101.116:58781;rinstance=1c7cb51d9f464ed3>
> 	To: <sip:1506 at 104.197.69.7>
> 	From: <sip:1506 at 104.197.69.7>;tag=bc201339
> 	Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> 	CSeq: 1 REGISTER
> 	Expires: 3600
> 	Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
> 	User-Agent: Bria 4 release 4.6.0 stamp 82162
> 	Content-Length: 0
> 	
> 	
> 	0x0000:  5245 4749 5354 4552 2073 6970 3a31 3034
> 	0x0010:  2e31 3937 2e36 392e 3720 5349 502f 322e
> 	0x0020:  300d 0a56 6961 3a20 5349 502f 322e 302f
> 	0x0030:  5544 5020 3130 2e32 3030 2e31 3031 2e31
> 	0x0040:  3136 3a35 3837 3831 3b62 7261 6e63 683d
> 	0x0050:  7a39 6847 3462 4b2d 3532 3432 3837 2d31
> 	0x0060:  2d2d 2d35 3130 6337 3031 6565 6435 3266
> 	0x0070:  3336 343b 7270 6f72 740d 0a4d 6178 2d46
> 	0x0080:  6f72 7761 7264 733a 2037 300d 0a43 6f6e
> 	0x0090:  7461 6374 3a20 3c73 6970 3a31 3530 3640
> 	0x00a0:  3130 2e32 3030 2e31 3031 2e31 3136 3a35
> 	0x00b0:  3837 3831 3b72 696e 7374 616e 6365 3d31
> 	0x00c0:  6337 6362 3531 6439 6634 3634 6564 333e
> 	0x00d0:  0d0a 546f 3a20 3c73 6970 3a31 3530 3640
> 	0x00e0:  3130 342e 3139 372e 3639 2e37 3e0d 0a46
> 	0x00f0:  726f 6d3a 203c 7369 703a 3135 3036 4031
> 	0x0100:  3034 2e31 3937 2e36 392e 373e 3b74 6167
> 	0x0110:  3d62 6332 3031 3333 390d 0a43 616c 6c2d
> 	0x0120:  4944 3a20 3832 3136 324d 6a41 354e 5445
> 	0x0130:  3059 6a6b 795a 5445 344d 6a41 335a 4755
> 	0x0140:  7a4e 7a5a 6859 6a51 784e 4463 324d 546c
> 	0x0150:  6c4d 7a49 0d0a 4353 6571 3a20 3120 5245
> 	0x0160:  4749 5354 4552 0d0a 4578 7069 7265 733a
> 	0x0170:  2033 3630 300d 0a41 6c6c 6f77 3a20 5355
> 	0x0180:  4253 4352 4942 452c 204e 4f54 4946 592c
> 	0x0190:  2049 4e56 4954 452c 2041 434b 2c20 4341
> 	0x01a0:  4e43 454c 2c20 4259 452c 2052 4546 4552
> 	0x01b0:  2c20 494e 464f 2c20 4f50 5449 4f4e 532c
> 	0x01c0:  204d 4553 5341 4745 0d0a 5573 6572 2d41
> 	0x01d0:  6765 6e74 3a20 4272 6961 2034 2072 656c
> 	0x01e0:  6561 7365 2034 2e36 2e30 2073 7461 6d70
> 	0x01f0:  2038 3231 3632 0d0a 436f 6e74 656e 742d
> 	0x0200:  4c65 6e67 7468 3a20 300d 0a0d 0a
> 16:35:47.374595 IP (tos 0x0, ttl 64, id 42673, offset 0, flags [DF], proto UDP (17), length 72)
>     localhost.41841 > localhost.domain: [bad udp cksum 0xfe47 -> 0xcda6!] 40893+ PTR? 131.160.49.12.in-addr.arpa. (44)
> 16:35:47.374628 IP (tos 0x0, ttl 64, id 42675, offset 0, flags [DF], proto UDP (17), length 72)
>     localhost.60441 > localhost.domain: [bad udp cksum 0xfe47 -> 0x84fe!] 40893+ PTR? 131.160.49.12.in-addr.arpa. (44)
> 16:35:47.872889 IP (tos 0x0, ttl 53, id 19187, offset 0, flags [none], proto UDP (17), length 553)
>     12.49.160.131.58781 > devast.c.cnp1-143601.internal.sip: [udp sum ok] SIP, length: 525
> 	REGISTER sip:104.197.69.7 SIP/2.0
> 	Via: SIP/2.0/UDP 10.200.101.116:58781;branch=z9hG4bK-524287-1---510c701eed52f364;rport
> 	Max-Forwards: 70
> 	Contact: <sip:1506 at 10.200.101.116:58781;rinstance=1c7cb51d9f464ed3>
> 	To: <sip:1506 at 104.197.69.7>
> 	From: <sip:1506 at 104.197.69.7>;tag=bc201339
> 	Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> 	CSeq: 1 REGISTER
> 	Expires: 3600
> 	Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
> 	User-Agent: Bria 4 release 4.6.0 stamp 82162
> 	Content-Length: 0
> 	
> 	
> 	0x0000:  5245 4749 5354 4552 2073 6970 3a31 3034
> 	0x0010:  2e31 3937 2e36 392e 3720 5349 502f 322e
> 	0x0020:  300d 0a56 6961 3a20 5349 502f 322e 302f
> 	0x0030:  5544 5020 3130 2e32 3030 2e31 3031 2e31
> 	0x0040:  3136 3a35 3837 3831 3b62 7261 6e63 683d
> 	0x0050:  7a39 6847 3462 4b2d 3532 3432 3837 2d31
> 	0x0060:  2d2d 2d35 3130 6337 3031 6565 6435 3266
> 	0x0070:  3336 343b 7270 6f72 740d 0a4d 6178 2d46
> 	0x0080:  6f72 7761 7264 733a 2037 300d 0a43 6f6e
> 	0x0090:  7461 6374 3a20 3c73 6970 3a31 3530 3640
> 	0x00a0:  3130 2e32 3030 2e31 3031 2e31 3136 3a35
> 	0x00b0:  3837 3831 3b72 696e 7374 616e 6365 3d31
> 	0x00c0:  6337 6362 3531 6439 6634 3634 6564 333e
> 	0x00d0:  0d0a 546f 3a20 3c73 6970 3a31 3530 3640
> 	0x00e0:  3130 342e 3139 372e 3639 2e37 3e0d 0a46
> 	0x00f0:  726f 6d3a 203c 7369 703a 3135 3036 4031
> 	0x0100:  3034 2e31 3937 2e36 392e 373e 3b74 6167
> 	0x0110:  3d62 6332 3031 3333 390d 0a43 616c 6c2d
> 	0x0120:  4944 3a20 3832 3136 324d 6a41 354e 5445
> 	0x0130:  3059 6a6b 795a 5445 344d 6a41 335a 4755
> 	0x0140:  7a4e 7a5a 6859 6a51 784e 4463 324d 546c
> 	0x0150:  6c4d 7a49 0d0a 4353 6571 3a20 3120 5245
> 	0x0160:  4749 5354 4552 0d0a 4578 7069 7265 733a
> 	0x0170:  2033 3630 300d 0a41 6c6c 6f77 3a20 5355
> 	0x0180:  4253 4352 4942 452c 204e 4f54 4946 592c
> 	0x0190:  2049 4e56 4954 452c 2041 434b 2c20 4341
> 	0x01a0:  4e43 454c 2c20 4259 452c 2052 4546 4552
> 	0x01b0:  2c20 494e 464f 2c20 4f50 5449 4f4e 532c
> 	0x01c0:  204d 4553 5341 4745 0d0a 5573 6572 2d41
> 	0x01d0:  6765 6e74 3a20 4272 6961 2034 2072 656c
> 	0x01e0:  6561 7365 2034 2e36 2e30 2073 7461 6d70
> 	0x01f0:  2038 3231 3632 0d0a 436f 6e74 656e 742d
> 	0x0200:  4c65 6e67 7468 3a20 300d 0a0d 0a
> 16:35:48.876407 IP (tos 0x0, ttl 53, id 41254, offset 0, flags [none], proto UDP (17), length 553)
>     12.49.160.131.58781 > devast.c.cnp1-143601.internal.sip: [udp sum ok] SIP, length: 525
> 	REGISTER sip:104.197.69.7 SIP/2.0
> 	Via: SIP/2.0/UDP 10.200.101.116:58781;branch=z9hG4bK-524287-1---510c701eed52f364;rport
> 	Max-Forwards: 70
> 	Contact: <sip:1506 at 10.200.101.116:58781;rinstance=1c7cb51d9f464ed3>
> 	To: <sip:1506 at 104.197.69.7>
> 	From: <sip:1506 at 104.197.69.7>;tag=bc201339
> 	Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> 	CSeq: 1 REGISTER
> 	Expires: 3600
> 	Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
> 	User-Agent: Bria 4 release 4.6.0 stamp 82162
> 	Content-Length: 0
> 	
> 	
> 	0x0000:  5245 4749 5354 4552 2073 6970 3a31 3034
> 	0x0010:  2e31 3937 2e36 392e 3720 5349 502f 322e
> 	0x0020:  300d 0a56 6961 3a20 5349 502f 322e 302f
> 	0x0030:  5544 5020 3130 2e32 3030 2e31 3031 2e31
> 	0x0040:  3136 3a35 3837 3831 3b62 7261 6e63 683d
> 	0x0050:  7a39 6847 3462 4b2d 3532 3432 3837 2d31
> 	0x0060:  2d2d 2d35 3130 6337 3031 6565 6435 3266
> 	0x0070:  3336 343b 7270 6f72 740d 0a4d 6178 2d46
> 	0x0080:  6f72 7761 7264 733a 2037 300d 0a43 6f6e
> 	0x0090:  7461 6374 3a20 3c73 6970 3a31 3530 3640
> 	0x00a0:  3130 2e32 3030 2e31 3031 2e31 3136 3a35
> 	0x00b0:  3837 3831 3b72 696e 7374 616e 6365 3d31
> 	0x00c0:  6337 6362 3531 6439 6634 3634 6564 333e
> 	0x00d0:  0d0a 546f 3a20 3c73 6970 3a31 3530 3640
> 	0x00e0:  3130 342e 3139 372e 3639 2e37 3e0d 0a46
> 	0x00f0:  726f 6d3a 203c 7369 703a 3135 3036 4031
> 	0x0100:  3034 2e31 3937 2e36 392e 373e 3b74 6167
> 	0x0110:  3d62 6332 3031 3333 390d 0a43 616c 6c2d
> 	0x0120:  4944 3a20 3832 3136 324d 6a41 354e 5445
> 	0x0130:  3059 6a6b 795a 5445 344d 6a41 335a 4755
> 	0x0140:  7a4e 7a5a 6859 6a51 784e 4463 324d 546c
> 	0x0150:  6c4d 7a49 0d0a 4353 6571 3a20 3120 5245
> 	0x0160:  4749 5354 4552 0d0a 4578 7069 7265 733a
> 	0x0170:  2033 3630 300d 0a41 6c6c 6f77 3a20 5355
> 	0x0180:  4253 4352 4942 452c 204e 4f54 4946 592c
> 	0x0190:  2049 4e56 4954 452c 2041 434b 2c20 4341
> 	0x01a0:  4e43 454c 2c20 4259 452c 2052 4546 4552
> 	0x01b0:  2c20 494e 464f 2c20 4f50 5449 4f4e 532c
> 	0x01c0:  204d 4553 5341 4745 0d0a 5573 6572 2d41
> 	0x01d0:  6765 6e74 3a20 4272 6961 2034 2072 656c
> 	0x01e0:  6561 7365 2034 2e36 2e30 2073 7461 6d70
> 	0x01f0:  2038 3231 3632 0d0a 436f 6e74 656e 742d
> 	0x0200:  4c65 6e67 7468 3a20 300d 0a0d 0a
> 16:35:50.876637 IP (tos 0x0, ttl 53, id 61840, offset 0, flags [none], proto UDP (17), length 553)
>     12.49.160.131.58781 > devast.c.cnp1-143601.internal.sip: [udp sum ok] SIP, length: 525
> 	REGISTER sip:104.197.69.7 SIP/2.0
> 	Via: SIP/2.0/UDP 10.200.101.116:58781;branch=z9hG4bK-524287-1---510c701eed52f364;rport
> 	Max-Forwards: 70
> 	Contact: <sip:1506 at 10.200.101.116:58781;rinstance=1c7cb51d9f464ed3>
> 	To: <sip:1506 at 104.197.69.7>
> 	From: <sip:1506 at 104.197.69.7>;tag=bc201339
> 	Call-ID: 82162MjA5NTE0YjkyZTE4MjA3ZGUzNzZhYjQxNDc2MTllMzI
> 	CSeq: 1 REGISTER
> 	Expires: 3600
> 	Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
> 	User-Agent: Bria 4 release 4.6.0 stamp 82162
> 	Content-Length: 0
> 	
> 	
> 	0x0000:  5245 4749 5354 4552 2073 6970 3a31 3034
> 	0x0010:  2e31 3937 2e36 392e 3720 5349 502f 322e
> 	0x0020:  300d 0a56 6961 3a20 5349 502f 322e 302f
> 	0x0030:  5544 5020 3130 2e32 3030 2e31 3031 2e31
> 	0x0040:  3136 3a35 3837 3831 3b62 7261 6e63 683d
> 	0x0050:  7a39 6847 3462 4b2d 3532 3432 3837 2d31
> 	0x0060:  2d2d 2d35 3130 6337 3031 6565 6435 3266
> 	0x0070:  3336 343b 7270 6f72 740d 0a4d 6178 2d46
> 	0x0080:  6f72 7761 7264 733a 2037 300d 0a43 6f6e
> 	0x0090:  7461 6374 3a20 3c73 6970 3a31 3530 3640
> 	0x00a0:  3130 2e32 3030 2e31 3031 2e31 3136 3a35
> 	0x00b0:  3837 3831 3b72 696e 7374 616e 6365 3d31
> 	0x00c0:  6337 6362 3531 6439 6634 3634 6564 333e
> 	0x00d0:  0d0a 546f 3a20 3c73 6970 3a31 3530 3640
> 	0x00e0:  3130 342e 3139 372e 3639 2e37 3e0d 0a46
> 	0x00f0:  726f 6d3a 203c 7369 703a 3135 3036 4031
> 	0x0100:  3034 2e31 3937 2e36 392e 373e 3b74 6167
> 	0x0110:  3d62 6332 3031 3333 390d 0a43 616c 6c2d
> 	0x0120:  4944 3a20 3832 3136 324d 6a41 354e 5445
> 	0x0130:  3059 6a6b 795a 5445 344d 6a41 335a 4755
> 	0x0140:  7a4e 7a5a 6859 6a51 784e 4463 324d 546c
> 	0x0150:  6c4d 7a49 0d0a 4353 6571 3a20 3120 5245
> 	0x0160:  4749 5354 4552 0d0a 4578 7069 7265 733a
> 	0x0170:  2033 3630 300d 0a41 6c6c 6f77 3a20 5355
> 	0x0180:  4253 4352 4942 452c 204e 4f54 4946 592c
> 	0x0190:  2049 4e56 4954 452c 2041 434b 2c20 4341
> 	0x01a0:  4e43 454c 2c20 4259 452c 2052 4546 4552
> 	0x01b0:  2c20 494e 464f 2c20 4f50 5449 4f4e 532c
> 	0x01c0:  204d 4553 5341 4745 0d0a 5573 6572 2d41
> 	0x01d0:  6765 6e74 3a20 4272 6961 2034 2072 656c
> 	0x01e0:  6561 7365 2034 2e36 2e30 2073 7461 6d70
> 	0x01f0:  2038 3231 3632 0d0a 436f 6e74 656e 742d
> 	0x0200:  4c65 6e67 7468 3a20 300d 0a0d 0a
> ^C
> 6 packets captured
> 8 packets received by filter
> 0 packets dropped by kernel
> {code}



--
This message was sent by Atlassian JIRA
(v6.2#6252)



More information about the asterisk-bugs mailing list