2017-10-18 15:42:49.152180 [INFO] switch_core.c:2803 Shutting down 2017-10-18 15:42:49.152180 [CONSOLE] switch_core.c:2930 End existing sessions 32fbbb61-aed9-4032-8cfe-97ddc6a8c997 2017-10-18 15:42:49.152180 [NOTICE] switch_core_session.c:381 Hangup sofia/agent/8185991030@10.120.3.24 [CS_EXECUTE] [SYSTEM_SHUTDOWN] cf23ecb1-7143-4ee4-8af7-292087ffbe2a 2017-10-18 15:42:49.152180 [NOTICE] switch_core_session.c:381 Hangup sofia/ivr/9498387905@10.120.3.24 [CS_EXECUTE] [SYSTEM_SHUTDOWN] 08f7c376-2fa4-4e5d-a306-9ffd7a32d53a 2017-10-18 15:42:49.152180 [NOTICE] switch_core_session.c:381 Hangup sofia/agent/5625241426@10.120.3.24 [CS_EXECUTE] [SYSTEM_SHUTDOWN] c9d42ef3-b72b-4f3e-be72-2fd7eca1d268 2017-10-18 15:42:49.152180 [NOTICE] switch_core_session.c:381 Hangup sofia/ivr/9095797550@10.120.3.24 [CS_EXECUTE] [SYSTEM_SHUTDOWN] 171dca23-b0fe-4c87-ace4-116ab6077bfa 2017-10-18 15:42:49.152180 [NOTICE] switch_core_session.c:381 Hangup sofia/agent/9512179836@10.120.3.24 [CS_EXECUTE] [SYSTEM_SHUTDOWN] 2017-10-18 15:42:56.068131 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_logfile] 2017-10-18 15:42:56.069147 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_enum] 2017-10-18 15:42:56.069161 [NOTICE] switch_loadable_module.c:250 Adding Dialplan 'enum' 2017-10-18 15:42:56.069177 [NOTICE] switch_loadable_module.c:292 Adding Application 'enum' 2017-10-18 15:42:56.069185 [NOTICE] switch_loadable_module.c:338 Adding API Function 'enum' 2017-10-18 15:42:56.069222 [NOTICE] switch_loadable_module.c:338 Adding API Function 'enum_auto' 2017-10-18 15:42:56.069455 [NOTICE] mod_xml_curl.c:543 Binding [directory] XML Fetch Function [https://ccc-prod-lb.objectbrains.com/tms/rest/all_in_one/directory] [directory] 2017-10-18 15:42:56.069471 [NOTICE] mod_xml_curl.c:543 Binding [dialplan] XML Fetch Function [https://ccc-prod-lb.objectbrains.com/tms/rest/all_in_one/dialplan] [dialplan] 2017-10-18 15:42:56.069494 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_xml_curl] 2017-10-18 15:42:56.069502 [NOTICE] switch_loadable_module.c:338 Adding API Function 'xml_curl' 2017-10-18 15:42:56.069746 [NOTICE] mod_xml_cdr.c:102 Rotating log file paths 2017-10-18 15:42:56.069755 [NOTICE] mod_xml_cdr.c:129 Setting log file path to /usr/local/freeswitch/log/xml_cdr 2017-10-18 15:42:56.069765 [NOTICE] mod_xml_cdr.c:168 Setting err log file path to /usr/local/freeswitch/log/xml_cdr 2017-10-18 15:42:56.069776 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_xml_cdr] 2017-10-18 15:42:56.070002 [DEBUG] mod_cdr_csv.c:368 Adding default template. 2017-10-18 15:42:56.070014 [DEBUG] mod_cdr_csv.c:415 Adding template sql. 2017-10-18 15:42:56.070017 [DEBUG] mod_cdr_csv.c:415 Adding template example. 2017-10-18 15:42:56.070031 [DEBUG] mod_cdr_csv.c:415 Adding template snom. 2017-10-18 15:42:56.070036 [DEBUG] mod_cdr_csv.c:415 Adding template linksys. 2017-10-18 15:42:56.070038 [DEBUG] mod_cdr_csv.c:415 Adding template asterisk. 2017-10-18 15:42:56.070040 [DEBUG] mod_cdr_csv.c:415 Adding template opencdrrate. 2017-10-18 15:42:56.070066 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_cdr_csv] 2017-10-18 15:42:56.070074 [NOTICE] switch_loadable_module.c:338 Adding API Function 'cdr_csv' 2017-10-18 15:42:56.070313 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_event_socket] 2017-10-18 15:42:56.070326 [NOTICE] switch_loadable_module.c:292 Adding Application 'socket' 2017-10-18 15:42:56.070342 [NOTICE] switch_loadable_module.c:338 Adding API Function 'event_sink' 2017-10-18 15:42:56.071376 [INFO] mod_sofia.c:5958 Starting initial message thread. 2017-10-18 15:42:56.071436 [DEBUG] sofia.c:4450 debug [0] 2017-10-18 15:42:56.071443 [DEBUG] sofia.c:4450 sip-trace [no] 2017-10-18 15:42:56.071445 [DEBUG] sofia.c:4450 sip-capture [yes] 2017-10-18 15:42:56.071461 [DEBUG] sofia.c:4450 rfc2833-pt [101] 2017-10-18 15:42:56.071474 [DEBUG] sofia.c:4450 sip-port [5044] 2017-10-18 15:42:56.071481 [DEBUG] sofia.c:4450 dialplan [XML] 2017-10-18 15:42:56.071492 [DEBUG] sofia.c:4450 context [agent_dp] 2017-10-18 15:42:56.071500 [DEBUG] sofia.c:4450 dtmf-duration [2000] 2017-10-18 15:42:56.071507 [DEBUG] sofia.c:4450 liberal-dtmf [true] 2017-10-18 15:42:56.071512 [DEBUG] sofia.c:4450 inbound-codec-prefs [PCMU] 2017-10-18 15:42:56.071515 [DEBUG] sofia.c:4450 outbound-codec-prefs [PCMU] 2017-10-18 15:42:56.071521 [DEBUG] sofia.c:4450 hold-music [local_stream://moh] 2017-10-18 15:42:56.071528 [DEBUG] sofia.c:4450 rtp-timer-name [soft] 2017-10-18 15:42:56.071533 [DEBUG] sofia.c:4450 local-network-acl [localnet.auto] 2017-10-18 15:42:56.071539 [DEBUG] sofia.c:4450 apply-candidate-acl [rfc1918.auto] 2017-10-18 15:42:56.071545 [DEBUG] sofia.c:4450 manage-presence [false] 2017-10-18 15:42:56.071553 [DEBUG] sofia.c:4450 inbound-codec-negotiation [generous] 2017-10-18 15:42:56.071562 [DEBUG] sofia.c:4450 nonce-ttl [60] 2017-10-18 15:42:56.071566 [DEBUG] sofia.c:4450 auth-calls [false] 2017-10-18 15:42:56.071571 [DEBUG] sofia.c:4450 inbound-late-negotiation [true] 2017-10-18 15:42:56.071574 [DEBUG] sofia.c:4450 inbound-zrtp-passthru [true] 2017-10-18 15:42:56.071576 [DEBUG] sofia.c:4450 rtp-ip [10.120.3.24] 2017-10-18 15:42:56.071579 [DEBUG] sofia.c:4450 sip-ip [10.120.3.24] 2017-10-18 15:42:56.071582 [DEBUG] sofia.c:4450 ext-rtp-ip [auto-nat] 2017-10-18 15:42:56.071584 [DEBUG] sofia.c:4450 ext-sip-ip [auto-nat] 2017-10-18 15:42:56.071586 [DEBUG] sofia.c:4450 rtp-timeout-sec [300] 2017-10-18 15:42:56.071592 [DEBUG] sofia.c:4450 rtp-hold-timeout-sec [1800] 2017-10-18 15:42:56.071597 [DEBUG] sofia.c:4450 tls [false] 2017-10-18 15:42:56.071601 [DEBUG] sofia.c:4450 tls-only [false] 2017-10-18 15:42:56.071610 [DEBUG] sofia.c:4450 wss-binding [:7443] 2017-10-18 15:42:56.071615 [DEBUG] sofia.c:4450 tls-bind-params [transport=tls] 2017-10-18 15:42:56.071619 [DEBUG] sofia.c:4450 tls-sip-port [5045] 2017-10-18 15:42:56.071629 [DEBUG] sofia.c:4450 tls-passphrase [] 2017-10-18 15:42:56.071637 [DEBUG] sofia.c:4450 tls-verify-date [true] 2017-10-18 15:42:56.071643 [DEBUG] sofia.c:4450 tls-verify-policy [none] 2017-10-18 15:42:56.071654 [DEBUG] sofia.c:4450 tls-verify-depth [2] 2017-10-18 15:42:56.071661 [DEBUG] sofia.c:4450 tls-verify-in-subjects [] 2017-10-18 15:42:56.071665 [DEBUG] sofia.c:4450 tls-version [tlsv1,tlsv1.1,tlsv1.2] 2017-10-18 15:42:56.071678 [INFO] sofia.c:5782 Setting MAX Auth Validity to 0 Attempts 2017-10-18 15:42:56.071723 [NOTICE] sofia.c:5949 Started Profile agent [sofia_reg_agent] 2017-10-18 15:42:56.071793 [DEBUG] sofia.c:4450 debug [0] 2017-10-18 15:42:56.071800 [DEBUG] sofia.c:4450 sip-trace [no] 2017-10-18 15:42:56.071811 [DEBUG] sofia.c:4450 sip-capture [yes] 2017-10-18 15:42:56.071816 [DEBUG] sofia.c:4450 rfc2833-pt [101] 2017-10-18 15:42:56.071824 [DEBUG] sofia.c:4450 sip-port [5050] 2017-10-18 15:42:56.071827 [DEBUG] sofia.c:4450 dialplan [XML] 2017-10-18 15:42:56.071838 [DEBUG] sofia.c:3046 Creating agent for agent 2017-10-18 15:42:56.071844 [DEBUG] sofia.c:4450 context [dq_dp] 2017-10-18 15:42:56.071848 [DEBUG] sofia.c:4450 dtmf-duration [2000] 2017-10-18 15:42:56.071853 [DEBUG] sofia.c:4450 inbound-codec-prefs [PCMU] 2017-10-18 15:42:56.071860 [DEBUG] sofia.c:4450 outbound-codec-prefs [PCMU] 2017-10-18 15:42:56.071867 [DEBUG] sofia.c:4450 hold-music [local_stream://moh] 2017-10-18 15:42:56.071869 [DEBUG] sofia.c:4450 rtp-timer-name [soft] 2017-10-18 15:42:56.071872 [DEBUG] sofia.c:4450 local-network-acl [localnet.auto] 2017-10-18 15:42:56.071875 [DEBUG] sofia.c:4450 manage-presence [false] 2017-10-18 15:42:56.071878 [DEBUG] sofia.c:4450 odbc-dsn [pgsql://hostaddr=10.120.3.3 dbname=svp2 user=tms password='s1IghR2gMZ19G81LxFtvc8BH0TJgq7Mw' options='-c client_min_messages=NOTICE' application_name='freeswitch'] 2017-10-18 15:42:56.071883 [DEBUG] sofia.c:4450 inbound-codec-negotiation [generous] 2017-10-18 15:42:56.071887 [DEBUG] sofia.c:4450 nonce-ttl [60] 2017-10-18 15:42:56.071895 [DEBUG] sofia.c:4450 auth-calls [false] 2017-10-18 15:42:56.071899 [DEBUG] sofia.c:4450 inbound-late-negotiation [true] 2017-10-18 15:42:56.071914 [DEBUG] sofia.c:4450 inbound-zrtp-passthru [true] 2017-10-18 15:42:56.071918 [DEBUG] sofia.c:4450 rtp-ip [10.120.3.24] 2017-10-18 15:42:56.071922 [DEBUG] sofia.c:4450 sip-ip [10.120.3.24] 2017-10-18 15:42:56.071926 [DEBUG] sofia.c:4450 ext-rtp-ip [10.120.3.24] 2017-10-18 15:42:56.071930 [DEBUG] sofia.c:4450 ext-sip-ip [10.120.3.24] 2017-10-18 15:42:56.071935 [DEBUG] sofia.c:4450 rtp-timeout-sec [300] 2017-10-18 15:42:56.071942 [DEBUG] sofia.c:4450 rtp-hold-timeout-sec [1800] 2017-10-18 15:42:56.071945 [DEBUG] sofia.c:4450 tls [false] 2017-10-18 15:42:56.071950 [DEBUG] sofia.c:4450 tls-only [false] 2017-10-18 15:42:56.071958 [DEBUG] sofia.c:4450 tls-bind-params [transport=tls] 2017-10-18 15:42:56.071963 [DEBUG] sofia.c:4450 tls-sip-port [5051] 2017-10-18 15:42:56.071970 [DEBUG] sofia.c:4450 tls-passphrase [] 2017-10-18 15:42:56.071974 [DEBUG] sofia.c:4450 tls-verify-date [true] 2017-10-18 15:42:56.071981 [DEBUG] sofia.c:4450 tls-verify-policy [none] 2017-10-18 15:42:56.071988 [DEBUG] sofia.c:4450 tls-verify-depth [2] 2017-10-18 15:42:56.071991 [DEBUG] sofia.c:4450 tls-verify-in-subjects [] 2017-10-18 15:42:56.071994 [DEBUG] sofia.c:4450 tls-version [tlsv1,tlsv1.1,tlsv1.2] 2017-10-18 15:42:56.072002 [INFO] sofia.c:5782 Setting MAX Auth Validity to 0 Attempts 2017-10-18 15:42:56.072044 [NOTICE] sofia.c:5946 Connecting ODBC Profile dq [sofia_reg_dq] 2017-10-18 15:42:56.072135 [DEBUG] sofia.c:3046 Creating agent for dq 2017-10-18 15:42:56.072226 [DEBUG] switch_core_sqldb.c:1347 SQL ERR [no such table: sip_registrations] [delete from sip_registrations where sub_host is null and hostname='ccc-prod-fs2' and network_ip like '%' and network_port like '%' and sip_username like '%' and mwi_user like '%' and mwi_host like '%' and orig_server_host like '%' and orig_hostname like '%'] Auto Generating Table! 2017-10-18 15:42:56.072252 [DEBUG] switch_core_sqldb.c:1354 Ignoring SQL ERR [no such table: sip_registrations] [drop table sip_registrations] 2017-10-18 15:42:56.072707 [DEBUG] switch_core_sqldb.c:1347 SQL ERR [no such table: sip_subscriptions] [delete from sip_subscriptions where hostname='ccc-prod-fs2' and full_to='XXX'] Auto Generating Table! 2017-10-18 15:42:56.072728 [DEBUG] switch_core_sqldb.c:1354 Ignoring SQL ERR [no such table: sip_subscriptions] [DROP TABLE sip_subscriptions] 2017-10-18 15:42:56.072964 [DEBUG] switch_core_sqldb.c:1347 SQL ERR [no such table: sip_dialogs] [delete from sip_dialogs where hostname='ccc-prod-fs2' and (expires <> -9999 or rpid='' or sip_from_tag='' or rcd > 0)] Auto Generating Table! 2017-10-18 15:42:56.072985 [DEBUG] switch_core_sqldb.c:1354 Ignoring SQL ERR [no such table: sip_dialogs] [DROP TABLE sip_dialogs] 2017-10-18 15:42:56.073209 [DEBUG] switch_core_sqldb.c:1347 SQL ERR [no such table: sip_presence] [delete from sip_presence where hostname='ccc-prod-fs2' or open_closed=''] Auto Generating Table! 2017-10-18 15:42:56.073229 [DEBUG] switch_core_sqldb.c:1354 Ignoring SQL ERR [no such table: sip_presence] [DROP TABLE sip_presence] 2017-10-18 15:42:56.073418 [DEBUG] switch_core_sqldb.c:1347 SQL ERR [no such table: sip_authentication] [delete from sip_authentication where hostname='ccc-prod-fs2' or last_nc >= 0] Auto Generating Table! 2017-10-18 15:42:56.073439 [DEBUG] switch_core_sqldb.c:1354 Ignoring SQL ERR [no such table: sip_authentication] [DROP TABLE sip_authentication] 2017-10-18 15:42:56.073595 [DEBUG] switch_core_sqldb.c:1347 SQL ERR [no such table: sip_shared_appearance_subscriptions] [delete from sip_shared_appearance_subscriptions where contact_str='' or hostname='ccc-prod-fs2' and network_ip like '%'] Auto Generating Table! 2017-10-18 15:42:56.073618 [DEBUG] switch_core_sqldb.c:1354 Ignoring SQL ERR [no such table: sip_shared_appearance_subscriptions] [DROP TABLE sip_shared_appearance_subscriptions] 2017-10-18 15:42:56.073802 [DEBUG] switch_core_sqldb.c:1347 SQL ERR [no such table: sip_shared_appearance_dialogs] [delete from sip_shared_appearance_dialogs where contact_str='' or hostname='ccc-prod-fs2' and network_ip like '%'] Auto Generating Table! 2017-10-18 15:42:56.073823 [DEBUG] switch_core_sqldb.c:1354 Ignoring SQL ERR [no such table: sip_shared_appearance_dialogs] [DROP TABLE sip_shared_appearance_dialogs] 2017-10-18 15:42:56.114657 [DEBUG] switch_pgsql.c:415 Query (create index sr_call_id on sip_registrations (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.115028 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_user on sip_registrations (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.115301 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_host on sip_registrations (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.115615 [DEBUG] switch_pgsql.c:415 Query (create index sr_sub_host on sip_registrations (sub_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.115912 [DEBUG] switch_pgsql.c:415 Query (create index sr_mwi_user on sip_registrations (mwi_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.116200 [DEBUG] switch_pgsql.c:415 Query (create index sr_mwi_host on sip_registrations (mwi_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.116488 [DEBUG] switch_pgsql.c:415 Query (create index sr_profile_name on sip_registrations (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.116780 [DEBUG] switch_pgsql.c:415 Query (create index sr_presence_hosts on sip_registrations (presence_hosts)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.117047 [DEBUG] switch_pgsql.c:415 Query (create index sr_contact on sip_registrations (contact)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.117382 [DEBUG] switch_pgsql.c:415 Query (create index sr_expires on sip_registrations (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.117696 [DEBUG] switch_pgsql.c:415 Query (create index sr_ping_expires on sip_registrations (ping_expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.117981 [DEBUG] switch_pgsql.c:415 Query (create index sr_hostname on sip_registrations (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.118245 [DEBUG] switch_pgsql.c:415 Query (create index sr_status on sip_registrations (status)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.118493 [DEBUG] switch_pgsql.c:415 Query (create index sr_ping_status on sip_registrations (ping_status)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.118804 [DEBUG] switch_pgsql.c:415 Query (create index sr_network_ip on sip_registrations (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.119073 [DEBUG] switch_pgsql.c:415 Query (create index sr_network_port on sip_registrations (network_port)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.119344 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_username on sip_registrations (sip_username)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.119604 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_realm on sip_registrations (sip_realm)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.119871 [DEBUG] switch_pgsql.c:415 Query (create index sr_orig_server_host on sip_registrations (orig_server_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.120119 [DEBUG] switch_pgsql.c:415 Query (create index sr_orig_hostname on sip_registrations (orig_hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.120373 [DEBUG] switch_pgsql.c:415 Query (create index ss_call_id on sip_subscriptions (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.120680 [DEBUG] switch_pgsql.c:415 Query (create index ss_multi on sip_subscriptions (call_id, profile_name, hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.120922 [DEBUG] switch_pgsql.c:415 Query (create index ss_hostname on sip_subscriptions (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.121187 [DEBUG] switch_pgsql.c:415 Query (create index ss_network_ip on sip_subscriptions (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.121446 [DEBUG] switch_pgsql.c:415 Query (create index ss_sip_user on sip_subscriptions (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.121739 [DEBUG] switch_pgsql.c:415 Query (create index ss_sip_host on sip_subscriptions (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.121990 [DEBUG] switch_pgsql.c:415 Query (create index ss_presence_hosts on sip_subscriptions (presence_hosts)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.122076 [DEBUG] sofia.c:3164 Created agent for agent 2017-10-18 15:42:56.122113 [DEBUG] sofia.c:3212 Set params for agent 2017-10-18 15:42:56.122118 [DEBUG] sofia.c:3259 Activated db for agent 2017-10-18 15:42:56.122240 [DEBUG] switch_pgsql.c:415 Query (create index ss_event on sip_subscriptions (event)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.122496 [DEBUG] switch_pgsql.c:415 Query (create index ss_proto on sip_subscriptions (proto)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.122802 [DEBUG] switch_pgsql.c:415 Query (create index ss_sub_to_user on sip_subscriptions (sub_to_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.123065 [INFO] switch_core_sqldb.c:1693 sofia:agent Starting SQL thread. 2017-10-18 15:42:56.123071 [DEBUG] switch_pgsql.c:415 Query (create index ss_sub_to_host on sip_subscriptions (sub_to_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.123141 [DEBUG] sofia.c:3297 Starting thread for agent 2017-10-18 15:42:56.123146 [DEBUG] sofia.c:2946 Launching worker thread for agent 2017-10-18 15:42:56.123314 [DEBUG] switch_pgsql.c:415 Query (create index ss_expires on sip_subscriptions (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.123586 [DEBUG] switch_pgsql.c:415 Query (create index ss_orig_proto on sip_subscriptions (orig_proto)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.123856 [DEBUG] switch_pgsql.c:415 Query (create index ss_network_port on sip_subscriptions (network_port)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.124119 [DEBUG] switch_pgsql.c:415 Query (create index ss_profile_name on sip_subscriptions (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.124365 [DEBUG] switch_pgsql.c:415 Query (create index ss_version on sip_subscriptions (version)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.124616 [DEBUG] switch_pgsql.c:415 Query (create index ss_full_from on sip_subscriptions (full_from)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.124862 [DEBUG] switch_pgsql.c:415 Query (create index ss_contact on sip_subscriptions (contact)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.125118 [DEBUG] switch_pgsql.c:415 Query (create index sd_uuid on sip_dialogs (uuid)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.125363 [DEBUG] switch_pgsql.c:415 Query (create index sd_hostname on sip_dialogs (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.125638 [DEBUG] switch_pgsql.c:415 Query (create index sd_presence_data on sip_dialogs (presence_data)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.125955 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_info on sip_dialogs (call_info)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.126228 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_info_state on sip_dialogs (call_info_state)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.126480 [DEBUG] switch_pgsql.c:415 Query (create index sd_expires on sip_dialogs (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.126775 [DEBUG] switch_pgsql.c:415 Query (create index sd_rcd on sip_dialogs (rcd)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.127020 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_to_tag on sip_dialogs (sip_to_tag)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.127278 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_user on sip_dialogs (sip_from_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.127551 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_host on sip_dialogs (sip_from_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.127810 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_to_host on sip_dialogs (sip_to_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.128063 [DEBUG] switch_pgsql.c:415 Query (create index sd_presence_id on sip_dialogs (presence_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.128308 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_id on sip_dialogs (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.128578 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_tag on sip_dialogs (sip_from_tag)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.128836 [DEBUG] switch_pgsql.c:415 Query (create index sp_hostname on sip_presence (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.129078 [DEBUG] switch_pgsql.c:415 Query (create index sp_open_closed on sip_presence (open_closed)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.129342 [DEBUG] switch_pgsql.c:415 Query (create index sp_sip_user on sip_presence (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.129619 [DEBUG] switch_pgsql.c:415 Query (create index sp_sip_host on sip_presence (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.129921 [DEBUG] switch_pgsql.c:415 Query (create index sp_profile_name on sip_presence (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.130206 [DEBUG] switch_pgsql.c:415 Query (create index sp_expires on sip_presence (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.131297 [DEBUG] switch_pgsql.c:415 Query (create index sa_nonce on sip_authentication (nonce)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.131642 [DEBUG] switch_pgsql.c:415 Query (create index sa_hostname on sip_authentication (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.131900 [DEBUG] switch_pgsql.c:415 Query (create index sa_expires on sip_authentication (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.132176 [DEBUG] switch_pgsql.c:415 Query (create index sa_last_nc on sip_authentication (last_nc)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.132473 [DEBUG] switch_pgsql.c:415 Query (create index ssa_hostname on sip_shared_appearance_subscriptions (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.132771 [DEBUG] switch_pgsql.c:415 Query (create index ssa_network_ip on sip_shared_appearance_subscriptions (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.133060 [DEBUG] switch_pgsql.c:415 Query (create index ssa_subscriber on sip_shared_appearance_subscriptions (subscriber)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.133356 [DEBUG] switch_pgsql.c:415 Query (create index ssa_profile_name on sip_shared_appearance_subscriptions (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.133627 [DEBUG] switch_pgsql.c:415 Query (create index ssa_aor on sip_shared_appearance_subscriptions (aor)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.133883 [DEBUG] switch_pgsql.c:415 Query (create index ssd_profile_name on sip_shared_appearance_dialogs (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.134162 [DEBUG] switch_pgsql.c:415 Query (create index ssd_hostname on sip_shared_appearance_dialogs (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.134434 [DEBUG] switch_pgsql.c:415 Query (create index ssd_contact_str on sip_shared_appearance_dialogs (contact_str)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.134691 [DEBUG] switch_pgsql.c:415 Query (create index ssd_call_id on sip_shared_appearance_dialogs (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.134944 [DEBUG] switch_pgsql.c:415 Query (create index ssd_expires on sip_shared_appearance_dialogs (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:56.170467 [DEBUG] sofia.c:3164 Created agent for dq 2017-10-18 15:42:56.170523 [DEBUG] sofia.c:3212 Set params for dq 2017-10-18 15:42:56.170527 [DEBUG] sofia.c:3259 Activated db for dq 2017-10-18 15:42:56.171524 [INFO] switch_core_sqldb.c:1693 sofia:dq Starting SQL thread. 2017-10-18 15:42:56.171612 [DEBUG] sofia.c:3297 Starting thread for dq 2017-10-18 15:42:56.171619 [DEBUG] sofia.c:2946 Launching worker thread for dq 2017-10-18 15:42:56.222627 [ERR] mod_xml_curl.c:315 Received HTTP error 500 trying to fetch https://ccc-prod-lb.objectbrains.com/tms/rest/all_in_one/directory data: [hostname=ccc-prod-fs2§ion=directory&tag_name=&key_name=&key_value=&Event-Name=REQUEST_PARAMS&Core-UUID=17ecaae7-fd12-4299-afd6-870c5152c3ab&FreeSWITCH-Hostname=ccc-prod-fs2&FreeSWITCH-Switchname=ccc-prod-fs2&FreeSWITCH-IPv4=10.120.3.24&FreeSWITCH-IPv6=%3A%3A1&Event-Date-Local=2017-10-18%2015%3A42%3A56&Event-Date-GMT=Wed,%2018%20Oct%202017%2015%3A42%3A56%20GMT&Event-Date-Timestamp=1508341376123188&Event-Calling-File=sofia.c&Event-Calling-Function=launch_sofia_worker_thread&Event-Calling-Line-Number=2967&Event-Sequence=33&purpose=gateways&profile=agent] 2017-10-18 15:42:56.222818 [NOTICE] sofia_reg.c:3398 Added gateway 'example.com' to profile 'agent' 2017-10-18 15:42:56.270879 [ERR] mod_xml_curl.c:315 Received HTTP error 500 trying to fetch https://ccc-prod-lb.objectbrains.com/tms/rest/all_in_one/directory data: [hostname=ccc-prod-fs2§ion=directory&tag_name=&key_name=&key_value=&Event-Name=REQUEST_PARAMS&Core-UUID=17ecaae7-fd12-4299-afd6-870c5152c3ab&FreeSWITCH-Hostname=ccc-prod-fs2&FreeSWITCH-Switchname=ccc-prod-fs2&FreeSWITCH-IPv4=10.120.3.24&FreeSWITCH-IPv6=%3A%3A1&Event-Date-Local=2017-10-18%2015%3A42%3A56&Event-Date-GMT=Wed,%2018%20Oct%202017%2015%3A42%3A56%20GMT&Event-Date-Timestamp=1508341376171657&Event-Calling-File=sofia.c&Event-Calling-Function=launch_sofia_worker_thread&Event-Calling-Line-Number=2967&Event-Sequence=36&purpose=gateways&profile=dq] 2017-10-18 15:42:57.072200 [DEBUG] sofia.c:4450 debug [0] 2017-10-18 15:42:57.072220 [DEBUG] sofia.c:4450 sip-trace [no] 2017-10-18 15:42:57.072224 [DEBUG] sofia.c:4450 sip-capture [yes] 2017-10-18 15:42:57.072230 [DEBUG] sofia.c:4450 rfc2833-pt [101] 2017-10-18 15:42:57.072246 [DEBUG] sofia.c:4450 sip-port [5040] 2017-10-18 15:42:57.072250 [DEBUG] sofia.c:4450 dialplan [XML] 2017-10-18 15:42:57.072257 [DEBUG] sofia.c:4450 context [fifo_dp] 2017-10-18 15:42:57.072261 [DEBUG] sofia.c:4450 dtmf-duration [2000] 2017-10-18 15:42:57.072265 [DEBUG] sofia.c:4450 inbound-codec-prefs [PCMU] 2017-10-18 15:42:57.072271 [DEBUG] sofia.c:4450 outbound-codec-prefs [PCMU] 2017-10-18 15:42:57.072274 [DEBUG] sofia.c:4450 hold-music [local_stream://moh] 2017-10-18 15:42:57.072277 [DEBUG] sofia.c:4450 rtp-timer-name [soft] 2017-10-18 15:42:57.072279 [DEBUG] sofia.c:4450 local-network-acl [localnet.auto] 2017-10-18 15:42:57.072282 [DEBUG] sofia.c:4450 manage-presence [false] 2017-10-18 15:42:57.072285 [DEBUG] sofia.c:4450 odbc-dsn [pgsql://hostaddr=10.120.3.3 dbname=svp2 user=tms password='s1IghR2gMZ19G81LxFtvc8BH0TJgq7Mw' options='-c client_min_messages=NOTICE' application_name='freeswitch'] 2017-10-18 15:42:57.072290 [DEBUG] sofia.c:4450 inbound-codec-negotiation [generous] 2017-10-18 15:42:57.072293 [DEBUG] sofia.c:4450 nonce-ttl [60] 2017-10-18 15:42:57.072295 [DEBUG] sofia.c:4450 auth-calls [false] 2017-10-18 15:42:57.072298 [DEBUG] sofia.c:4450 inbound-late-negotiation [true] 2017-10-18 15:42:57.072301 [DEBUG] sofia.c:4450 inbound-zrtp-passthru [true] 2017-10-18 15:42:57.072305 [DEBUG] sofia.c:4450 rtp-ip [10.120.3.24] 2017-10-18 15:42:57.072308 [DEBUG] sofia.c:4450 sip-ip [10.120.3.24] 2017-10-18 15:42:57.072312 [DEBUG] sofia.c:4450 ext-rtp-ip [auto-nat] 2017-10-18 15:42:57.072315 [DEBUG] sofia.c:4450 ext-sip-ip [auto-nat] 2017-10-18 15:42:57.072319 [DEBUG] sofia.c:4450 rtp-timeout-sec [300] 2017-10-18 15:42:57.072323 [DEBUG] sofia.c:4450 rtp-hold-timeout-sec [1800] 2017-10-18 15:42:57.072325 [DEBUG] sofia.c:4450 tls [false] 2017-10-18 15:42:57.072329 [DEBUG] sofia.c:4450 tls-only [false] 2017-10-18 15:42:57.072333 [DEBUG] sofia.c:4450 tls-bind-params [transport=tls] 2017-10-18 15:42:57.072337 [DEBUG] sofia.c:4450 tls-sip-port [5041] 2017-10-18 15:42:57.072340 [DEBUG] sofia.c:4450 tls-passphrase [] 2017-10-18 15:42:57.072345 [DEBUG] sofia.c:4450 tls-verify-date [true] 2017-10-18 15:42:57.072351 [DEBUG] sofia.c:4450 tls-verify-policy [none] 2017-10-18 15:42:57.072355 [DEBUG] sofia.c:4450 tls-verify-depth [2] 2017-10-18 15:42:57.072366 [DEBUG] sofia.c:4450 tls-verify-in-subjects [] 2017-10-18 15:42:57.072369 [DEBUG] sofia.c:4450 tls-version [tlsv1,tlsv1.1,tlsv1.2] 2017-10-18 15:42:57.072387 [INFO] sofia.c:5782 Setting MAX Auth Validity to 0 Attempts 2017-10-18 15:42:57.072455 [NOTICE] sofia.c:5946 Connecting ODBC Profile fifo [sofia_reg_fifo] 2017-10-18 15:42:57.072516 [DEBUG] sofia.c:3046 Creating agent for fifo 2017-10-18 15:42:57.091876 [DEBUG] switch_pgsql.c:415 Query (create index sr_call_id on sip_registrations (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.092199 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_user on sip_registrations (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.092537 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_host on sip_registrations (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.092826 [DEBUG] switch_pgsql.c:415 Query (create index sr_sub_host on sip_registrations (sub_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.093099 [DEBUG] switch_pgsql.c:415 Query (create index sr_mwi_user on sip_registrations (mwi_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.093373 [DEBUG] switch_pgsql.c:415 Query (create index sr_mwi_host on sip_registrations (mwi_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.093627 [DEBUG] switch_pgsql.c:415 Query (create index sr_profile_name on sip_registrations (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.093921 [DEBUG] switch_pgsql.c:415 Query (create index sr_presence_hosts on sip_registrations (presence_hosts)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.094201 [DEBUG] switch_pgsql.c:415 Query (create index sr_contact on sip_registrations (contact)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.094574 [DEBUG] switch_pgsql.c:415 Query (create index sr_expires on sip_registrations (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.094900 [DEBUG] switch_pgsql.c:415 Query (create index sr_ping_expires on sip_registrations (ping_expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.095182 [DEBUG] switch_pgsql.c:415 Query (create index sr_hostname on sip_registrations (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.095452 [DEBUG] switch_pgsql.c:415 Query (create index sr_status on sip_registrations (status)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.095709 [DEBUG] switch_pgsql.c:415 Query (create index sr_ping_status on sip_registrations (ping_status)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.095967 [DEBUG] switch_pgsql.c:415 Query (create index sr_network_ip on sip_registrations (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.096226 [DEBUG] switch_pgsql.c:415 Query (create index sr_network_port on sip_registrations (network_port)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.096483 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_username on sip_registrations (sip_username)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.096733 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_realm on sip_registrations (sip_realm)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.096991 [DEBUG] switch_pgsql.c:415 Query (create index sr_orig_server_host on sip_registrations (orig_server_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.097266 [DEBUG] switch_pgsql.c:415 Query (create index sr_orig_hostname on sip_registrations (orig_hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.097539 [DEBUG] switch_pgsql.c:415 Query (create index ss_call_id on sip_subscriptions (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.097831 [DEBUG] switch_pgsql.c:415 Query (create index ss_multi on sip_subscriptions (call_id, profile_name, hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.098100 [DEBUG] switch_pgsql.c:415 Query (create index ss_hostname on sip_subscriptions (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.098369 [DEBUG] switch_pgsql.c:415 Query (create index ss_network_ip on sip_subscriptions (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.098638 [DEBUG] switch_pgsql.c:415 Query (create index ss_sip_user on sip_subscriptions (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.098924 [DEBUG] switch_pgsql.c:415 Query (create index ss_sip_host on sip_subscriptions (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.099189 [DEBUG] switch_pgsql.c:415 Query (create index ss_presence_hosts on sip_subscriptions (presence_hosts)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.099451 [DEBUG] switch_pgsql.c:415 Query (create index ss_event on sip_subscriptions (event)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.099743 [DEBUG] switch_pgsql.c:415 Query (create index ss_proto on sip_subscriptions (proto)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.100006 [DEBUG] switch_pgsql.c:415 Query (create index ss_sub_to_user on sip_subscriptions (sub_to_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.100261 [DEBUG] switch_pgsql.c:415 Query (create index ss_sub_to_host on sip_subscriptions (sub_to_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.100518 [DEBUG] switch_pgsql.c:415 Query (create index ss_expires on sip_subscriptions (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.100771 [DEBUG] switch_pgsql.c:415 Query (create index ss_orig_proto on sip_subscriptions (orig_proto)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.101019 [DEBUG] switch_pgsql.c:415 Query (create index ss_network_port on sip_subscriptions (network_port)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.101288 [DEBUG] switch_pgsql.c:415 Query (create index ss_profile_name on sip_subscriptions (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.101564 [DEBUG] switch_pgsql.c:415 Query (create index ss_version on sip_subscriptions (version)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.101828 [DEBUG] switch_pgsql.c:415 Query (create index ss_full_from on sip_subscriptions (full_from)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.102113 [DEBUG] switch_pgsql.c:415 Query (create index ss_contact on sip_subscriptions (contact)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.102383 [DEBUG] switch_pgsql.c:415 Query (create index sd_uuid on sip_dialogs (uuid)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.102662 [DEBUG] switch_pgsql.c:415 Query (create index sd_hostname on sip_dialogs (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.102931 [DEBUG] switch_pgsql.c:415 Query (create index sd_presence_data on sip_dialogs (presence_data)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.103190 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_info on sip_dialogs (call_info)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.103446 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_info_state on sip_dialogs (call_info_state)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.103693 [DEBUG] switch_pgsql.c:415 Query (create index sd_expires on sip_dialogs (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.103948 [DEBUG] switch_pgsql.c:415 Query (create index sd_rcd on sip_dialogs (rcd)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.104206 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_to_tag on sip_dialogs (sip_to_tag)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.104465 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_user on sip_dialogs (sip_from_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.104743 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_host on sip_dialogs (sip_from_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.105012 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_to_host on sip_dialogs (sip_to_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.105291 [DEBUG] switch_pgsql.c:415 Query (create index sd_presence_id on sip_dialogs (presence_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.105550 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_id on sip_dialogs (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.105816 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_tag on sip_dialogs (sip_from_tag)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.106104 [DEBUG] switch_pgsql.c:415 Query (create index sp_hostname on sip_presence (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.106387 [DEBUG] switch_pgsql.c:415 Query (create index sp_open_closed on sip_presence (open_closed)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.106675 [DEBUG] switch_pgsql.c:415 Query (create index sp_sip_user on sip_presence (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.106970 [DEBUG] switch_pgsql.c:415 Query (create index sp_sip_host on sip_presence (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.107236 [DEBUG] switch_pgsql.c:415 Query (create index sp_profile_name on sip_presence (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.107508 [DEBUG] switch_pgsql.c:415 Query (create index sp_expires on sip_presence (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.107788 [DEBUG] switch_pgsql.c:415 Query (create index sa_nonce on sip_authentication (nonce)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.108043 [DEBUG] switch_pgsql.c:415 Query (create index sa_hostname on sip_authentication (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.108304 [DEBUG] switch_pgsql.c:415 Query (create index sa_expires on sip_authentication (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.108561 [DEBUG] switch_pgsql.c:415 Query (create index sa_last_nc on sip_authentication (last_nc)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.108815 [DEBUG] switch_pgsql.c:415 Query (create index ssa_hostname on sip_shared_appearance_subscriptions (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.109062 [DEBUG] switch_pgsql.c:415 Query (create index ssa_network_ip on sip_shared_appearance_subscriptions (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.109325 [DEBUG] switch_pgsql.c:415 Query (create index ssa_subscriber on sip_shared_appearance_subscriptions (subscriber)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.109592 [DEBUG] switch_pgsql.c:415 Query (create index ssa_profile_name on sip_shared_appearance_subscriptions (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.109849 [DEBUG] switch_pgsql.c:415 Query (create index ssa_aor on sip_shared_appearance_subscriptions (aor)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.110122 [DEBUG] switch_pgsql.c:415 Query (create index ssd_profile_name on sip_shared_appearance_dialogs (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.110383 [DEBUG] switch_pgsql.c:415 Query (create index ssd_hostname on sip_shared_appearance_dialogs (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.110637 [DEBUG] switch_pgsql.c:415 Query (create index ssd_contact_str on sip_shared_appearance_dialogs (contact_str)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.110899 [DEBUG] switch_pgsql.c:415 Query (create index ssd_call_id on sip_shared_appearance_dialogs (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.111161 [DEBUG] switch_pgsql.c:415 Query (create index ssd_expires on sip_shared_appearance_dialogs (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:57.146952 [DEBUG] sofia.c:3164 Created agent for fifo 2017-10-18 15:42:57.147001 [DEBUG] sofia.c:3212 Set params for fifo 2017-10-18 15:42:57.147004 [DEBUG] sofia.c:3259 Activated db for fifo 2017-10-18 15:42:57.147951 [INFO] switch_core_sqldb.c:1693 sofia:fifo Starting SQL thread. 2017-10-18 15:42:57.148035 [DEBUG] sofia.c:3297 Starting thread for fifo 2017-10-18 15:42:57.148043 [DEBUG] sofia.c:2946 Launching worker thread for fifo 2017-10-18 15:42:57.241538 [ERR] mod_xml_curl.c:315 Received HTTP error 500 trying to fetch https://ccc-prod-lb.objectbrains.com/tms/rest/all_in_one/directory data: [hostname=ccc-prod-fs2§ion=directory&tag_name=&key_name=&key_value=&Event-Name=REQUEST_PARAMS&Core-UUID=17ecaae7-fd12-4299-afd6-870c5152c3ab&FreeSWITCH-Hostname=ccc-prod-fs2&FreeSWITCH-Switchname=ccc-prod-fs2&FreeSWITCH-IPv4=10.120.3.24&FreeSWITCH-IPv6=%3A%3A1&Event-Date-Local=2017-10-18%2015%3A42%3A57&Event-Date-GMT=Wed,%2018%20Oct%202017%2015%3A42%3A57%20GMT&Event-Date-Timestamp=1508341377148081&Event-Calling-File=sofia.c&Event-Calling-Function=launch_sofia_worker_thread&Event-Calling-Line-Number=2967&Event-Sequence=41&purpose=gateways&profile=fifo] 2017-10-18 15:42:57.371318 [WARNING] sofia.c:2206 MSG Thread 1 Started 2017-10-18 15:42:57.371317 [WARNING] sofia.c:2206 MSG Thread 0 Started 2017-10-18 15:42:58.072567 [DEBUG] sofia.c:4450 debug [0] 2017-10-18 15:42:58.072580 [DEBUG] sofia.c:4450 sip-trace [no] 2017-10-18 15:42:58.072583 [DEBUG] sofia.c:4450 sip-capture [yes] 2017-10-18 15:42:58.072587 [DEBUG] sofia.c:4450 rfc2833-pt [101] 2017-10-18 15:42:58.072593 [DEBUG] sofia.c:4450 sip-port [5042] 2017-10-18 15:42:58.072598 [DEBUG] sofia.c:4450 dialplan [XML] 2017-10-18 15:42:58.072605 [DEBUG] sofia.c:4450 context [ivr_dp] 2017-10-18 15:42:58.072609 [DEBUG] sofia.c:4450 dtmf-duration [2000] 2017-10-18 15:42:58.072616 [DEBUG] sofia.c:4450 inbound-codec-prefs [PCMU] 2017-10-18 15:42:58.072619 [DEBUG] sofia.c:4450 outbound-codec-prefs [PCMU] 2017-10-18 15:42:58.072622 [DEBUG] sofia.c:4450 hold-music [local_stream://moh] 2017-10-18 15:42:58.072625 [DEBUG] sofia.c:4450 rtp-timer-name [soft] 2017-10-18 15:42:58.072628 [DEBUG] sofia.c:4450 local-network-acl [localnet.auto] 2017-10-18 15:42:58.072630 [DEBUG] sofia.c:4450 manage-presence [false] 2017-10-18 15:42:58.072634 [DEBUG] sofia.c:4450 odbc-dsn [pgsql://hostaddr=10.120.3.3 dbname=svp2 user=tms password='s1IghR2gMZ19G81LxFtvc8BH0TJgq7Mw' options='-c client_min_messages=NOTICE' application_name='freeswitch'] 2017-10-18 15:42:58.072638 [DEBUG] sofia.c:4450 inbound-codec-negotiation [generous] 2017-10-18 15:42:58.072642 [DEBUG] sofia.c:4450 nonce-ttl [60] 2017-10-18 15:42:58.072646 [DEBUG] sofia.c:4450 auth-calls [false] 2017-10-18 15:42:58.072653 [DEBUG] sofia.c:4450 inbound-late-negotiation [true] 2017-10-18 15:42:58.072659 [DEBUG] sofia.c:4450 inbound-zrtp-passthru [true] 2017-10-18 15:42:58.072663 [DEBUG] sofia.c:4450 rtp-ip [10.120.3.24] 2017-10-18 15:42:58.072666 [DEBUG] sofia.c:4450 sip-ip [10.120.3.24] 2017-10-18 15:42:58.072669 [DEBUG] sofia.c:4450 ext-rtp-ip [auto-nat] 2017-10-18 15:42:58.072672 [DEBUG] sofia.c:4450 ext-sip-ip [auto-nat] 2017-10-18 15:42:58.072675 [DEBUG] sofia.c:4450 rtp-timeout-sec [300] 2017-10-18 15:42:58.072678 [DEBUG] sofia.c:4450 rtp-hold-timeout-sec [1800] 2017-10-18 15:42:58.072682 [DEBUG] sofia.c:4450 enable-3pcc [true] 2017-10-18 15:42:58.072685 [DEBUG] sofia.c:4450 tls [false] 2017-10-18 15:42:58.072691 [DEBUG] sofia.c:4450 tls-only [false] 2017-10-18 15:42:58.072697 [DEBUG] sofia.c:4450 tls-bind-params [transport=tls] 2017-10-18 15:42:58.072706 [DEBUG] sofia.c:4450 tls-sip-port [5043] 2017-10-18 15:42:58.072710 [DEBUG] sofia.c:4450 tls-passphrase [] 2017-10-18 15:42:58.072716 [DEBUG] sofia.c:4450 tls-verify-date [true] 2017-10-18 15:42:58.072721 [DEBUG] sofia.c:4450 tls-verify-policy [none] 2017-10-18 15:42:58.072725 [DEBUG] sofia.c:4450 tls-verify-depth [2] 2017-10-18 15:42:58.072728 [DEBUG] sofia.c:4450 tls-verify-in-subjects [] 2017-10-18 15:42:58.072732 [DEBUG] sofia.c:4450 tls-version [tlsv1,tlsv1.1,tlsv1.2] 2017-10-18 15:42:58.072749 [INFO] sofia.c:5782 Setting MAX Auth Validity to 0 Attempts 2017-10-18 15:42:58.072845 [NOTICE] sofia.c:5946 Connecting ODBC Profile ivr [sofia_reg_ivr] 2017-10-18 15:42:58.072924 [DEBUG] sofia.c:3046 Creating agent for ivr 2017-10-18 15:42:58.081914 [DEBUG] switch_pgsql.c:415 Query (create index sr_call_id on sip_registrations (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.082291 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_user on sip_registrations (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.082551 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_host on sip_registrations (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.082907 [DEBUG] switch_pgsql.c:415 Query (create index sr_sub_host on sip_registrations (sub_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.083221 [DEBUG] switch_pgsql.c:415 Query (create index sr_mwi_user on sip_registrations (mwi_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.083572 [DEBUG] switch_pgsql.c:415 Query (create index sr_mwi_host on sip_registrations (mwi_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.083871 [DEBUG] switch_pgsql.c:415 Query (create index sr_profile_name on sip_registrations (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.084201 [DEBUG] switch_pgsql.c:415 Query (create index sr_presence_hosts on sip_registrations (presence_hosts)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.084505 [DEBUG] switch_pgsql.c:415 Query (create index sr_contact on sip_registrations (contact)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.084956 [DEBUG] switch_pgsql.c:415 Query (create index sr_expires on sip_registrations (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.085284 [DEBUG] switch_pgsql.c:415 Query (create index sr_ping_expires on sip_registrations (ping_expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.085555 [DEBUG] switch_pgsql.c:415 Query (create index sr_hostname on sip_registrations (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.085941 [DEBUG] switch_pgsql.c:415 Query (create index sr_status on sip_registrations (status)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.086220 [DEBUG] switch_pgsql.c:415 Query (create index sr_ping_status on sip_registrations (ping_status)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.086490 [DEBUG] switch_pgsql.c:415 Query (create index sr_network_ip on sip_registrations (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.086764 [DEBUG] switch_pgsql.c:415 Query (create index sr_network_port on sip_registrations (network_port)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.087033 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_username on sip_registrations (sip_username)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.087325 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_realm on sip_registrations (sip_realm)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.087595 [DEBUG] switch_pgsql.c:415 Query (create index sr_orig_server_host on sip_registrations (orig_server_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.087874 [DEBUG] switch_pgsql.c:415 Query (create index sr_orig_hostname on sip_registrations (orig_hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.088135 [DEBUG] switch_pgsql.c:415 Query (create index ss_call_id on sip_subscriptions (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.088423 [DEBUG] switch_pgsql.c:415 Query (create index ss_multi on sip_subscriptions (call_id, profile_name, hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.088676 [DEBUG] switch_pgsql.c:415 Query (create index ss_hostname on sip_subscriptions (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.088937 [DEBUG] switch_pgsql.c:415 Query (create index ss_network_ip on sip_subscriptions (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.089233 [DEBUG] switch_pgsql.c:415 Query (create index ss_sip_user on sip_subscriptions (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.089491 [DEBUG] switch_pgsql.c:415 Query (create index ss_sip_host on sip_subscriptions (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.089745 [DEBUG] switch_pgsql.c:415 Query (create index ss_presence_hosts on sip_subscriptions (presence_hosts)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.090022 [DEBUG] switch_pgsql.c:415 Query (create index ss_event on sip_subscriptions (event)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.090296 [DEBUG] switch_pgsql.c:415 Query (create index ss_proto on sip_subscriptions (proto)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.090550 [DEBUG] switch_pgsql.c:415 Query (create index ss_sub_to_user on sip_subscriptions (sub_to_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.090838 [DEBUG] switch_pgsql.c:415 Query (create index ss_sub_to_host on sip_subscriptions (sub_to_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.091090 [DEBUG] switch_pgsql.c:415 Query (create index ss_expires on sip_subscriptions (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.091344 [DEBUG] switch_pgsql.c:415 Query (create index ss_orig_proto on sip_subscriptions (orig_proto)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.091729 [DEBUG] switch_pgsql.c:415 Query (create index ss_network_port on sip_subscriptions (network_port)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.092025 [DEBUG] switch_pgsql.c:415 Query (create index ss_profile_name on sip_subscriptions (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.092307 [DEBUG] switch_pgsql.c:415 Query (create index ss_version on sip_subscriptions (version)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.092584 [DEBUG] switch_pgsql.c:415 Query (create index ss_full_from on sip_subscriptions (full_from)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.092869 [DEBUG] switch_pgsql.c:415 Query (create index ss_contact on sip_subscriptions (contact)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.093140 [DEBUG] switch_pgsql.c:415 Query (create index sd_uuid on sip_dialogs (uuid)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.093413 [DEBUG] switch_pgsql.c:415 Query (create index sd_hostname on sip_dialogs (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.093673 [DEBUG] switch_pgsql.c:415 Query (create index sd_presence_data on sip_dialogs (presence_data)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.093956 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_info on sip_dialogs (call_info)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.094230 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_info_state on sip_dialogs (call_info_state)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.094471 [DEBUG] switch_pgsql.c:415 Query (create index sd_expires on sip_dialogs (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.094766 [DEBUG] switch_pgsql.c:415 Query (create index sd_rcd on sip_dialogs (rcd)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.095030 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_to_tag on sip_dialogs (sip_to_tag)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.095347 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_user on sip_dialogs (sip_from_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.095618 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_host on sip_dialogs (sip_from_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.095927 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_to_host on sip_dialogs (sip_to_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.096229 [DEBUG] switch_pgsql.c:415 Query (create index sd_presence_id on sip_dialogs (presence_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.096516 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_id on sip_dialogs (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.096789 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_tag on sip_dialogs (sip_from_tag)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.097089 [DEBUG] switch_pgsql.c:415 Query (create index sp_hostname on sip_presence (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.097393 [DEBUG] switch_pgsql.c:415 Query (create index sp_open_closed on sip_presence (open_closed)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.097671 [DEBUG] switch_pgsql.c:415 Query (create index sp_sip_user on sip_presence (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.097957 [DEBUG] switch_pgsql.c:415 Query (create index sp_sip_host on sip_presence (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.098239 [DEBUG] switch_pgsql.c:415 Query (create index sp_profile_name on sip_presence (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.098575 [DEBUG] switch_pgsql.c:415 Query (create index sp_expires on sip_presence (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.098870 [DEBUG] switch_pgsql.c:415 Query (create index sa_nonce on sip_authentication (nonce)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.099175 [DEBUG] switch_pgsql.c:415 Query (create index sa_hostname on sip_authentication (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.099495 [DEBUG] switch_pgsql.c:415 Query (create index sa_expires on sip_authentication (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.099751 [DEBUG] switch_pgsql.c:415 Query (create index sa_last_nc on sip_authentication (last_nc)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.100054 [DEBUG] switch_pgsql.c:415 Query (create index ssa_hostname on sip_shared_appearance_subscriptions (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.100393 [DEBUG] switch_pgsql.c:415 Query (create index ssa_network_ip on sip_shared_appearance_subscriptions (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.100687 [DEBUG] switch_pgsql.c:415 Query (create index ssa_subscriber on sip_shared_appearance_subscriptions (subscriber)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.101004 [DEBUG] switch_pgsql.c:415 Query (create index ssa_profile_name on sip_shared_appearance_subscriptions (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.101304 [DEBUG] switch_pgsql.c:415 Query (create index ssa_aor on sip_shared_appearance_subscriptions (aor)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.101572 [DEBUG] switch_pgsql.c:415 Query (create index ssd_profile_name on sip_shared_appearance_dialogs (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.101860 [DEBUG] switch_pgsql.c:415 Query (create index ssd_hostname on sip_shared_appearance_dialogs (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.102174 [DEBUG] switch_pgsql.c:415 Query (create index ssd_contact_str on sip_shared_appearance_dialogs (contact_str)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.102461 [DEBUG] switch_pgsql.c:415 Query (create index ssd_call_id on sip_shared_appearance_dialogs (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.102764 [DEBUG] switch_pgsql.c:415 Query (create index ssd_expires on sip_shared_appearance_dialogs (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:58.138762 [DEBUG] sofia.c:3164 Created agent for ivr 2017-10-18 15:42:58.138815 [DEBUG] sofia.c:3212 Set params for ivr 2017-10-18 15:42:58.138818 [DEBUG] sofia.c:3259 Activated db for ivr 2017-10-18 15:42:58.139766 [INFO] switch_core_sqldb.c:1693 sofia:ivr Starting SQL thread. 2017-10-18 15:42:58.139853 [DEBUG] sofia.c:3297 Starting thread for ivr 2017-10-18 15:42:58.139858 [DEBUG] sofia.c:2946 Launching worker thread for ivr 2017-10-18 15:42:58.226917 [ERR] mod_xml_curl.c:315 Received HTTP error 500 trying to fetch https://ccc-prod-lb.objectbrains.com/tms/rest/all_in_one/directory data: [hostname=ccc-prod-fs2§ion=directory&tag_name=&key_name=&key_value=&Event-Name=REQUEST_PARAMS&Core-UUID=17ecaae7-fd12-4299-afd6-870c5152c3ab&FreeSWITCH-Hostname=ccc-prod-fs2&FreeSWITCH-Switchname=ccc-prod-fs2&FreeSWITCH-IPv4=10.120.3.24&FreeSWITCH-IPv6=%3A%3A1&Event-Date-Local=2017-10-18%2015%3A42%3A58&Event-Date-GMT=Wed,%2018%20Oct%202017%2015%3A42%3A58%20GMT&Event-Date-Timestamp=1508341378139898&Event-Calling-File=sofia.c&Event-Calling-Function=launch_sofia_worker_thread&Event-Calling-Line-Number=2967&Event-Sequence=45&purpose=gateways&profile=ivr] 2017-10-18 15:42:59.072987 [DEBUG] sofia.c:4450 debug [0] 2017-10-18 15:42:59.073001 [DEBUG] sofia.c:4450 sip-trace [no] 2017-10-18 15:42:59.073004 [DEBUG] sofia.c:4450 sip-capture [yes] 2017-10-18 15:42:59.073010 [DEBUG] sofia.c:4450 rfc2833-pt [101] 2017-10-18 15:42:59.073016 [DEBUG] sofia.c:4450 sip-port [5048] 2017-10-18 15:42:59.073020 [DEBUG] sofia.c:4450 dialplan [XML] 2017-10-18 15:42:59.073027 [DEBUG] sofia.c:4450 context [rsbc_dp] 2017-10-18 15:42:59.073031 [DEBUG] sofia.c:4450 dtmf-duration [2000] 2017-10-18 15:42:59.073035 [DEBUG] sofia.c:4450 inbound-codec-prefs [PCMU] 2017-10-18 15:42:59.073039 [DEBUG] sofia.c:4450 outbound-codec-prefs [PCMU] 2017-10-18 15:42:59.073042 [DEBUG] sofia.c:4450 hold-music [local_stream://moh] 2017-10-18 15:42:59.073044 [DEBUG] sofia.c:4450 rtp-timer-name [soft] 2017-10-18 15:42:59.073046 [DEBUG] sofia.c:4450 local-network-acl [localnet.auto] 2017-10-18 15:42:59.073049 [DEBUG] sofia.c:4450 manage-presence [false] 2017-10-18 15:42:59.073051 [DEBUG] sofia.c:4450 inbound-codec-negotiation [generous] 2017-10-18 15:42:59.073054 [DEBUG] sofia.c:4450 nonce-ttl [60] 2017-10-18 15:42:59.073066 [DEBUG] sofia.c:4450 auth-calls [false] 2017-10-18 15:42:59.073071 [DEBUG] sofia.c:4450 inbound-late-negotiation [true] 2017-10-18 15:42:59.073074 [DEBUG] sofia.c:4450 inbound-zrtp-passthru [true] 2017-10-18 15:42:59.073076 [DEBUG] sofia.c:4450 rtp-ip [10.120.3.24] 2017-10-18 15:42:59.073079 [DEBUG] sofia.c:4450 sip-ip [10.120.3.24] 2017-10-18 15:42:59.073082 [DEBUG] sofia.c:4450 ext-rtp-ip [auto-nat] 2017-10-18 15:42:59.073086 [DEBUG] sofia.c:4450 ext-sip-ip [auto-nat] 2017-10-18 15:42:59.073090 [DEBUG] sofia.c:4450 rtp-timeout-sec [300] 2017-10-18 15:42:59.073093 [DEBUG] sofia.c:4450 rtp-hold-timeout-sec [1800] 2017-10-18 15:42:59.073095 [DEBUG] sofia.c:4450 enable-3pcc [true] 2017-10-18 15:42:59.073100 [DEBUG] sofia.c:4450 tls [false] 2017-10-18 15:42:59.073105 [DEBUG] sofia.c:4450 tls-only [false] 2017-10-18 15:42:59.073130 [DEBUG] sofia.c:4450 tls-bind-params [transport=tls] 2017-10-18 15:42:59.073137 [DEBUG] sofia.c:4450 tls-sip-port [5049] 2017-10-18 15:42:59.073142 [DEBUG] sofia.c:4450 tls-passphrase [] 2017-10-18 15:42:59.073152 [DEBUG] sofia.c:4450 tls-verify-date [true] 2017-10-18 15:42:59.073158 [DEBUG] sofia.c:4450 tls-verify-policy [none] 2017-10-18 15:42:59.073161 [DEBUG] sofia.c:4450 tls-verify-depth [2] 2017-10-18 15:42:59.073169 [DEBUG] sofia.c:4450 tls-verify-in-subjects [] 2017-10-18 15:42:59.073176 [DEBUG] sofia.c:4450 tls-version [tlsv1,tlsv1.1,tlsv1.2] 2017-10-18 15:42:59.073199 [INFO] sofia.c:5782 Setting MAX Auth Validity to 0 Attempts 2017-10-18 15:42:59.073272 [NOTICE] sofia.c:5949 Started Profile rsbc [sofia_reg_rsbc] 2017-10-18 15:42:59.073302 [DEBUG] sofia.c:4450 debug [0] 2017-10-18 15:42:59.073304 [DEBUG] sofia.c:4450 sip-trace [no] 2017-10-18 15:42:59.073306 [DEBUG] sofia.c:4450 sip-capture [yes] 2017-10-18 15:42:59.073309 [DEBUG] sofia.c:4450 rfc2833-pt [101] 2017-10-18 15:42:59.073313 [DEBUG] sofia.c:4450 sip-port [5046] 2017-10-18 15:42:59.073317 [DEBUG] sofia.c:4450 dialplan [XML] 2017-10-18 15:42:59.073325 [DEBUG] sofia.c:4450 context [sbc_dp] 2017-10-18 15:42:59.073331 [DEBUG] sofia.c:4450 dtmf-duration [2000] 2017-10-18 15:42:59.073335 [DEBUG] sofia.c:4450 inbound-codec-prefs [PCMU] 2017-10-18 15:42:59.073345 [DEBUG] sofia.c:4450 outbound-codec-prefs [PCMU] 2017-10-18 15:42:59.073353 [DEBUG] sofia.c:4450 hold-music [local_stream://moh] 2017-10-18 15:42:59.073358 [DEBUG] sofia.c:4450 rtp-timer-name [soft] 2017-10-18 15:42:59.073361 [DEBUG] sofia.c:4450 local-network-acl [localnet.auto] 2017-10-18 15:42:59.073364 [DEBUG] sofia.c:4450 manage-presence [false] 2017-10-18 15:42:59.073365 [DEBUG] sofia.c:3046 Creating agent for rsbc 2017-10-18 15:42:59.073367 [DEBUG] sofia.c:4450 odbc-dsn [pgsql://hostaddr=10.120.3.3 dbname=svp2 user=tms password='s1IghR2gMZ19G81LxFtvc8BH0TJgq7Mw' options='-c client_min_messages=NOTICE' application_name='freeswitch'] 2017-10-18 15:42:59.073421 [DEBUG] sofia.c:4450 inbound-codec-negotiation [generous] 2017-10-18 15:42:59.073428 [DEBUG] sofia.c:4450 nonce-ttl [60] 2017-10-18 15:42:59.073437 [DEBUG] sofia.c:4450 auth-calls [false] 2017-10-18 15:42:59.073443 [DEBUG] sofia.c:4450 inbound-late-negotiation [true] 2017-10-18 15:42:59.073446 [DEBUG] sofia.c:4450 inbound-zrtp-passthru [true] 2017-10-18 15:42:59.073449 [DEBUG] sofia.c:4450 rtp-ip [10.120.3.24] 2017-10-18 15:42:59.073455 [DEBUG] sofia.c:4450 sip-ip [10.120.3.24] 2017-10-18 15:42:59.073458 [DEBUG] sofia.c:4450 ext-rtp-ip [auto-nat] 2017-10-18 15:42:59.073462 [DEBUG] sofia.c:4450 ext-sip-ip [auto-nat] 2017-10-18 15:42:59.073466 [DEBUG] sofia.c:4450 rtp-timeout-sec [300] 2017-10-18 15:42:59.073472 [DEBUG] sofia.c:4450 rtp-hold-timeout-sec [1800] 2017-10-18 15:42:59.073480 [DEBUG] sofia.c:4450 enable-3pcc [true] 2017-10-18 15:42:59.073486 [DEBUG] sofia.c:4450 tls [false] 2017-10-18 15:42:59.073495 [DEBUG] sofia.c:4450 tls-only [false] 2017-10-18 15:42:59.073503 [DEBUG] sofia.c:4450 tls-bind-params [transport=tls] 2017-10-18 15:42:59.073513 [DEBUG] sofia.c:4450 tls-sip-port [5047] 2017-10-18 15:42:59.073520 [DEBUG] sofia.c:4450 tls-passphrase [] 2017-10-18 15:42:59.073530 [DEBUG] sofia.c:4450 tls-verify-date [true] 2017-10-18 15:42:59.073542 [DEBUG] sofia.c:4450 tls-verify-policy [none] 2017-10-18 15:42:59.073549 [DEBUG] sofia.c:4450 tls-verify-depth [2] 2017-10-18 15:42:59.073553 [DEBUG] sofia.c:4450 tls-verify-in-subjects [] 2017-10-18 15:42:59.073559 [DEBUG] sofia.c:4450 tls-version [tlsv1,tlsv1.1,tlsv1.2] 2017-10-18 15:42:59.073569 [INFO] sofia.c:5782 Setting MAX Auth Validity to 0 Attempts 2017-10-18 15:42:59.073618 [NOTICE] sofia.c:5946 Connecting ODBC Profile sbc [sofia_reg_sbc] 2017-10-18 15:42:59.073732 [DEBUG] sofia.c:3046 Creating agent for sbc 2017-10-18 15:42:59.082495 [DEBUG] switch_pgsql.c:415 Query (create index sr_call_id on sip_registrations (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.082792 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_user on sip_registrations (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.083043 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_host on sip_registrations (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.083298 [DEBUG] switch_pgsql.c:415 Query (create index sr_sub_host on sip_registrations (sub_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.083554 [DEBUG] switch_pgsql.c:415 Query (create index sr_mwi_user on sip_registrations (mwi_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.083800 [DEBUG] switch_pgsql.c:415 Query (create index sr_mwi_host on sip_registrations (mwi_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.084056 [DEBUG] switch_pgsql.c:415 Query (create index sr_profile_name on sip_registrations (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.084309 [DEBUG] switch_pgsql.c:415 Query (create index sr_presence_hosts on sip_registrations (presence_hosts)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.084569 [DEBUG] switch_pgsql.c:415 Query (create index sr_contact on sip_registrations (contact)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.084884 [DEBUG] switch_pgsql.c:415 Query (create index sr_expires on sip_registrations (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.085215 [DEBUG] switch_pgsql.c:415 Query (create index sr_ping_expires on sip_registrations (ping_expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.085481 [DEBUG] switch_pgsql.c:415 Query (create index sr_hostname on sip_registrations (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.085865 [DEBUG] switch_pgsql.c:415 Query (create index sr_status on sip_registrations (status)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.086153 [DEBUG] switch_pgsql.c:415 Query (create index sr_ping_status on sip_registrations (ping_status)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.086406 [DEBUG] switch_pgsql.c:415 Query (create index sr_network_ip on sip_registrations (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.086652 [DEBUG] switch_pgsql.c:415 Query (create index sr_network_port on sip_registrations (network_port)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.086900 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_username on sip_registrations (sip_username)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.087153 [DEBUG] switch_pgsql.c:415 Query (create index sr_sip_realm on sip_registrations (sip_realm)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.087394 [DEBUG] switch_pgsql.c:415 Query (create index sr_orig_server_host on sip_registrations (orig_server_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.087666 [DEBUG] switch_pgsql.c:415 Query (create index sr_orig_hostname on sip_registrations (orig_hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.087927 [DEBUG] switch_pgsql.c:415 Query (create index ss_call_id on sip_subscriptions (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.088251 [DEBUG] switch_pgsql.c:415 Query (create index ss_multi on sip_subscriptions (call_id, profile_name, hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.088505 [DEBUG] switch_pgsql.c:415 Query (create index ss_hostname on sip_subscriptions (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.088761 [DEBUG] switch_pgsql.c:415 Query (create index ss_network_ip on sip_subscriptions (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.089013 [DEBUG] switch_pgsql.c:415 Query (create index ss_sip_user on sip_subscriptions (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.089269 [DEBUG] switch_pgsql.c:415 Query (create index ss_sip_host on sip_subscriptions (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.089553 [DEBUG] switch_pgsql.c:415 Query (create index ss_presence_hosts on sip_subscriptions (presence_hosts)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.089821 [DEBUG] switch_pgsql.c:415 Query (create index ss_event on sip_subscriptions (event)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.090077 [DEBUG] switch_pgsql.c:415 Query (create index ss_proto on sip_subscriptions (proto)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.090348 [DEBUG] switch_pgsql.c:415 Query (create index ss_sub_to_user on sip_subscriptions (sub_to_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.090635 [DEBUG] switch_pgsql.c:415 Query (create index ss_sub_to_host on sip_subscriptions (sub_to_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.090900 [DEBUG] switch_pgsql.c:415 Query (create index ss_expires on sip_subscriptions (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.091163 [DEBUG] switch_pgsql.c:415 Query (create index ss_orig_proto on sip_subscriptions (orig_proto)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.091521 [DEBUG] switch_pgsql.c:415 Query (create index ss_network_port on sip_subscriptions (network_port)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.091781 [DEBUG] switch_pgsql.c:415 Query (create index ss_profile_name on sip_subscriptions (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.092096 [DEBUG] switch_pgsql.c:415 Query (create index ss_version on sip_subscriptions (version)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.092425 [DEBUG] switch_pgsql.c:415 Query (create index ss_full_from on sip_subscriptions (full_from)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.092725 [DEBUG] switch_pgsql.c:415 Query (create index ss_contact on sip_subscriptions (contact)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.092997 [DEBUG] switch_pgsql.c:415 Query (create index sd_uuid on sip_dialogs (uuid)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.093297 [DEBUG] switch_pgsql.c:415 Query (create index sd_hostname on sip_dialogs (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.093586 [DEBUG] switch_pgsql.c:415 Query (create index sd_presence_data on sip_dialogs (presence_data)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.093841 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_info on sip_dialogs (call_info)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.094120 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_info_state on sip_dialogs (call_info_state)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.094371 [DEBUG] switch_pgsql.c:415 Query (create index sd_expires on sip_dialogs (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.094620 [DEBUG] switch_pgsql.c:415 Query (create index sd_rcd on sip_dialogs (rcd)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.094869 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_to_tag on sip_dialogs (sip_to_tag)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.095140 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_user on sip_dialogs (sip_from_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.095398 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_host on sip_dialogs (sip_from_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.095657 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_to_host on sip_dialogs (sip_to_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.095914 [DEBUG] switch_pgsql.c:415 Query (create index sd_presence_id on sip_dialogs (presence_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.096156 [DEBUG] switch_pgsql.c:415 Query (create index sd_call_id on sip_dialogs (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.096406 [DEBUG] switch_pgsql.c:415 Query (create index sd_sip_from_tag on sip_dialogs (sip_from_tag)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.096655 [DEBUG] switch_pgsql.c:415 Query (create index sp_hostname on sip_presence (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.096909 [DEBUG] switch_pgsql.c:415 Query (create index sp_open_closed on sip_presence (open_closed)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.097191 [DEBUG] switch_pgsql.c:415 Query (create index sp_sip_user on sip_presence (sip_user)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.097470 [DEBUG] switch_pgsql.c:415 Query (create index sp_sip_host on sip_presence (sip_host)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.097748 [DEBUG] switch_pgsql.c:415 Query (create index sp_profile_name on sip_presence (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.098162 [DEBUG] switch_pgsql.c:415 Query (create index sp_expires on sip_presence (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.098459 [DEBUG] switch_pgsql.c:415 Query (create index sa_nonce on sip_authentication (nonce)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.098764 [DEBUG] switch_pgsql.c:415 Query (create index sa_hostname on sip_authentication (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.099085 [DEBUG] switch_pgsql.c:415 Query (create index sa_expires on sip_authentication (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.099356 [DEBUG] switch_pgsql.c:415 Query (create index sa_last_nc on sip_authentication (last_nc)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.099654 [DEBUG] switch_pgsql.c:415 Query (create index ssa_hostname on sip_shared_appearance_subscriptions (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.099910 [DEBUG] switch_pgsql.c:415 Query (create index ssa_network_ip on sip_shared_appearance_subscriptions (network_ip)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.100179 [DEBUG] switch_pgsql.c:415 Query (create index ssa_subscriber on sip_shared_appearance_subscriptions (subscriber)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.100470 [DEBUG] switch_pgsql.c:415 Query (create index ssa_profile_name on sip_shared_appearance_subscriptions (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.100746 [DEBUG] switch_pgsql.c:415 Query (create index ssa_aor on sip_shared_appearance_subscriptions (aor)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.101019 [DEBUG] switch_pgsql.c:415 Query (create index ssd_profile_name on sip_shared_appearance_dialogs (profile_name)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.101317 [DEBUG] switch_pgsql.c:415 Query (create index ssd_hostname on sip_shared_appearance_dialogs (hostname)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.101632 [DEBUG] switch_pgsql.c:415 Query (create index ssd_contact_str on sip_shared_appearance_dialogs (contact_str)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.101881 [DEBUG] switch_pgsql.c:415 Query (create index ssd_call_id on sip_shared_appearance_dialogs (call_id)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.102145 [DEBUG] switch_pgsql.c:415 Query (create index ssd_expires on sip_shared_appearance_dialogs (expires)) returned PGRES_FATAL_ERROR 2017-10-18 15:42:59.110464 [DEBUG] sofia.c:3164 Created agent for rsbc 2017-10-18 15:42:59.110507 [DEBUG] sofia.c:3212 Set params for rsbc 2017-10-18 15:42:59.110510 [DEBUG] sofia.c:3259 Activated db for rsbc 2017-10-18 15:42:59.111421 [INFO] switch_core_sqldb.c:1693 sofia:rsbc Starting SQL thread. 2017-10-18 15:42:59.111495 [DEBUG] sofia.c:3297 Starting thread for rsbc 2017-10-18 15:42:59.111501 [DEBUG] sofia.c:2946 Launching worker thread for rsbc 2017-10-18 15:42:59.138086 [DEBUG] sofia.c:3164 Created agent for sbc 2017-10-18 15:42:59.138121 [DEBUG] sofia.c:3212 Set params for sbc 2017-10-18 15:42:59.138124 [DEBUG] sofia.c:3259 Activated db for sbc 2017-10-18 15:42:59.139079 [INFO] switch_core_sqldb.c:1693 sofia:sbc Starting SQL thread. 2017-10-18 15:42:59.139149 [DEBUG] sofia.c:3297 Starting thread for sbc 2017-10-18 15:42:59.139154 [DEBUG] sofia.c:2946 Launching worker thread for sbc 2017-10-18 15:42:59.139252 [NOTICE] sofia_reg.c:3398 Added gateway 'ca-smh-as5400-01' to profile 'sbc' 2017-10-18 15:42:59.139297 [NOTICE] sofia_reg.c:3398 Added gateway 'p2-p1-gateway' to profile 'sbc' 2017-10-18 15:42:59.139345 [NOTICE] sofia_reg.c:3398 Added gateway 'rsbc-110-2' to profile 'sbc' 2017-10-18 15:42:59.139386 [NOTICE] sofia_reg.c:3398 Added gateway 'rsbc-110-3' to profile 'sbc' 2017-10-18 15:42:59.139426 [NOTICE] sofia_reg.c:3398 Added gateway 'rsbc-111-2' to profile 'sbc' 2017-10-18 15:42:59.139455 [NOTICE] sofia_reg.c:3398 Added gateway 'rsbc-111-3' to profile 'sbc' 2017-10-18 15:42:59.200148 [ERR] mod_xml_curl.c:315 Received HTTP error 500 trying to fetch https://ccc-prod-lb.objectbrains.com/tms/rest/all_in_one/directory data: [hostname=ccc-prod-fs2§ion=directory&tag_name=&key_name=&key_value=&Event-Name=REQUEST_PARAMS&Core-UUID=17ecaae7-fd12-4299-afd6-870c5152c3ab&FreeSWITCH-Hostname=ccc-prod-fs2&FreeSWITCH-Switchname=ccc-prod-fs2&FreeSWITCH-IPv4=10.120.3.24&FreeSWITCH-IPv6=%3A%3A1&Event-Date-Local=2017-10-18%2015%3A42%3A59&Event-Date-GMT=Wed,%2018%20Oct%202017%2015%3A42%3A59%20GMT&Event-Date-Timestamp=1508341379111537&Event-Calling-File=sofia.c&Event-Calling-Function=launch_sofia_worker_thread&Event-Calling-Line-Number=2967&Event-Sequence=50&purpose=gateways&profile=rsbc] 2017-10-18 15:42:59.227830 [ERR] mod_xml_curl.c:315 Received HTTP error 500 trying to fetch https://ccc-prod-lb.objectbrains.com/tms/rest/all_in_one/directory data: [hostname=ccc-prod-fs2§ion=directory&tag_name=&key_name=&key_value=&Event-Name=REQUEST_PARAMS&Core-UUID=17ecaae7-fd12-4299-afd6-870c5152c3ab&FreeSWITCH-Hostname=ccc-prod-fs2&FreeSWITCH-Switchname=ccc-prod-fs2&FreeSWITCH-IPv4=10.120.3.24&FreeSWITCH-IPv6=%3A%3A1&Event-Date-Local=2017-10-18%2015%3A42%3A59&Event-Date-GMT=Wed,%2018%20Oct%202017%2015%3A42%3A59%20GMT&Event-Date-Timestamp=1508341379139478&Event-Calling-File=sofia.c&Event-Calling-Function=launch_sofia_worker_thread&Event-Calling-Line-Number=2967&Event-Sequence=59&purpose=gateways&profile=sbc] 2017-10-18 15:43:00.073738 [DEBUG] mod_sofia.c:5974 Waiting for profiles to start 2017-10-18 15:43:01.573950 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_sofia] 2017-10-18 15:43:01.573978 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'sofia' 2017-10-18 15:43:01.574010 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'rtp' 2017-10-18 15:43:01.574018 [NOTICE] switch_loadable_module.c:292 Adding Application 'sofia_sla' 2017-10-18 15:43:01.574027 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sofia' 2017-10-18 15:43:01.574035 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sofia_gateway_data' 2017-10-18 15:43:01.574046 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sofia_username_of' 2017-10-18 15:43:01.574115 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sofia_contact' 2017-10-18 15:43:01.574157 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sofia_count_reg' 2017-10-18 15:43:01.574172 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sofia_dig' 2017-10-18 15:43:01.574205 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sofia_presence_data' 2017-10-18 15:43:01.574243 [NOTICE] switch_loadable_module.c:483 Adding Chat interface 'sip' 2017-10-18 15:43:01.574276 [NOTICE] switch_loadable_module.c:529 Adding Management interface 'mod_sofia' OID[.1.3.6.1.4.1.27880.1001] 2017-10-18 15:43:01.574680 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_loopback] 2017-10-18 15:43:01.574695 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'loopback' 2017-10-18 15:43:01.574719 [NOTICE] switch_loadable_module.c:292 Adding Application 'unloop' 2017-10-18 15:43:01.574914 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_rtc] 2017-10-18 15:43:01.574928 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'rtc' 2017-10-18 15:43:01.575662 [INFO] mod_verto.c:4647 Secure key and cert specified 2017-10-18 15:43:01.575683 [DEBUG] mod_verto.c:4751 default-v4 Bound to 10.120.3.24:8081 2017-10-18 15:43:01.575688 [DEBUG] mod_verto.c:4751 default-v4 Bound to 10.120.3.24:8082 2017-10-18 15:43:01.575782 [INFO] mod_verto.c:4647 Secure key and cert specified 2017-10-18 15:43:01.575796 [DEBUG] mod_verto.c:4751 default-v6 Bound to [::1]:8081 2017-10-18 15:43:01.575797 [DEBUG] mod_verto.c:4751 default-v6 Bound to [::1]:8082 2017-10-18 15:43:01.576849 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_verto] 2017-10-18 15:43:01.576865 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'verto.rtc' 2017-10-18 15:43:01.576882 [NOTICE] switch_loadable_module.c:338 Adding API Function 'verto' 2017-10-18 15:43:01.576890 [NOTICE] switch_loadable_module.c:338 Adding API Function 'verto_contact' 2017-10-18 15:43:01.576935 [NOTICE] switch_loadable_module.c:361 Adding JSON API Function 'store' 2017-10-18 15:43:01.576972 [NOTICE] switch_loadable_module.c:483 Adding Chat interface 'verto' 2017-10-18 15:43:01.576978 [DEBUG] mod_verto.c:4412 MCAST Bound to 224.1.1.1:1337/1338 2017-10-18 15:43:01.578998 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_commands] 2017-10-18 15:43:01.579013 [NOTICE] switch_loadable_module.c:338 Adding API Function 'bg_system' 2017-10-18 15:43:01.579033 [NOTICE] switch_loadable_module.c:338 Adding API Function 'system' 2017-10-18 15:43:01.579044 [NOTICE] switch_loadable_module.c:338 Adding API Function 'acl' 2017-10-18 15:43:01.579056 [NOTICE] switch_loadable_module.c:338 Adding API Function 'alias' 2017-10-18 15:43:01.579087 [NOTICE] switch_loadable_module.c:338 Adding API Function 'coalesce' 2017-10-18 15:43:01.579117 [NOTICE] switch_loadable_module.c:338 Adding API Function 'banner' 2017-10-18 15:43:01.579129 [NOTICE] switch_loadable_module.c:338 Adding API Function 'bgapi' 2017-10-18 15:43:01.579166 [NOTICE] switch_loadable_module.c:338 Adding API Function 'break' 2017-10-18 15:43:01.579188 [NOTICE] switch_loadable_module.c:338 Adding API Function 'complete' 2017-10-18 15:43:01.579220 [NOTICE] switch_loadable_module.c:338 Adding API Function 'cond' 2017-10-18 15:43:01.579248 [NOTICE] switch_loadable_module.c:338 Adding API Function 'console_complete' 2017-10-18 15:43:01.579276 [NOTICE] switch_loadable_module.c:338 Adding API Function 'console_complete_xml' 2017-10-18 15:43:01.579307 [NOTICE] switch_loadable_module.c:338 Adding API Function 'create_uuid' 2017-10-18 15:43:01.579335 [NOTICE] switch_loadable_module.c:338 Adding API Function 'db_cache' 2017-10-18 15:43:01.579359 [NOTICE] switch_loadable_module.c:338 Adding API Function 'domain_exists' 2017-10-18 15:43:01.579398 [NOTICE] switch_loadable_module.c:338 Adding API Function 'echo' 2017-10-18 15:43:01.579425 [NOTICE] switch_loadable_module.c:338 Adding API Function 'event_channel_broadcast' 2017-10-18 15:43:01.579454 [NOTICE] switch_loadable_module.c:338 Adding API Function 'escape' 2017-10-18 15:43:01.579487 [NOTICE] switch_loadable_module.c:338 Adding API Function 'eval' 2017-10-18 15:43:01.579511 [NOTICE] switch_loadable_module.c:338 Adding API Function 'expand' 2017-10-18 15:43:01.579543 [NOTICE] switch_loadable_module.c:338 Adding API Function 'find_user_xml' 2017-10-18 15:43:01.579582 [NOTICE] switch_loadable_module.c:338 Adding API Function 'fsctl' 2017-10-18 15:43:01.579597 [NOTICE] switch_loadable_module.c:338 Adding API Function '...' 2017-10-18 15:43:01.579604 [NOTICE] switch_loadable_module.c:338 Adding API Function 'shutdown' 2017-10-18 15:43:01.579611 [NOTICE] switch_loadable_module.c:338 Adding API Function 'version' 2017-10-18 15:43:01.579651 [NOTICE] switch_loadable_module.c:338 Adding API Function 'global_getvar' 2017-10-18 15:43:01.579680 [NOTICE] switch_loadable_module.c:338 Adding API Function 'global_setvar' 2017-10-18 15:43:01.579712 [NOTICE] switch_loadable_module.c:338 Adding API Function 'group_call' 2017-10-18 15:43:01.579755 [NOTICE] switch_loadable_module.c:338 Adding API Function 'help' 2017-10-18 15:43:01.579787 [NOTICE] switch_loadable_module.c:338 Adding API Function 'host_lookup' 2017-10-18 15:43:01.579814 [NOTICE] switch_loadable_module.c:338 Adding API Function 'hostname' 2017-10-18 15:43:01.579844 [NOTICE] switch_loadable_module.c:338 Adding API Function 'interface_ip' 2017-10-18 15:43:01.579879 [NOTICE] switch_loadable_module.c:338 Adding API Function 'switchname' 2017-10-18 15:43:01.579910 [NOTICE] switch_loadable_module.c:338 Adding API Function 'gethost' 2017-10-18 15:43:01.579939 [NOTICE] switch_loadable_module.c:338 Adding API Function 'getenv' 2017-10-18 15:43:01.579967 [NOTICE] switch_loadable_module.c:338 Adding API Function 'hupall' 2017-10-18 15:43:01.579997 [NOTICE] switch_loadable_module.c:338 Adding API Function 'in_group' 2017-10-18 15:43:01.580026 [NOTICE] switch_loadable_module.c:338 Adding API Function 'is_lan_addr' 2017-10-18 15:43:01.580056 [NOTICE] switch_loadable_module.c:338 Adding API Function 'limit_usage' 2017-10-18 15:43:01.580077 [NOTICE] switch_loadable_module.c:338 Adding API Function 'limit_hash_usage' 2017-10-18 15:43:01.580106 [NOTICE] switch_loadable_module.c:338 Adding API Function 'limit_status' 2017-10-18 15:43:01.580134 [NOTICE] switch_loadable_module.c:338 Adding API Function 'limit_reset' 2017-10-18 15:43:01.580150 [NOTICE] switch_loadable_module.c:338 Adding API Function 'limit_interval_reset' 2017-10-18 15:43:01.580186 [NOTICE] switch_loadable_module.c:338 Adding API Function 'list_users' 2017-10-18 15:43:01.580215 [NOTICE] switch_loadable_module.c:338 Adding API Function 'load' 2017-10-18 15:43:01.580234 [NOTICE] switch_loadable_module.c:338 Adding API Function 'log' 2017-10-18 15:43:01.580266 [NOTICE] switch_loadable_module.c:338 Adding API Function 'md5' 2017-10-18 15:43:01.580295 [NOTICE] switch_loadable_module.c:338 Adding API Function 'module_exists' 2017-10-18 15:43:01.580324 [NOTICE] switch_loadable_module.c:338 Adding API Function 'msleep' 2017-10-18 15:43:01.580353 [NOTICE] switch_loadable_module.c:338 Adding API Function 'nat_map' 2017-10-18 15:43:01.580401 [NOTICE] switch_loadable_module.c:338 Adding API Function 'originate' 2017-10-18 15:43:01.580420 [NOTICE] switch_loadable_module.c:338 Adding API Function 'pause' 2017-10-18 15:43:01.580449 [NOTICE] switch_loadable_module.c:338 Adding API Function 'quote_shell_arg' 2017-10-18 15:43:01.580479 [NOTICE] switch_loadable_module.c:338 Adding API Function 'regex' 2017-10-18 15:43:01.580509 [NOTICE] switch_loadable_module.c:338 Adding API Function 'reloadacl' 2017-10-18 15:43:01.580539 [NOTICE] switch_loadable_module.c:338 Adding API Function 'reload' 2017-10-18 15:43:01.580569 [NOTICE] switch_loadable_module.c:338 Adding API Function 'reloadxml' 2017-10-18 15:43:01.580586 [NOTICE] switch_loadable_module.c:338 Adding API Function 'replace' 2017-10-18 15:43:01.580616 [NOTICE] switch_loadable_module.c:338 Adding API Function 'say_string' 2017-10-18 15:43:01.580645 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sched_api' 2017-10-18 15:43:01.580674 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sched_broadcast' 2017-10-18 15:43:01.580702 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sched_del' 2017-10-18 15:43:01.580734 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sched_hangup' 2017-10-18 15:43:01.580765 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sched_transfer' 2017-10-18 15:43:01.580796 [NOTICE] switch_loadable_module.c:338 Adding API Function 'show' 2017-10-18 15:43:01.580824 [NOTICE] switch_loadable_module.c:338 Adding API Function 'sql_escape' 2017-10-18 15:43:01.580855 [NOTICE] switch_loadable_module.c:338 Adding API Function 'status' 2017-10-18 15:43:01.580886 [NOTICE] switch_loadable_module.c:338 Adding API Function 'strftime_tz' 2017-10-18 15:43:01.580916 [NOTICE] switch_loadable_module.c:338 Adding API Function 'stun' 2017-10-18 15:43:01.580947 [NOTICE] switch_loadable_module.c:338 Adding API Function 'time_test' 2017-10-18 15:43:01.580986 [NOTICE] switch_loadable_module.c:338 Adding API Function 'timer_test' 2017-10-18 15:43:01.581018 [NOTICE] switch_loadable_module.c:338 Adding API Function 'tone_detect' 2017-10-18 15:43:01.581048 [NOTICE] switch_loadable_module.c:338 Adding API Function 'unload' 2017-10-18 15:43:01.581078 [NOTICE] switch_loadable_module.c:338 Adding API Function 'unsched_api' 2017-10-18 15:43:01.581106 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uptime' 2017-10-18 15:43:01.581132 [NOTICE] switch_loadable_module.c:338 Adding API Function 'reg_url' 2017-10-18 15:43:01.581159 [NOTICE] switch_loadable_module.c:338 Adding API Function 'url_decode' 2017-10-18 15:43:01.581188 [NOTICE] switch_loadable_module.c:338 Adding API Function 'url_encode' 2017-10-18 15:43:01.581211 [NOTICE] switch_loadable_module.c:338 Adding API Function 'user_data' 2017-10-18 15:43:01.581240 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_early_ok' 2017-10-18 15:43:01.581268 [NOTICE] switch_loadable_module.c:338 Adding API Function 'user_exists' 2017-10-18 15:43:01.581297 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_answer' 2017-10-18 15:43:01.581325 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_audio' 2017-10-18 15:43:01.581353 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_break' 2017-10-18 15:43:01.581382 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_bridge' 2017-10-18 15:43:01.581421 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_broadcast' 2017-10-18 15:43:01.581449 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_buglist' 2017-10-18 15:43:01.581478 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_chat' 2017-10-18 15:43:01.581506 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_codec_debug' 2017-10-18 15:43:01.581537 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_codec_param' 2017-10-18 15:43:01.581549 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_debug_media' 2017-10-18 15:43:01.581577 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_deflect' 2017-10-18 15:43:01.581611 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_displace' 2017-10-18 15:43:01.581643 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_display' 2017-10-18 15:43:01.581664 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_drop_dtmf' 2017-10-18 15:43:01.581696 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_dump' 2017-10-18 15:43:01.581725 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_exists' 2017-10-18 15:43:01.581757 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_fileman' 2017-10-18 15:43:01.581790 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_flush_dtmf' 2017-10-18 15:43:01.581819 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_getvar' 2017-10-18 15:43:01.581850 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_hold' 2017-10-18 15:43:01.581880 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_kill' 2017-10-18 15:43:01.581911 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_send_message' 2017-10-18 15:43:01.581945 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_send_info' 2017-10-18 15:43:01.581972 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_set_media_stats' 2017-10-18 15:43:01.582005 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_video_bitrate' 2017-10-18 15:43:01.582028 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_video_refresh' 2017-10-18 15:43:01.582058 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_outgoing_answer' 2017-10-18 15:43:01.582088 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_limit' 2017-10-18 15:43:01.582113 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_limit_release' 2017-10-18 15:43:01.582142 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_limit_release' 2017-10-18 15:43:01.582168 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_loglevel' 2017-10-18 15:43:01.582202 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_media' 2017-10-18 15:43:01.582249 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_media_3p' 2017-10-18 15:43:01.582277 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_media_reneg' 2017-10-18 15:43:01.582306 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_park' 2017-10-18 15:43:01.582337 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_pause' 2017-10-18 15:43:01.582367 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_phone_event' 2017-10-18 15:43:01.582396 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_ring_ready' 2017-10-18 15:43:01.582425 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_pre_answer' 2017-10-18 15:43:01.582455 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_preprocess' 2017-10-18 15:43:01.582485 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_record' 2017-10-18 15:43:01.582516 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_recovery_refresh' 2017-10-18 15:43:01.582547 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_recv_dtmf' 2017-10-18 15:43:01.582579 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_redirect' 2017-10-18 15:43:01.582608 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_send_dtmf' 2017-10-18 15:43:01.582638 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_session_heartbeat' 2017-10-18 15:43:01.582675 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_setvar_multi' 2017-10-18 15:43:01.582699 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_setvar' 2017-10-18 15:43:01.582711 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_transfer' 2017-10-18 15:43:01.582757 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_dual_transfer' 2017-10-18 15:43:01.582785 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_simplify' 2017-10-18 15:43:01.582815 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_jitterbuffer' 2017-10-18 15:43:01.582846 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_zombie_exec' 2017-10-18 15:43:01.582876 [NOTICE] switch_loadable_module.c:338 Adding API Function 'uuid_xfer_zombie' 2017-10-18 15:43:01.582908 [NOTICE] switch_loadable_module.c:338 Adding API Function 'xml_flush_cache' 2017-10-18 15:43:01.582937 [NOTICE] switch_loadable_module.c:338 Adding API Function 'xml_locate' 2017-10-18 15:43:01.582965 [NOTICE] switch_loadable_module.c:338 Adding API Function 'xml_wrap' 2017-10-18 15:43:01.582996 [NOTICE] switch_loadable_module.c:338 Adding API Function 'file_exists' 2017-10-18 15:43:01.583029 [NOTICE] switch_loadable_module.c:338 Adding API Function 'getcputime' 2017-10-18 15:43:01.583061 [NOTICE] switch_loadable_module.c:338 Adding API Function 'json' 2017-10-18 15:43:01.583092 [NOTICE] switch_loadable_module.c:361 Adding JSON API Function 'mediaStats' 2017-10-18 15:43:01.583121 [NOTICE] switch_loadable_module.c:361 Adding JSON API Function 'status' 2017-10-18 15:43:01.583149 [NOTICE] switch_loadable_module.c:361 Adding JSON API Function 'fsapi' 2017-10-18 15:43:01.583176 [NOTICE] switch_loadable_module.c:361 Adding JSON API Function 'execute' 2017-10-18 15:43:01.583202 [NOTICE] switch_loadable_module.c:361 Adding JSON API Function 'channelData' 2017-10-18 15:43:01.584030 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_conference] 2017-10-18 15:43:01.584046 [NOTICE] switch_loadable_module.c:292 Adding Application 'conference' 2017-10-18 15:43:01.584055 [NOTICE] switch_loadable_module.c:292 Adding Application 'conference_set_auto_outcall' 2017-10-18 15:43:01.584064 [NOTICE] switch_loadable_module.c:338 Adding API Function 'conference' 2017-10-18 15:43:01.584073 [NOTICE] switch_loadable_module.c:483 Adding Chat interface 'conf' 2017-10-18 15:43:01.584164 [CONSOLE] sofia_presence.c:1619 Event Thread Started 2017-10-18 15:43:01.584825 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_db] 2017-10-18 15:43:01.584843 [NOTICE] switch_loadable_module.c:292 Adding Application 'db' 2017-10-18 15:43:01.584854 [NOTICE] switch_loadable_module.c:292 Adding Application 'group' 2017-10-18 15:43:01.584864 [NOTICE] switch_loadable_module.c:338 Adding API Function 'db' 2017-10-18 15:43:01.584871 [NOTICE] switch_loadable_module.c:338 Adding API Function 'group' 2017-10-18 15:43:01.584911 [NOTICE] switch_loadable_module.c:556 Adding Limit interface 'db' 2017-10-18 15:43:02.084458 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_dptools] 2017-10-18 15:43:02.084495 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'error' 2017-10-18 15:43:02.084531 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'group' 2017-10-18 15:43:02.084541 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'user' 2017-10-18 15:43:02.084575 [NOTICE] switch_loadable_module.c:162 Adding Endpoint 'pickup' 2017-10-18 15:43:02.084605 [NOTICE] switch_loadable_module.c:250 Adding Dialplan 'inline' 2017-10-18 15:43:02.084638 [NOTICE] switch_loadable_module.c:292 Adding Application 'blind_transfer_ack' 2017-10-18 15:43:02.084667 [NOTICE] switch_loadable_module.c:292 Adding Application 'bind_digit_action' 2017-10-18 15:43:02.084700 [NOTICE] switch_loadable_module.c:292 Adding Application 'capture' 2017-10-18 15:43:02.084727 [NOTICE] switch_loadable_module.c:292 Adding Application 'clear_digit_action' 2017-10-18 15:43:02.084756 [NOTICE] switch_loadable_module.c:292 Adding Application 'digit_action_set_realm' 2017-10-18 15:43:02.084785 [NOTICE] switch_loadable_module.c:292 Adding Application 'privacy' 2017-10-18 15:43:02.084815 [NOTICE] switch_loadable_module.c:292 Adding Application 'set_audio_level' 2017-10-18 15:43:02.084852 [NOTICE] switch_loadable_module.c:292 Adding Application 'set_mute' 2017-10-18 15:43:02.084867 [NOTICE] switch_loadable_module.c:292 Adding Application 'flush_dtmf' 2017-10-18 15:43:02.084902 [NOTICE] switch_loadable_module.c:292 Adding Application 'hold' 2017-10-18 15:43:02.084931 [NOTICE] switch_loadable_module.c:292 Adding Application 'unhold' 2017-10-18 15:43:02.084965 [NOTICE] switch_loadable_module.c:292 Adding Application 'mutex' 2017-10-18 15:43:02.084994 [NOTICE] switch_loadable_module.c:292 Adding Application 'page' 2017-10-18 15:43:02.085023 [NOTICE] switch_loadable_module.c:292 Adding Application 'transfer' 2017-10-18 15:43:02.085051 [NOTICE] switch_loadable_module.c:292 Adding Application 'check_acl' 2017-10-18 15:43:02.085079 [NOTICE] switch_loadable_module.c:292 Adding Application 'verbose_events' 2017-10-18 15:43:02.085101 [NOTICE] switch_loadable_module.c:292 Adding Application 'novideo' 2017-10-18 15:43:02.085136 [NOTICE] switch_loadable_module.c:292 Adding Application 'cng_plc' 2017-10-18 15:43:02.085163 [NOTICE] switch_loadable_module.c:292 Adding Application 'early_hangup' 2017-10-18 15:43:02.085193 [NOTICE] switch_loadable_module.c:292 Adding Application 'sleep' 2017-10-18 15:43:02.085222 [NOTICE] switch_loadable_module.c:292 Adding Application 'delay_echo' 2017-10-18 15:43:02.085254 [NOTICE] switch_loadable_module.c:292 Adding Application 'strftime' 2017-10-18 15:43:02.085286 [NOTICE] switch_loadable_module.c:292 Adding Application 'phrase' 2017-10-18 15:43:02.085316 [NOTICE] switch_loadable_module.c:292 Adding Application 'eval' 2017-10-18 15:43:02.085343 [NOTICE] switch_loadable_module.c:292 Adding Application 'set_media_stats' 2017-10-18 15:43:02.085373 [NOTICE] switch_loadable_module.c:292 Adding Application 'stop' 2017-10-18 15:43:02.085400 [NOTICE] switch_loadable_module.c:292 Adding Application 'set_zombie_exec' 2017-10-18 15:43:02.085435 [NOTICE] switch_loadable_module.c:292 Adding Application 'pre_answer' 2017-10-18 15:43:02.085454 [NOTICE] switch_loadable_module.c:292 Adding Application 'answer' 2017-10-18 15:43:02.085475 [NOTICE] switch_loadable_module.c:292 Adding Application 'wait_for_answer' 2017-10-18 15:43:02.085522 [NOTICE] switch_loadable_module.c:292 Adding Application 'hangup' 2017-10-18 15:43:02.085551 [NOTICE] switch_loadable_module.c:292 Adding Application 'set_name' 2017-10-18 15:43:02.085580 [NOTICE] switch_loadable_module.c:292 Adding Application 'presence' 2017-10-18 15:43:02.085611 [NOTICE] switch_loadable_module.c:292 Adding Application 'log' 2017-10-18 15:43:02.085635 [NOTICE] switch_loadable_module.c:292 Adding Application 'info' 2017-10-18 15:43:02.085665 [NOTICE] switch_loadable_module.c:292 Adding Application 'event' 2017-10-18 15:43:02.085694 [NOTICE] switch_loadable_module.c:292 Adding Application 'sound_test' 2017-10-18 15:43:02.085723 [NOTICE] switch_loadable_module.c:292 Adding Application 'export' 2017-10-18 15:43:02.085752 [NOTICE] switch_loadable_module.c:292 Adding Application 'bridge_export' 2017-10-18 15:43:02.085782 [NOTICE] switch_loadable_module.c:292 Adding Application 'set' 2017-10-18 15:43:02.085812 [NOTICE] switch_loadable_module.c:292 Adding Application 'multiset' 2017-10-18 15:43:02.085846 [NOTICE] switch_loadable_module.c:292 Adding Application 'push' 2017-10-18 15:43:02.085876 [NOTICE] switch_loadable_module.c:292 Adding Application 'unshift' 2017-10-18 15:43:02.085907 [NOTICE] switch_loadable_module.c:292 Adding Application 'set_global' 2017-10-18 15:43:02.085937 [NOTICE] switch_loadable_module.c:292 Adding Application 'set_profile_var' 2017-10-18 15:43:02.085968 [NOTICE] switch_loadable_module.c:292 Adding Application 'unset' 2017-10-18 15:43:02.085998 [NOTICE] switch_loadable_module.c:292 Adding Application 'multiunset' 2017-10-18 15:43:02.086030 [NOTICE] switch_loadable_module.c:292 Adding Application 'ring_ready' 2017-10-18 15:43:02.086062 [NOTICE] switch_loadable_module.c:292 Adding Application 'remove_bugs' 2017-10-18 15:43:02.086104 [NOTICE] switch_loadable_module.c:292 Adding Application 'break' 2017-10-18 15:43:02.086135 [NOTICE] switch_loadable_module.c:292 Adding Application 'detect_speech' 2017-10-18 15:43:02.086160 [NOTICE] switch_loadable_module.c:292 Adding Application 'play_and_detect_speech' 2017-10-18 15:43:02.086196 [NOTICE] switch_loadable_module.c:292 Adding Application 'ivr' 2017-10-18 15:43:02.086229 [NOTICE] switch_loadable_module.c:292 Adding Application 'redirect' 2017-10-18 15:43:02.086263 [NOTICE] switch_loadable_module.c:292 Adding Application 'video_refresh' 2017-10-18 15:43:02.086295 [NOTICE] switch_loadable_module.c:292 Adding Application 'video_decode' 2017-10-18 15:43:02.086329 [NOTICE] switch_loadable_module.c:292 Adding Application 'send_info' 2017-10-18 15:43:02.086377 [NOTICE] switch_loadable_module.c:292 Adding Application 'jitterbuffer' 2017-10-18 15:43:02.086408 [NOTICE] switch_loadable_module.c:292 Adding Application 'send_display' 2017-10-18 15:43:02.086442 [NOTICE] switch_loadable_module.c:292 Adding Application 'respond' 2017-10-18 15:43:02.086477 [NOTICE] switch_loadable_module.c:292 Adding Application 'deflect' 2017-10-18 15:43:02.086522 [NOTICE] switch_loadable_module.c:292 Adding Application 'recovery_refresh' 2017-10-18 15:43:02.086559 [NOTICE] switch_loadable_module.c:292 Adding Application 'queue_dtmf' 2017-10-18 15:43:02.086590 [NOTICE] switch_loadable_module.c:292 Adding Application 'send_dtmf' 2017-10-18 15:43:02.086622 [NOTICE] switch_loadable_module.c:292 Adding Application 'sched_cancel' 2017-10-18 15:43:02.086669 [NOTICE] switch_loadable_module.c:292 Adding Application 'sched_hangup' 2017-10-18 15:43:02.086703 [NOTICE] switch_loadable_module.c:292 Adding Application 'sched_broadcast' 2017-10-18 15:43:02.086741 [NOTICE] switch_loadable_module.c:292 Adding Application 'sched_transfer' 2017-10-18 15:43:02.086774 [NOTICE] switch_loadable_module.c:292 Adding Application 'execute_extension' 2017-10-18 15:43:02.086806 [NOTICE] switch_loadable_module.c:292 Adding Application 'sched_heartbeat' 2017-10-18 15:43:02.086846 [NOTICE] switch_loadable_module.c:292 Adding Application 'enable_heartbeat' 2017-10-18 15:43:02.086887 [NOTICE] switch_loadable_module.c:292 Adding Application 'enable_keepalive' 2017-10-18 15:43:02.086919 [NOTICE] switch_loadable_module.c:292 Adding Application 'media_reset' 2017-10-18 15:43:02.086958 [NOTICE] switch_loadable_module.c:292 Adding Application 'mkdir' 2017-10-18 15:43:02.086997 [NOTICE] switch_loadable_module.c:292 Adding Application 'rename' 2017-10-18 15:43:02.087029 [NOTICE] switch_loadable_module.c:292 Adding Application 'transfer_vars' 2017-10-18 15:43:02.087061 [NOTICE] switch_loadable_module.c:292 Adding Application 'soft_hold' 2017-10-18 15:43:02.087093 [NOTICE] switch_loadable_module.c:292 Adding Application 'bind_meta_app' 2017-10-18 15:43:02.087122 [NOTICE] switch_loadable_module.c:292 Adding Application 'unbind_meta_app' 2017-10-18 15:43:02.087157 [NOTICE] switch_loadable_module.c:292 Adding Application 'block_dtmf' 2017-10-18 15:43:02.087175 [NOTICE] switch_loadable_module.c:292 Adding Application 'unblock_dtmf' 2017-10-18 15:43:02.087205 [NOTICE] switch_loadable_module.c:292 Adding Application 'intercept' 2017-10-18 15:43:02.087235 [NOTICE] switch_loadable_module.c:292 Adding Application 'eavesdrop' 2017-10-18 15:43:02.087273 [NOTICE] switch_loadable_module.c:292 Adding Application 'three_way' 2017-10-18 15:43:02.087304 [NOTICE] switch_loadable_module.c:292 Adding Application 'set_user' 2017-10-18 15:43:02.087334 [NOTICE] switch_loadable_module.c:292 Adding Application 'stop_dtmf' 2017-10-18 15:43:02.087360 [NOTICE] switch_loadable_module.c:292 Adding Application 'start_dtmf' 2017-10-18 15:43:02.087388 [NOTICE] switch_loadable_module.c:292 Adding Application 'stop_dtmf_generate' 2017-10-18 15:43:02.087421 [NOTICE] switch_loadable_module.c:292 Adding Application 'start_dtmf_generate' 2017-10-18 15:43:02.087451 [NOTICE] switch_loadable_module.c:292 Adding Application 'stop_tone_detect' 2017-10-18 15:43:02.087480 [NOTICE] switch_loadable_module.c:292 Adding Application 'fax_detect' 2017-10-18 15:43:02.087519 [NOTICE] switch_loadable_module.c:292 Adding Application 'tone_detect' 2017-10-18 15:43:02.087548 [NOTICE] switch_loadable_module.c:292 Adding Application 'echo' 2017-10-18 15:43:02.087576 [NOTICE] switch_loadable_module.c:292 Adding Application 'park' 2017-10-18 15:43:02.087605 [NOTICE] switch_loadable_module.c:292 Adding Application 'park_state' 2017-10-18 15:43:02.087636 [NOTICE] switch_loadable_module.c:292 Adding Application 'gentones' 2017-10-18 15:43:02.087667 [NOTICE] switch_loadable_module.c:292 Adding Application 'playback' 2017-10-18 15:43:02.087696 [NOTICE] switch_loadable_module.c:292 Adding Application 'endless_playback' 2017-10-18 15:43:02.087729 [NOTICE] switch_loadable_module.c:292 Adding Application 'loop_playback' 2017-10-18 15:43:02.087757 [NOTICE] switch_loadable_module.c:292 Adding Application 'att_xfer' 2017-10-18 15:43:02.087786 [NOTICE] switch_loadable_module.c:292 Adding Application 'read' 2017-10-18 15:43:02.087815 [NOTICE] switch_loadable_module.c:292 Adding Application 'play_and_get_digits' 2017-10-18 15:43:02.087846 [NOTICE] switch_loadable_module.c:292 Adding Application 'stop_video_write_overlay' 2017-10-18 15:43:02.087877 [NOTICE] switch_loadable_module.c:292 Adding Application 'video_write_overlay' 2017-10-18 15:43:02.087911 [NOTICE] switch_loadable_module.c:292 Adding Application 'stop_record_session' 2017-10-18 15:43:02.087940 [NOTICE] switch_loadable_module.c:292 Adding Application 'record_session' 2017-10-18 15:43:02.087972 [NOTICE] switch_loadable_module.c:292 Adding Application 'record_session_mask' 2017-10-18 15:43:02.088003 [NOTICE] switch_loadable_module.c:292 Adding Application 'record_session_unmask' 2017-10-18 15:43:02.088032 [NOTICE] switch_loadable_module.c:292 Adding Application 'record' 2017-10-18 15:43:02.088065 [NOTICE] switch_loadable_module.c:292 Adding Application 'preprocess' 2017-10-18 15:43:02.088095 [NOTICE] switch_loadable_module.c:292 Adding Application 'stop_displace_session' 2017-10-18 15:43:02.088122 [NOTICE] switch_loadable_module.c:292 Adding Application 'displace_session' 2017-10-18 15:43:02.088154 [NOTICE] switch_loadable_module.c:292 Adding Application 'speak' 2017-10-18 15:43:02.088183 [NOTICE] switch_loadable_module.c:292 Adding Application 'clear_speech_cache' 2017-10-18 15:43:02.088213 [NOTICE] switch_loadable_module.c:292 Adding Application 'bridge' 2017-10-18 15:43:02.088244 [NOTICE] switch_loadable_module.c:292 Adding Application 'system' 2017-10-18 15:43:02.088272 [NOTICE] switch_loadable_module.c:292 Adding Application 'bgsystem' 2017-10-18 15:43:02.088302 [NOTICE] switch_loadable_module.c:292 Adding Application 'say' 2017-10-18 15:43:02.088333 [NOTICE] switch_loadable_module.c:292 Adding Application 'detect_audio' 2017-10-18 15:43:02.088382 [NOTICE] switch_loadable_module.c:292 Adding Application 'detect_silence' 2017-10-18 15:43:02.088404 [NOTICE] switch_loadable_module.c:292 Adding Application 'wait_for_silence' 2017-10-18 15:43:02.088431 [NOTICE] switch_loadable_module.c:292 Adding Application 'session_loglevel' 2017-10-18 15:43:02.088464 [NOTICE] switch_loadable_module.c:292 Adding Application 'limit' 2017-10-18 15:43:02.088494 [NOTICE] switch_loadable_module.c:292 Adding Application 'limit_hash' 2017-10-18 15:43:02.088527 [NOTICE] switch_loadable_module.c:292 Adding Application 'limit_execute' 2017-10-18 15:43:02.088561 [NOTICE] switch_loadable_module.c:292 Adding Application 'limit_hash_execute' 2017-10-18 15:43:02.088591 [NOTICE] switch_loadable_module.c:292 Adding Application 'pickup' 2017-10-18 15:43:02.088621 [NOTICE] switch_loadable_module.c:292 Adding Application 'deduplicate_dtmf' 2017-10-18 15:43:02.088652 [NOTICE] switch_loadable_module.c:338 Adding API Function 'strepoch' 2017-10-18 15:43:02.088683 [NOTICE] switch_loadable_module.c:338 Adding API Function 'page' 2017-10-18 15:43:02.088714 [NOTICE] switch_loadable_module.c:338 Adding API Function 'strmicroepoch' 2017-10-18 15:43:02.088744 [NOTICE] switch_loadable_module.c:338 Adding API Function 'chat' 2017-10-18 15:43:02.088775 [NOTICE] switch_loadable_module.c:338 Adding API Function 'strftime' 2017-10-18 15:43:02.088806 [NOTICE] switch_loadable_module.c:338 Adding API Function 'presence' 2017-10-18 15:43:02.088837 [NOTICE] switch_loadable_module.c:390 Adding File Format 'file_string' 2017-10-18 15:43:02.088868 [NOTICE] switch_loadable_module.c:390 Adding File Format 'file' 2017-10-18 15:43:02.088899 [NOTICE] switch_loadable_module.c:483 Adding Chat interface 'event' 2017-10-18 15:43:02.088928 [NOTICE] switch_loadable_module.c:483 Adding Chat interface 'api' 2017-10-18 15:43:02.089298 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_expr] 2017-10-18 15:43:02.089313 [NOTICE] switch_loadable_module.c:338 Adding API Function 'expr' 2017-10-18 15:43:02.090360 [INFO] switch_core_sqldb.c:1693 fifo Starting SQL thread. 2017-10-18 15:43:02.094858 [INFO] mod_fifo.c:4627 cool_fifo@ccc-prod-fs2.objectbrains.com configured 2017-10-18 15:43:02.094951 [CONSOLE] switch_loadable_module.c:1540 Successfully Loaded [mod_fifo] 2017-10-18 15:43:02.094968 [NOTICE] switch_loadable_module.c:292 Adding Application 'fifo' 2017-10-18 15:43:02.095002 [NOTICE] switch_loadable_module.c:292 Adding Application 'fifo_track_call' 2017-10-18 15:43:02.095019 [NOTICE] switch_loadable_module.c:338 Adding API Function 'fifo' 2017-10-18 15:43:02.095046 [NOTICE] switch_loadable_module.c:338 Adding API Function 'fifo_member' 2017-10-18 15:43:02.095072 [NOTICE] switch_loadable_module.c:338 Adding API Function 'fifo_add_outbound' 2017-10-18 15:43:02.095105 [NOTICE] switch_loadable_module.c:338 Adding API Function 'fifo_check_bridge' 2017-10-18 15:43:02.095486 [DEBUG] switch_scheduler.c:249 Added task 4 limit_hash_cleanup (mod_hash)