[2016-12-20 12:34:37] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:34:37] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:34:37] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:34:37] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:34:37] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:34:37] DEBUG[18062] http.c: HTTP opening session. Top level [2016-12-20 12:34:37] DEBUG[18062] http.c: Match made with [ari] [2016-12-20 12:34:37] DEBUG[18062] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:37] DEBUG[18062] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:37] DEBUG[18062] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:37] DEBUG[18062] http.c: HTTP closing session. Top level [2016-12-20 12:34:38] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:34:38] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:34:38] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:34:38] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:34:38] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:34:38] DEBUG[18063] http.c: HTTP opening session. Top level [2016-12-20 12:34:38] DEBUG[18063] http.c: Match made with [ari] [2016-12-20 12:34:38] DEBUG[18063] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:38] DEBUG[18063] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:38] DEBUG[18063] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:38] DEBUG[18063] http.c: HTTP closing session. Top level [2016-12-20 12:34:40] DEBUG[18064] http.c: HTTP opening session. Top level [2016-12-20 12:34:40] DEBUG[18064] http.c: Match made with [ari] [2016-12-20 12:34:40] DEBUG[18064] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:40] DEBUG[18064] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:40] DEBUG[18064] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:40] DEBUG[18064] http.c: HTTP closing session. Top level [2016-12-20 12:34:41] DEBUG[18065] http.c: HTTP opening session. Top level [2016-12-20 12:34:41] DEBUG[18065] http.c: Match made with [ari] [2016-12-20 12:34:41] DEBUG[18065] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:41] DEBUG[18065] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:41] DEBUG[18065] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:41] DEBUG[18065] http.c: HTTP closing session. Top level [2016-12-20 12:34:42] DEBUG[18066] http.c: HTTP opening session. Top level [2016-12-20 12:34:42] DEBUG[18066] http.c: Match made with [ari] [2016-12-20 12:34:42] DEBUG[18066] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:42] DEBUG[18066] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:42] DEBUG[18066] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:42] DEBUG[18066] http.c: HTTP closing session. Top level [2016-12-20 12:34:43] DEBUG[18067] http.c: HTTP opening session. Top level [2016-12-20 12:34:43] DEBUG[18067] http.c: Match made with [ari] [2016-12-20 12:34:43] DEBUG[18067] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:43] DEBUG[18067] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:43] DEBUG[18067] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:43] DEBUG[18067] http.c: HTTP closing session. Top level [2016-12-20 12:34:44] DEBUG[18068] http.c: HTTP opening session. Top level [2016-12-20 12:34:44] DEBUG[18068] http.c: Match made with [ari] [2016-12-20 12:34:44] DEBUG[18068] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:44] DEBUG[18068] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:44] DEBUG[18068] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:44] DEBUG[18068] http.c: HTTP closing session. Top level [2016-12-20 12:34:45] DEBUG[18069] http.c: HTTP opening session. Top level [2016-12-20 12:34:45] DEBUG[18069] http.c: Match made with [ari] [2016-12-20 12:34:45] DEBUG[18069] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:45] DEBUG[18069] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:45] DEBUG[18069] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:45] DEBUG[18069] http.c: HTTP closing session. Top level [2016-12-20 12:34:46] DEBUG[18070] http.c: HTTP opening session. Top level [2016-12-20 12:34:46] DEBUG[18070] http.c: Match made with [ari] [2016-12-20 12:34:46] DEBUG[18070] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:46] DEBUG[18070] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:46] DEBUG[18070] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:46] DEBUG[18070] http.c: HTTP closing session. Top level [2016-12-20 12:34:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:34:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255287' [2016-12-20 12:34:48] DEBUG[18071] http.c: HTTP opening session. Top level [2016-12-20 12:34:48] DEBUG[18071] http.c: Match made with [ari] [2016-12-20 12:34:48] DEBUG[18071] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:48] DEBUG[18071] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:48] DEBUG[18071] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:48] DEBUG[18071] http.c: HTTP closing session. Top level [2016-12-20 12:34:48] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:34:48] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:34:48] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:34:48] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:34:48] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:34:49] DEBUG[18073] http.c: HTTP opening session. Top level [2016-12-20 12:34:49] DEBUG[18073] http.c: Match made with [ari] [2016-12-20 12:34:49] DEBUG[18073] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:49] DEBUG[18073] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:49] DEBUG[18073] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:49] DEBUG[18073] http.c: HTTP closing session. Top level [2016-12-20 12:34:49] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:34:49] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:34:49] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:34:49] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:34:49] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:34:50] DEBUG[18074] http.c: HTTP opening session. Top level [2016-12-20 12:34:50] DEBUG[18074] http.c: Match made with [ari] [2016-12-20 12:34:50] DEBUG[18074] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:50] DEBUG[18074] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:50] DEBUG[18074] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:50] DEBUG[18074] http.c: HTTP closing session. Top level [2016-12-20 12:34:51] DEBUG[18075] http.c: HTTP opening session. Top level [2016-12-20 12:34:51] DEBUG[18075] http.c: Match made with [ari] [2016-12-20 12:34:51] DEBUG[18075] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:51] DEBUG[18075] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:51] DEBUG[18075] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:51] DEBUG[18075] http.c: HTTP closing session. Top level [2016-12-20 12:34:53] DEBUG[18076] http.c: HTTP opening session. Top level [2016-12-20 12:34:53] DEBUG[18076] http.c: Match made with [ari] [2016-12-20 12:34:53] DEBUG[18076] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:53] DEBUG[18076] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:53] DEBUG[18076] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:53] DEBUG[18076] http.c: HTTP closing session. Top level [2016-12-20 12:34:54] DEBUG[18077] http.c: HTTP opening session. Top level [2016-12-20 12:34:54] DEBUG[18077] http.c: Match made with [ari] [2016-12-20 12:34:54] DEBUG[18077] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:54] DEBUG[18077] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:54] DEBUG[18077] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:54] DEBUG[18077] http.c: HTTP closing session. Top level [2016-12-20 12:34:55] DEBUG[18078] http.c: HTTP opening session. Top level [2016-12-20 12:34:55] DEBUG[18078] http.c: Match made with [ari] [2016-12-20 12:34:55] DEBUG[18078] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:55] DEBUG[18078] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:55] DEBUG[18078] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:55] DEBUG[18078] http.c: HTTP closing session. Top level [2016-12-20 12:34:57] DEBUG[18079] http.c: HTTP opening session. Top level [2016-12-20 12:34:57] DEBUG[18079] http.c: Match made with [ari] [2016-12-20 12:34:57] DEBUG[18079] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:57] DEBUG[18079] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:57] DEBUG[18079] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:57] DEBUG[18079] http.c: HTTP closing session. Top level [2016-12-20 12:34:58] DEBUG[18080] http.c: HTTP opening session. Top level [2016-12-20 12:34:58] DEBUG[18080] http.c: Match made with [ari] [2016-12-20 12:34:58] DEBUG[18080] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:58] DEBUG[18080] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:58] DEBUG[18080] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:58] DEBUG[18080] http.c: HTTP closing session. Top level [2016-12-20 12:34:59] DEBUG[18081] http.c: HTTP opening session. Top level [2016-12-20 12:34:59] DEBUG[18081] http.c: Match made with [ari] [2016-12-20 12:34:59] DEBUG[18081] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:34:59] DEBUG[18081] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:34:59] DEBUG[18081] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:34:59] DEBUG[18081] http.c: HTTP closing session. Top level [2016-12-20 12:35:00] DEBUG[18082] http.c: HTTP opening session. Top level [2016-12-20 12:35:00] DEBUG[18082] http.c: Match made with [ari] [2016-12-20 12:35:00] DEBUG[18082] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:00] DEBUG[18082] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:00] DEBUG[18082] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:00] DEBUG[18082] http.c: HTTP closing session. Top level [2016-12-20 12:35:01] Asterisk 13.12.2 built by root @ voip on a x86_64 running Linux on 2016-12-19 21:56:50 UTC [2016-12-20 12:35:01] DEBUG[18056] config.c: Parsing /etc/asterisk/logger.conf [2016-12-20 12:35:02] DEBUG[18083] http.c: HTTP opening session. Top level [2016-12-20 12:35:02] DEBUG[18083] http.c: Match made with [ari] [2016-12-20 12:35:02] DEBUG[18083] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:02] DEBUG[18083] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:02] DEBUG[18083] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:02] DEBUG[18083] http.c: HTTP closing session. Top level [2016-12-20 12:35:03] DEBUG[18084] http.c: HTTP opening session. Top level [2016-12-20 12:35:03] DEBUG[18084] http.c: Match made with [ari] [2016-12-20 12:35:03] DEBUG[18084] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:03] DEBUG[18084] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:03] DEBUG[18084] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:03] DEBUG[18084] http.c: HTTP closing session. Top level [2016-12-20 12:35:03] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:03] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:35:03] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:03] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:35:03] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:04] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:04] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:35:04] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:04] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:35:04] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:04] DEBUG[18085] http.c: HTTP opening session. Top level [2016-12-20 12:35:04] DEBUG[18085] http.c: Match made with [ari] [2016-12-20 12:35:04] DEBUG[18085] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:04] DEBUG[18085] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:04] DEBUG[18085] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:04] DEBUG[18085] http.c: HTTP closing session. Top level [2016-12-20 12:35:06] DEBUG[18086] http.c: HTTP opening session. Top level [2016-12-20 12:35:06] DEBUG[18086] http.c: Match made with [ari] [2016-12-20 12:35:06] DEBUG[18086] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:06] DEBUG[18086] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:06] DEBUG[18086] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:06] DEBUG[18086] http.c: HTTP closing session. Top level [2016-12-20 12:35:07] DEBUG[18087] http.c: HTTP opening session. Top level [2016-12-20 12:35:07] DEBUG[18087] http.c: Match made with [ari] [2016-12-20 12:35:07] DEBUG[18087] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:07] DEBUG[18087] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:07] DEBUG[18087] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:07] DEBUG[18087] http.c: HTTP closing session. Top level [2016-12-20 12:35:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:35:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:35:07] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:08] DEBUG[18088] http.c: HTTP opening session. Top level [2016-12-20 12:35:08] DEBUG[18088] http.c: Match made with [ari] [2016-12-20 12:35:08] DEBUG[18088] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:08] DEBUG[18088] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:08] DEBUG[18088] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:08] DEBUG[18088] http.c: HTTP closing session. Top level [2016-12-20 12:35:08] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:08] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:35:08] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:08] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:35:08] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:08] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:08] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:35:08] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:08] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:35:08] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:09] DEBUG[18089] http.c: HTTP opening session. Top level [2016-12-20 12:35:09] DEBUG[18089] http.c: Match made with [ari] [2016-12-20 12:35:09] DEBUG[18089] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:09] DEBUG[18089] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:09] DEBUG[18089] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:09] DEBUG[18089] http.c: HTTP closing session. Top level [2016-12-20 12:35:09] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:09] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:35:09] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:09] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:35:09] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:10] DEBUG[18090] http.c: HTTP opening session. Top level [2016-12-20 12:35:10] DEBUG[18090] http.c: Match made with [ari] [2016-12-20 12:35:10] DEBUG[18090] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:10] DEBUG[18090] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:10] DEBUG[18090] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:10] DEBUG[18090] http.c: HTTP closing session. Top level [2016-12-20 12:35:11] DEBUG[18091] http.c: HTTP opening session. Top level [2016-12-20 12:35:11] DEBUG[18091] http.c: Match made with [ari] [2016-12-20 12:35:11] DEBUG[18091] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:11] DEBUG[18091] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:11] DEBUG[18091] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:11] DEBUG[18091] http.c: HTTP closing session. Top level [2016-12-20 12:35:12] DEBUG[18092] http.c: HTTP opening session. Top level [2016-12-20 12:35:12] DEBUG[18092] http.c: Match made with [ari] [2016-12-20 12:35:12] DEBUG[18092] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:12] DEBUG[18092] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:12] DEBUG[18092] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:12] DEBUG[18092] http.c: HTTP closing session. Top level [2016-12-20 12:35:13] DEBUG[18093] http.c: HTTP opening session. Top level [2016-12-20 12:35:13] DEBUG[18093] http.c: Match made with [ari] [2016-12-20 12:35:13] DEBUG[18093] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:13] DEBUG[18093] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:13] DEBUG[18093] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:13] DEBUG[18093] http.c: HTTP closing session. Top level [2016-12-20 12:35:15] DEBUG[18094] http.c: HTTP opening session. Top level [2016-12-20 12:35:15] DEBUG[18094] http.c: Match made with [ari] [2016-12-20 12:35:15] DEBUG[18094] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:15] DEBUG[18094] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:15] DEBUG[18094] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:15] DEBUG[18094] http.c: HTTP closing session. Top level [2016-12-20 12:35:16] DEBUG[18095] http.c: HTTP opening session. Top level [2016-12-20 12:35:16] DEBUG[18095] http.c: Match made with [ari] [2016-12-20 12:35:16] DEBUG[18095] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:16] DEBUG[18095] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:16] DEBUG[18095] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:16] DEBUG[18095] http.c: HTTP closing session. Top level [2016-12-20 12:35:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:35:16] DEBUG[14197] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:35:16] DEBUG[14198] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:35:16] DEBUG[14198] chan_iax2.c: Peer switchvox: got pong, lastms 1, historicms 1, maxms 2000 [2016-12-20 12:35:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:35:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255317' [2016-12-20 12:35:17] DEBUG[18096] http.c: HTTP opening session. Top level [2016-12-20 12:35:17] DEBUG[18096] http.c: Match made with [ari] [2016-12-20 12:35:17] DEBUG[18096] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:17] DEBUG[18096] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:17] DEBUG[18096] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:17] DEBUG[18096] http.c: HTTP closing session. Top level [2016-12-20 12:35:18] DEBUG[18097] http.c: HTTP opening session. Top level [2016-12-20 12:35:18] DEBUG[18097] http.c: Match made with [ari] [2016-12-20 12:35:18] DEBUG[18097] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:18] DEBUG[18097] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:18] DEBUG[18097] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:18] DEBUG[18097] http.c: HTTP closing session. Top level [2016-12-20 12:35:19] DEBUG[18098] http.c: HTTP opening session. Top level [2016-12-20 12:35:19] DEBUG[18098] http.c: Match made with [ari] [2016-12-20 12:35:19] DEBUG[18098] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:19] DEBUG[18098] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:19] DEBUG[18098] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:19] DEBUG[18098] http.c: HTTP closing session. Top level [2016-12-20 12:35:19] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:19] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:35:19] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:19] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:35:19] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:20] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:20] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:35:20] DEBUG[18100] http.c: HTTP opening session. Top level [2016-12-20 12:35:20] DEBUG[18100] http.c: Match made with [ari] [2016-12-20 12:35:20] DEBUG[18100] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:20] DEBUG[18100] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:20] DEBUG[18100] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:20] DEBUG[18100] http.c: HTTP closing session. Top level [2016-12-20 12:35:20] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:20] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:35:20] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:22] DEBUG[18101] http.c: HTTP opening session. Top level [2016-12-20 12:35:22] DEBUG[18101] http.c: Match made with [ari] [2016-12-20 12:35:22] DEBUG[18101] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:22] DEBUG[18101] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:22] DEBUG[18101] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:22] DEBUG[18101] http.c: HTTP closing session. Top level [2016-12-20 12:35:23] DEBUG[18105] http.c: HTTP opening session. Top level [2016-12-20 12:35:23] DEBUG[18105] http.c: Match made with [ari] [2016-12-20 12:35:23] DEBUG[18105] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:23] DEBUG[18105] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:23] DEBUG[18105] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:23] DEBUG[18105] http.c: HTTP closing session. Top level [2016-12-20 12:35:24] DEBUG[18106] http.c: HTTP opening session. Top level [2016-12-20 12:35:24] DEBUG[18106] http.c: Match made with [ari] [2016-12-20 12:35:24] DEBUG[18106] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:24] DEBUG[18106] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:24] DEBUG[18106] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:24] DEBUG[18106] http.c: HTTP closing session. Top level [2016-12-20 12:35:25] DEBUG[18107] http.c: HTTP opening session. Top level [2016-12-20 12:35:25] DEBUG[18107] http.c: Match made with [ari] [2016-12-20 12:35:25] DEBUG[18107] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:25] DEBUG[18107] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:25] DEBUG[18107] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:25] DEBUG[18107] http.c: HTTP closing session. Top level [2016-12-20 12:35:26] DEBUG[18108] http.c: HTTP opening session. Top level [2016-12-20 12:35:26] DEBUG[18108] http.c: Match made with [ari] [2016-12-20 12:35:26] DEBUG[18108] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:26] DEBUG[18108] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:26] DEBUG[18108] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:26] DEBUG[18108] http.c: HTTP closing session. Top level [2016-12-20 12:35:27] DEBUG[18109] http.c: HTTP opening session. Top level [2016-12-20 12:35:27] DEBUG[18109] http.c: Match made with [ari] [2016-12-20 12:35:27] DEBUG[18109] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:27] DEBUG[18109] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:27] DEBUG[18109] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:27] DEBUG[18109] http.c: HTTP closing session. Top level [2016-12-20 12:35:28] DEBUG[18110] http.c: HTTP opening session. Top level [2016-12-20 12:35:28] DEBUG[18110] http.c: Match made with [ari] [2016-12-20 12:35:28] DEBUG[18110] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:28] DEBUG[18110] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:28] DEBUG[18110] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:28] DEBUG[18110] http.c: HTTP closing session. Top level [2016-12-20 12:35:29] DEBUG[18111] http.c: HTTP opening session. Top level [2016-12-20 12:35:29] DEBUG[18111] http.c: Match made with [ari] [2016-12-20 12:35:29] DEBUG[18111] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:29] DEBUG[18111] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:29] DEBUG[18111] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:29] DEBUG[18111] http.c: HTTP closing session. Top level [2016-12-20 12:35:31] DEBUG[18112] http.c: HTTP opening session. Top level [2016-12-20 12:35:31] DEBUG[18112] http.c: Match made with [ari] [2016-12-20 12:35:31] DEBUG[18112] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:31] DEBUG[18112] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:31] DEBUG[18112] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:31] DEBUG[18112] http.c: HTTP closing session. Top level [2016-12-20 12:35:32] DEBUG[18113] http.c: HTTP opening session. Top level [2016-12-20 12:35:32] DEBUG[18113] http.c: Match made with [ari] [2016-12-20 12:35:32] DEBUG[18113] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:32] DEBUG[18113] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:32] DEBUG[18113] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:32] DEBUG[18113] http.c: HTTP closing session. Top level [2016-12-20 12:35:33] DEBUG[18114] http.c: HTTP opening session. Top level [2016-12-20 12:35:33] DEBUG[18114] http.c: Match made with [ari] [2016-12-20 12:35:33] DEBUG[18114] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:33] DEBUG[18114] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:33] DEBUG[18114] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:33] DEBUG[18114] http.c: HTTP closing session. Top level [2016-12-20 12:35:34] DEBUG[18115] http.c: HTTP opening session. Top level [2016-12-20 12:35:34] DEBUG[18115] http.c: Match made with [ari] [2016-12-20 12:35:34] DEBUG[18115] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:34] DEBUG[18115] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:34] DEBUG[18115] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:34] DEBUG[18115] http.c: HTTP closing session. Top level [2016-12-20 12:35:34] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:34] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:35:34] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:34] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:35:34] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:35] DEBUG[18116] http.c: HTTP opening session. Top level [2016-12-20 12:35:35] DEBUG[18116] http.c: Match made with [ari] [2016-12-20 12:35:35] DEBUG[18116] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:35] DEBUG[18116] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:35] DEBUG[18116] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:35] DEBUG[18116] http.c: HTTP closing session. Top level [2016-12-20 12:35:35] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:35] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:35:35] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:35] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:35:35] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:36] DEBUG[18117] http.c: HTTP opening session. Top level [2016-12-20 12:35:36] DEBUG[18117] http.c: Match made with [ari] [2016-12-20 12:35:36] DEBUG[18117] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:36] DEBUG[18117] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:36] DEBUG[18117] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:36] DEBUG[18117] http.c: HTTP closing session. Top level [2016-12-20 12:35:37] DEBUG[18118] http.c: HTTP opening session. Top level [2016-12-20 12:35:37] DEBUG[18118] http.c: Match made with [ari] [2016-12-20 12:35:37] DEBUG[18118] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:37] DEBUG[18118] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:37] DEBUG[18118] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:37] DEBUG[18118] http.c: HTTP closing session. Top level [2016-12-20 12:35:39] DEBUG[18119] http.c: HTTP opening session. Top level [2016-12-20 12:35:39] DEBUG[18119] http.c: Match made with [ari] [2016-12-20 12:35:39] DEBUG[18119] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:39] DEBUG[18119] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:39] DEBUG[18119] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:39] DEBUG[18119] http.c: HTTP closing session. Top level [2016-12-20 12:35:39] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:39] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:35:39] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:39] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:35:39] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:40] DEBUG[18120] http.c: HTTP opening session. Top level [2016-12-20 12:35:40] DEBUG[18120] http.c: Match made with [ari] [2016-12-20 12:35:40] DEBUG[18120] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:40] DEBUG[18120] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:40] DEBUG[18120] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:40] DEBUG[18120] http.c: HTTP closing session. Top level [2016-12-20 12:35:40] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:40] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:35:40] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:40] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:35:40] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:41] DEBUG[18121] http.c: HTTP opening session. Top level [2016-12-20 12:35:41] DEBUG[18121] http.c: Match made with [ari] [2016-12-20 12:35:41] DEBUG[18121] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:41] DEBUG[18121] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:41] DEBUG[18121] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:41] DEBUG[18121] http.c: HTTP closing session. Top level [2016-12-20 12:35:42] DEBUG[18122] http.c: HTTP opening session. Top level [2016-12-20 12:35:42] DEBUG[18122] http.c: Match made with [ari] [2016-12-20 12:35:42] DEBUG[18122] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:42] DEBUG[18122] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:42] DEBUG[18122] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:42] DEBUG[18122] http.c: HTTP closing session. Top level [2016-12-20 12:35:43] DEBUG[18123] http.c: HTTP opening session. Top level [2016-12-20 12:35:43] DEBUG[18123] http.c: Match made with [ari] [2016-12-20 12:35:43] DEBUG[18123] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:35:43] DEBUG[18123] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:35:43] DEBUG[18123] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:35:43] DEBUG[18123] http.c: HTTP closing session. Top level [2016-12-20 12:35:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:35:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255347' [2016-12-20 12:35:50] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:50] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:35:50] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:50] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:35:51] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:51] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:35:51] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:51] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:51] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:35:51] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:52] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:52] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:35:52] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:52] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:35:52] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:35:52] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:52] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:35:52] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:35:52] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:35:52] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:05] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:05] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:36:05] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:05] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:36:05] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:36:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:36:07] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:10] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:10] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:36:10] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:10] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:36:10] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:11] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:11] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:36:11] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:11] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:36:11] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:36:16] DEBUG[14200] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:36:16] DEBUG[14201] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:36:16] DEBUG[14201] chan_iax2.c: Peer switchvox: got pong, lastms 3, historicms 3, maxms 2000 [2016-12-20 12:36:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:36:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255377' [2016-12-20 12:36:22] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:22] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:36:22] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:22] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:36:22] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:23] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:23] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:36:23] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:23] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:36:23] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:28] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:28] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:36:28] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:28] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:36:28] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:29] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:29] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:36:29] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:29] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:36:29] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:37] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:37] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:36:37] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:37] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:36:37] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:38] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:38] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:36:38] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:38] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:36:38] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:41] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:41] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:36:41] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:41] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:36:41] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:42] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:42] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:36:43] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:43] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:36:43] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:36:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255407' [2016-12-20 12:36:53] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:53] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:36:53] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:53] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:36:53] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:36:54] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:54] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:36:54] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:36:54] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:36:54] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:05] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:05] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:37:05] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:05] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:37:05] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:06] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:06] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:37:06] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:06] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:37:06] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:08] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:08] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:37:08] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:08] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:37:08] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:09] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:09] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:37:09] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:09] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:37:09] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:13] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:13] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:37:13] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:13] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:37:13] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:14] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:14] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:37:14] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:14] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:37:14] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:37:16] DEBUG[14203] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:37:16] DEBUG[14204] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:37:16] DEBUG[14204] chan_iax2.c: Peer switchvox: got pong, lastms 1, historicms 1, maxms 2000 [2016-12-20 12:37:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:37:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255437' [2016-12-20 12:37:24] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:24] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:37:24] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:24] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:37:24] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:25] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:25] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:37:25] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:25] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:37:25] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:39] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:39] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:37:39] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:39] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:37:39] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:40] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:40] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:37:40] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:40] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:37:40] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:44] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:44] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:37:44] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:44] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:37:44] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:45] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:45] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:37:45] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:45] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:37:45] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:37:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255467' [2016-12-20 12:37:48] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:48] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:37:48] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:48] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:37:48] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:49] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:49] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:37:49] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:49] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:37:49] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:55] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:55] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:37:55] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:55] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:37:55] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:37:57] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:57] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:37:57] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:37:57] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:37:57] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:10] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:10] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:38:10] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:10] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:38:10] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:11] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:11] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:38:11] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:11] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:38:11] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:15] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:15] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:38:15] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:15] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:38:15] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:16] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:16] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:38:16] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:16] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:38:16] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:38:16] DEBUG[14196] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:38:16] DEBUG[14197] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:38:16] DEBUG[14197] chan_iax2.c: Peer switchvox: got pong, lastms 1, historicms 1, maxms 2000 [2016-12-20 12:38:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:38:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255497' [2016-12-20 12:38:25] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:25] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:38:25] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:25] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:38:25] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:26] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:26] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:38:26] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:26] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:38:26] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:27] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:27] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:38:27] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:27] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:38:27] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:28] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:28] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:38:28] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:28] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:38:28] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:41] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:41] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:38:41] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:41] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:38:41] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:42] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:42] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:38:42] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:42] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:38:42] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:46] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:46] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:38:46] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:46] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:38:46] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:38:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255527' [2016-12-20 12:38:47] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:47] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:38:47] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:47] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:38:47] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:58] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:58] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:38:58] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:58] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:38:58] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:38:59] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:59] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:38:59] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:38:59] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:38:59] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:02] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:02] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:39:02] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:02] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:39:02] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:03] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:03] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:39:03] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:03] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:39:03] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:12] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:12] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:39:12] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:12] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:39:12] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:13] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:13] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:39:13] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:13] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:39:13] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:39:16] DEBUG[14199] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:39:16] DEBUG[14200] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:39:16] DEBUG[14200] chan_iax2.c: Peer switchvox: got pong, lastms 1, historicms 1, maxms 2000 [2016-12-20 12:39:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:39:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255557' [2016-12-20 12:39:17] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:17] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:39:17] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:17] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:39:17] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:18] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:18] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:39:18] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:18] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:39:18] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '100@1.1.1.1' [2016-12-20 12:39:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '100' [2016-12-20 12:39:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = 'anonymous@1.1.1.1' [2016-12-20 12:39:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = 'anonymous' [2016-12-20 12:39:29] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:29] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:39:29] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:29] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:39:29] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:31] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:31] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:39:31] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:31] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:39:31] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:39] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:39] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:39:39] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:39] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:39:39] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:41] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:41] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:39:41] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:41] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:39:41] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:43] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:43] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:39:43] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:43] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:39:43] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:44] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:44] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:39:44] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:44] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:39:44] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:39:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255587' [2016-12-20 12:39:48] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:48] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:39:48] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:48] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:39:48] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:39:49] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:49] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:39:49] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:39:49] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:39:49] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:01] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:01] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:40:01] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:01] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:40:01] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:02] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:02] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:40:02] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:02] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:40:02] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:10] DEBUG[18185] http.c: HTTP opening session. Top level [2016-12-20 12:40:10] DEBUG[18185] http.c: Match made with [ari] [2016-12-20 12:40:10] DEBUG[18185] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:10] DEBUG[18185] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:10] DEBUG[18185] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:10] DEBUG[18185] http.c: HTTP closing session. Top level [2016-12-20 12:40:10] DEBUG[18186] http.c: HTTP opening session. Top level [2016-12-20 12:40:10] DEBUG[18186] http.c: Match made with [ari] [2016-12-20 12:40:10] DEBUG[18186] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:10] DEBUG[18186] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:10] DEBUG[18186] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:10] DEBUG[18186] http.c: HTTP closing session. Top level [2016-12-20 12:40:11] DEBUG[18187] http.c: HTTP opening session. Top level [2016-12-20 12:40:11] DEBUG[18187] http.c: Match made with [ari] [2016-12-20 12:40:11] DEBUG[18187] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:11] DEBUG[18187] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:11] DEBUG[18187] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:11] DEBUG[18187] http.c: HTTP closing session. Top level [2016-12-20 12:40:11] DEBUG[18188] http.c: HTTP opening session. Top level [2016-12-20 12:40:11] DEBUG[18188] http.c: Match made with [ari] [2016-12-20 12:40:11] DEBUG[18188] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:11] DEBUG[18188] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:11] DEBUG[18188] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:11] DEBUG[18188] http.c: HTTP closing session. Top level [2016-12-20 12:40:12] DEBUG[18189] http.c: HTTP opening session. Top level [2016-12-20 12:40:12] DEBUG[18189] http.c: Match made with [ari] [2016-12-20 12:40:12] DEBUG[18189] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:12] DEBUG[18189] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:12] DEBUG[18189] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:12] DEBUG[18189] http.c: HTTP closing session. Top level [2016-12-20 12:40:12] DEBUG[18190] http.c: HTTP opening session. Top level [2016-12-20 12:40:12] DEBUG[18190] http.c: Match made with [ari] [2016-12-20 12:40:12] DEBUG[18190] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:12] DEBUG[18190] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:12] DEBUG[18190] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:12] DEBUG[18190] http.c: HTTP closing session. Top level [2016-12-20 12:40:13] DEBUG[18193] http.c: HTTP opening session. Top level [2016-12-20 12:40:13] DEBUG[18193] http.c: Match made with [rawman] [2016-12-20 12:40:13] DEBUG[18193] manager.c: HTTP Manager add header Action: Login [2016-12-20 12:40:13] DEBUG[18193] manager.c: HTTP Manager add header Username: USERNAME [2016-12-20 12:40:13] DEBUG[18193] manager.c: HTTP Manager add header Secret: PASSWORD [2016-12-20 12:40:13] DEBUG[18193] manager.c: Running action 'Login' [2016-12-20 12:40:13] DEBUG[18193] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:13] DEBUG[18193] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:13] DEBUG[18193] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:13] DEBUG[18193] http.c: HTTP closing session. Top level [2016-12-20 12:40:13] DEBUG[18194] http.c: HTTP opening session. Top level [2016-12-20 12:40:13] DEBUG[18194] http.c: Match made with [rawman] [2016-12-20 12:40:13] DEBUG[18194] http.c: HTTP Cookie, Name: 'mansession_id' Value: '9987e1b8' [2016-12-20 12:40:13] DEBUG[18194] manager.c: HTTP Manager add header Action: SorceryMemoryCacheStaleObject [2016-12-20 12:40:13] DEBUG[18194] manager.c: HTTP Manager add header cache: res_pjsip/endpoint [2016-12-20 12:40:13] DEBUG[18194] manager.c: HTTP Manager add header object: 2 [2016-12-20 12:40:13] DEBUG[18194] manager.c: Running action 'SorceryMemoryCacheStaleObject' [2016-12-20 12:40:13] DEBUG[18194] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:13] DEBUG[18194] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:13] DEBUG[18194] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:13] DEBUG[18194] http.c: HTTP closing session. Top level [2016-12-20 12:40:13] DEBUG[18195] http.c: HTTP opening session. Top level [2016-12-20 12:40:13] DEBUG[18195] http.c: Match made with [rawman] [2016-12-20 12:40:13] DEBUG[18195] manager.c: HTTP Manager add header Action: Login [2016-12-20 12:40:13] DEBUG[18195] manager.c: HTTP Manager add header Username: USERNAME [2016-12-20 12:40:13] DEBUG[18195] manager.c: HTTP Manager add header Secret: PASSWORD [2016-12-20 12:40:13] DEBUG[18195] manager.c: Running action 'Login' [2016-12-20 12:40:13] DEBUG[18195] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:13] DEBUG[18195] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:13] DEBUG[18195] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:13] DEBUG[18195] http.c: HTTP closing session. Top level [2016-12-20 12:40:13] DEBUG[18196] http.c: HTTP opening session. Top level [2016-12-20 12:40:13] DEBUG[18196] http.c: Match made with [rawman] [2016-12-20 12:40:13] DEBUG[18196] http.c: HTTP Cookie, Name: 'mansession_id' Value: 'c038f26a' [2016-12-20 12:40:13] DEBUG[18196] manager.c: HTTP Manager add header Action: SorceryMemoryCacheStaleObject [2016-12-20 12:40:13] DEBUG[18196] manager.c: HTTP Manager add header cache: res_pjsip/endpoint [2016-12-20 12:40:13] DEBUG[18196] manager.c: HTTP Manager add header object: 5 [2016-12-20 12:40:13] DEBUG[18196] manager.c: Running action 'SorceryMemoryCacheStaleObject' [2016-12-20 12:40:13] DEBUG[18196] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:13] DEBUG[18196] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:13] DEBUG[18196] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:13] DEBUG[18196] http.c: HTTP closing session. Top level [2016-12-20 12:40:14] DEBUG[18197] http.c: HTTP opening session. Top level [2016-12-20 12:40:14] DEBUG[18197] http.c: Match made with [ari] [2016-12-20 12:40:14] DEBUG[18197] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:14] DEBUG[18197] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:14] DEBUG[18197] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:14] DEBUG[18197] http.c: HTTP closing session. Top level [2016-12-20 12:40:14] DEBUG[18198] http.c: HTTP opening session. Top level [2016-12-20 12:40:14] DEBUG[18198] http.c: Match made with [ari] [2016-12-20 12:40:14] DEBUG[18198] http.c: HTTP keeping session open. status_code:200 [2016-12-20 12:40:14] DEBUG[18198] tcptls.c: TLS clean shutdown alert reading data [2016-12-20 12:40:14] DEBUG[18198] http.c: HTTP idle timeout or peer closed connection. [2016-12-20 12:40:14] DEBUG[18198] http.c: HTTP closing session. Top level [2016-12-20 12:40:14] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:14] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:40:14] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:14] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:40:14] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:15] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:15] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:40:15] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:15] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:40:15] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:40:16] DEBUG[14202] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:40:16] DEBUG[14203] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:40:16] DEBUG[14203] chan_iax2.c: Peer switchvox: got pong, lastms 1, historicms 1, maxms 2000 [2016-12-20 12:40:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:40:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255617' [2016-12-20 12:40:19] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:19] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:40:19] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:19] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:40:19] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:40:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:40:21] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:23] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:23] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:40:23] DEBUG[14541] res_sorcery_memory_cache.c: Cached sorcery object type 'endpoint' ID '2' is stale. Refreshing [2016-12-20 12:40:23] DEBUG[14173] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:23] DEBUG[14173] res_config_odbc.c: Parameter 1 ('id') = '2' [2016-12-20 12:40:23] DEBUG[14173] res_sorcery_realtime.c: Filtering out realtime field 'disallow' from retrieval [2016-12-20 12:40:23] DEBUG[14173] res_sorcery_memory_cache.c: Refreshing stale cache object type 'endpoint' ID '2' [2016-12-20 12:40:23] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:23] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:40:23] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:24] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:24] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:40:24] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:24] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:40:24] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:32] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:32] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:40:32] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:32] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:40:32] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:33] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:33] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:40:33] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:33] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:40:33] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:45] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:45] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:40:45] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:45] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:40:45] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:47] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:47] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:40:47] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:47] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:40:47] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:40:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255647' [2016-12-20 12:40:51] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:51] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:40:51] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:51] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:40:51] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:40:52] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:52] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:40:52] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:40:52] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:40:52] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:00] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:00] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:41:00] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:00] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:41:00] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:01] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:01] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:41:01] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:01] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:41:01] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:03] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:03] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:41:03] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:03] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:41:03] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:04] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:04] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:41:04] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:04] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:41:04] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:41:16] DEBUG[14195] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:41:16] DEBUG[14196] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:41:16] DEBUG[14196] chan_iax2.c: Peer switchvox: got pong, lastms 1, historicms 1, maxms 2000 [2016-12-20 12:41:17] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:17] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:41:17] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:17] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:41:17] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:41:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255677' [2016-12-20 12:41:18] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:18] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:41:18] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:18] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:41:18] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:22] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:22] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:41:22] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:22] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:41:22] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:23] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:23] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:41:23] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:23] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:41:23] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:34] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:34] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:41:34] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:34] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:41:34] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:36] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:36] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:41:36] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:36] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:41:36] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:37] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:37] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:41:37] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:37] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:41:37] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:38] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:38] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:41:38] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:38] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:41:38] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:41:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255707' [2016-12-20 12:41:48] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:48] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:41:48] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:48] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:41:48] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:49] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:49] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:41:49] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:49] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:41:49] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:53] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:53] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:41:53] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:53] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:41:53] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:41:54] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:54] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:41:54] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:41:54] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:41:54] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:06] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:06] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:42:06] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:06] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:42:06] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:42:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:42:07] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:42:16] DEBUG[14198] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:42:16] DEBUG[14199] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:42:16] DEBUG[14199] chan_iax2.c: Peer switchvox: got pong, lastms 1, historicms 1, maxms 2000 [2016-12-20 12:42:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:42:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255737' [2016-12-20 12:42:19] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:19] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:42:19] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:19] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:42:19] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:20] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:20] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:42:20] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:20] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:42:20] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:20] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:20] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:42:20] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:20] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:42:20] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:42:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:42:21] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:24] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:24] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:42:24] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:24] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:42:24] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:25] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:25] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:42:25] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:25] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:42:25] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:37] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:37] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:42:37] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:37] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:42:37] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:38] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:38] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:42:38] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:38] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:42:38] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:42:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255767' [2016-12-20 12:42:50] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:50] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:42:50] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:50] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:42:50] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:51] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:51] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:42:51] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:51] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:42:51] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:55] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:55] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:42:55] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:55] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:42:55] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:56] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:56] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:42:56] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:56] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:42:56] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:57] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:57] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:42:57] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:57] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:42:57] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:42:58] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:58] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:42:58] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:42:58] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:42:58] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE id LIKE ? ORDER BY id [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id LIKE') = '4;@%' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: UPDATE ps_contacts SET qualify_timeout=?, reg_server=?, call_id=?, via_addr=?, outbound_proxy=?, expiration_time=?, path=?, endpoint=?, qualify_frequency=?, user_agent=?, authenticate_qualify=?, uri=?, via_port=? WHERE id=? [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('qualify_timeout') = '3.000000' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 2 ('reg_server') = '' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 3 ('call_id') = '202898393-58249-1@BJC.BGI.A.BB' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 4 ('via_addr') = '192.168.0.11' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 5 ('outbound_proxy') = '' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 6 ('expiration_time') = '1482259387' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 7 ('path') = '' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 8 ('endpoint') = '4' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 9 ('qualify_frequency') = '60' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 10 ('user_agent') = 'user agent' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 11 ('authenticate_qualify') = 'yes' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 12 ('uri') = 'sip:4@contact string' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 13 ('via_port') = '39734' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 14 = '4;@f8bdf2a7b2f7be4a711efb2c6f5ae558' [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE id LIKE ? ORDER BY id [2016-12-20 12:43:07] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id LIKE') = '4;@%' [2016-12-20 12:43:07] DEBUG[18203] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE id LIKE ? ORDER BY id [2016-12-20 12:43:07] DEBUG[18203] res_config_odbc.c: Parameter 1 ('id LIKE') = '4;@%' [2016-12-20 12:43:09] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:09] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:09] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:09] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:09] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:10] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:10] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:10] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:10] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:10] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:43:16] DEBUG[14201] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:43:16] DEBUG[14202] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:43:16] DEBUG[14202] chan_iax2.c: Peer switchvox: got pong, lastms 1, historicms 1, maxms 2000 [2016-12-20 12:43:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:43:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255797' [2016-12-20 12:43:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:43:21] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:21] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:43:21] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:22] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:22] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:43:22] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:22] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:43:22] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:26] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:26] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:43:26] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:26] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:43:26] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:27] DEBUG[18204] threadpool.c: Worker thread idle timeout reached. Dying. [2016-12-20 12:43:27] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:27] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:43:27] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:27] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:43:27] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:35] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:35] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:43:35] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:35] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:43:35] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:36] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:36] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:43:36] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:36] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:43:36] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:40] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:40] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:40] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:40] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:40] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:42] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:42] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:42] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:42] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:43:42] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:43:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255827' [2016-12-20 12:43:52] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:52] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:43:52] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:52] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:43:52] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:53] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:53] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:43:53] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:53] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:43:53] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:57] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:57] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:43:57] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:57] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:43:57] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:43:59] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:59] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:43:59] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:43:59] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:43:59] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:07] DEBUG[18205] threadpool.c: Worker thread idle timeout reached. Dying. [2016-12-20 12:44:07] DEBUG[18206] threadpool.c: Worker thread idle timeout reached. Dying. [2016-12-20 12:44:07] DEBUG[18208] threadpool.c: Worker thread idle timeout reached. Dying. [2016-12-20 12:44:07] DEBUG[18207] threadpool.c: Worker thread idle timeout reached. Dying. [2016-12-20 12:44:07] DEBUG[18209] threadpool.c: Worker thread idle timeout reached. Dying. [2016-12-20 12:44:07] DEBUG[18203] threadpool.c: Worker thread idle timeout reached. Dying. [2016-12-20 12:44:12] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:12] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:44:12] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:12] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:44:12] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:13] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:13] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:44:13] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:13] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:44:13] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:16] DEBUG[14193] chan_iax2.c: ip callno count decremented to 0 for IP ADDRESS [2016-12-20 12:44:16] DEBUG[14204] chan_iax2.c: ip callno count incremented to 1 for IP ADDRESS [2016-12-20 12:44:16] DEBUG[14195] chan_iax2.c: schedule decrement of callno used for IP ADDRESS in 60 seconds [2016-12-20 12:44:16] DEBUG[14195] chan_iax2.c: Peer switchvox: got pong, lastms 3, historicms 3, maxms 2000 [2016-12-20 12:44:17] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:44:17] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255857' [2016-12-20 12:44:18] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:18] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:44:18] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:18] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:44:18] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:19] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:19] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:44:19] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:19] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:44:19] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:23] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:23] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:44:23] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:23] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:44:23] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:24] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:24] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:44:24] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:24] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:44:24] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:29] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:29] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:44:29] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:29] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:44:29] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:30] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:30] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:44:30] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:30] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:44:30] DEBUG[14541] res_pjsip_mwi.c: AOR 3 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:43] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:43] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:44:43] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:43] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:44:43] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:44] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:44] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:44:44] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:44] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '4@asterisk' [2016-12-20 12:44:44] DEBUG[14541] res_pjsip_mwi.c: AOR 4 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:47] DEBUG[14208] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_contacts WHERE expiration_time <= ? ORDER BY expiration_time [2016-12-20 12:44:47] DEBUG[14208] res_config_odbc.c: Parameter 1 ('expiration_time <=') = '1482255887' [2016-12-20 12:44:54] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:54] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:44:54] DEBUG[14541] res_sorcery_memory_cache.c: Cached sorcery object type 'endpoint' ID '1' is stale. Refreshing [2016-12-20 12:44:54] DEBUG[14541] res_sorcery_memory_cache.c: Cached sorcery object type 'auth' ID '1' is stale. Refreshing [2016-12-20 12:44:54] DEBUG[14173] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:54] DEBUG[14173] res_config_odbc.c: Parameter 1 ('id') = '1' [2016-12-20 12:44:54] DEBUG[14173] res_sorcery_realtime.c: Filtering out realtime field 'disallow' from retrieval [2016-12-20 12:44:54] DEBUG[14173] res_sorcery_memory_cache.c: Refreshing stale cache object type 'endpoint' ID '1' [2016-12-20 12:44:54] DEBUG[14173] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_auths WHERE id = ? [2016-12-20 12:44:54] DEBUG[14173] res_config_odbc.c: Parameter 1 ('id') = '1' [2016-12-20 12:44:54] DEBUG[14173] res_sorcery_memory_cache.c: Refreshing stale cache object type 'auth' ID '1' [2016-12-20 12:44:54] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:54] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:44:54] DEBUG[14541] res_sorcery_memory_cache.c: Cached sorcery object type 'aor' ID '1' is stale. Refreshing [2016-12-20 12:44:54] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:54] DEBUG[14173] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_aors WHERE id = ? [2016-12-20 12:44:54] DEBUG[14173] res_config_odbc.c: Parameter 1 ('id') = '1' [2016-12-20 12:44:54] DEBUG[14173] res_sorcery_memory_cache.c: Refreshing stale cache object type 'aor' ID '1' [2016-12-20 12:44:55] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:55] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:44:55] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:55] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:44:55] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:55] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:55] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:44:55] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:55] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '1@asterisk' [2016-12-20 12:44:55] DEBUG[14541] res_pjsip_mwi.c: AOR 1 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:44:56] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:56] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:44:56] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:44:56] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '2@asterisk' [2016-12-20 12:44:56] DEBUG[14541] res_pjsip_mwi.c: AOR 2 has no configured mailboxes. MWI subscription failed. [2016-12-20 12:45:00] DEBUG[14541] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:45:00] DEBUG[14541] res_config_odbc.c: Parameter 1 ('id') = '3@asterisk' [2016-12-20 12:45:00] DEBUG[14541] res_sorcery_memory_cache.c: Cached sorcery object type 'endpoint' ID '3' is stale. Refreshing [2016-12-20 12:45:00] DEBUG[14173] res_config_odbc.c: Skip: 0; SQL: SELECT * FROM ps_endpoints WHERE id = ? [2016-12-20 12:45:00] DEBUG[14173] res_config_odbc.c: Parameter 1 ('id') = '3' [2016-12-20 12:45:00] DEBUG[14173] res_sorcery_realtime.c: Filtering out realtime field 'disallow' from retrieval [2016-12-20 12:45:00] DEBUG[14173] res_sorcery_memory_cache.c: Refreshing stale cache object type 'endpoint' ID '3' [2016-12-20 13:50:10] Asterisk 13.12.2 built by root @ voip on a x86_64 running Linux on 2016-12-19 21:56:50 UTC