Summary:	ASTERISK-30208: runtests.py hangs forever if Asterisk cannot start
Reporter:	N A (InterLinked)	Labels:
Date Opened:	2022-09-01 15:21:25	Date Closed:
Priority:	Minor	Regression?
Status:	Open/New	Components:	Tests/testsuite
Versions:	18.14.0	Frequency of Occurrence	Constant
Related Issues:
Environment:	Linux debian11 5.10.0-12-amd64 #1 SMP Debian 5.10.103-1 (2022-03-07) x86_64 GNU/Linux	Attachments:
Description:	If Asterisk fails to start for a test, then runtests.py just hangs forever until it gets a SIGINT. Probably only a minor issue - this shouldn't happen, but if it happens, then the tests aren't going to pass anyway, so it only happens if there's another problem. From log/messages.txt: {noformat} [Sep 01 09:52:09] INFO[2716462]: asterisk.test_case:168 __init__: Executing tests/apps/agents/agent_acknowledge/agent_acknowledge_error [Sep 01 09:52:09] INFO[2716462]: asterisk.test_case:279 create_asterisk: Creating Asterisk instance 1 [Sep 01 09:52:09] INFO[2716462]: asterisk.test_case:458 _start_asterisk: Starting Asterisk instance 1 [Sep 01 09:52:09] WARNING[2716462]: asterisk.asterisk:246 errReceived: Asterisk 127.0.0.1 received error: ASTdb initialization failed.  ASTERISK EXITING! [Sep 01 09:52:18] INFO[2716462]: twisted:147 publishToNewObserver: Received SIGINT, shutting down. [Sep 01 09:52:18] INFO[2716462]: twisted:147 publishToNewObserver: Main loop terminated. [Sep 01 09:52:18] INFO[2716462]: test_runner:312 main: Test run for tests/apps/agents/agent_acknowledge/agent_acknowledge_error completed with result None [Sep 01 09:52:18] CRITICAL[2716462]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 09:52:18] CRITICAL[2716462]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 09:52:18] CRITICAL[2716462]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 09:52:18] CRITICAL[2716462]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 09:52:18] CRITICAL[2716462]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 09:52:18] CRITICAL[2716462]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 09:52:18] CRITICAL[2716462]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 09:52:38] INFO[2716483]: asterisk.test_case:168 __init__: Executing tests/apps/agents/agent_acknowledge/agent_acknowledge_error [Sep 01 09:52:38] INFO[2716483]: asterisk.test_case:279 create_asterisk: Creating Asterisk instance 1 [Sep 01 09:52:38] INFO[2716483]: asterisk.test_case:458 _start_asterisk: Starting Asterisk instance 1 [Sep 01 09:52:38] WARNING[2716483]: asterisk.asterisk:246 errReceived: Asterisk 127.0.0.1 received error: ASTdb initialization failed.  ASTERISK EXITING! [Sep 01 09:52:39] INFO[2716483]: twisted:147 publishToNewObserver: Received SIGINT, shutting down. [Sep 01 09:52:39] INFO[2716483]: twisted:147 publishToNewObserver: Main loop terminated. [Sep 01 09:52:39] INFO[2716483]: test_runner:312 main: Test run for tests/apps/agents/agent_acknowledge/agent_acknowledge_error completed with result None [Sep 01 11:24:20] INFO[2720252]: asterisk.test_case:168 __init__: Executing tests/apps/agents/agent_acknowledge/agent_acknowledge_error [Sep 01 11:24:20] INFO[2720252]: asterisk.test_case:279 create_asterisk: Creating Asterisk instance 1 [Sep 01 11:24:20] INFO[2720252]: asterisk.test_case:458 _start_asterisk: Starting Asterisk instance 1 [Sep 01 11:24:20] WARNING[2720252]: asterisk.asterisk:246 errReceived: Asterisk 127.0.0.1 received error: ASTdb initialization failed.  ASTERISK EXITING! [Sep 01 11:24:22] INFO[2720252]: twisted:147 publishToNewObserver: Received SIGINT, shutting down. [Sep 01 11:24:22] INFO[2720252]: twisted:147 publishToNewObserver: Main loop terminated. [Sep 01 11:24:22] INFO[2720252]: test_runner:312 main: Test run for tests/apps/agents/agent_acknowledge/agent_acknowledge_error completed with result None [Sep 01 15:50:41] INFO[2724484]: asterisk.test_case:168 __init__: Executing tests/apps/assert [Sep 01 15:50:41] INFO[2724484]: asterisk.test_case:279 create_asterisk: Creating Asterisk instance 1 [Sep 01 15:50:41] INFO[2724484]: asterisk.test_case:458 _start_asterisk: Starting Asterisk instance 1 [Sep 01 15:50:42] WARNING[2724484]: asterisk.asterisk:246 errReceived: Asterisk 127.0.0.1 received error: ASTdb initialization failed.  ASTERISK EXITING! [Sep 01 15:50:54] INFO[2724484]: twisted:147 publishToNewObserver: Received SIGINT, shutting down. [Sep 01 15:50:54] INFO[2724484]: twisted:147 publishToNewObserver: Main loop terminated. [Sep 01 15:50:54] INFO[2724484]: test_runner:312 main: Test run for tests/apps/assert completed with result None [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:50:54] CRITICAL[2724484]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:51:53] INFO[2724533]: asterisk.test_case:168 __init__: Executing tests/apps/agents/agent_acknowledge/agent_acknowledge_error [Sep 01 15:51:53] INFO[2724533]: asterisk.test_case:279 create_asterisk: Creating Asterisk instance 1 [Sep 01 15:51:53] INFO[2724533]: asterisk.test_case:458 _start_asterisk: Starting Asterisk instance 1 [Sep 01 15:51:53] WARNING[2724533]: asterisk.asterisk:246 errReceived: Asterisk 127.0.0.1 received error: ASTdb initialization failed.  ASTERISK EXITING! [Sep 01 15:52:26] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:52:26] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:52:26] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:50] INFO[2724533]: twisted:147 publishToNewObserver: Received SIGINT, shutting down. [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] CRITICAL[2724533]: twisted:147 publishToNewObserver: Unhandled error in Deferred: [Sep 01 15:57:51] INFO[2724533]: twisted:147 publishToNewObserver: Main loop terminated. [Sep 01 15:57:51] INFO[2724533]: test_runner:312 main: Test run for tests/apps/agents/agent_acknowledge/agent_acknowledge_error completed with result None {noformat}
Comments:	By: Asterisk Team (asteriskteam) 2022-09-01 15:21:29.352-0500 Thanks for creating a report! The issue has entered the triage process. That means the issue will wait in this status until a Bug Marshal has an opportunity to review the issue. Once the issue has been reviewed you will receive comments regarding the next steps towards resolution. Please note that log messages and other files should not be sent to the Sangoma Asterisk Team unless explicitly asked for. All files should be placed on this issue in a sanitized fashion as needed. A good first step is for you to review the [Asterisk Issue Guidelines|https://wiki.asterisk.org/wiki/display/AST/Asterisk+Issue+Guidelines] if you haven't already. The guidelines detail what is expected from an Asterisk issue report. Then, if you are submitting a patch, please review the [Patch Contribution Process|https://wiki.asterisk.org/wiki/display/AST/Patch+Contribution+Process]. Please note that once your issue enters an open state it has been accepted. As Asterisk is an open source project there is no guarantee or timeframe on when your issue will be looked into. If you need expedient resolution you will need to find and pay a suitable developer. Asking for an update on your issue will not yield any progress on it and will not result in a response. All updates are posted to the issue when they occur. Please note that by submitting data, code, or documentation to Sangoma through JIRA, you accept the Terms of Use present at [https://www.asterisk.org/terms-of-use/|https://www.asterisk.org/terms-of-use/].