search

ugoviti / izpbx

izPBX is a Turnkey Cloud Native Telephony System powered by Asterisk Engine and FreePBX Management GUI
GNU General Public License v3.0
168 stars 69 forks source link

lack of audio RTP activity in 30 seconds #49

Closed fred-gb closed 6 months ago

fred-gb commented 1 year ago

Bonjour, šŸ‘‹šŸ»

First of all, thanks a lot for this repo and project. I'm happy to use this instead a dedicated VM. I start with pbx systems.

I can launched job with Noad + Consul + Vault.

I can access to interface. I can create extensions. I can log with iOS app and MacOS app to server.

I add in SIP Settings, networks ranges: 192.168.10.0/20 172.26.64.0/20 172.17.0.0/16

But, when I make a call between two extentions after 30s it hangs up.

With this error:

[2023-04-13 18:47:20] NOTICE[1335] res_pjsip_sdp_rtp.c: Disconnecting channel 'PJSIP/100-00000004' for lack of audio RTP activity in 30 seconds

I found this article: https://jplucero.com/freepbx-lack-of-rtp-activity/

But I think I already do this with network settings.

I reboot docker. No more works.

I customized port range for RTP: 18000:18100 . It just for my homelab no need many simultanemous calls.

When I make call, I see in netstat open ports:

(izPBX)[root@pbx.service: /]# netstat -lpn
Active Internet connections (only servers)
Proto Recv-Q Send-Q Local Address           Foreign Address         State       PID/Program name    
tcp        0      0 0.0.0.0:80              0.0.0.0:*               LISTEN      1153/httpd          
tcp        0      0 0.0.0.0:5060            0.0.0.0:*               LISTEN      1150/asterisk       
tcp        0      0 0.0.0.0:5038            0.0.0.0:*               LISTEN      1150/asterisk       
tcp        0      0 0.0.0.0:24175           0.0.0.0:*               LISTEN      -                   
tcp        0      0 127.0.0.1:4573          0.0.0.0:*               LISTEN      1590/node /data/var 
tcp        0      0 127.0.0.1:8088          0.0.0.0:*               LISTEN      1150/asterisk       
tcp        0      0 0.0.0.0:29193           0.0.0.0:*               LISTEN      -                   
tcp        0      0 127.0.0.1:3306          0.0.0.0:*               LISTEN      -                   
tcp        0      0 127.0.0.2:19001         0.0.0.0:*               LISTEN      -                   
tcp        0      0 127.0.0.2:19002         0.0.0.0:*               LISTEN      -                   
tcp6       0      0 :::8089                 :::*                    LISTEN      1150/asterisk       
tcp6       0      0 :::8001                 :::*                    LISTEN      1681/node /data/var 
tcp6       0      0 :::8003                 :::*                    LISTEN      1681/node /data/var 
udp        0      0 0.0.0.0:49118           0.0.0.0:*                           1150/asterisk       
udp        0      0 0.0.0.0:35150           0.0.0.0:*                           1150/asterisk       
udp        0      0 0.0.0.0:4520            0.0.0.0:*                           1150/asterisk       
udp        0      0 0.0.0.0:4569            0.0.0.0:*                           1150/asterisk       
udp        0      0 0.0.0.0:5060            0.0.0.0:*                           1150/asterisk       
udp6       0      0 :::18050                :::*                                1150/asterisk       
udp6       0      0 :::18051                :::*                                1150/asterisk       
udp6       0      0 :::18074                :::*                                1150/asterisk       
udp6       0      0 :::18075                :::*                                1150/asterisk       
udp6       0      0 :::60562                :::*                                1150/asterisk       
Active UNIX domain sockets (only servers)
Proto RefCnt Flags       Type       State         I-Node   PID/Program name     Path
unix  2      [ ACC ]     STREAM     LISTENING     13104504 1/python3.6          /run/supervisor/supervisor.sock.1
unix  2      [ ACC ]     STREAM     LISTENING     13107233 1152/python3.6       /var/run/fail2ban/fail2ban.sock
unix  2      [ ACC ]     STREAM     LISTENING     13106319 1150/asterisk        /var/run/asterisk/asterisk.ctl
unix  2      [ ACC ]     STREAM     LISTENING     13104622 1420/PM2 v4.5.0: Go  /home/asterisk/.pm2/pub.sock
unix  2      [ ACC ]     STREAM     LISTENING     13104623 1420/PM2 v4.5.0: Go  /home/asterisk/.pm2/rpc.sock
Active Bluetooth connections (only servers)
Proto  Destination       Source            State         PSM DCID   SCID      IMTU    OMTU Security
Proto  Destination       Source            State     Channel

