AllStarLink / app_rpt

Refactoring and upgrade of AllStarLink's app_rpt, etc.
8 stars 6 forks source link

SimpleUSB CPU Utilization w/o Configured Device #330

Open tsawyer opened 4 months ago

tsawyer commented 4 months ago

On my Rpi5 with a configured SimpleUSB device unplugged one CPU and one thread reach near 100%. No impact to node performance is noticed. CPU utilization returns to normal when device is plugged in.

Screenshot 2024-05-16 at 10 43 54 AM
InterLinked1 commented 4 months ago

On my Rpi5 with a configured SimpleUSB device unplugged one CPU and one thread reach near 100%. No impact to node performance is noticed. CPU utilization returns to normal when device is plugged in.

Screenshot 2024-05-16 at 10 43 54 AM

This needs a backtrace (using ast_coredumper), please also include the output of phreaknet threads

tsawyer commented 4 months ago

This needs a backtrace (using ast_coredumper), please also include the output of phreaknet threads

I'll need to build a new system to do that. This is a debs install. I'll make a note to set up a new source based system..

Also I think a priority of -11 is CPU friendly. Maybe device string discovery is doing this at a low priority?

KB4MDD commented 4 months ago

@tsawyer does your config file for simpleusb contain a device string?

KB4MDD commented 4 months ago

It would also be helpful to see the log file right before the unplug, during the unplug, and after it is reconnected.

tsawyer commented 4 months ago

simpleusb.conf has devstr = 1-2:1.0

When unplugging the USB cable the log shows... [2024-05-18 11:55:44.063] ERROR[4315] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found. No messages are seen while unplugged or when plugged back in.

tsawyer commented 4 months ago

Occasionally there are some related messages not mentioned above. There isn't a discernible pattern I see. Here's more log...

