moodeaudio.org > Moode Forum › moOde audio player › Support v
[PROBLEM] Unreachable SSH and HDMI black screen after loading OS.

Thank you for your donation!


Cloudsmith graciously provides open-source package management and distribution for our project.


Thread Modes
Problem: Unreachable SSH and HDMI black screen after loading OS.
Pavel Frolov Offline
Junior Member
*
Posts: 14
Threads: 2
Joined: Jun 2022
Reputation: 0
#1
06-01-2022, 04:00 PM
Hello,
I have an issue: black screen and unreachable system after loading.

When loading is finished, I see login prompt, but after several seconds my screen becomes black and unreachable by SSH. PI power is on. It's not reboot or shutdown because in case of PI off - my monitor tries to search other sources. Also red light of PI is on and green light blinks time to time.

I have downloaded Release 8.0.2 2022-03-25, have wrote it by PI Imager. Set additional settings, related to network, ssh access and other (from Imager). First boot with resizing file system was done.

My PI is raspberry pi 3b v1.2.
Before I get black screen I can see started the system in the wi-fi network and can connect via ssh can ping. But after black screen I cannot connect to the system.
My connected hardware is usb keyboard and hdmi display. I tried disconnect HDMI monitor, but behavior the same - after some time, the system is unreachable.

By the way, I had under voltage issue before, but I fixed this issue. I installed Raspberry PI OS Lite from PI Imager, and LibreElec - both worked stable. Also I tried to rewrite sd card several times - any way the same issue. Several times installed Volumio - also worked.

In SSH session I see following info:
Code:
Linux: 11.2 | 5.15.28-v7+ #1532 | armv7l (32-bit)
Raspi:
Audio: Pi HDMI 1

                     ____     __      ___
         __ _  ___  / __ \___/ /__   ( _ )
        /  ' \/ _ \/ /_/ / _  / -_) / _  |
       /_/_/_/\___/\____/\_,_/\__/  \___/

                moOde audio player
             Release 8.0.2 2022-03-25
               (C) 2014 Tim Curtis

I looked at /var/log, searched any errors.
found:


/var/log/samba/log.wb-FROLOV-MEDIA:
Code:
...
[2022/05/31 21:20:00.800399,  0] ../../source3/rpc_server/rpc_ncacn_np.c:454(rpcint_dispatch)
  rpcint_dispatch: DCE/RPC fault in call lsarpc:32 - DCERPC_NCA_S_OP_RNG_ERROR
[2022/06/01 19:04:15.962481,  0] ../../source3/winbindd/winbindd_cm.c:1873(wb_open_internal_pipe)
  open_internal_pipe: Could not connect to dssetup pipe: NT_STATUS_RPC_INTERFACE_NOT_FOUND
[2022/06/01 19:04:16.008955,  0] ../../source3/rpc_server/rpc_ncacn_np.c:454(rpcint_dispatch)
  rpcint_dispatch: DCE/RPC fault in call lsarpc:2E - DCERPC_NCA_S_OP_RNG_ERROR
[2022/06/01 19:04:16.060512,  0] ../../source3/rpc_server/rpc_ncacn_np.c:454(rpcint_dispatch)
  rpcint_dispatch: DCE/RPC fault in call lsarpc:32 - DCERPC_NCA_S_OP_RNG_ERROR
[2022/06/01 19:04:16.062315,  0] ../../source3/rpc_server/rpc_ncacn_np.c:454(rpcint_dispatch)
  rpcint_dispatch: DCE/RPC fault in call lsarpc:32 - DCERPC_NCA_S_OP_RNG_ERROR

/var/log/auth.log
a lot of root sessions, but I din't do anything, maybe it's internal things.
Code:
...
Jun  1 19:04:58 frolov-media sudo: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jun  1 19:04:58 frolov-media sudo: pam_unix(sudo:session): session closed for user root
Jun  1 19:04:58 frolov-media sudo: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jun  1 19:04:58 frolov-media sudo: pam_unix(sudo:session): session closed for user root


