[OpenSIPS-Users] opensips is restarting after call is finished
Bogdan-Andrei Iancu
bogdan at opensips.org
Thu Dec 7 15:52:37 UTC 2023
Hi Simon,
Well, the log is very self explanatory:
Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]: INFO:core:handle_sigs:
child process 28495 exited by a signal 11
Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]: INFO:core:handle_sigs:
core was generated
Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]: INFO:core:handle_sigs:
terminating due to SIGCHLD
Or shortly, you opensips just crashed :). So see
https://opensips.org/Documentation/TroubleShooting-Crash for how to
report further.
Regards,
Bogdan-Andrei Iancu
OpenSIPS Founder and Developer
https://www.opensips-solutions.com
https://www.siphub.com
On 07.12.2023 17:17, Simon Gajski via Users wrote:
>
> Hi
>
> we are running opensips 3.4.2
> on Ubuntu 22.04.3 LTS
> and also use RTPengine Version: 10.5.0.0+0~mr10.5.0.0 git-master-74075f63
>
> Opensips acts as SBC with RTP engine enabled.
>
> Calls are working fine, however after each call is finished, bellow
> action happens.
>
> We had same problem with opensips 3.2 and Ubuntu 20. So we did upgrade
> to latest stable release, and it is the same.
>
> Is this opensips script configuration issue or a bug? And how could I
> fix it?
>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]: INFO:core:handle_sigs:
> child process 28495 exited by a signal 11
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]: INFO:core:handle_sigs:
> core was generated
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]: INFO:core:handle_sigs:
> terminating due to SIGCHLD
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28491]: INFO:core:sig_usr:
> signal 15 received
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28492]: INFO:core:sig_usr:
> signal 15 received
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 4(28492) [timer] terminated,
> still waiting for 16 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 18(28508) [TCP main] terminated,
> still waiting for 15 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 3(28491) [time_keeper]
> terminated, still waiting for 14 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 16(28504) [TCP receiver]
> terminated, still waiting for 13 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 2(28490) [MI FIFO] terminated,
> still waiting for 12 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 15(28503) [TCP receiver]
> terminated, still waiting for 11 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 14(28502) [TCP receiver]
> terminated, still waiting for 10 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 12(28500) [TCP receiver]
> terminated, still waiting for 9 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 1(28489) [HTTPD 127.0.0.1:8888]
> terminated, still waiting for 8 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 8(28496) [SIP receiver
> udp:213.253.120.65:5060] terminated, still waiting for 7 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 10(28498) [TCP receiver]
> terminated, still waiting for 6 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 13(28501) [TCP receiver]
> terminated, still waiting for 5 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 9(28497) [TCP receiver]
> terminated, still waiting for 4 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 11(28499) [TCP receiver]
> terminated, still waiting for 3 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 6(28494) [SIP receiver
> udp:213.253.120.65:5060] terminated, still waiting for 2 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 17(28507) [Timer handler]
> terminated, still waiting for 1 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]:
> INFO:core:shutdown_opensips: process 5(28493) [SIP receiver
> udp:213.253.120.65:5060] terminated, still waiting for 0 more
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[28488]: INFO:core:cleanup: cleanup
> Dec 7 15:59:47 sbc2 opensips: INFO:core:fix_poll_method: using epoll
> as the IO watch method (auto detected)
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: NOTICE:core:main:
> version: opensips 3.4.2 (x86_64/linux)
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: NOTICE:core:main:
> using 64 MB of shared memory, allocator: F_MALLOC
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: NOTICE:core:main:
> using 4 MB of private process memory, allocator: F_MALLOC
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> WARNING:core:init_reactor_size: shrinking reactor size from 262144
> (autodetected via rlimit) to 10485 (limited by memory of 10% from 4Mb)
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> WARNING:core:init_reactor_size: use 'open_files_limit' to enforce
> other limit or increase pkg memory
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:init_reactor_size: reactor size 10485 (using up to 0.40Mb of
> memory per process)
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_CORE_THRESHOLD(1)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_CORE_SHM_THRESHOLD(2)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_CORE_PKG_THRESHOLD(3)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_CORE_PROC_AUTO_SCALE(4)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_CORE_TCP_DISCONNECT(5)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:tm:mod_init: TM -
> initializing...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:sl:mod_init:
> Initializing StateLess engine
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> NOTICE:signaling:mod_init: initializing module ...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_MYSQL_CONNECTION(6)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:dialog:mod_init:
> Dialog module - initializing
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_DLG_STATE_CHANGED(7)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:rr:mod_init: rr -
> initializing
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:uac:mod_init:
> initializing...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:acc:mod_init:
> initializing...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_ACC_EVENT(8)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_ACC_CDR(9)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_ACC_MISSED_EVENT(10)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:textops:mod_init:
> initializing...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:maxfwd:mod_init:
> initializing...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:sipmsgops:mod_init: initializing...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:avpops:avpops_init: initializing...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:drouting:dr_init:
> dynamic routing - initializing
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:drouting:init_prefix_tree: counted 10 possible chars under a node
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_DROUTING_STATUS(11)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:permissions:mod_init: default allow file
> (/etc/opensips/permissions.allow) not found => empty rule set
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:permissions:mod_init: default deny file
> (/etc/opensips/permissions.deny) not found => empty rule set
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:regex:mod_init:
> initializing module...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: NOTICE:regex:mod_init:
> 'file' parameter is not set, group matching disabled
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:topology_hiding:mod_init: initializing...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_RTPENGINE_STATUS(12)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:userblacklist:mod_init: initializing ...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:userblacklist:mod_init: finished initializing
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:dialplan:mod_init: initializing module...
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:core:mod_init:
> initializing UDP-plain protocol
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]: INFO:core:mod_init:
> initializing TCP-plain protocol
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31289]:
> INFO:core:evi_publish_event: Registered event <E_CORE_LOG(13)>
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31290]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:47 sbc2 /usr/sbin/opensips[31291]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31294]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31294]:
> INFO:drouting:dr_reload_data_head: loading drouting data!
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31295]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31296]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31297]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31298]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31299]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31300]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31301]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31302]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31303]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31304]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31305]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 /usr/sbin/opensips[31306]:
> INFO:rtpengine:rtpe_test: rtp proxy <udp:127.0.0.1:2223> found,
> support for it enabled
> Dec 7 15:59:48 sbc2 opensips: INFO:core:daemonize: pre-daemon process
> exiting with 0
>
> Thanks for all tips.
>
> BR
> Simon
>
>
> _______________________________________________
> Users mailing list
> Users at lists.opensips.org
> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20231207/1277ab49/attachment-0001.html>
More information about the Users
mailing list