This is full log of a call:


[2023-04-13 18:46:50] VERBOSE[1294] netsock2.c: Using SIP RTP Audio TOS bits 184
[2023-04-13 18:46:50] VERBOSE[1294] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2023-04-13 18:46:50] VERBOSE[1294] netsock2.c: Using SIP RTP Audio CoS mark 5
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [101@from-internal:1] GotoIf("PJSIP/100-00000004", "1?ext-local,101,1:followme-check,101,1") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (ext-local,101,1)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [101@ext-local:1] Set("PJSIP/100-00000004", "__RINGTIMER=15") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [101@ext-local:2] ExecIf("PJSIP/100-00000004", "0?Set(__CWIGNORE=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [101@ext-local:3] Macro("PJSIP/100-00000004", "exten-vm,novm,101,0,0,0") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-exten-vm:1] Macro("PJSIP/100-00000004", "user-callerid,") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/100-00000004", "TOUCH_MONITOR=1681404410.4") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/100-00000004", "CHANCONTEXT=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/100-00000004", "CHANCONTEXT=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/100-00000004", "CHANEXTENCONTEXT=100-00000004") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/100-00000004", "CHANEXTEN=100-00000004") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/100-00000004", "CALLERID(number)=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/100-00000004", "AMPUSER=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/100-00000004", "HOTDESCKCHAN=100-00000004") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/100-00000004", "HOTDESKEXTEN=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/100-00000004", "HOTDESKCALL=0") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("PJSIP/100-00000004", "0?Set(HOTDESKCALL=1)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/100-00000004", "0?Set(CALLERID(name)=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/100-00000004", "0?report") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/100-00000004", "1?Set(REALCALLERIDNUM=100)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/100-00000004", "AMPUSER=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("PJSIP/100-00000004", "0?limit") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/100-00000004", "AMPUSERCIDNAME=Fred") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("PJSIP/100-00000004", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("PJSIP/100-00000004", "0?report") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/100-00000004", "AMPUSERCID=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:21] Set("PJSIP/100-00000004", "__DIAL_OPTIONS=HhTtr") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:22] Set("PJSIP/100-00000004", "CALLERID(all)="Fred" <100>") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("PJSIP/100-00000004", "0?Set(CUSDIAL=101)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/100-00000004", "0?Set(CALLERID(all)="Fred" <100>)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("PJSIP/100-00000004", "0?limit") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:26] ExecIf("PJSIP/100-00000004", "0?Set(GROUP(concurrency_limit)=100)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:27] NoOp("PJSIP/100-00000004", "Macro Depth is 2") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:28] GotoIf("PJSIP/100-00000004", "1?report2:macroerror") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,29)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:29] GotoIf("PJSIP/100-00000004", "0?continue") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:30] Set("PJSIP/100-00000004", "__TTL=64") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/100-00000004", "1?continue") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,47)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:47] Set("PJSIP/100-00000004", "CALLERID(number)=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:48] Set("PJSIP/100-00000004", "CALLERID(name)=Fred") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:49] GotoIf("PJSIP/100-00000004", "0?cnum") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/100-00000004", "CDR(cnam)=Fred") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/100-00000004", "CDR(cnum)=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-user-callerid:52] Set("PJSIP/100-00000004", "CHANNEL(language)=en") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/100-00000004", "RingGroupMethod=none") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/100-00000004", "__EXTTOCALL=101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/100-00000004", "__PICKUPMARK=101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/100-00000004", "RT=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-exten-vm:6] Gosub("PJSIP/100-00000004", "sub-record-check,s,1(exten,101,dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/100-00000004", "0?initialized") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/100-00000004", "__REC_STATUS=INITIALIZED") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/100-00000004", "NOW=1681404410") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/100-00000004", "__DAY=13") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/100-00000004", "__MONTH=04") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/100-00000004", "__YEAR=2023") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/100-00000004", "__TIMESTR=20230413-184650") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/100-00000004", "__FROMEXTEN=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/100-00000004", "__MON_FMT=wav") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/100-00000004", "Recordings initialized") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/100-00000004", "0?Set(ARG3=dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/100-00000004", "REC_POLICY_MODE_SAVE=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/100-00000004", "0?Set(REC_STATUS=NO)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/100-00000004", "5?checkaction") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,17)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/100-00000004", "1?sub-record-check,exten,1") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (sub-record-check,exten,1)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/100-00000004", "Exten Recording Check between 100 and 101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/100-00000004", "CALLTYPE=internal") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/100-00000004", "0?Set(CALLTYPE=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/100-00000004", "CALLEE=dontcare") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/100-00000004", "0?Set(CALLEE=dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/100-00000004", "0?callee") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:7] GotoIf("PJSIP/100-00000004", "1?caller") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (sub-record-check,exten,13)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:13] Set("PJSIP/100-00000004", "RECMODE=dontcare") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:14] Set("PJSIP/100-00000004", "CALLERRECMODE=dontcare") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:15] Set("PJSIP/100-00000004", "CALEERECMODE=dontcare") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:16] GotoIf("PJSIP/100-00000004", "0?processnormal") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:17] ExecIf("PJSIP/100-00000004", "0?Set(RECMODE=dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:18] ExecIf("PJSIP/100-00000004", "0?Set(RECMODE=dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:19] ExecIf("PJSIP/100-00000004", "0?Set(RECMODE=dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:20] ExecIf("PJSIP/100-00000004", "0?Set(RECMODE=dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:21] ExecIf("PJSIP/100-00000004", "0?Set(RECMODE=dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:22] ExecIf("PJSIP/100-00000004", "1?Set(RECMODE=dontcare)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:23] Gosub("PJSIP/100-00000004", "recordcheck,1(dontcare,internal,101)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/100-00000004", "Starting recording check against dontcare") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/100-00000004", "dontcare") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/100-00000004", "") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [exten@sub-record-check:24] Return("PJSIP/100-00000004", "") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-exten-vm:7] Macro("PJSIP/100-00000004", "dial-one,,HhTtr,101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/100-00000004", "DEXTEN=101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:2] ExecIf("PJSIP/100-00000004", "0?Set(__EXTTOCALL=101)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:3] Set("PJSIP/100-00000004", "DIALSTATUS_CW=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:4] GosubIf("PJSIP/100-00000004", "0?screen,1()") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:5] GosubIf("PJSIP/100-00000004", "0?cf,1()") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:6] GotoIf("PJSIP/100-00000004", "1?skip1") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,9)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:9] GotoIf("PJSIP/100-00000004", "0?nodial") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:10] GotoIf("PJSIP/100-00000004", "0?continue") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:11] Set("PJSIP/100-00000004", "EXTHASCW=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:12] GotoIf("PJSIP/100-00000004", "1?next1:cwinusebusy") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,13)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:13] GotoIf("PJSIP/100-00000004", "0?docfu:skip3") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,17)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:17] GotoIf("PJSIP/100-00000004", "1?next2:continue") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,18)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:18] GotoIf("PJSIP/100-00000004", "1?continue") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,26)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:26] GotoIf("PJSIP/100-00000004", "0?nodial") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:27] GosubIf("PJSIP/100-00000004", "1?dstring,1():dlocal,1()") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/100-00000004", "DSTRING=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/100-00000004", "DEVICES=101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/100-00000004", "0?Return()") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/100-00000004", "0?Set(DEVICES=01)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/100-00000004", "LOOPCNT=1") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/100-00000004", "ITER=1") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/100-00000004", "THISDIAL=PJSIP/101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:8] GotoIf("PJSIP/100-00000004", "0?docheck") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:9] NoOp("PJSIP/100-00000004", "Debug: Found PJSIP Destination PJSIP/101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:10] GotoIf("PJSIP/100-00000004", "0?doset") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:11] NoOp("PJSIP/100-00000004", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:12] Set("PJSIP/100-00000004", "THISDIAL=PJSIP/101/sip:101@192.168.10.189:50008;rinstance=9c4c02817b2b805a") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:13] ExecIf("PJSIP/100-00000004", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("PJSIP/100-00000004", "0?skipset") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:15] Set("PJSIP/100-00000004", "DSTRING=PJSIP/101/sip:101@192.168.10.189:50008;rinstance=9c4c02817b2b805a&") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/100-00000004", "ITER=2") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("PJSIP/100-00000004", "0?begin") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("PJSIP/100-00000004", "0?Return()") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:19] Set("PJSIP/100-00000004", "DSTRING=PJSIP/101/sip:101@192.168.10.189:50008;rinstance=9c4c02817b2b805a") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [dstring@macro-dial-one:20] Return("PJSIP/100-00000004", "") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:28] GotoIf("PJSIP/100-00000004", "0?nodial") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:29] GotoIf("PJSIP/100-00000004", "0?skiptrace") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:30] GosubIf("PJSIP/100-00000004", "1?ctset,1():ctclear,1()") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [ctset@macro-dial-one:1] Set("PJSIP/100-00000004", "DB(CALLTRACE/101)=100") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [ctset@macro-dial-one:2] Return("PJSIP/100-00000004", "") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:31] Set("PJSIP/100-00000004", "D_OPTIONS=HhTtr") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:32] GosubIf("PJSIP/100-00000004", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:33] NoOp("PJSIP/100-00000004", "Blind Transfer: , Attended Transfer: , User: 100, Alert Info: ") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:34] ExecIf("PJSIP/100-00000004", "1?Set(ALERT_INFO=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:35] ExecIf("PJSIP/100-00000004", "0?Set(ALERT_INFO=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:36] ExecIf("PJSIP/100-00000004", "0?Set(ALERT_INFO=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:37] ExecIf("PJSIP/100-00000004", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:38] ExecIf("PJSIP/100-00000004", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:39] GosubIf("PJSIP/100-00000004", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:40] ExecIf("PJSIP/100-00000004", "0?Set(CHANNEL(musicclass)=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:41] GosubIf("PJSIP/100-00000004", "0?qwait,1()") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:42] Set("PJSIP/100-00000004", "__CWIGNORE=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:43] Set("PJSIP/100-00000004", "__KEEPCID=TRUE") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:44] GotoIf("PJSIP/100-00000004", "0?usegoto,1") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:45] GotoIf("PJSIP/100-00000004", "0?godial") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:46] Gosub("PJSIP/100-00000004", "sub-presencestate-display,s,1(101)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@sub-presencestate-display:1] Goto("PJSIP/100-00000004", "state-available,1") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (sub-presencestate-display,state-available,1)
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [state-available@sub-presencestate-display:1] Set("PJSIP/100-00000004", "PRESENCESTATE_DISPLAY=(Available)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [state-available@sub-presencestate-display:2] Return("PJSIP/100-00000004", "") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:47] Set("PJSIP/100-00000004", "CONNECTEDLINE(name,i)=Fred-macbook (Available)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:48] Set("PJSIP/100-00000004", "CONNECTEDLINE(num)=101") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:49] Set("PJSIP/100-00000004", "D_OPTIONS=HhTtr") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:50] Macro("PJSIP/100-00000004", "dialout-one-predial-hook,") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] MacroExit("PJSIP/100-00000004", "") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:51] ExecIf("PJSIP/100-00000004", "0?Set(D_OPTIONS=HhtrI)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:52] ExecIf("PJSIP/100-00000004", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:53] NoOp("PJSIP/100-00000004", "") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:54] ExecIf("PJSIP/100-00000004", "0?Set(D_OPTIONS=HhTtrg)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-dial-one:55] Dial("PJSIP/100-00000004", "PJSIP/101/sip:101@192.168.10.189:50008;rinstance=9c4c02817b2b805a,,HhTtrb(func-apply-sipheaders^s^1)") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] app_stack.c: PJSIP/101-00000005 Internal Gosub(func-apply-sipheaders,s,1) start
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("PJSIP/101-00000005", "Applying SIP Headers to channel PJSIP/101-00000005") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:2] Set("PJSIP/101-00000005", "TECH=PJSIP") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/101-00000005", "SIPHEADERKEYS=") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:4] While("PJSIP/101-00000005", "0") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] app_while.c: Jumping to priority 10
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:11] Return("PJSIP/101-00000005", "") in new stack
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] app_stack.c: Spawn extension (func-apply-sipheaders, s, 11) exited non-zero on 'PJSIP/101-00000005'
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] app_stack.c: PJSIP/101-00000005 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2023-04-13 18:46:50] VERBOSE[1294] netsock2.c: Using SIP RTP Audio TOS bits 184
[2023-04-13 18:46:50] VERBOSE[1294] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2023-04-13 18:46:50] VERBOSE[1294] netsock2.c: Using SIP RTP Audio CoS mark 5
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] app_dial.c: Called PJSIP/101/sip:101@192.168.10.189:50008;rinstance=9c4c02817b2b805a
[2023-04-13 18:46:50] VERBOSE[5495][C-00000003] app_dial.c: PJSIP/101-00000005 is ringing
[2023-04-13 18:47:01] VERBOSE[5495][C-00000003] app_dial.c: PJSIP/101-00000005 answered PJSIP/100-00000004
[2023-04-13 18:47:01] VERBOSE[5514][C-00000003] bridge_channel.c: Channel PJSIP/101-00000005 joined 'simple_bridge' basic-bridge <7839f153-eefe-475c-96af-f3a9d2de879a>
[2023-04-13 18:47:01] VERBOSE[5495][C-00000003] bridge_channel.c: Channel PJSIP/100-00000004 joined 'simple_bridge' basic-bridge <7839f153-eefe-475c-96af-f3a9d2de879a>
[2023-04-13 18:47:20] NOTICE[1335] res_pjsip_sdp_rtp.c: Disconnecting channel 'PJSIP/101-00000005' for lack of audio RTP activity in 30 seconds
[2023-04-13 18:47:20] VERBOSE[5514][C-00000003] bridge_channel.c: Channel PJSIP/101-00000005 left 'simple_bridge' basic-bridge <7839f153-eefe-475c-96af-f3a9d2de879a>
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] bridge_channel.c: Channel PJSIP/100-00000004 left 'simple_bridge' basic-bridge <7839f153-eefe-475c-96af-f3a9d2de879a>
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] app_macro.c: Spawn extension (macro-dial-one, s, 55) exited non-zero on 'PJSIP/100-00000004' in macro 'dial-one'
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] app_macro.c: Spawn extension (macro-exten-vm, s, 7) exited non-zero on 'PJSIP/100-00000004' in macro 'exten-vm'
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] pbx.c: Spawn extension (ext-local, 101, 3) exited non-zero on 'PJSIP/100-00000004'
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/100-00000004", "hangupcall,") in new stack
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/100-00000004", "1?theend") in new stack
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2023-04-13 18:47:20] NOTICE[1335] res_pjsip_sdp_rtp.c: Disconnecting channel 'PJSIP/100-00000004' for lack of audio RTP activity in 30 seconds
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/100-00000004", "0?Set(CDR(recordingfile)=)") in new stack
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] pbx.c: Executing [s@macro-hangupcall:4] Hangup("PJSIP/100-00000004", "") in new stack
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'PJSIP/100-00000004' in macro 'hangupcall'
[2023-04-13 18:47:20] VERBOSE[5495][C-00000003] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/100-00000004'
^C
(izPBX)[root@pbx.service: /]#

When I start the job, I have this error:

[2023-04-13 18:20:19] ERROR[1150] loader.c: Error loading module 'res_pjsip_phoneprov_provider.so', missing dependency: res_phoneprov
[2023-04-13 18:20:19] ERROR[1150] loader.c: chan_dongle declined to load.

I don't know if it's related.

Other tweak I did, in cel_odbc.conf I changed:

[cel]
connection=pbx-cdrdb <---- I have an special mariadb database for it
loguniqueid=yes
table=cel
usegmtime=no
#include cel_odbc_custom.conf

Does I need to changes other settings from initial launch?

As often, it should be a detail that I miss. Thanks! šŸ˜¢ šŸ†˜

ugoviti commented 1 year ago

Hi Fred,

this problem is strange... what distribution do you use in the host server? If using RedHat based distro, can make sure you have deactivated "firewalld" service and "selinux"?

Kind regards

fred-gb commented 1 year ago

Hi & thanks!

Ubuntu 22.04 No UFW install yet.

khairul85 commented 1 year ago

same error

[2023-04-17 15:25:49] NOTICE[1137]: res_pjsip_sdp_rtp.c:146 rtp_check_timeout: Disconnecting channel 'PJSIP/200-00000016' for lack of video RTP activity in 30 seconds

fred-gb commented 1 year ago