grep -i error daemon.log
Code:
...
May 31 20:35:00 frolov-media winbindd[872]:   rpcint_dispatch: DCE/RPC fault in call lsarpc:32 - DCERPC_NCA_S_OP_RNG_ERROR
May 31 20:35:02 frolov-media bash[884]: MPD error: Connection refused
May 31 20:35:04 frolov-media systemd[892]: gpgconf: error running '/usr/lib/gnupg/scdaemon': probably not installed
May 31 20:35:05 frolov-media bash[927]: MPD error: Connection refused
...
May 31 20:35:32 frolov-media bash[1183]: MPD error: Connection refused
May 31 20:40:00 frolov-media winbindd[872]:   rpcint_dispatch: DCE/RPC fault in call lsarpc:32 - DCERPC_NCA_S_OP_RNG_ERROR
...
Jun  1 19:04:16 frolov-media winbindd[590]:   rpcint_dispatch: DCE/RPC fault in call lsarpc:32 - DCERPC_NCA_S_OP_RNG_ERROR
Jun  1 19:04:16 frolov-media winbindd[590]:   rpcint_dispatch: DCE/RPC fault in call lsarpc:32 - DCERPC_NCA_S_OP_RN

last in /var/log/kern.log
Code:
May 31 20:34:51 frolov-media kernel: [   12.002362] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
May 31 20:34:52 frolov-media kernel: [   12.426254] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
May 31 20:34:52 frolov-media kernel: [   12.571464] smsc95xx 1-1.1:1.0 eth0: Link is Down
May 31 20:34:53 frolov-media kernel: [   13.388838] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jun  1 19:04:24 frolov-media kernel: [   32.527853] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
Jun  1 19:04:26 frolov-media kernel: [   33.770200] cam-dummy-reg: disabling
Jun  1 19:04:55 frolov-media kernel: [   62.860711] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready

