ha-plugins icon indicating copy to clipboard operation
ha-plugins copied to clipboard

/run.sh: line 56: 228 Segmentation fault (core dumped) python3 /ha-sip/main.py

Open bp112 opened this issue 1 year ago • 2 comments

Hallo Zusammen,

gelegentlich schlägt das aufbauen des Anruf mit folgendem LOG fehl.

| 09:09:35.897554 [1] Registering call with id sip:**[email protected]:5060 | 09:09:35.898921 [ ] Add to state: sip:**[email protected]:5060 /run.sh: line 56: 228 Segmentation fault (core dumped) python3 /ha-sip/main.py s6-rc: info: service legacy-services: stopping

Das irritirende daran ist das wenn über HA der Befehl erneut ausgelöst wird, klappt es.

data: addon: c7744bff_ha-sip input: command: dial number: sip:**[email protected]:5060 ring_timeout: null menu: message: Starte die Standheizung! action: hassio.addon_stdin

Also kann man sagen in 9 von 10 Fällen funktioniert es. Von daher kann an der Config eigentlich kein Fehler sein ODER ?

Auszug aus dem LOG:

| 09:08:47.782435 [1] OnRegState: 200 OK | 09:09:35.833042 [ ] Got "dial" command for sip:**[email protected]:5060 | &id001 | id: null | message: Starte die Standheizung! | audio_file: null | language: de | action: null | choices_are_pin: false | choices: {} | default_choice: | id: null | message: Unknown option | audio_file: null | language: en | action: null | choices_are_pin: false | choices: null | default_choice: null | timeout_choice: null | post_action: | action: return | level: 1 | timeout: 300.0 | parent_menu: *id001 | cache_audio: false | wait_for_audio_to_finish: false | timeout_choice: | id: null | message: null | audio_file: null | language: en | action: null | choices_are_pin: false | choices: null | default_choice: null | timeout_choice: null | post_action: | action: hangup | timeout: 300.0 | parent_menu: *id001 | cache_audio: false | wait_for_audio_to_finish: false | timeout: 300.0 | post_action: | action: noop | parent_menu: null | cache_audio: false | wait_for_audio_to_finish: false | | 09:09:35.897554 [1] Registering call with id sip:**[email protected]:5060 | 09:09:35.898921 [ ] Add to state: sip:**[email protected]:5060 /run.sh: line 56: 228 Segmentation fault (core dumped) python3 /ha-sip/main.py s6-rc: info: service legacy-services: stopping s6-rc: info: service legacy-services successfully stopped s6-rc: info: service legacy-cont-init: stopping s6-rc: info: service legacy-cont-init successfully stopped s6-rc: info: service fix-attrs: stopping s6-rc: info: service fix-attrs successfully stopped s6-rc: info: service s6rc-oneshot-runner: stopping s6-rc: info: service s6rc-oneshot-runner successfully stopped s6-rc: info: service s6rc-oneshot-runner: starting s6-rc: info: service s6rc-oneshot-runner successfully started s6-rc: info: service fix-attrs: starting s6-rc: info: service fix-attrs successfully started s6-rc: info: service legacy-cont-init: starting s6-rc: info: service legacy-cont-init successfully started s6-rc: info: service legacy-services: starting s6-rc: info: service legacy-services successfully started Getting config options from home-assistant OS. Python 3.11.3 | 09:09:45.041358 [ ] Found cache directory '/config/audio_cache' | 09:09:45.046559 [1] Loaded menu for incoming call. | 09:09:45.046653 [2] No file name for incoming call config specified. | 09:09:45.046682 [3] No file name for incoming call config specified. 09:09:45.050 os_core_unix.c !pjlib 2.14.1 for POSIX initialized 09:09:45.053 sip_endpoint.c .Creating endpoint instance... 09:09:45.053 pjlib .select() I/O Queue created (0x7f94841120c8) 09:09:45.053 sip_endpoint.c .Module "mod-msg-print" registered 09:09:45.053 sip_transport.c .Transport manager created. 09:09:45.053 pjsua_core.c .PJSUA state changed: NULL --> CREATED | 09:09:45.076767 [ ] Supported audio codecs: speex/16000/1, speex/8000/1, speex/32000/1, iLBC/8000/1, GSM/8000/1, PCMU/8000/1, PCMA/8000/1, G722/16000/1, opus/48000/2, L16/44100/2, L16/44100/1 | 09:09:45.093443 [1] OnRegState: 200 OK | 09:10:47.896043 [ ] Got "dial" command for sip:**[email protected]:5060 | &id001 | id: null | message: Starte die Standheizung! | audio_file: null | language: de | action: null | choices_are_pin: false | choices: {} | default_choice: | id: null | message: Unknown option | audio_file: null | language: en | action: null | choices_are_pin: false | choices: null | default_choice: null | timeout_choice: null | post_action: | action: return | level: 1 | timeout: 300.0 | parent_menu: *id001 | cache_audio: false | wait_for_audio_to_finish: false | timeout_choice: | id: null | message: null | audio_file: null | language: en | action: null | choices_are_pin: false | choices: null | default_choice: null | timeout_choice: null | post_action: | action: hangup | timeout: 300.0 | parent_menu: *id001 | cache_audio: false | wait_for_audio_to_finish: false | timeout: 300.0 | post_action: | action: noop | parent_menu: null | cache_audio: false | wait_for_audio_to_finish: false | | 09:10:47.899105 [1] Registering call with id sip:**[email protected]:5060 | 09:10:47.899143 [ ] Add to state: sip:**[email protected]:5060 | 09:10:47.912186 [1] Calling | 09:10:47.953873 [1] Early | 09:10:47.956170 [1] onCallMediaState call info state 3 | 09:10:47.957223 [1] Connected media 1 | 09:11:54.997109 [1] Call disconnected | 09:11:54.997203 [ ] Calling webhook sip_call_webhook_id with data {'event': 'call_disconnected', 'caller': 'sip:**[email protected]:5060', 'parsed_caller': '**702', 'sip_account': 1} | 09:11:55.008037 [ ] Webhook response 200 b'' | 09:11:55.008777 [ ] Remove from state: sip:**[email protected]:5060 | 09:14:40.104241 [1] OnRegState: 200 OK | 09:19:35.114913 [1] OnRegState: 200 OK | 09:24:30.126326 [1] OnRegState: 200 OK

bp112 avatar Dec 14 '24 09:12 bp112

Auf welcher Hardware läuft dein Home Assistant?

arnonym avatar Dec 14 '24 16:12 arnonym

Auf welcher Hardware läuft dein Home Assistant?

Auf einem Intel I5 mit Proxmox. > HAOS als VM 2 CPU / 4GiB RAM / 32GiB Bootdisk

bp112 avatar Dec 14 '24 18:12 bp112

Hallo, bei mir taucht das gleiche Problem auf. Meistens funktionieren die Anrufe, nur sporadisch taucht auch der gleiche Fehler auf. Ich kann allerdings hinzufügen, dass ich immer zwei Anrufe nacheinander tätige, und dass der Fehler zweimal auftaucht, was man im Log sehen kann:

| 13:24:37.307795 [1] OnRegState: 200 OK
| 13:27:23.732461 [ ] Got "dial" command for sip:[email protected]
| &id001
| id: null
| message: "***Editiert wegen Datenschutz***"
| audio_file: null
| language: fr
| action: null
| choices_are_pin: false
| choices: {}
| default_choice:
|   id: null
|   message: Unknown option
|   audio_file: null
|   language: en
|   action: null
|   choices_are_pin: false
|   choices: null
|   default_choice: null
|   timeout_choice: null
|   post_action:
|     action: return
|     level: 1
|   timeout: 300.0
|   parent_menu: *id001
|   cache_audio: false
|   wait_for_audio_to_finish: false
| timeout_choice:
|   id: null
|   message: null
|   audio_file: null
|   language: en
|   action: null
|   choices_are_pin: false
|   choices: null
|   default_choice: null
|   timeout_choice: null
|   post_action:
|     action: hangup
|   timeout: 300.0
|   parent_menu: *id001
|   cache_audio: false
|   wait_for_audio_to_finish: false
| timeout: 300.0
| post_action:
|   action: hangup
| parent_menu: null
| cache_audio: false
| wait_for_audio_to_finish: false
| 
| 13:27:23.739695 [1] Registering call with id sip:[email protected]
| 13:27:23.739800 [ ] Add to state: sip:[email protected]
/run.sh: line 56:   228 Segmentation fault      (core dumped) python3 /ha-sip/main.py
s6-rc: info: service legacy-services: stopping
s6-rc: info: service legacy-services successfully stopped
s6-rc: info: service legacy-cont-init: stopping
s6-rc: info: service legacy-cont-init successfully stopped
s6-rc: info: service fix-attrs: stopping
s6-rc: info: service fix-attrs successfully stopped
s6-rc: info: service s6rc-oneshot-runner: stopping
s6-rc: info: service s6rc-oneshot-runner successfully stopped
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
s6-rc: info: service legacy-services successfully started
Getting config options from home-assistant OS.
Python 3.11.3
| 13:27:31.708521 [ ] Setting name server: ['5.180.166.3']
| 13:27:31.708596 [ ] Found cache directory '/config/audio_cache'
| 13:27:31.708628 [1] No file name for incoming call config specified.
| 13:27:31.708801 [2] No file name for incoming call config specified.
| 13:27:31.708836 [3] No file name for incoming call config specified.
13:27:31.709         os_core_unix.c !pjlib 2.14.1 for POSIX initialized
13:27:31.710         sip_endpoint.c  .Creating endpoint instance...
13:27:31.710                  pjlib  .select() I/O Queue created (0x7f0e9f9980b8)
13:27:31.710         sip_endpoint.c  .Module "mod-msg-print" registered
13:27:31.710        sip_transport.c  .Transport manager created.
13:27:31.710           pjsua_core.c  .PJSUA state changed: NULL --> CREATED
| 13:27:31.717843 [ ] Supported audio codecs: speex/16000/1, speex/8000/1, speex/32000/1, iLBC/8000/1, GSM/8000/1, PCMU/8000/1, PCMA/8000/1, G722/16000/1, opus/48000/2, L16/44100/2, L16/44100/1
| 13:27:31.722710 [1] OnRegState: 200 OK
| 13:28:09.722683 [ ] Got "dial" command for sip:[email protected]
| &id001
| id: null
| message: "***Editiert wegen Datenschutz***"
| audio_file: null
| language: fr
| action: null
| choices_are_pin: false
| choices: {}
| default_choice:
|   id: null
|   message: Unknown option
|   audio_file: null
|   language: en
|   action: null
|   choices_are_pin: false
|   choices: null
|   default_choice: null
|   timeout_choice: null
|   post_action:
|     action: return
|     level: 1
|   timeout: 300.0
|   parent_menu: *id001
|   cache_audio: false
|   wait_for_audio_to_finish: false
| timeout_choice:
|   id: null
|   message: null
|   audio_file: null
|   language: en
|   action: null
|   choices_are_pin: false
|   choices: null
|   default_choice: null
|   timeout_choice: null
|   post_action:
|     action: hangup
|   timeout: 300.0
|   parent_menu: *id001
|   cache_audio: false
|   wait_for_audio_to_finish: false
| timeout: 300.0
| post_action:
|   action: hangup
| parent_menu: null
| cache_audio: false
| wait_for_audio_to_finish: false
| 
| 13:28:09.728910 [1] Registering call with id sip:[email protected]
| 13:28:09.728992 [ ] Add to state: sip:[email protected]
/run.sh: line 56:   228 Segmentation fault      (core dumped) python3 /ha-sip/main.py
s6-rc: info: service legacy-services: stopping
s6-rc: info: service legacy-services successfully stopped
s6-rc: info: service legacy-cont-init: stopping
s6-rc: info: service legacy-cont-init successfully stopped
s6-rc: info: service fix-attrs: stopping
s6-rc: info: service fix-attrs successfully stopped
s6-rc: info: service s6rc-oneshot-runner: stopping
s6-rc: info: service s6rc-oneshot-runner successfully stopped
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
s6-rc: info: service legacy-services successfully started
Getting config options from home-assistant OS.
Python 3.11.3
| 13:28:18.014551 [ ] Setting name server: ['5.180.166.3']
| 13:28:18.014629 [ ] Found cache directory '/config/audio_cache'
| 13:28:18.014662 [1] No file name for incoming call config specified.
| 13:28:18.014691 [2] No file name for incoming call config specified.
| 13:28:18.014708 [3] No file name for incoming call config specified.
13:28:18.015         os_core_unix.c !pjlib 2.14.1 for POSIX initialized
13:28:18.015         sip_endpoint.c  .Creating endpoint instance...
13:28:18.015                  pjlib  .select() I/O Queue created (0x7f95170480b8)
13:28:18.015         sip_endpoint.c  .Module "mod-msg-print" registered
13:28:18.015        sip_transport.c  .Transport manager created.
13:28:18.015           pjsua_core.c  .PJSUA state changed: NULL --> CREATED
| 13:28:18.022235 [ ] Supported audio codecs: speex/16000/1, speex/8000/1, speex/32000/1, iLBC/8000/1, GSM/8000/1, PCMU/8000/1, PCMA/8000/1, G722/16000/1, opus/48000/2, L16/44100/2, L16/44100/1
| 13:28:18.028681 [1] OnRegState: 200 OK

Mein HA OS läuft auch in einer VM mit 4CPU, 4Gig Ram und 128 GB Disk.

DarkWarden85 avatar Apr 14 '25 12:04 DarkWarden85

Ich habe das gleiche Problem. Mein HA läuft insgesamt sehr stabil in einer VM auf meiner Synology mit 3GB RAM (für die VM). HA ist immer die aktuellste Version.

Ich versuche eigenlich nur ein FritzFon klingeln zu lassen, quasi als Verlängerung der Haustürklingel: Eine Sprachnachricht wäre zwar schön - ist aber zweitrangig. Zumindest momentan.

Leider funktioniert das Klingeln aber eher selten, denn meist bekomme ich auch die

/run.sh: line 56: 228 Segmentation fault (core dumped) python3 /ha-sip/main.py

Fehlermeldung wie meine Vorredner. Ich wäre sehr dankbar für jeden Hinweis und offen für alle Versuche.

Ralf

ralf8070 avatar Apr 30 '25 20:04 ralf8070

Ich habe diesen Effekt auch auf einem Home Assistant Green, ebenfalls aktuellste HA-Version. In der Vergangenheit ist mir das nicht aufgefallen, weil es eigentlich lief und ich die Funktion selten genutzt habe. Ich habe aber gerade etwas umgestellt und wollte dafür Testanrufe starten - einige wenigen liefen, aber die meisten brachten obigen Fehler. Ich bin ebenfalls fürs Debugging oder etwaige Versuche offen.

fwmone avatar May 16 '25 13:05 fwmone

Hab das Problem auch

kugel- avatar Jun 05 '25 06:06 kugel-

This issue is unfortunately making the plugin unusable. About every third call I get this error.

matrndev avatar Jun 14 '25 13:06 matrndev

Gleiches bei mir: 00:27:03.194 pjsua_aud.c ...Opening null sound device.. /run.sh: line 56: 228 Segmentation fault (core dumped) python3 /ha-sip/main.py

JohnnyMT avatar Jun 28 '25 22:06 JohnnyMT

Can you check with 4.1, please?

arnonym avatar Jul 19 '25 08:07 arnonym

Can you check with 4.1, please?

It seems to work stable now, Arne. Thank you very much !! Great work !

ralf8070 avatar Jul 20 '25 14:07 ralf8070

Hi Arne, I heavily used your plugin the last 2 days and had not a single occurance of the issue anymore. So it looks like it is fixed. Thanks a lot! 👍🏻

JohnnyMT avatar Jul 20 '25 15:07 JohnnyMT

I also tried it multiple times and for now the problem has not resurfaced. Seems fixed for me. Thank you very much.

DarkWarden85 avatar Jul 21 '25 09:07 DarkWarden85