[LBBS-80] mod_mimeparse: Occasional segfault when running tests
mod_mimeparse can sometimes cause issues when unloaded:
[2024-11-14 14:19:12.851] [1;32m DEBUG[0m[37137]: [1;37mmodule.c:1600 unload_modules_helper[0m: Attempting to unload mod_mimeparse.so
[2024-11-14 14:19:12.854] [1;32m DEBUG[0m[37137]: [1;37mmodule.c:1612 unload_modules_helper[0m: Module mod_mimeparse.so previously was in use but unloaded on pass 2
[2024-11-14 14:19:12.855] [1;32m DEBUG[0m[37137]: [1;37mmodule.c:310 logged_dlclose[0m: dlclose: mod_mimeparse
[2024-11-14 14:19:12.855] === Unregistering module mod_mimeparse
[2024-11-14 14:19:13.333] [1;32m DEBUG[0m: test.c:886 run_test: Child process 37137 has exited
[2024-11-14 14:19:13.333] [1;31m ERROR[0m: test.c:889 run_test: Process 37137 (/home/runner/work/lbbs/lbbs/tests/test_imap.so) killed, signal Segmentation fault
[2024-11-14 14:19:13.333] [1;32m DEBUG[0m: test.c:895 run_test: Test return code so far is 0
[2024-11-14 14:19:13.333] [1;32m DEBUG[0m: test.c:396 io_relay: read returned 0
==37137== Thread 3:
==37137== Jump to the invalid address stated on the next line
==37137== at 0x621D683: ???
==37137== by 0x158F01: thread_run (thread.c:411)
==37137== by 0x50FBA93: start_thread (pthread_create.c:447)
==37137== by 0x5188A33: clone (clone.S:100)
==37137== Address 0x621d683 is in the Text segment of /usr/lib/lbbs/modules/net_smtp.so
==37137== at 0x621D683: ???
==37137==
==37137==
==37137== Process terminating with default action of signal 11 (SIGSEGV): dumping core
==37137== Access not within mapped region at address 0x621D683
==37137== at 0x621D683: ???
==37137== by 0x158F01: thread_run (thread.c:411)
==37137== by 0x50FBA93: start_thread (pthread_create.c:447)
==37137== by 0x5188A33: clone (clone.S:100)
==37137== If you believe this happened as a result of a stack
==37137== overflow in your program's main thread (unlikely but
==37137== possible), you can try to increase the size of the
==37137== main thread stack using the --main-stacksize= flag.
==37137== The main thread stack size used in this run was 8388608.Another example: https://github.com/InterLinked1/lbbs/actions/runs/12060196582/job/33630180204
==37299== 1 errors in context 1 of 3:
==37299== Thread 3:
==37299== Jump to the invalid address stated on the next line
==37299== at 0x621D6B3: ???
==37299== by 0x159BF1: thread_run (thread.c:411)
==37299== by 0x50FBA93: start_thread (pthread_create.c:447)
==37299== by 0x5188A33: clone (clone.S:100)
==37299== Address 0x621d6b3 is in the Text segment of /usr/lib/lbbs/modules/net_smtp.so
==37299== at 0x621D6B3: ???Another example:
[2025-03-04 02:33:34.597] === Unregistering module mod_mail
[2025-03-04 02:33:34.599] [1;32m DEBUG[0m[37582]: [1;37mmodule.c:1856 unload_modules_helper[0m: Attempting to unload mod_mimeparse.so
[2025-03-04 02:33:34.603] [1;32m DEBUG[0m[37582]: [1;37mmodule.c:1868 unload_modules_helper[0m: Module mod_mimeparse.so previously was in use but unloaded on pass 2
[2025-03-04 02:33:34.603] [1;32m DEBUG[0m[37582]: [1;37mmodule.c:330 logged_dlclose[0m: dlclose: mod_mimeparse
[2025-03-04 02:33:34.603] === Unregistering module mod_mimeparse
[2025-03-04 02:33:35.518] [1;32m DEBUG[0m: test.c:894 run_test: Child process 37582 has exited
[2025-03-04 02:33:35.518] [1;31m ERROR[0m: test.c:897 run_test: Process 37582 (/home/runner/work/lbbs/lbbs/tests/test_imap.so) killed, signal Segmentation fault
[2025-03-04 02:33:35.518] [1;32m DEBUG[0m: test.c:905 run_test: Test return code so far is 0
[2025-03-04 02:33:35.518] [1;32m DEBUG[0m: test.c:401 io_relay: read returned 0
==37582== Thread 3:
==37582== Jump to the invalid address stated on the next line
==37582== at 0x56670B3: ???
==37582== by 0x159DC1: thread_run (thread.c:421)
==37582== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37582== by 0x5068A33: clone (clone.S:100)
==37582== Address 0x56670b3 is in the Text segment of /usr/lib/lbbs/modules/net_smtp.so
==37582== at 0x56670B3: ???
==37582==
==37582==
==37582== Process terminating with default action of signal 11 (SIGSEGV): dumping core
==37582== Access not within mapped region at address 0x56670B3
==37582== at 0x56670B3: ???
==37582== by 0x159DC1: thread_run (thread.c:421)
==37582== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37582== by 0x5068A33: clone (clone.S:100)
==37582== If you believe this happened as a result of a stack
==37582== overflow in your program's main thread (unlikely but
==37582== possible), you can try to increase the size of the
==37582== main thread stack using the --main-stacksize= flag.
==37582== The main thread stack size used in this run was 8388608.And another:
[2025-03-04 03:57:40.510] DEBUG[26762]: module.c:1856 unload_modules_helper: Attempting to unload net_imap.so
[2025-03-04 03:57:40.516] DEBUG[26762]: module.c:907 dec_refcounts: net_imap no longer depends on module mod_mail.so
[2025-03-04 03:57:40.507] DEBUG[26769]: node.c:698 node_free: Node 4 now freed
[2025-03-04 03:57:40.517] DEBUG[26762]: module.c:907 dec_refcounts: net_imap no longer depends on module mod_mimeparse.so
[2025-03-04 03:57:40.519] DEBUG[26762]: module.c:330 logged_dlclose: dlclose: net_imap
[2025-03-04 03:57:40.517] DEBUG[26765]: socket.c:738 tcp_multilistener: TCP multilistener is now watching 2 sockets
[2025-03-04 03:57:40.520] === Unregistering module net_imap
[2025-03-04 03:57:40.521] DEBUG[26762]: module.c:1856 unload_modules_helper: Attempting to unload net_smtp.so
[2025-03-04 03:57:40.524] DEBUG[26762]: module.c:907 dec_refcounts: net_smtp no longer depends on module mod_mail.so
[2025-03-04 03:57:40.525] DEBUG[26762]: module.c:330 logged_dlclose: dlclose: net_smtp
[2025-03-04 03:57:40.525] === Unregistering module net_smtp
[2025-03-04 03:57:40.529] DEBUG[26762]: module.c:1856 unload_modules_helper: Attempting to unload mod_mail.so
[2025-03-04 03:57:40.531] DEBUG[26762]: module.c:1868 unload_modules_helper: Module mod_mail.so previously was in use but unloaded on pass 2
[2025-03-04 03:57:40.521] == Node 4 has exited
[2025-03-04 03:57:40.531] DEBUG[26762]: module.c:330 logged_dlclose: dlclose: mod_mail
[2025-03-04 03:57:40.532] === Unregistering module mod_mail
[2025-03-04 03:57:41.407] DEBUG: test.c:898 run_test: Child process 26762 has exited
[2025-03-04 03:57:41.407] ERROR: test.c:901 run_test: Process 26762 (/home/runner/work/lbbs/lbbs/tests/test_imap_msn.so) killed, signal Segmentation fault
[2025-03-04 03:57:41.407] DEBUG: test.c:909 run_test: Test return code so far is 0
[2025-03-04 03:57:41.407] DEBUG: test.c:401 io_relay: read returned 0
==26762== Thread 6:
==26762== Jump to the invalid address stated on the next line
==26762== at 0x5CD2622: ???
==26762== by 0x156F14: thread_run (thread.c:421)
==26762== by 0x4F16AC2: start_thread (pthread_create.c:442)
==26762== by 0x4FA7A03: clone (clone.S:100)
==26762== Address 0x5cd2622 is in the Text segment of /usr/lib/lbbs/modules/net_imap.so
==26762== at 0x5CD2622: ???
==26762==
==26762==
==26762== Process terminating with default action of signal 11 (SIGSEGV): dumping core
==26762== Access not within mapped region at address 0x5CD2622
==26762== at 0x5CD2622: ???
==26762== by 0x156F14: thread_run (thread.c:421)
==26762== by 0x4F16AC2: start_thread (pthread_create.c:442)
==26762== by 0x4FA7A03: clone (clone.S:100)
==26762== If you believe this happened as a result of a stack
==26762== overflow in your program's main thread (unlikely but
==26762== possible), you can try to increase the size of the
==26762== main thread stack using the --main-stacksize= flag.
==26762== The main thread stack size used in this run was 8388608.And another:
[2025-03-05 02:19:21.207] [1;32m DEBUG[0m[37580]: [1;37mmodule.c:935 dec_refcounts[0m: net_imap no longer depends on module mod_mimeparse.so
[2025-03-05 02:19:21.208] [1;32m DEBUG[0m[37580]: [1;37mmodule.c:347 logged_dlclose[0m: dlclose: net_imap
[2025-03-05 02:19:21.209] === Unregistering module net_imap
[2025-03-05 02:19:21.208] [1;32m DEBUG[0m[37592]: [1;37mnode.c:698 node_free[0m: Node 2 now freed
[2025-03-05 02:19:21.210] [1;32m DEBUG[0m[37580]: [1;37mmodule.c:1905 unload_modules_helper[0m: Attempting to unload net_smtp.so
[2025-03-05 02:19:21.213] [1;32m DEBUG[0m[37580]: [1;37mmodule.c:935 dec_refcounts[0m: net_smtp no longer depends on module mod_mail.so
[2025-03-05 02:19:21.215] [1;32m DEBUG[0m[37580]: [1;37mmodule.c:347 logged_dlclose[0m: dlclose: net_smtp
[2025-03-05 02:19:21.215] === Unregistering module net_smtp
[2025-03-05 02:19:21.211] == Node 2 has exited
[2025-03-05 02:19:21.214] [1;32m DEBUG[0m[37583]: [1;37msocket.c:738 tcp_multilistener[0m: TCP multilistener is now watching 0 sockets
[2025-03-05 02:19:21.220] [1;32m DEBUG[0m[37583]: [1;37mthread.c:138 __thread_unregister[0m: Thread 37583 is exiting (detached)
[2025-03-05 02:19:21.221] [1;32m DEBUG[0m[37580]: [1;37mmodule.c:1905 unload_modules_helper[0m: Attempting to unload mod_mail.so
[2025-03-05 02:19:22.239] [1;32m DEBUG[0m: test.c:907 run_test: Child process 37580 has exited
[2025-03-05 02:19:22.239] [1;31m ERROR[0m: test.c:910 run_test: Process 37580 (/home/runner/work/lbbs/lbbs/tests/test_imap.so) killed, signal Segmentation fault
[2025-03-05 02:19:22.239] [1;32m DEBUG[0m: test.c:918 run_test: Test return code so far is 0
[2025-03-05 02:19:22.239] [1;32m DEBUG[0m: test.c:407 io_relay: read returned 0
==37580== Thread 3:
==37580== Jump to the invalid address stated on the next line
==37580== at 0x56670B3: ???
==37580== by 0x159CE1: thread_run (thread.c:421)
==37580== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37580== by 0x5068A33: clone (clone.S:100)
==37580== Address 0x56670b3 is in the Text segment of /usr/lib/lbbs/modules/net_smtp.so
==37580== at 0x56670B3: ???And another:
[2025-03-06 02:43:40.020] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:1905 unload_modules_helper[0m: Attempting to unload net_imap.so
[2025-03-06 02:43:40.026] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:935 dec_refcounts[0m: net_imap no longer depends on module mod_mail.so
[2025-03-06 02:43:40.011] == Node 2 has exited
[2025-03-06 02:43:40.028] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:935 dec_refcounts[0m: net_imap no longer depends on module mod_mimeparse.so
[2025-03-06 02:43:40.028] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:347 logged_dlclose[0m: dlclose: net_imap
[2025-03-06 02:43:40.028] === Unregistering module net_imap
[2025-03-06 02:43:40.030] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:1905 unload_modules_helper[0m: Attempting to unload net_smtp.so
[2025-03-06 02:43:40.033] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:935 dec_refcounts[0m: net_smtp no longer depends on module mod_mail.so
[2025-03-06 02:43:40.027] [1;32m DEBUG[0m[37558]: [1;37msocket.c:738 tcp_multilistener[0m: TCP multilistener is now watching 2 sockets
[2025-03-06 02:43:40.034] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:347 logged_dlclose[0m: dlclose: net_smtp
[2025-03-06 02:43:40.034] === Unregistering module net_smtp
[2025-03-06 02:43:40.038] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:1905 unload_modules_helper[0m: Attempting to unload mod_mail.so
[2025-03-06 02:43:40.040] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:1920 unload_modules_helper[0m: Module mod_mail.so previously was in use but unloaded on pass 2
[2025-03-06 02:43:40.041] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:347 logged_dlclose[0m: dlclose: mod_mail
[2025-03-06 02:43:40.041] === Unregistering module mod_mail
[2025-03-06 02:43:40.042] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:1905 unload_modules_helper[0m: Attempting to unload mod_mimeparse.so
[2025-03-06 02:43:40.046] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:1920 unload_modules_helper[0m: Module mod_mimeparse.so previously was in use but unloaded on pass 2
[2025-03-06 02:43:40.047] [1;32m DEBUG[0m[37555]: [1;37mmodule.c:347 logged_dlclose[0m: dlclose: mod_mimeparse
[2025-03-06 02:43:40.047] === Unregistering module mod_mimeparse
[2025-03-06 02:43:40.056] [1;32m DEBUG[0m[37558]: [1;37msocket.c:738 tcp_multilistener[0m: TCP multilistener is now watching 0 sockets
[2025-03-06 02:43:40.058] [1;32m DEBUG[0m[37558]: [1;37mthread.c:138 __thread_unregister[0m: Thread 37558 is exiting (detached)
[2025-03-06 02:43:40.943] [1;32m DEBUG[0m: test.c:942 run_test: Child process 37555 has exited
[2025-03-06 02:43:40.943] [1;31m ERROR[0m: test.c:945 run_test: Process 37555 (/home/runner/work/lbbs/lbbs/tests/test_imap.so) killed, signal Segmentation fault
[2025-03-06 02:43:40.943] [1;32m DEBUG[0m: test.c:953 run_test: Test return code so far is 0
[2025-03-06 02:43:40.944] [1;32m DEBUG[0m: test.c:418 io_relay: read returned 0
==37555== Thread 3:
==37555== Jump to the invalid address stated on the next line
==37555== at 0x56670B3: ???
==37555== by 0x15A7D1: thread_run (thread.c:421)
==37555== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37555== by 0x5068A33: clone (clone.S:100)
==37555== Address 0x56670b3 is in the Text segment of /usr/lib/lbbs/modules/net_smtp.so
==37555== at 0x56670B3: ???
==37555==
==37555==
==37555== Process terminating with default action of signal 11 (SIGSEGV): dumping core
==37555== Access not within mapped region at address 0x56670B3
==37555== at 0x56670B3: ???
==37555== by 0x15A7D1: thread_run (thread.c:421)
==37555== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37555== by 0x5068A33: clone (clone.S:100)
==37555== If you believe this happened as a result of a stack
==37555== overflow in your program's main thread (unlikely but
==37555== possible), you can try to increase the size of the
==37555== main thread stack using the --main-stacksize= flag.
==37555== The main thread stack size used in this run was 8388608.And another:
[2025-03-06 04:20:20.607] DEBUG[37127]: module.c:1905 unload_modules_helper: Attempting to unload net_imap.so
[2025-03-06 04:20:20.613] DEBUG[37127]: module.c:935 dec_refcounts: net_imap no longer depends on module mod_mail.so
[2025-03-06 04:20:20.613] DEBUG[37127]: module.c:935 dec_refcounts: net_imap no longer depends on module mod_mimeparse.so
[2025-03-06 04:20:20.613] DEBUG[37127]: module.c:347 logged_dlclose: dlclose: net_imap
[2025-03-06 04:20:20.613] === Unregistering module net_imap
[2025-03-06 04:20:20.615] DEBUG[37127]: module.c:1905 unload_modules_helper: Attempting to unload net_smtp.so
[2025-03-06 04:20:20.617] DEBUG[37127]: module.c:935 dec_refcounts: net_smtp no longer depends on module mod_mail.so
[2025-03-06 04:20:20.618] DEBUG[37127]: module.c:347 logged_dlclose: dlclose: net_smtp
[2025-03-06 04:20:20.618] === Unregistering module net_smtp
[2025-03-06 04:20:20.620] DEBUG[37129]: socket.c:738 tcp_multilistener: TCP multilistener is now watching 0 sockets
[2025-03-06 04:20:20.623] DEBUG[37127]: module.c:1905 unload_modules_helper: Attempting to unload mod_mail.so
[2025-03-06 04:20:20.625] DEBUG[37129]: thread.c:138 __thread_unregister: Thread 37129 is exiting (detached)
[2025-03-06 04:20:21.534] DEBUG: test.c:1010 run_test: Child process 37127 has exited
[2025-03-06 04:20:21.534] ERROR: test.c:1013 run_test: Process 37127 (/home/runner/work/lbbs/lbbs/tests/test_imap_msn.so) killed, signal Segmentation fault
[2025-03-06 04:20:21.534] DEBUG: test.c:1021 run_test: Test return code so far is 0
[2025-03-06 04:20:21.534] DEBUG: test.c:422 io_relay: read returned 0
==37127== Thread 6:
==37127== Jump to the invalid address stated on the next line
==37127== at 0x5D8B4A0: ???
==37127== by 0x159CF1: thread_run (thread.c:421)
==37127== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37127== by 0x5068A33: clone (clone.S:100)
==37127== Address 0x5d8b4a0 is in the Text segment of /usr/lib/lbbs/modules/net_imap.so
==37127== at 0x5D8B4A0: ???
==37127==
==37127==
==37127== Process terminating with default action of signal 11 (SIGSEGV): dumping core
==37127== Access not within mapped region at address 0x5D8B4A0
==37127== at 0x5D8B4A0: ???
==37127== by 0x159CF1: thread_run (thread.c:421)
==37127== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37127== by 0x5068A33: clone (clone.S:100)
==37127== If you believe this happened as a result of a stack
==37127== overflow in your program's main thread (unlikely but
==37127== possible), you can try to increase the size of the
==37127== main thread stack using the --main-stacksize= flag.
==37127== The main thread stack size used in this run was 8388608.Another:
[2025-03-11 12:55:48.386] === Unregistering module net_imap
[2025-03-11 12:55:48.387] DEBUG[37410]: module.c:1924 unload_modules_helper: Attempting to unload net_smtp.so
[2025-03-11 12:55:48.388] DEBUG[37412]: socket.c:738 tcp_multilistener: TCP multilistener is now watching 4 sockets
[2025-03-11 12:55:48.391] DEBUG[37412]: socket.c:738 tcp_multilistener: TCP multilistener is now watching 2 sockets
[2025-03-11 12:55:48.391] DEBUG[37410]: module.c:952 dec_refcounts: net_smtp no longer depends on module mod_mail.so
[2025-03-11 12:55:48.392] DEBUG[37410]: module.c:347 logged_dlclose: dlclose: net_smtp
[2025-03-11 12:55:48.392] DEBUG[37412]: socket.c:738 tcp_multilistener: TCP multilistener is now watching 2 sockets
[2025-03-11 12:55:48.392] DEBUG[37414]: node.c:649 node_shutdown: Node 1 has no PTY thread to clean up
[2025-03-11 12:55:48.393] === Unregistering module net_smtp
[2025-03-11 12:55:48.395] DEBUG[37410]: module.c:1916 unload_modules_helper: Skipping unload of net_ws.so with use count 1 on pass 1
[2025-03-11 12:55:48.396] DEBUG[37410]: module.c:1916 unload_modules_helper: Skipping unload of mod_http.so with use count 1 on pass 2
[2025-03-11 12:55:48.396] DEBUG[37410]: module.c:1924 unload_modules_helper: Attempting to unload mod_mail.so
[2025-03-11 12:55:48.399] DEBUG[37410]: module.c:1939 unload_modules_helper: Module mod_mail.so previously was in use but unloaded on pass 2
[2025-03-11 12:55:48.399] DEBUG[37410]: module.c:347 logged_dlclose: dlclose: mod_mail
[2025-03-11 12:55:48.400] === Unregistering module mod_mail
[2025-03-11 12:55:48.401] DEBUG[37414]: node.c:680 node_shutdown: Shutdown pending finalization for node 1
[2025-03-11 12:55:48.402] DEBUG[37410]: module.c:1924 unload_modules_helper: Attempting to unload mod_mimeparse.so
[2025-03-11 12:55:48.402] DEBUG[37414]: node.c:698 node_free: Node 1 now freed
[2025-03-11 12:55:48.406] DEBUG[37410]: module.c:1939 unload_modules_helper: Module mod_mimeparse.so previously was in use but unloaded on pass 2
[2025-03-11 12:55:48.406] DEBUG[37410]: module.c:347 logged_dlclose: dlclose: mod_mimeparse
[2025-03-11 12:55:48.407] === Unregistering module mod_mimeparse
[2025-03-11 12:55:48.415] DEBUG[37410]: module.c:1924 unload_modules_helper: Attempting to unload net_ws.so
[2025-03-11 12:55:48.417] DEBUG[37410]: module.c:1939 unload_modules_helper: Module net_ws.so previously was in use but unloaded on pass 2
[2025-03-11 12:55:48.417] DEBUG[37412]: socket.c:738 tcp_multilistener: TCP multilistener is now watching 0 sockets
[2025-03-11 12:55:48.418] DEBUG[37410]: module.c:952 dec_refcounts: net_ws no longer depends on module mod_http.so
[2025-03-11 12:55:48.418] DEBUG[37410]: module.c:347 logged_dlclose: dlclose: net_ws
[2025-03-11 12:55:48.418] === Unregistering module net_ws
[2025-03-11 12:55:48.422] == Node 1 has exited
[2025-03-11 12:55:49.319] DEBUG: test.c:1028 run_test: Child process 37410 has exited
[2025-03-11 12:55:49.319] ERROR: test.c:1031 run_test: Process 37410 (/home/runner/work/lbbs/lbbs/tests/test_webmail.so) killed, signal Segmentation fault
[2025-03-11 12:55:49.319] DEBUG: test.c:1039 run_test: Test /home/runner/work/lbbs/lbbs/tests/test_webmail.so return code so far is 0
[2025-03-11 12:55:49.319] DEBUG: test.c:438 io_relay: read returned 0
==37410== Thread 4:
==37410== Jump to the invalid address stated on the next line
==37410== at 0x5D90690: ???
==37410== by 0x159F91: thread_run (thread.c:421)
==37410== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37410== by 0x5068A33: clone (clone.S:100)
==37410== Address 0x5d90690 is in the Text segment of /usr/lib/lbbs/modules/net_ws.so
==37410== at 0x5D90690: ???
==37410==
==37410==
==37410== Process terminating with default action of signal 11 (SIGSEGV): dumping core
==37410== Access not within mapped region at address 0x5D90690
==37410== at 0x5D90690: ???
==37410== by 0x159F91: thread_run (thread.c:421)
==37410== by 0x4FDBAA3: start_thread (pthread_create.c:447)
==37410== by 0x5068A33: clone (clone.S:100)
==37410== If you believe this happened as a result of a stack
==37410== overflow in your program's main thread (unlikely but
==37410== possible), you can try to increase the size of the
==37410== main thread stack using the --main-stacksize= flag.
==37410== The main thread stack size used in this run was 8388608.Another:
[2025-03-15 15:05:21.914] DEBUG[26823]: module.c:347 logged_dlclose: dlclose: net_imap
[2025-03-15 15:05:21.914] === Unregistering module net_imap
[2025-03-15 15:05:21.915] DEBUG[26823]: module.c:1928 unload_modules_helper: Attempting to unload net_smtp.so
[2025-03-15 15:05:21.918] DEBUG[26823]: module.c:952 dec_refcounts: net_smtp no longer depends on module mod_mail.so
[2025-03-15 15:05:21.920] DEBUG[26825]: socket.c:738 tcp_multilistener: TCP multilistener is now watching 0 sockets
[2025-03-15 15:05:21.888] == Node 4 has exited
[2025-03-15 15:05:21.920] DEBUG[26823]: module.c:347 logged_dlclose: dlclose: net_smtp
[2025-03-15 15:05:21.920] === Unregistering module net_smtp
[2025-03-15 15:05:21.924] DEBUG[26823]: module.c:1928 unload_modules_helper: Attempting to unload mod_mail.so
[2025-03-15 15:05:21.926] DEBUG[26823]: module.c:1943 unload_modules_helper: Module mod_mail.so previously was in use but unloaded on pass 2
[2025-03-15 15:05:21.926] DEBUG[26823]: module.c:347 logged_dlclose: dlclose: mod_mail
[2025-03-15 15:05:21.927] === Unregistering module mod_mail
[2025-03-15 15:05:21.928] DEBUG[26823]: module.c:1928 unload_modules_helper: Attempting to unload mod_mimeparse.so
[2025-03-15 15:05:21.935] DEBUG[26823]: module.c:1943 unload_modules_helper: Module mod_mimeparse.so previously was in use but unloaded on pass 2
[2025-03-15 15:05:21.935] DEBUG[26823]: module.c:347 logged_dlclose: dlclose: mod_mimeparse
[2025-03-15 15:05:21.935] === Unregistering module mod_mimeparse
[2025-03-15 15:05:21.944] DEBUG[26825]: thread.c:138 __thread_unregister: Thread 26825 is exiting (detached)
[2025-03-15 15:05:22.784] DEBUG: test.c:1033 run_test: Child process 26823 has exited
[2025-03-15 15:05:22.784] ERROR: test.c:1036 run_test: Process 26823 (/home/runner/work/lbbs/lbbs/tests/test_imap_msn.so) killed, signal Segmentation fault
[2025-03-15 15:05:22.784] DEBUG: test.c:1044 run_test: Test /home/runner/work/lbbs/lbbs/tests/test_imap_msn.so return code so far is 0
[2025-03-15 15:05:22.784] DEBUG: test.c:441 io_relay: read returned 0
==26823== Thread 6:
==26823== Jump to the invalid address stated on the next line
==26823== at 0x5CD2622: ???
==26823== by 0x157234: thread_run (thread.c:421)
==26823== by 0x4F16AC2: start_thread (pthread_create.c:442)
==26823== by 0x4FA7A03: clone (clone.S:100)
==26823== Address 0x5cd2622 is in the Text segment of /usr/lib/lbbs/modules/net_imap.so
==26823== at 0x5CD2622: ???
==26823==
==26823==
==26823== Process terminating with default action of signal 11 (SIGSEGV): dumping core
==26823== Access not within mapped region at address 0x5CD2622
==26823== at 0x5CD2622: ???
==26823== by 0x157234: thread_run (thread.c:421)
==26823== by 0x4F16AC2: start_thread (pthread_create.c:442)
==26823== by 0x4FA7A03: clone (clone.S:100)
==26823== If you believe this happened as a result of a stack
==26823== overflow in your program's main thread (unlikely but
==26823== possible), you can try to increase the size of the
==26823== main thread stack using the --main-stacksize= flag.
==26823== The main thread stack size used in this run was 8388608.Possibly related:
[2025-03-15 16:45:20.231] === Unregistering module net_smtp
[2025-03-15 16:45:20.234] DEBUG[37342]: module.c:1920 unload_modules_helper: Skipping unload of mod_mail.so with use count 1 on pass 2
...
[2025-03-15 16:45:25.053] DEBUG[37342]: module.c:1920 unload_modules_helper: Skipping unload of net_imap.so with use count 1 on pass 26
Module # PR Reffing Module Ref Location
mod_mail.so 1 1 net_smtp.so module.c:311 __bbs_require_module
mod_mimeparse.so 1 1 net_imap.so module.c:311 __bbs_require_module
net_imap.so 1 1 node.c:373 __bbs_node_request
3 total references
[2025-03-15 16:45:25.058] DEBUG[37342]: module.c:1968 unload_modules_helper: All nodes have exited
[2025-03-15 16:45:25.258] DEBUG[37342]: module.c:1920 unload_modules_helper: Skipping unload of mod_mail.so with use count 1 on pass 27
...
[2025-03-15 16:45:30.077] DEBUG[37342]: module.c:1920 unload_modules_helper: Skipping unload of net_imap.so with use count 1 on pass 51
Module # PR Reffing Module Ref Location
mod_mail.so 1 1 net_smtp.so module.c:311 __bbs_require_module
mod_mimeparse.so 1 1 net_imap.so module.c:311 __bbs_require_module
net_imap.so 1 1 node.c:373 __bbs_node_request
3 total references
[2025-03-15 16:45:30.078] DEBUG[37342]: module.c:1968 unload_modules_helper: All nodes have exited
[2025-03-15 16:45:30.278] ERROR[37342]: module.c:1976 unload_modules_helper: 3 modules could not be unloaded after 51 passes
[2025-03-15 16:45:30.279] WARNING[37342]: module.c:1992 unload_modules: Module mod_mail.so still registered during BBS shutdown
[2025-03-15 16:45:30.280] WARNING[37342]: module.c:1992 unload_modules: Module mod_mimeparse.so still registered during BBS shutdown
[2025-03-15 16:45:30.280] WARNING[37342]: module.c:1992 unload_modules: Module net_imap.so still registered during BBS shutdown
...
==37342== Invalid read of size 1
==37342== at 0x484F226: strlen (in /usr/libexec/valgrind/vgpreload_memcheck-amd64-linux.so)
==37342== by 0x4FA9DA7: __printf_buffer (vfprintf-process-arg.c:435)
==37342== by 0x4FAA5A1: __vfprintf_internal (vfprintf-internal.c:1559)
==37342== by 0x12E3CB: vprintf (stdio2.h:99)
==37342== by 0x12E3CB: bbs_dprintf (logger.c:411)
==37342== by 0x13D1F3: list_modulerefs (module.c:1450)
==37342== by 0x13D1F3: unload_modules_helper (module.c:1963)
==37342== by 0x13D1F3: unload_modules (module.c:1986)
==37342== by 0x11DBFB: bbs_shutdown (bbs.c:589)
==37342== by 0x11DBFB: bbs_shutdown (bbs.c:567)
==37342== by 0x1179F0: monitor_sig_flags (bbs.c:847)
==37342== by 0x1179F0: main (bbs.c:1137)
==37342== Address 0x5282a80 is 208 bytes inside a block of size 220 free'd
==37342== at 0x484988F: free (in /usr/libexec/valgrind/vgpreload_memcheck-amd64-linux.so)
==37342== by 0x139502: free_module (module.c:132)
==37342== by 0x139502: bbs_module_unregister (module.c:187)
==37342== by 0x40010F1: _dl_call_fini (dl-call_fini.c:43)
==37342== by 0x40015B1: _dl_catch_exception (dl-catch.c:211)
==37342== by 0x4001D38: _dl_close_worker.part.0 (dl-close.c:264)
==37342== by 0x40027BD: _dl_close_worker (dl-close.c:120)
==37342== by 0x40027BD: _dl_close (dl-close.c:793)
==37342== by 0x400151B: _dl_catch_exception (dl-catch.c:237)
==37342== by 0x4001668: _dl_catch_error (dl-catch.c:256)
==37342== by 0x4FD6C82: _dlerror_run (dlerror.c:138)
==37342== by 0x4FD69B5: dlclose@@GLIBC_2.34 (dlclose.c:31)
==37342== by 0x13820C: logged_dlclose (module.c:349)
==37342== by 0x1383E9: unload_dynamic_module (module.c:728)
==37342== Block was alloc'd at
==37342== at 0x484D953: calloc (in /usr/libexec/valgrind/vgpreload_memcheck-amd64-linux.so)
==37342== by 0x118607: __bbs_calloc (alloc.c:83)
==37342== by 0x138D0E: load_dlopen (module.c:380)
==37342== by 0x139D6E: load_dynamic_module.constprop.0 (module.c:537)
==37342== by 0x139836: load_resource.constprop.0 (module.c:802)
==37342== by 0x13C6EB: do_autoload_module (module.c:1133)
==37342== by 0x13C6EB: try_autoload_modules (module.c:1265)
==37342== by 0x13C6EB: load_modules (module.c:1862)
==37342== by 0x11762E: main (bbs.c:1104)Comments
You must be