/var/log/moode.log
Code:
20220601 190415 worker: --
20220601 190415 worker: -- Start moOde 8 series
20220601 190415 worker: --
20220601 190415 worker: Successfully daemonized
20220601 190419 worker: File check (OK)
20220601 190419 worker: Session vacuumed
20220601 190419 worker: Session loaded
20220601 190419 worker: Debug logging (OFF)
20220601 190419 worker: --
20220601 190419 worker: -- Audio debug
20220601 190419 worker: --
20220601 190419 worker: ALSA cards: (0:b1 | 1:Headphones | 2:empty | 3:empty
20220601 190419 worker: MPD config: (0:Pi HDMI 1 | mixer:(HDMI) | card:0)
20220601 190420 worker: ALSA mixer actual (HDMI)
20220601 190420 worker: ALSA HDMI volume set to (0%)
20220601 190420 worker: --
20220601 190420 worker: -- System
20220601 190420 worker: --
20220601 190422 worker: Host      (moode)
20220601 190422 worker: moOde     (8.0.2 2022-03-25)
20220601 190422 worker: RaspiOS   (11.2)
20220601 190422 worker: Kernel    (5.15.28-v7+ #1532)
20220601 190422 worker: Platform  (Pi-3B 1.2 1GB)
20220601 190422 worker: ARM arch  (armv7l, 32-bit)
20220601 190422 worker: MPD ver   (0.23.5)
20220601 190422 worker: CPU gov   (ondemand)
20220601 190422 worker: USB boot  (not enabled yet)
20220601 190422 worker: File sys  (expanded)
20220601 190422 worker: HDMI port (On)
20220601 190422 worker: Sys LED0  (On)
20220601 190422 worker: Sys LED1  (On)
20220601 190422 worker: --
20220601 190422 worker: -- Network
20220601 190422 worker: --
20220601 190422 worker: eth0 adapter exists
20220601 190422 worker: eth0 wait for address (No)
20220601 190422 worker: eth0 address not assigned
20220601 190422 worker: wlan0 adapter exists
20220601 190422 worker: wlan0 country (US)
20220601 190422 worker: wlan0 SSID is blank
20220601 190422 worker: wlan0 AP mode started
20220601 190455 worker: IP addr (192.168.1.12)
20220601 190455 worker: Netmask (255.255.255.0)
20220601 190455 worker: Gateway ()
20220601 190455 worker: Pri DNS (127.0.0.1)
20220601 190455 worker: Domain  ()
20220601 190455 worker: wlan0 power save disabled
20220601 190455 worker: --
20220601 190455 worker: -- Audio config
20220601 190455 worker: --
20220601 190456 worker: MPD conf updated
20220601 190456 worker: ALSA card number (0)
20220601 190456 worker: MPD audio output (Pi HDMI 1)
20220601 190456 worker: Audio formats (U8, S16_LE)
20220601 190456 worker: ALSA mixer name (HDMI)
20220601 190456 worker: MPD mixer type (hardware)
20220601 190456 worker: Hdwr volume controller exists
20220601 190456 worker: Max ALSA volume (100%)
20220601 190456 worker: ALSA output mode (Default: plughw)
20220601 190457 worker: ALSA loopback (Off)
20220601 190457 worker: Reset renderer active flags
20220601 190457 worker: CamillaDSP (off)
20220601 190457 worker: --
20220601 190457 worker: -- MPD startup
20220601 190457 worker: --
20220601 190457 worker: MPD started
20220601 190457 worker: MPD accepting connections
20220601 190457 worker: MPD output 1 ALSA Default (on)
20220601 190457 worker: MPD output 2 ALSA Bluetooth (off)
20220601 190457 worker: MPD output 3 HTTP Server (off)
20220601 190457 worker: MPD crossfade (off)
20220601 190457 worker: MPD ignore CUE files (yes)
20220601 190457 worker: --
20220601 190457 worker: -- Feature availability
20220601 190457 worker: --
20220601 190457 worker: Source select (available)
20220601 190457 worker: Source select (source: MPD)
20220601 190457 worker: Source select (output: Pi HDMI 1)
20220601 190457 worker: Bluetooth (available)
20220601 190457 worker: Airplay renderer (available)
20220601 190457 worker: Spotify renderer (available)
20220601 190457 worker: Squeezelite (available)
20220601 190457 worker: RoonBridge renderer (not installed)
20220601 190457 worker: Multiroom sender (available)
20220601 190457 worker: Multiroom receiver (available)
20220601 190457 worker: UPnP renderer (available)
20220601 190457 worker: DLNA server (available)
20220601 190457 worker: UPnP browser (available)
20220601 190457 worker: GPIO button handler (available)
20220601 190457 worker: Stream recorder (n/a)
20220601 190457 worker: --
20220601 190457 worker: -- Music sources
20220601 190457 worker: --
20220601 190458 worker: USB sources (none attached)
20220601 190458 worker: NAS and UPnP sources (none configured)
20220601 190458 worker: --
20220601 190458 worker: -- Other
20220601 190458 worker: --
20220601 190458 worker: USB volume knob (Off)
20220601 190458 worker: USB auto-mounter (udisks-glue)
20220601 190458 worker: Saved MPD vol level (0)
20220601 190458 worker: Preamp volume level (0)
20220601 190458 worker: MPD volume level (0) restored
20220601 190458 worker: ALSA HDMI volume (0%)
20220601 190458 worker: Auto-play (Off)
20220601 190458 worker: Maintenance interval (120 minutes)
20220601 190458 worker: Screen saver activation (Never)
20220601 190458 worker: Session permissions (OK)
20220601 190458 worker: Watchdog started
20220601 190458 worker: Ready

last from /log/syslog

Code:
Jun  1 19:04:55 frolov-media systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server.
Jun  1 19:04:55 frolov-media systemd[1]: Reached target Host and Network Name Lookups.
Jun  1 19:04:57 frolov-media systemd[1]: Starting Music Player Daemon...
Jun  1 19:04:57 frolov-media mpd[1197]: Ignoring the 'pid_file' setting in systemd mode
Jun  1 19:04:57 frolov-media systemd[1]: Started Music Player Daemon.
Jun  1 19:05:00 frolov-media dhcpcd[972]: wlan0: using static address 172.24.1.1/24
Jun  1 19:05:00 frolov-media avahi-daemon[394]: Registering new address record for 172.24.1.1 on wlan0.IPv4.
Jun  1 19:05:00 frolov-media dhcpcd[972]: wlan0: adding route to 172.24.1.0/24
Jun  1 19:05:00 frolov-media dnsmasq[996]: no servers found in /run/dnsmasq/resolv.conf, will retry
Jun  1 19:05:08 frolov-media dhcpcd[972]: wlan0: no IPv6 Routers available
Find
Reply
Pavel Frolov Offline
Junior Member
*
Posts: 14
Threads: 2
Joined: Jun 2022
Reputation: 0
#2
06-01-2022, 04:02 PM
Jun 1 19:04:24 frolov-media kernel: [ 32.527853] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled

may be related with this. I will try to catch moment, when the system freezes and check logs in this second...
Find
Reply
Pavel Frolov Offline
Junior Member
*
Posts: 14
Threads: 2
Joined: Jun 2022
Reputation: 0
#3
06-01-2022, 04:28 PM (This post was last modified: 06-01-2022, 04:29 PM by Pavel Frolov.)
Couple of news:
1) I found that system uptime in htop is 30 sec when the system ssh session is frozen.
2) I tried to switch terminal by Alt+F2 - It works!

