Justin Piszcz
2022-Dec-02 17:22 UTC
[asterisk-users] Upgraded from asterisk 18.14.0 to 20.0.0 and inbound registration(?) is now failing
Hello, I have been using asterisk for the past decade and never had an issue with upgrades until now. Recently, in November I upgraded from 18.14.0 to 20.0.0 and afterwards my SPA3102 can no longer register with asterisk. I have not made any asterisk or SPA3102 configuration changes in ~1-2 years. asterisk versions: (old -> new) 18.14.0~dfsg+~cs6.12.40431414-1+b1 20.0.0~dfsg+~cs6.12.40431414-2 An example of the log from the SPA3102 under asterisk (succeeds) 18 vs. asterisk 20 (fails), kindly inquiring what I may have missed that is causing these failures? asterisk18_sip_success.txt (inbound call success) from the SPA3102 (with asterisk 18 installed) Dec 1 17:34:55 system1 local3 fs: 11707:11782:65536 Dec 1 17:34:55 system1 local3 fls: af:1:0:0 Dec 1 17:34:55 system1 local3 fbr: 0:3000:3000:03d6a:0008:0007:5.1.10(GW) Dec 1 17:34:55 system1 local3 fhs: 01:0:0001:upg:app:0:3.3.6(GW) Dec 1 17:34:55 system1 local3 fhs: 02:0:0002:upg:app:1:3.3.6(GW) Dec 1 17:34:55 system1 local3 fhs: 03:0:0003:upg:app:2:3.3.6(GW) Dec 1 17:34:55 system1 local3 fhs: 04:0:0004:upg:app:0:5.1.10(GW) Dec 1 17:34:55 system1 local3 fhs: 05:0:0005:upg:app:1:5.1.10(GW) Dec 1 17:34:55 system1 local3 fhs: 06:0:0006:upg:app:2:5.1.10(GW) Dec 1 17:34:56 system1 local3 fu: 0:3d91, 0003 0001 Dec 1 17:35:19 system1 local2 FXO: Start CNDD Dec 1 17:35:21 system1 local2 FXO: CNDD name=11234567890, number=1234567890 Dec 1 17:35:21 system1 local2 FXO: Stop CNDD Dec 1 17:35:21 system1 local3 FXO: CNDD Name=11234567890 Phone=1234567890 Dec 1 17:35:22 system1 local2 AUD: Stop PSTN Tone Dec 1 17:35:22 system1 local2 AUD: Stop PSTN Tone Dec 1 17:35:22 system1 local2 Calling: 123 at system1.int.com:0 Dec 1 17:35:22 system1 local2 [1:0]AUD ALLOC CALL (port=16458) Dec 1 17:35:22 system1 local2 [1:0]RTP Rx Up Dec 1 17:35:22 system1 local2 CC: pc(0)=18 not in codec list Dec 1 17:35:22 system1 local2 [0:0]AUD ALLOC CALL (port=16460) Dec 1 17:35:22 system1 local2 [0:0]RTP Rx Up Dec 1 17:35:22 system1 local2 CC: Ringback Dec 1 17:35:22 system1 local2 [1:0]RTP Rx Dn Dec 1 17:35:22 system1 local2 AUD: Play PSTN Tone 9 Dec 1 17:35:23 system1 local3 IDBG: sc-0 Dec 1 17:35:23 system1 local3 IDBG: rs:10 Dec 1 17:35:26 system1 local3 IDBG: sc-0 Dec 1 17:35:26 system1 local3 IDBG: rs:8 Dec 1 17:35:32 system1 local2 AUD: Stop PSTN Tone Dec 1 17:35:32 system1 local3 FXO: On Hook Dec 1 17:35:32 system1 local2 AUD: Stop PSTN Tone Dec 1 17:35:32 system1 local2 FXO: Stop CNDD Dec 1 17:35:32 system1 local3 [0]FM Alert Stop RxTx (c=002550b0;a=0) Dec 1 17:35:32 system1 local2 [1:0]AUD Rel Call Dec 1 17:35:32 system1 local3 [0]FM Alert Stop RxTx (c=0024e5e8;a=0) Dec 1 17:35:32 system1 local2 [0:0]AUD Rel Call Dec 1 17:35:32 system1 local2 CC: Ended asterisk20_sip_error.txt (inbound call failure) from the SPA3102 (with asterisk 20 installed) Dec 1 17:23:21 system1 local2 FXO: Start CNDD Dec 1 17:23:23 system1 local2 FXO: CNDD name=11234567890, number=1234567890 Dec 1 17:23:23 system1 local2 FXO: Stop CNDD Dec 1 17:23:23 system1 local3 FXO: CNDD Name=11234567890 Phone=1234567890 Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone Dec 1 17:23:24 system1 local2 Calling: 123 at system1.int.com:0 Dec 1 17:23:24 system1 local2 [1:0]AUD ALLOC CALL (port=16418) Dec 1 17:23:24 system1 local2 [1:0]RTP Rx Up Dec 1 17:23:24 system1 local2 [1]SIP:ICMP Error -1 (a000001:5060, 2) Dec 1 17:23:24 system1 local3 RSE_DEBUG: getting alternate from domain: system1.int.com Dec 1 17:23:24 system1 local3 [0]FM Alert Stop RxTx (c=002550b0;a=0) Dec 1 17:23:24 system1 local2 [1:0]AUD Rel Call Dec 1 17:23:24 system1 local2 CC: Failed w/ Calling Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone Dec 1 17:23:39 system1 local2 AUD: Stop PSTN Tone Dec 1 17:23:39 system1 local3 FXO: On Hook Dec 1 17:23:39 system1 local2 AUD: Stop PSTN Tone Dec 1 17:23:39 system1 local2 FXO: Stop CNDD Regards, Justin -------------- next part -------------- An HTML attachment was scrubbed... URL: <http://lists.digium.com/pipermail/asterisk-users/attachments/20221202/bc84d206/attachment.html>
Mark Murawski
2022-Dec-02 17:30 UTC
[asterisk-users] Upgraded from asterisk 18.14.0 to 20.0.0 and inbound registration(?) is now failing
Hi Justin, There's absolutely no detail here regarding the SIP messages going out and back. You'll need to include the asterisk-side sip debug. https://wiki.asterisk.org/wiki/display/AST/Collecting+Debug+Information https://support.digium.com/s/article/How-to-collect-an-Asterisk-Debug-Capture If you're using pjsip, you'll need to use it's specific logging. https://www.asterisk.org/new-pjsip-logging-functionality/ On 12/2/22 12:22, Justin Piszcz wrote:> Hello, > > I have been using asterisk for the past decade and never had an issue > with upgrades until now. Recently, in November I upgraded from > 18.14.0 to 20.0.0 and afterwards my SPA3102 can no longer register > with asterisk. I have not made any asterisk or SPA3102 configuration > changes in ~1-2 years. > > asterisk versions: (old -> new) > 18.14.0~dfsg+~cs6.12.40431414-1+b1 > 20.0.0~dfsg+~cs6.12.40431414-2 > > An example of the log from the SPA3102 under asterisk (succeeds) 18 > vs. asterisk 20 (fails), kindly inquiring what I may have missed that > is causing these failures? > > asterisk18_sip_success.txt (inbound call success) from the SPA3102 > (with asterisk 18 installed) > Dec 1 17:34:55 system1 local3 fs: 11707:11782:65536 > Dec 1 17:34:55 system1 local3 fls: af:1:0:0 > Dec 1 17:34:55 system1 local3 fbr: 0:3000:3000:03d6a:0008:0007:5.1.10(GW) > Dec 1 17:34:55 system1 local3 fhs: 01:0:0001:upg:app:0:3.3.6(GW) > Dec 1 17:34:55 system1 local3 fhs: 02:0:0002:upg:app:1:3.3.6(GW) > Dec 1 17:34:55 system1 local3 fhs: 03:0:0003:upg:app:2:3.3.6(GW) > Dec 1 17:34:55 system1 local3 fhs: 04:0:0004:upg:app:0:5.1.10(GW) > Dec 1 17:34:55 system1 local3 fhs: 05:0:0005:upg:app:1:5.1.10(GW) > Dec 1 17:34:55 system1 local3 fhs: 06:0:0006:upg:app:2:5.1.10(GW) > Dec 1 17:34:56 system1 local3 fu: 0:3d91, 0003 0001 > Dec 1 17:35:19 system1 local2 FXO: Start CNDD > Dec 1 17:35:21 system1 local2 FXO: CNDD name=11234567890, > number=1234567890 > Dec 1 17:35:21 system1 local2 FXO: Stop CNDD > Dec 1 17:35:21 system1 local3 FXO: CNDD Name=11234567890 Phone=1234567890 > Dec 1 17:35:22 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:35:22 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:35:22 system1 local2 Calling: 123 at system1.int.com:0 > <http://123 at system1.int.com:0> > Dec 1 17:35:22 system1 local2 [1:0]AUD ALLOC CALL (port=16458) > Dec 1 17:35:22 system1 local2 [1:0]RTP Rx Up > Dec 1 17:35:22 system1 local2 CC: pc(0)=18 not in codec list > Dec 1 17:35:22 system1 local2 [0:0]AUD ALLOC CALL (port=16460) > Dec 1 17:35:22 system1 local2 [0:0]RTP Rx Up > Dec 1 17:35:22 system1 local2 CC: Ringback > Dec 1 17:35:22 system1 local2 [1:0]RTP Rx Dn > Dec 1 17:35:22 system1 local2 AUD: Play PSTN Tone 9 > Dec 1 17:35:23 system1 local3 IDBG: sc-0 > Dec 1 17:35:23 system1 local3 IDBG: rs:10 > Dec 1 17:35:26 system1 local3 IDBG: sc-0 > Dec 1 17:35:26 system1 local3 IDBG: rs:8 > Dec 1 17:35:32 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:35:32 system1 local3 FXO: On Hook > Dec 1 17:35:32 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:35:32 system1 local2 FXO: Stop CNDD > Dec 1 17:35:32 system1 local3 [0]FM Alert Stop RxTx (c=002550b0;a=0) > Dec 1 17:35:32 system1 local2 [1:0]AUD Rel Call > Dec 1 17:35:32 system1 local3 [0]FM Alert Stop RxTx (c=0024e5e8;a=0) > Dec 1 17:35:32 system1 local2 [0:0]AUD Rel Call > Dec 1 17:35:32 system1 local2 CC: Ended > > > asterisk20_sip_error.txt (inbound call failure) from the SPA3102 > (with asterisk 20 installed) > Dec 1 17:23:21 system1 local2 FXO: Start CNDD > Dec 1 17:23:23 system1 local2 FXO: CNDD name=11234567890, > number=1234567890 > Dec 1 17:23:23 system1 local2 FXO: Stop CNDD > Dec 1 17:23:23 system1 local3 FXO: CNDD Name=11234567890 Phone=1234567890 > Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:24 system1 local2 Calling: 123 at system1.int.com:0 > <http://123 at system1.int.com:0> > Dec 1 17:23:24 system1 local2 [1:0]AUD ALLOC CALL (port=16418) > Dec 1 17:23:24 system1 local2 [1:0]RTP Rx Up > Dec 1 17:23:24 system1 local2 [1]SIP:ICMP Error -1 (a000001:5060, 2) > Dec 1 17:23:24 system1 local3 RSE_DEBUG: getting alternate from > domain:system1.int.com <http://system1.int.com> > Dec 1 17:23:24 system1 local3 [0]FM Alert Stop RxTx (c=002550b0;a=0) > Dec 1 17:23:24 system1 local2 [1:0]AUD Rel Call > Dec 1 17:23:24 system1 local2 CC: Failed w/ Calling > Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:39 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:39 system1 local3 FXO: On Hook > Dec 1 17:23:39 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:39 system1 local2 FXO: Stop CNDD > > Regards, > Justin > >-------------- next part -------------- An HTML attachment was scrubbed... URL: <http://lists.digium.com/pipermail/asterisk-users/attachments/20221202/946c070b/attachment.html>
John Harragin
2022-Dec-02 20:47 UTC
[asterisk-users] Upgraded from asterisk 18.14.0 to 20.0.0 and inbound registration(?) is now failing
I had similar issues. It looks like modules related to pjsip (geolocation?) introduced new prerequisites. There is a script in the source that prepares for an asterisk build. Try running that, then recompile asterisk and see if that fixes things. John On Fri, Dec 2, 2022 at 3:36 PM Justin Piszcz <jpiszcz at lucidpixels.com> wrote:> > Hello, > > I have been using asterisk for the past decade and never had an issue with upgrades until now. Recently, in November I upgraded from 18.14.0 to 20.0.0 and afterwards my SPA3102 can no longer register with asterisk. I have not made any asterisk or SPA3102 configuration changes in ~1-2 years. > > asterisk versions: (old -> new) > 18.14.0~dfsg+~cs6.12.40431414-1+b1 > 20.0.0~dfsg+~cs6.12.40431414-2 > > An example of the log from the SPA3102 under asterisk (succeeds) 18 vs. asterisk 20 (fails), kindly inquiring what I may have missed that is causing these failures? > > asterisk18_sip_success.txt (inbound call success) from the SPA3102 (with asterisk 18 installed) > Dec 1 17:34:55 system1 local3 fs: 11707:11782:65536 > Dec 1 17:34:55 system1 local3 fls: af:1:0:0 > Dec 1 17:34:55 system1 local3 fbr: 0:3000:3000:03d6a:0008:0007:5.1.10(GW) > Dec 1 17:34:55 system1 local3 fhs: 01:0:0001:upg:app:0:3.3.6(GW) > Dec 1 17:34:55 system1 local3 fhs: 02:0:0002:upg:app:1:3.3.6(GW) > Dec 1 17:34:55 system1 local3 fhs: 03:0:0003:upg:app:2:3.3.6(GW) > Dec 1 17:34:55 system1 local3 fhs: 04:0:0004:upg:app:0:5.1.10(GW) > Dec 1 17:34:55 system1 local3 fhs: 05:0:0005:upg:app:1:5.1.10(GW) > Dec 1 17:34:55 system1 local3 fhs: 06:0:0006:upg:app:2:5.1.10(GW) > Dec 1 17:34:56 system1 local3 fu: 0:3d91, 0003 0001 > Dec 1 17:35:19 system1 local2 FXO: Start CNDD > Dec 1 17:35:21 system1 local2 FXO: CNDD name=11234567890, number=1234567890 > Dec 1 17:35:21 system1 local2 FXO: Stop CNDD > Dec 1 17:35:21 system1 local3 FXO: CNDD Name=11234567890 Phone=1234567890 > Dec 1 17:35:22 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:35:22 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:35:22 system1 local2 Calling: 123 at system1.int.com:0 > Dec 1 17:35:22 system1 local2 [1:0]AUD ALLOC CALL (port=16458) > Dec 1 17:35:22 system1 local2 [1:0]RTP Rx Up > Dec 1 17:35:22 system1 local2 CC: pc(0)=18 not in codec list > Dec 1 17:35:22 system1 local2 [0:0]AUD ALLOC CALL (port=16460) > Dec 1 17:35:22 system1 local2 [0:0]RTP Rx Up > Dec 1 17:35:22 system1 local2 CC: Ringback > Dec 1 17:35:22 system1 local2 [1:0]RTP Rx Dn > Dec 1 17:35:22 system1 local2 AUD: Play PSTN Tone 9 > Dec 1 17:35:23 system1 local3 IDBG: sc-0 > Dec 1 17:35:23 system1 local3 IDBG: rs:10 > Dec 1 17:35:26 system1 local3 IDBG: sc-0 > Dec 1 17:35:26 system1 local3 IDBG: rs:8 > Dec 1 17:35:32 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:35:32 system1 local3 FXO: On Hook > Dec 1 17:35:32 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:35:32 system1 local2 FXO: Stop CNDD > Dec 1 17:35:32 system1 local3 [0]FM Alert Stop RxTx (c=002550b0;a=0) > Dec 1 17:35:32 system1 local2 [1:0]AUD Rel Call > Dec 1 17:35:32 system1 local3 [0]FM Alert Stop RxTx (c=0024e5e8;a=0) > Dec 1 17:35:32 system1 local2 [0:0]AUD Rel Call > Dec 1 17:35:32 system1 local2 CC: Ended > > > asterisk20_sip_error.txt (inbound call failure) from the SPA3102 (with asterisk 20 installed) > Dec 1 17:23:21 system1 local2 FXO: Start CNDD > Dec 1 17:23:23 system1 local2 FXO: CNDD name=11234567890, number=1234567890 > Dec 1 17:23:23 system1 local2 FXO: Stop CNDD > Dec 1 17:23:23 system1 local3 FXO: CNDD Name=11234567890 Phone=1234567890 > Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:24 system1 local2 Calling: 123 at system1.int.com:0 > Dec 1 17:23:24 system1 local2 [1:0]AUD ALLOC CALL (port=16418) > Dec 1 17:23:24 system1 local2 [1:0]RTP Rx Up > Dec 1 17:23:24 system1 local2 [1]SIP:ICMP Error -1 (a000001:5060, 2) > Dec 1 17:23:24 system1 local3 RSE_DEBUG: getting alternate from domain:system1.int.com > Dec 1 17:23:24 system1 local3 [0]FM Alert Stop RxTx (c=002550b0;a=0) > Dec 1 17:23:24 system1 local2 [1:0]AUD Rel Call > Dec 1 17:23:24 system1 local2 CC: Failed w/ Calling > Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:24 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:39 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:39 system1 local3 FXO: On Hook > Dec 1 17:23:39 system1 local2 AUD: Stop PSTN Tone > Dec 1 17:23:39 system1 local2 FXO: Stop CNDD > > Regards, > Justin > > -- > _____________________________________________________________________ > -- Bandwidth and Colocation Provided by http://www.api-digital.com -- > > Check out the new Asterisk community forum at: https://community.asterisk.org/ > > New to Asterisk? Start here: > https://wiki.asterisk.org/wiki/display/AST/Getting+Started > > asterisk-users mailing list > To UNSUBSCRIBE or update options visit: > http://lists.digium.com/mailman/listinfo/asterisk-users