Network rules as often.

I tried on another VM with only docker-compose (so I entirely change than hashistack) and It works out-of-box, like @ugoviti said.

Are you in netwok mode host?

khairul85 commented 1 year ago

Hi Fred,

The current setup is in host mode.

I thought that using the UDP transport would not be an issue. However, problems arose when using the WS/WSS transport with the WebRTC client.

For testing, I'm using this client --> https://www.innovateasterisk.com/phone

fred-gb commented 1 year ago

Hi,

Can you try: tcpdump -i eth0 portrange 10000-20000

(Remember to adjust eth0 and portrange according to your configuration.)

And make a call to see in the log if there is any traffic activity.

michaelfangtw commented 1 year ago

@khairul85 I build izpbx on gcp and I have the same issue with you ,disconnected after slient 30sec. I use 2 microsip phones to connect to izpbx on GCP. here are some notes for you to refer to.

  1. if you run izpbx in INTERNET and your sip phone is in intranet and using nat to internet.

freepbx/setting/advance sip setting/ nat setting/external address -->fill your pbx external ip <MUST , in internet> nat setting/local networks -->fill your pbx local network ip

  1. if you run izpbx in INTRANET : nat setting keep blank is ok.

ę“·å–

fittben commented 1 year ago

turn off sipalg if it is on in your router

ugoviti commented 6 months ago

this problem is solved? I close this issue, if so, reopen it