So, now I have direct access via USB keyboard and HDMI display, next need to solve issue with network. It's strange, network works first 10-20 seconds.
Find
Reply
Pavel Frolov Offline
Junior Member
*
Posts: 14
Threads: 2
Joined: Jun 2022
Reputation: 0
#4
06-01-2022, 05:15 PM
I catched the moment when the system is disconnected by run `watch -n1 date` in ssh terminal, and last date I see is date of disconnection.

frolov-media: Wed Jun  1 21:03:53 2022

syslog for this second:


Code:
Jun  1 21:03:48 frolov-media systemd[686]: Startup finished in 771ms.
Jun  1 21:03:50 frolov-media dhcpcd[537]: wlan0: no IPv6 Routers available
Jun  1 21:03:52 frolov-media systemd[1]: Reloading.
Jun  1 21:03:53 frolov-media dhcpcd[537]: received SIGTERM, stopping
Jun  1 21:03:53 frolov-media dhcpcd[537]: wlan0: removing interface
Jun  1 21:03:53 frolov-media systemd[1]: Stopping DHCP Client Daemon...
Jun  1 21:03:53 frolov-media dhcpcd[537]: eth0: removing interface
Jun  1 21:03:53 frolov-media dhcpcd[537]: dhcpcd exited

then:

Code:
Jun  1 21:03:54 frolov-media avahi-daemon[395]: Interface wlan0.IPv6 no longer relevant for mDNS.
Jun  1 21:03:54 frolov-media avahi-daemon[395]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::e259:f769:123a:dbc2.
Jun  1 21:03:54 frolov-media avahi-daemon[395]: Interface wlan0.IPv4 no longer relevant for mDNS.
Jun  1 21:03:54 frolov-media avahi-daemon[395]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.12.
Jun  1 21:03:54 frolov-media avahi-daemon[395]: Withdrawing address record for fe80::e259:f769:123a:dbc2 on wlan0.
Jun  1 21:03:54 frolov-media avahi-daemon[395]: Withdrawing address record for 192.168.1.12 on wlan0.
Jun  1 21:03:54 frolov-media systemd[1]: dhcpcd.service: Succeeded.
Jun  1 21:03:54 frolov-media systemd[1]: Stopped DHCP Client Daemon.
Jun  1 21:03:54 frolov-media systemd[1]: Starting DHCP Client Daemon...
Jun  1 21:03:54 frolov-media dhcpcd[952]: dev: loaded udev
Jun  1 21:03:54 frolov-media dhcpcd[952]: wlan0: connected to Access Point `'
Jun  1 21:03:54 frolov-media dhcpcd[952]: eth0: waiting for carrier
Jun  1 21:03:54 frolov-media avahi-daemon[395]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.12.
Jun  1 21:03:54 frolov-media kernel: [   31.279640] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
Jun  1 21:03:54 frolov-media avahi-daemon[395]: New relevant interface wlan0.IPv4 for mDNS.
Jun  1 21:03:54 frolov-media avahi-daemon[395]: Registering new address record for 192.168.1.12 on wlan0.IPv4.
Jun  1 21:03:54 frolov-media dhcpcd[952]: wlan0: waiting for carrier
Jun  1 21:03:56 frolov-media kernel: [   33.770172] cam-dummy-reg: disabling
Jun  1 21:04:03 frolov-media systemd[1]: systemd-fsckd.service: Succeeded.

Who can send TERM signal to DHCP?

Jun  1 21:03:53 frolov-media dhcpcd[537]: received SIGTERM, stopping
Find
Reply
Pavel Frolov Offline
Junior Member
*
Posts: 14
Threads: 2
Joined: Jun 2022
Reputation: 0
#5
06-01-2022, 05:58 PM
It seems I realized the issue: I have setup settings by RPi Imager, but boode setup guide says to work via Access Point. So I think my lost of connection is starting WiFi Access Point.
I will check it and write again..
Find
Reply
TheOldPresbyope Offline
Moderator
****
Posts: 5,549
Threads: 168
Joined: Apr 2018
Reputation: 205
#6
06-01-2022, 06:07 PM (This post was last modified: 06-01-2022, 06:08 PM by TheOldPresbyope. Edit Reason: cosmetic fix )
Simplest way to start:
  • flash a fresh unedited copy of moOde image to uSD card
  • boot Pi from this card
  • wait some time for system to make various adjustments
  • if the Pi is connected via ethernet it will become visible on LAN with IP dynamically assigned by router and with hostname "moode". Enter http://moode or http://moode.local or http:<numeric IP address> in a browser on any computer connected to the same LAN and proceed to use moOde's WebUI
  • if Pi is not connected via ethernet but has onboard WiFi adapter it will eventually become visible as an access point with name "moode". You'll have to connect wirelessly to this AP from some host which has a WiFi adapter---smart phone/tablet/laptop/whatever. In this case, enter http://172.24.1.1 in your web browser on the connected host
Now you can configure as desired.

From the information you've posted it appears
  1. you expect moOde to use a locally connected display and keyboard as if it were just another instance of Raspberry Pi OS. It is not; it is meant to be an appliance with a WebUI, True, the WebUI can be reflected on the local display but only after this feature is enabled.
  2. you've partially configured the moOde image but incorrectly---don't edit the files in the image until you've read and understood what they do in this appliance.

In particular, I see this stanza in the moode.log you posted

Code:
20220601 190422 worker: -- Network
20220601 190422 worker: --
20220601 190422 worker: eth0 adapter exists
20220601 190422 worker: eth0 wait for address (No)
20220601 190422 worker: eth0 address not assigned
20220601 190422 worker: wlan0 adapter exists
20220601 190422 worker: wlan0 country (US)
20220601 190422 worker: wlan0 SSID is blank
20220601 190422 worker: wlan0 AP mode started
20220601 190455 worker: IP addr (192.168.1.12)
20220601 190455 worker: Netmask (255.255.255.0)
20220601 190455 worker: Gateway ()
20220601 190455 worker: Pri DNS (127.0.0.1)
20220601 190455 worker: Domain  ()
20220601 190455 worker: wlan0 power save disabled
The IP addr (192.168.1.12) and Gateway () entries seem bogus.

Compare with this stanza I just clipped from moode.log of a Pi3B+ I just booted with no ethernet connection and no WiFi configuration
Code:
20220601 131611 worker: -- Network
20220601 131611 worker: --
20220601 131611 worker: eth0 adapter exists
20220601 131611 worker: eth0 wait for address (No)
20220601 131611 worker: eth0 address not assigned
20220601 131611 worker: wlan0 adapter exists
20220601 131611 worker: wlan0 country (US)
20220601 131611 worker: wlan0 SSID is blank
20220601 131611 worker: wlan0 AP mode started
20220601 131644 worker: wlan0 wait 0 for IP address
20220601 131646 worker: wlan0 wait 1 for IP address
20220601 131648 worker: wlan0 wait 2 for IP address
20220601 131650 worker: IP addr (172.24.1.1)
20220601 131650 worker: Netmask (255.255.255.0)
20220601 131650 worker: Gateway (0.0.0.0)
20220601 131650 worker: Pri DNS (127.0.0.1)
20220601 131650 worker: Domain  ()
20220601 131650 worker: wlan0 power save disabled

Regards,
Kent
Find
Reply
Pavel Frolov Offline
Junior Member
*
Posts: 14
Threads: 2
Joined: Jun 2022
Reputation: 0
#7
06-01-2022, 06:55 PM
That's right I did wrong setup.

Currently I rewrote cdcard properly, without any changes from Imager side. Then loaded the system, connected to AP WiFi from my phone and configure.
Find
Reply


Forum Jump: