-- Logs begin at Thu 2019-02-14 05:11:58 EST, end at Sun 2025-10-26 23:12:14 EDT. -- Oct 26 23:11:53 samjam systemd-timedated[1090]: Changed local time to Sun Oct 26 23:11:53 2025 Oct 26 23:11:53 samjam sudo[1082]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:53 samjam volumio-time-update[618]: volumio-time-update-util: System time updated successfully. Oct 26 23:11:53 samjam sudo[1116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Samkrepps,password=Aubrey122014,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //192.168.1.212/NAS /mnt/NAS/NAS Oct 26 23:11:53 samjam volumio[1025]: info: Starting Udev Watcher for removable devices Oct 26 23:11:53 samjam volumio[1025]: info: Ignoring mount for partition: boot Oct 26 23:11:53 samjam volumio[1025]: info: Ignoring mount for partition: volumio Oct 26 23:11:53 samjam volumio[1025]: info: Ignoring mount for partition: volumio_data Oct 26 23:11:53 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 26 23:11:53 samjam volumio[1025]: info: Loading plugin "volumio_command_line_client"... Oct 26 23:11:53 samjam systemd[1]: Starting Daily man-db regeneration... Oct 26 23:11:53 samjam sudo[1116]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:53 samjam sudo[1118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.154:/volume1/music/Plex /mnt/NAS/NerdLairNAS Oct 26 23:11:53 samjam sudo[1118]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:53 samjam sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.154/volume1/music/plex /mnt/NAS/NerdLair Oct 26 23:11:53 samjam systemd[1]: Starting Daily apt download activities... Oct 26 23:11:53 samjam sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:53 samjam volumio[1025]: info: Loading plugin "upnp"... Oct 26 23:11:53 samjam systemd[1]: Started Volumio Time Update Utility. Oct 26 23:11:53 samjam volumio[1025]: info: [1761534713119] Starting Upmpd Daemon Oct 26 23:11:53 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 26 23:11:53 samjam volumio[1025]: info: Loading plugin "my_music"... Oct 26 23:11:53 samjam volumio[1025]: info: Loading plugin "mpd"... Oct 26 23:11:53 samjam sudo[1116]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:53 samjam kernel: Key type cifs.spnego registered Oct 26 23:11:53 samjam kernel: Key type cifs.idmap registered Oct 26 23:11:53 samjam kernel: CIFS: Attempting to mount //192.168.1.212/NAS Oct 26 23:11:53 samjam kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Oct 26 23:11:53 samjam kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Oct 26 23:11:53 samjam kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 26 23:11:53 samjam kernel: CIFS: Attempting to mount //192.168.1.154/volume1/music/plex Oct 26 23:11:53 samjam kernel: cryptd: max_cpu_qlen set to 1000 Oct 26 23:11:53 samjam systemd[1]: systemd-hostnamed.service: Succeeded. Oct 26 23:11:53 samjam systemd[1]: man-db.service: Succeeded. Oct 26 23:11:53 samjam systemd[1]: Started Daily man-db regeneration. Oct 26 23:11:53 samjam volumio[1025]: info: Loading plugin "upnp_browser"... Oct 26 23:11:53 samjam sudo[1118]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:53 samjam kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Oct 26 23:11:53 samjam kernel: CIFS: VFS: \\192.168.1.154 Send error in SessSetup = -13 Oct 26 23:11:53 samjam kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Oct 26 23:11:53 samjam sudo[1121]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:53 samjam nmbd[758]: [2025/10/26 23:11:53.753002, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 26 23:11:53 samjam nmbd[758]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 26 23:11:53 samjam systemd[1]: Started Samba NMB Daemon. Oct 26 23:11:53 samjam systemd[1]: Starting Samba Winbind Daemon... Oct 26 23:11:54 samjam winbindd[1195]: [2025/10/26 23:11:54.128505, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 26 23:11:54 samjam winbindd[1195]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 26 23:11:54 samjam volumio[1025]: info: Loading plugin "alarm-clock"... Oct 26 23:11:54 samjam winbindd[1195]: [2025/10/26 23:11:54.194650, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 26 23:11:54 samjam systemd[1]: Started Samba Winbind Daemon. Oct 26 23:11:54 samjam winbindd[1195]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 26 23:11:54 samjam systemd[1]: Starting Samba SMB Daemon... Oct 26 23:11:54 samjam volumio[1025]: info: Loading plugin "airplay_emulation"... Oct 26 23:11:54 samjam volumio[1025]: info: Starting Shairport Sync Oct 26 23:11:54 samjam volumio[1025]: info: Loading plugin "last_100"... Oct 26 23:11:54 samjam volumio[1025]: info: Loading plugin "webradio"... Oct 26 23:11:54 samjam volumio[1025]: info: Loading plugin "i2s_dacs"... Oct 26 23:11:54 samjam volumio[1025]: info: I2S DAC not set, start Auto-detection Oct 26 23:11:54 samjam volumio[1025]: info: Loading plugin "volumiodiscovery"... Oct 26 23:11:54 samjam volumio[1025]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 26 23:11:54 samjam node[1025]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 26 23:11:54 samjam volumio[1025]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 26 23:11:54 samjam volumio[1025]: *** WARNING *** For more information see Oct 26 23:11:54 samjam volumio[1025]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 26 23:11:54 samjam volumio[1025]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 26 23:11:54 samjam volumio[1025]: *** WARNING *** For more information see Oct 26 23:11:54 samjam node[1025]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 26 23:11:54 samjam node[1025]: *** WARNING *** For more information see Oct 26 23:11:54 samjam node[1025]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 26 23:11:54 samjam node[1025]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 26 23:11:54 samjam node[1025]: *** WARNING *** For more information see Oct 26 23:11:54 samjam volumio[1025]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 26 23:11:54 samjam volumio[1025]: info: Discovery: Started advertising with name: samjam Oct 26 23:11:54 samjam smbd[1201]: [2025/10/26 23:11:54.846263, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 26 23:11:54 samjam systemd[1]: Started Samba SMB Daemon. Oct 26 23:11:54 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 26 23:11:54 samjam volumio[1025]: info: Loading plugin "spop"... Oct 26 23:11:54 samjam smbd[1201]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 26 23:11:54 samjam systemd[1]: Reached target Multi-User System. Oct 26 23:11:54 samjam systemd[1]: Reached target Graphical Interface. Oct 26 23:11:54 samjam systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 26 23:11:54 samjam volumio-remote-updater[628]: [2025-10-26 23:11:54] [connect] Successful connection Oct 26 23:11:54 samjam systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 26 23:11:54 samjam systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 26 23:11:55 samjam systemd[1]: apt-daily.service: Succeeded. Oct 26 23:11:55 samjam systemd[1]: Started Daily apt download activities. Oct 26 23:11:55 samjam systemd[1]: Starting Daily apt upgrade and clean activities... Oct 26 23:11:55 samjam volumio[1025]: info: Loading plugin "outputs"... Oct 26 23:11:55 samjam volumio[1025]: info: Loading plugin "albumart"... Oct 26 23:11:56 samjam volumio[1025]: info: Plugin example_plugin is not enabled Oct 26 23:11:56 samjam volumio[1025]: info: Loading plugin "inputs"... Oct 26 23:11:56 samjam volumio[1025]: info: Loading plugin "updater_comm"... Oct 26 23:11:56 samjam volumio[1025]: info: Plugin mpdemulation is not enabled Oct 26 23:11:56 samjam volumio[1025]: info: Loading plugin "rest_api"... Oct 26 23:11:56 samjam volumio[1025]: info: Loading plugin "websocket"... Oct 26 23:11:56 samjam volumio[1025]: info: Starting Socket.io Server version 2.3.0 Oct 26 23:11:56 samjam volumio[1025]: info: Loading plugin "lastfm"... Oct 26 23:11:56 samjam volumio[1025]: Forking 3 albumart workers Oct 26 23:11:56 samjam sudo[1097]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:56 samjam systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 26 23:11:56 samjam systemd[1]: Started Daily apt upgrade and clean activities. Oct 26 23:11:56 samjam systemd[1]: Startup finished in 12.587s (kernel) + 38.839s (userspace) = 51.426s. Oct 26 23:11:56 samjam volumio[1025]: info: Loading i18n strings for locale en Oct 26 23:11:56 samjam volumio[1025]: Updating browse sources language Oct 26 23:11:56 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 23:11:56 samjam volumio[1025]: Starting albumart workers Oct 26 23:11:57 samjam volumio[1025]: Starting albumart workers Oct 26 23:11:57 samjam volumio[1025]: Starting albumart workers Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::initPlayerControls Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: Express server listening on port 3000 Oct 26 23:11:57 samjam volumio[1025]: [Metrics] WebUI: 6s 845.25ms Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::resetVolumioState Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::getcurrentVolume Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioRetrievevolume Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: Cannot read play queue from file Oct 26 23:11:57 samjam volumio[1025]: info: Volumio Network Manager: Network status updated: 2 Oct 26 23:11:57 samjam volumio[1025]: info: Cannot mount NAS NerdLair at system boot, trial number 1 ,retrying in 5 seconds Oct 26 23:11:57 samjam volumio[1025]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Oct 26 23:11:57 samjam volumio-remote-updater[628]: [2025-10-26 23:11:57] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1761534714 101 Oct 26 23:11:57 samjam volumio[1025]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Oct 26 23:11:57 samjam volumio[1025]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 26 23:11:57 samjam volumio[1025]: info: VolumeController:: Volume=86 Mute =false Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::pushState Oct 26 23:11:57 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioPushState Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::updateTrackBlock Oct 26 23:11:57 samjam volumio[1025]: info: CorePlayQueue::getTrackBlock Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioRetrievevolume Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::setRepeat null single undefined Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::pushState Oct 26 23:11:57 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioPushState Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::setRandom null Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::pushState Oct 26 23:11:57 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioPushState Oct 26 23:11:57 samjam volumio[1025]: info: Setting Device type: Raspberry PI Oct 26 23:11:57 samjam volumio[1025]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Oct 26 23:11:57 samjam volumio[1025]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Oct 26 23:11:57 samjam volumio[1025]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Oct 26 23:11:57 samjam volumio[1025]: info: VolumeController:: Volume=86 Mute =false Oct 26 23:11:57 samjam volumio[1025]: info: CoreStateMachine::pushState Oct 26 23:11:57 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioPushState Oct 26 23:11:57 samjam volumio[1025]: info: Discovery: adding 06a2a9d2-e6f5-4270-a87b-b292d8b8fca5 Oct 26 23:11:57 samjam volumio[1025]: info: Discovery: Found device samjam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:11:57 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:57 samjam volumio[1025]: info: Completed loading Core Plugins Oct 26 23:11:57 samjam volumio[1025]: info: Preparing to generate the ALSA configuration file Oct 26 23:11:57 samjam volumio[1025]: info: Asound.conf file unchanged, so no further update is needed Oct 26 23:11:57 samjam volumio[1025]: info: Output device has changed, restarting MPD Oct 26 23:11:57 samjam sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 26 23:11:57 samjam volumio[1025]: info: Output device has changed, restarting Shairport Sync Oct 26 23:11:57 samjam sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:11:57 samjam sudo[1354]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:57 samjam sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 26 23:11:57 samjam sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:57 samjam systemd[1]: Stopping Music Player Daemon... Oct 26 23:11:57 samjam volumio[1025]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 23:11:57 samjam volumio[1025]: info: ___________ START PLUGINS ___________ Oct 26 23:11:57 samjam volumio[1025]: info: ControllerMpd::onStart: Initializing MPD Oct 26 23:11:57 samjam volumio[1025]: info: Creating MPD Configuration file Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 26 23:11:57 samjam volumio[1025]: info: [1761534717792] CoreMusicLibrary::Adding element Media Servers Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 23:11:57 samjam sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 26 23:11:57 samjam sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:57 samjam sudo[1363]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:11:57 samjam sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 26 23:11:57 samjam sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:57 samjam volumio[1025]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:11:57 samjam systemd[1]: mpd.service: Succeeded. Oct 26 23:11:57 samjam systemd[1]: Stopped Music Player Daemon. Oct 26 23:11:57 samjam volumio[1025]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 26 23:11:57 samjam volumio[1025]: info: [1761534717882] CoreMusicLibrary::Adding element Last_100 Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 26 23:11:57 samjam volumio[1025]: info: [1761534717884] CoreMusicLibrary::Adding element Webradio Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 23:11:57 samjam volumio[1025]: info: Initializing BBC Radios Oct 26 23:11:57 samjam systemd[1]: Starting Music Player Daemon... Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: Creating Spotify config file Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 26 23:11:57 samjam volumio[1025]: info: [1761534717955] CoreMusicLibrary::Adding element LastFM Oct 26 23:11:57 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 23:11:57 samjam volumio[1025]: Cannot find translation for source LastFM Oct 26 23:11:57 samjam volumio[1025]: info: [LastFM] scrobbler initiated! Oct 26 23:11:57 samjam volumio[1025]: info: [LastFM] extended logging: false Oct 26 23:11:57 samjam volumio[1025]: info: [LastFM] try scrobble stream/radio plays: true Oct 26 23:11:57 samjam volumio[1025]: info: [LastFM] Configuration parameters missing: "API_KEY" "API_SECRET" "username" "authToken" Oct 26 23:11:57 samjam volumio[1025]: info: [LastFM] Left init routine Oct 26 23:11:57 samjam volumio[1025]: info: [LastFM] Socket already connected: true Oct 26 23:11:57 samjam volumio[1025]: info: Volumio Calling Home Oct 26 23:11:57 samjam sudo[1372]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 26 23:11:57 samjam sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:57 samjam sudo[1372]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam volumio[1025]: info: [LastFM] finished init with error: Configuration parameters missing: "API_KEY" "API_SECRET" "username" "authToken" Oct 26 23:11:58 samjam volumio[1025]: info: MPD Permissions set Oct 26 23:11:58 samjam volumio[1025]: info: MPD Permissions set Oct 26 23:11:58 samjam volumio[1025]: info: Spotify config file written Oct 26 23:11:58 samjam volumio[1025]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 23:11:58 samjam volumio[1025]: info: No need to fix Spotify hosts Oct 26 23:11:58 samjam systemd[1]: Started go-librespot Daemon. Oct 26 23:11:58 samjam go-librespot[1397]: go-librespot daemon starting... Oct 26 23:11:58 samjam sudo[1391]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam volumio[1025]: info: Volumio called home Oct 26 23:11:58 samjam volumio[1025]: info: Starting Shairport Sync Oct 26 23:11:58 samjam volumio[1025]: info: Starting Shairport Sync Oct 26 23:11:58 samjam volumio[1025]: info: Starting Shairport Sync Oct 26 23:11:58 samjam sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 23:11:58 samjam sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:58 samjam sudo[1406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 23:11:58 samjam sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:58 samjam systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 26 23:11:58 samjam systemd[1]: shairport-sync.service: Succeeded. Oct 26 23:11:58 samjam systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 26 23:11:58 samjam sudo[1414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 23:11:58 samjam sudo[1414]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:11:58 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:58 samjam systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 26 23:11:58 samjam sudo[1404]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 26 23:11:58 samjam systemd[1]: shairport-sync.service: Succeeded. Oct 26 23:11:58 samjam systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 26 23:11:58 samjam systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 26 23:11:58 samjam sudo[1406]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam sudo[1420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 23:11:58 samjam sudo[1420]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:58 samjam volumio[1025]: info: Shairport-Sync Started Oct 26 23:11:58 samjam sudo[1420]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam volumio[1025]: Error adding Membership: Error: addMembership EINVAL Oct 26 23:11:58 samjam volumio[1025]: info: Shairport-Sync Started Oct 26 23:11:58 samjam sudo[1414]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 23:11:58 samjam sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:58 samjam volumio[1025]: info: Shairport-Sync Started Oct 26 23:11:58 samjam sudo[1423]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam volumio[1025]: verbose: New Socket.io Connection to 192.168.1.212 from 192.168.1.186 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 26 23:11:58 samjam go-librespot[1397]: time="2025-10-26T23:11:58-04:00" level=info msg="running go-librespot 0.4.0" Oct 26 23:11:58 samjam go-librespot[1397]: time="2025-10-26T23:11:58-04:00" level=debug msg="app state loaded" Oct 26 23:11:58 samjam go-librespot[1397]: time="2025-10-26T23:11:58-04:00" level=debug msg="stored credentials not found" Oct 26 23:11:58 samjam go-librespot[1397]: time="2025-10-26T23:11:58-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 23:11:58 samjam sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 23:11:58 samjam sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:58 samjam sudo[1430]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 23:11:58 samjam sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:11:58 samjam sudo[1432]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam volumio[1025]: verbose: New Socket.io Connection to 192.168.1.212 from 192.168.1.186 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 26 23:11:58 samjam mpd[1388]: Oct 26 23:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 26 23:11:58 samjam systemd[1]: Started Music Player Daemon. Oct 26 23:11:58 samjam sudo[1356]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam sudo[1365]: pam_unix(sudo:session): session closed for user root Oct 26 23:11:58 samjam go-librespot[1397]: time="2025-10-26T23:11:58-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Oct 26 23:11:58 samjam go-librespot[1397]: time="2025-10-26T23:11:58-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 26 23:11:58 samjam go-librespot[1397]: time="2025-10-26T23:11:58-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 26 23:11:58 samjam go-librespot[1397]: time="2025-10-26T23:11:58-04:00" level=info msg="zeroconf server listening on port 37227" Oct 26 23:11:58 samjam volumio[1025]: info: Completed starting Core Plugins Oct 26 23:11:58 samjam volumio[1025]: info: ------------------------------------------- Oct 26 23:11:58 samjam volumio[1025]: info: ----- MyVolumio plugins startup ---- Oct 26 23:11:58 samjam volumio[1025]: info: ------------------------------------------- Oct 26 23:11:58 samjam volumio[1025]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 26 23:11:58 samjam volumio[1025]: error: MPD error: The expression evaluated to a falsy value: Oct 26 23:11:58 samjam volumio[1025]: assert.ok(self.idling) Oct 26 23:11:58 samjam volumio[1025]: error: The expression evaluated to a falsy value: Oct 26 23:11:58 samjam volumio[1025]: assert.ok(self.idling) Oct 26 23:11:58 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 23:11:58 samjam volumio[1025]: info: MPD running with PID1388 Oct 26 23:11:58 samjam volumio[1025]: ,establishing connection Oct 26 23:11:58 samjam volumio[1025]: error: updateQueue error: null Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:11:59 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 23:11:59 samjam volumio[1025]: info: Received Get System Info Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 23:11:59 samjam volumio[1025]: info: Discovery: Getting this device information Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:11:59 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:11:59 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:11:59 samjam volumio[1025]: info: Listing playlists Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 23:11:59 samjam volumio[1025]: error: updateQueue error: null Oct 26 23:11:59 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:11:59 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:12:00 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 26 23:12:00 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 23:12:00 samjam volumio[1025]: info: Received Get System Info Oct 26 23:12:00 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 23:12:00 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 23:12:00 samjam volumio[1025]: info: Discovery: Getting this device information Oct 26 23:12:00 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:12:00 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:12:00 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 23:12:01 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 23:12:01 samjam volumio[1025]: info: Received Get System Info Oct 26 23:12:01 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 23:12:01 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 23:12:01 samjam volumio[1025]: info: Discovery: Getting this device information Oct 26 23:12:01 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:12:01 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:12:01 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 23:12:01 samjam volumio[1025]: info: go-librespot daemon successfully initialized Oct 26 23:12:01 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 26 23:12:01 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 26 23:12:02 samjam sudo[1441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.154/volume1/music/plex /mnt/NAS/NerdLair Oct 26 23:12:02 samjam sudo[1441]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:02 samjam sudo[1443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Samkrepps,password=Aubrey122014,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //192.168.1.212/NAS /mnt/NAS/NAS Oct 26 23:12:02 samjam sudo[1443]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:02 samjam kernel: CIFS: Attempting to mount //192.168.1.154/volume1/music/plex Oct 26 23:12:02 samjam sudo[1441]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:02 samjam volumio[1025]: info: Cannot mount NAS NerdLair at system boot, trial number 2 ,retrying in 5 seconds Oct 26 23:12:02 samjam kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Oct 26 23:12:02 samjam kernel: CIFS: VFS: \\192.168.1.154 Send error in SessSetup = -13 Oct 26 23:12:02 samjam kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Oct 26 23:12:02 samjam kernel: CIFS: Attempting to mount //192.168.1.212/NAS Oct 26 23:12:02 samjam sudo[1443]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:03 samjam sudo[1476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 23:12:03 samjam sudo[1476]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:03 samjam sudo[1476]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:03 samjam sudo[1478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 23:12:03 samjam sudo[1478]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:03 samjam sudo[1478]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:03 samjam sudo[1482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 26 23:12:03 samjam sudo[1482]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:03 samjam systemd[1]: Started UPnP Renderer front-end to MPD. Oct 26 23:12:03 samjam sudo[1482]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:03 samjam volumio[1025]: info: Upmpdcli Daemon Started Oct 26 23:12:03 samjam volumio[1484]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 26 23:12:03 samjam volumio[1025]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 26 23:12:04 samjam volumio[1025]: info: Initializing connection to go-librespot Websocket Oct 26 23:12:04 samjam go-librespot[1397]: time="2025-10-26T23:12:04-04:00" level=debug msg="new websocket client" Oct 26 23:12:04 samjam volumio[1025]: info: Connection to go-librespot Websocket established Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::volumioGetBrowseSources Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::volumioGetBrowseSources Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::volumioGetBrowseSources Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 23:12:05 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 26 23:12:07 samjam volumio[1025]: info: Adding plugin bluetooth to MyMusic Plugins Oct 26 23:12:07 samjam volumio[1025]: info: Adding plugin multiroom to MyMusic Plugins Oct 26 23:12:07 samjam volumio[1025]: info: Adding plugin metavolumio to MyMusic Plugins Oct 26 23:12:07 samjam volumio[1025]: info: Adding plugin cd_controller to MyMusic Plugins Oct 26 23:12:07 samjam volumio[1025]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 26 23:12:07 samjam volumio[1025]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 26 23:12:07 samjam volumio[1025]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 26 23:12:07 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:12:07 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:12:07 samjam volumio[1025]: info: Starting MyVolumio Remote Streaming Endpoints Oct 26 23:12:07 samjam volumio[1025]: info: MyVolumio login type: Token Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 26 23:12:07 samjam volumio[1025]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 26 23:12:08 samjam volumio[1025]: info: Starting Streaming Service Transparent Proxy Oct 26 23:12:08 samjam volumio[1025]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 26 23:12:08 samjam volumio[1025]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 26 23:12:08 samjam volumio[1025]: info: Streaming services startup Oct 26 23:12:08 samjam volumio[1025]: info: Starting Streaming Daemon Oct 26 23:12:08 samjam sudo[1519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 26 23:12:08 samjam sudo[1519]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:08 samjam volumio[1025]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 26 23:12:08 samjam sudo[1519]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:08 samjam volumio[1025]: info: Getting Spotify volume Oct 26 23:12:08 samjam sudo[1527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.154/volume1/music/plex /mnt/NAS/NerdLair Oct 26 23:12:08 samjam sudo[1527]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:08 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 23:12:08 samjam volumio[1025]: error: Cannot start Volumio Streaming Daemon Oct 26 23:12:08 samjam volumio[1025]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 26 23:12:08 samjam volumio[1025]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 26 23:12:08 samjam kernel: CIFS: Attempting to mount //192.168.1.154/volume1/music/plex Oct 26 23:12:08 samjam sudo[1527]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:09 samjam kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Oct 26 23:12:09 samjam kernel: CIFS: VFS: \\192.168.1.154 Send error in SessSetup = -13 Oct 26 23:12:09 samjam kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Oct 26 23:12:09 samjam volumio[1025]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 26 23:12:09 samjam volumio[1025]: info: Cannot mount NAS NerdLair at system boot, trial number 3 ,retrying in 5 seconds Oct 26 23:12:09 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:12:09 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:12:09 samjam volumio[1025]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 26 23:12:09 samjam volumio[1025]: SPOTIFY: SPOTIFY VOLUME undefined Oct 26 23:12:09 samjam volumio[1025]: SPOTIFY: VOLUMIO VOLUME 86 Oct 26 23:12:09 samjam volumio[1025]: info: Aligning Spotify Volume to Volumio Volume Oct 26 23:12:09 samjam volumio[1025]: info: CoreCommandRouter::volumioGetState Oct 26 23:12:09 samjam volumio[1025]: info: CorePlayQueue::getTrack 0 Oct 26 23:12:09 samjam volumio[1025]: info: Setting Spotify Volume from Volumio: 86 Oct 26 23:12:09 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 23:12:09 samjam volumio[1025]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 26 23:12:09 samjam volumio[1025]: STREAMING PROXY: Starting server on port 3245 Oct 26 23:12:09 samjam volumio[1025]: Node JS runtime: 14 Oct 26 23:12:10 samjam volumio[1025]: info: MyVolumio token set successfully Oct 26 23:12:10 samjam volumio[1025]: info: MYVOLUMIO: Adding device Oct 26 23:12:10 samjam volumio[1025]: info: MYVOLUMIO: Evaluating Server Oct 26 23:12:10 samjam volumio[1025]: info: MyVolumio status changed Oct 26 23:12:10 samjam volumio[1025]: info: Streaming services startup Oct 26 23:12:10 samjam volumio[1025]: info: Starting Streaming Daemon Oct 26 23:12:10 samjam volumio[1025]: info: Removing browser output: myVolumio user plan is not superstar Oct 26 23:12:10 samjam volumio[1025]: info: Removing audio output: Oct 26 23:12:10 samjam volumio[1025]: info: Stoppping Tunnel 1 Oct 26 23:12:10 samjam sudo[1550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 26 23:12:10 samjam sudo[1550]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:10 samjam sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 26 23:12:10 samjam sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 23:12:10 samjam sudo[1550]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:10 samjam volumio[1025]: error: Cannot start Volumio Streaming Daemon Oct 26 23:12:10 samjam volumio[1025]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 26 23:12:10 samjam volumio[1025]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 26 23:12:10 samjam sudo[1553]: pam_unix(sudo:session): session closed for user root Oct 26 23:12:10 samjam volumio[1025]: info: Remote SSH Stopped Oct 26 23:12:10 samjam volumio[1025]: SPOTIFY: SETTING SPOTIFY VOLUME 86 Oct 26 23:12:10 samjam volumio[1025]: info: Sending Spotify command with payload to local API: /player/volume Oct 26 23:12:11 samjam volumio[1025]: info: Setting Geolocation for MyVolumio to us1 Oct 26 23:12:11 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:12:11 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:12:11 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:12:11 samjam volumio[1025]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 26 23:12:12 samjam volumio[1025]: info: Updating MyVolumio device info Oct 26 23:12:12 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 23:12:12 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Oct 26 23:12:12 samjam volumio[1025]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 26 23:12:13 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 23:12:13 samjam volumio[1025]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 26 23:12:14 samjam volumio[1025]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 23:12:14 samjam volumio[1025]: TypeError: Cannot read property 'replace' of undefined Oct 26 23:12:14 samjam volumio[1025]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Oct 26 23:12:14 samjam volumio[1025]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Oct 26 23:12:14 samjam volumio[1025]: at listOnTimeout (internal/timers.js:554:17) Oct 26 23:12:14 samjam volumio[1025]: at processTimers (internal/timers.js:497:7) Oct 26 23:12:14 samjam volumio[1025]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 23:12:14 samjam sudo[1586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-26 23:11 Oct 26 23:12:14 samjam sudo[1586]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"