tail -100 /var/log/asterisk/messages.log
[2024-05-18 10:23:16.834] WARNING[4264] chan_dahdi.c: Only FXO signalled channels may belong to a call group
[2024-05-18 10:23:16.834] WARNING[4264] chan_dahdi.c: Only FXO signalled channels may belong to a pickup group
[2024-05-18 10:23:16.834] NOTICE[4264] chan_dahdi.c: Ignoring any changes to 'userbase' (on reload) at line 23.
[2024-05-18 10:23:16.834] NOTICE[4264] chan_dahdi.c: Ignoring any changes to 'vmsecret' (on reload) at line 31.
[2024-05-18 10:23:16.834] NOTICE[4264] chan_dahdi.c: Ignoring any changes to 'hassip' (on reload) at line 35.
[2024-05-18 10:23:16.834] NOTICE[4264] chan_dahdi.c: Ignoring any changes to 'hasiax' (on reload) at line 39.
[2024-05-18 10:23:16.834] NOTICE[4264] chan_dahdi.c: Ignoring any changes to 'hasmanager' (on reload) at line 47.
[2024-05-18 10:23:16.834] WARNING[4264] chan_dahdi.c: Only FXO signalled channels may belong to a call group
[2024-05-18 10:23:16.834] WARNING[4264] chan_dahdi.c: Only FXO signalled channels may belong to a pickup group
[2024-05-18 10:23:16.956] WARNING[4264] loader.c: Module 'res_adsi' has been loaded but may be removed in a future release.
[2024-05-18 10:23:17.095] NOTICE[4307] app_rpt.c: Normal Repeater Init  2506
[2024-05-18 10:23:17.095] NOTICE[4307] app_rpt.c: Normal Repeater Init  2507
[2024-05-18 10:23:17.096] NOTICE[4314] chan_simpleusb.c: Channel 2507: Set option TONE VERIFY, mode: OFF(0).
[2024-05-18 10:23:17.155] NOTICE[4315] chan_simpleusb.c: Channel 2507: Automatically assigned USB device 1-2:1.0 to SimpleUSB channel
[2024-05-18 10:28:16.887] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 10:28:17.080] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 10:33:17.081] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 10:38:17.079] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 10:43:17.103] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 10:53:17.073] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 10:53:17.078] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 10:58:17.073] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 11:08:17.071] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 11:08:17.076] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 11:23:17.073] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 11:28:17.073] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 11:33:17.086] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 11:33:17.092] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 11:38:17.078] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 11:38:17.083] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 11:48:17.073] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 11:48:17.077] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 11:53:46.759] ERROR[4315] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 11:55:15.743] ERROR[4315] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 11:55:44.063] ERROR[4315] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 11:58:17.072] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 11:58:17.076] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 12:01:04.107] ERROR[4315] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:01:37.003] ERROR[4314] chan_simpleusb.c: Channel 2507: HID process has died or is not responding.
[2024-05-18 12:01:39.631] WARNING[4307] app_rpt.c: rpt_thread restarted on node 2507
[2024-05-18 12:01:39.631] NOTICE[6362] chan_simpleusb.c: Channel 2507: Set option TONE VERIFY, mode: OFF(0).
[2024-05-18 12:02:09.239] ERROR[6363] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:03:04.587] DTMF[4312] channel.c: DTMF begin '*' received on voter/2506
[2024-05-18 12:03:04.587] DTMF[4312] channel.c: DTMF begin passthrough '*' on voter/2506
[2024-05-18 12:03:04.827] DTMF[4312] channel.c: DTMF end '*' received on voter/2506, duration 204 ms
[2024-05-18 12:03:04.827] DTMF[4312] channel.c: DTMF end accepted with begin '*' on voter/2506
[2024-05-18 12:03:04.827] DTMF[4312] channel.c: DTMF end passthrough '*' on voter/2506
[2024-05-18 12:03:05.107] DTMF[4312] channel.c: DTMF begin '7' received on voter/2506
[2024-05-18 12:03:05.107] DTMF[4312] channel.c: DTMF begin passthrough '7' on voter/2506
[2024-05-18 12:03:05.287] DTMF[4312] channel.c: DTMF end '7' received on voter/2506, duration 140 ms
[2024-05-18 12:03:05.287] DTMF[4312] channel.c: DTMF end accepted with begin '7' on voter/2506
[2024-05-18 12:03:05.287] DTMF[4312] channel.c: DTMF end passthrough '7' on voter/2506
[2024-05-18 12:03:05.707] DTMF[4312] channel.c: DTMF begin '0' received on voter/2506
[2024-05-18 12:03:05.707] DTMF[4312] channel.c: DTMF begin passthrough '0' on voter/2506
[2024-05-18 12:03:05.887] DTMF[4312] channel.c: DTMF end '0' received on voter/2506, duration 140 ms
[2024-05-18 12:03:05.887] DTMF[4312] channel.c: DTMF end accepted with begin '0' on voter/2506
[2024-05-18 12:03:05.887] DTMF[4312] channel.c: DTMF end passthrough '0' on voter/2506
[2024-05-18 12:03:17.071] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 12:03:17.075] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 12:04:45.467] DTMF[4312] channel.c: DTMF begin '*' received on voter/2506
[2024-05-18 12:04:45.467] DTMF[4312] channel.c: DTMF begin passthrough '*' on voter/2506
[2024-05-18 12:04:45.787] DTMF[4312] channel.c: DTMF end '*' received on voter/2506, duration 280 ms
[2024-05-18 12:04:45.787] DTMF[4312] channel.c: DTMF end accepted with begin '*' on voter/2506
[2024-05-18 12:04:45.787] DTMF[4312] channel.c: DTMF end passthrough '*' on voter/2506
[2024-05-18 12:04:47.487] DTMF[4312] channel.c: DTMF begin '*' received on voter/2506
[2024-05-18 12:04:47.487] DTMF[4312] channel.c: DTMF begin passthrough '*' on voter/2506
[2024-05-18 12:04:47.767] DTMF[4312] channel.c: DTMF end '*' received on voter/2506, duration 255 ms
[2024-05-18 12:04:47.767] DTMF[4312] channel.c: DTMF end accepted with begin '*' on voter/2506
[2024-05-18 12:04:47.767] DTMF[4312] channel.c: DTMF end passthrough '*' on voter/2506
[2024-05-18 12:04:50.087] DTMF[4312] channel.c: DTMF begin '*' received on voter/2506
[2024-05-18 12:04:50.087] DTMF[4312] channel.c: DTMF begin passthrough '*' on voter/2506
[2024-05-18 12:04:50.327] DTMF[4312] channel.c: DTMF end '*' received on voter/2506, duration 204 ms
[2024-05-18 12:04:50.327] DTMF[4312] channel.c: DTMF end accepted with begin '*' on voter/2506
[2024-05-18 12:04:50.327] DTMF[4312] channel.c: DTMF end passthrough '*' on voter/2506
[2024-05-18 12:04:55.027] DTMF[4312] channel.c: DTMF begin '#' received on voter/2506
[2024-05-18 12:04:55.027] DTMF[4312] channel.c: DTMF begin passthrough '#' on voter/2506
[2024-05-18 12:04:55.287] DTMF[4312] channel.c: DTMF end '#' received on voter/2506, duration 229 ms
[2024-05-18 12:04:55.287] DTMF[4312] channel.c: DTMF end accepted with begin '#' on voter/2506
[2024-05-18 12:04:55.287] DTMF[4312] channel.c: DTMF end passthrough '#' on voter/2506
[2024-05-18 12:07:27.111] ERROR[6363] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:08:15.003] ERROR[6362] chan_simpleusb.c: Channel 2507: HID process has died or is not responding.
[2024-05-18 12:08:17.076] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 12:08:17.632] WARNING[4307] app_rpt.c: rpt_thread restarted on node 2507
[2024-05-18 12:08:17.633] NOTICE[6514] chan_simpleusb.c: Channel 2507: Set option TONE VERIFY, mode: OFF(0).
[2024-05-18 12:08:31.115] ERROR[6515] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:08:37.003] ERROR[6514] chan_simpleusb.c: Channel 2507: HID process has died or is not responding.
[2024-05-18 12:08:39.633] WARNING[4307] app_rpt.c: rpt_thread restarted on node 2507
[2024-05-18 12:08:39.633] NOTICE[6555] chan_simpleusb.c: Channel 2507: Set option TONE VERIFY, mode: OFF(0).
[2024-05-18 12:09:27.647] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:09:52.499] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:10:01.455] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:10:56.407] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:11:46.563] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:12:10.495] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:12:51.215] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:15:33.903] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:18:17.080] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 162.248.92.131:443 to 34.105.111.212:443
[2024-05-18 12:21:43.183] ERROR[6556] chan_simpleusb.c: Channel 2507: Device string 1-2:1.0 was not found.
[2024-05-18 12:28:17.082] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
[2024-05-18 12:38:17.074] NOTICE[4288] dnsmgr.c: dnssrv: host 'register.allstarlink.org' changed from 34.105.111.212:443 to 162.248.92.131:443
root@rpi5:/etc/asterisk#