-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Wed 2025-05-28 22:20:46 UTC. -- May 28 22:19:06 volumio-living-room volumio[963]: info: Preload queue cleared May 28 22:19:06 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::ClearQueue May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::stop May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 22:19:06 volumio-living-room volumio[963]: info: CorePlayQueue::clearPlayQueue May 28 22:19:06 volumio-living-room volumio[963]: info: CorePlayQueue::saveQueue May 28 22:19:06 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushQueue May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::addQueueItems May 28 22:19:06 volumio-living-room volumio[963]: info: CorePlayQueue::addQueueItems May 28 22:19:06 volumio-living-room volumio[963]: info: Preload queue cleared May 28 22:19:06 volumio-living-room volumio[963]: info: Adding Item to queue: music-library/NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac May 28 22:19:06 volumio-living-room volumio[963]: info: Exploding uri music-library/NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac in service mpd May 28 22:19:06 volumio-living-room volumio[963]: info: ALBUMART /albumart?cacheid=126&web=Miles%20Davis%20Quintet/Workin'%20with%20the%20Miles%20Davis%20Quintet/extralarge&path=%2Fmnt%2FNAS%2FMusic01%2FMusic_01%2FMusic%2FMiles%20Davis%2FMiles%20Davis%20Quintet%20-%20Workin'%20with%20the%20Miles%20Davis%20Quintet%20(1959)%20%5Bgarybx%5D%20%7B24-96%7D%20%7BAnalogue%20Productions%2045RPM%7D%2F01%20-%20It%20Never%20Entered%20My%20Mind.flac&metadata=false May 28 22:19:06 volumio-living-room volumio[963]: info: URI /mnt/NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac May 28 22:19:06 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushQueue May 28 22:19:06 volumio-living-room volumio[963]: info: CorePlayQueue::saveQueue May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::updateTrackBlock May 28 22:19:06 volumio-living-room volumio[963]: info: CorePlayQueue::getTrackBlock May 28 22:19:06 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPlay May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::play index 0 May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::stop May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::play index undefined May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 22:19:06 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:06 volumio-living-room volumio[963]: info: CoreStateMachine::startPlaybackTimer May 28 22:19:06 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:06 volumio-living-room volumio[963]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac May 28 22:19:06 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand stop May 28 22:19:06 volumio-living-room volumio[963]: info: sendMpdCommand stop took 5 milliseconds May 28 22:19:06 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand clear May 28 22:19:06 volumio-living-room volumio[963]: info: May 28 22:19:06 volumio-living-room volumio[963]: ---------------------------- MPD announces system playlist update May 28 22:19:06 volumio-living-room volumio[963]: info: Ignoring MPD Status Update May 28 22:19:06 volumio-living-room volumio[963]: info: sendMpdCommand clear took 2 milliseconds May 28 22:19:06 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac" May 28 22:19:06 volumio-living-room volumio[963]: error: updateQueue error: null May 28 22:19:06 volumio-living-room volumio[963]: info: ------------------------------ 4ms May 28 22:19:06 volumio-living-room volumio[963]: info: May 28 22:19:06 volumio-living-room volumio[963]: ---------------------------- MPD announces system playlist update May 28 22:19:06 volumio-living-room volumio[963]: info: Ignoring MPD Status Update May 28 22:19:06 volumio-living-room volumio[963]: info: sendMpdCommand add "NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac" took 5 milliseconds May 28 22:19:06 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand play May 28 22:19:06 volumio-living-room volumio[963]: info: ------------------------------ 4ms May 28 22:19:06 volumio-living-room volumio[963]: info: sendMpdCommand play took 5 milliseconds May 28 22:19:07 volumio-living-room volumio[963]: info: May 28 22:19:07 volumio-living-room volumio[963]: ---------------------------- MPD announces state update: player May 28 22:19:07 volumio-living-room volumio[963]: info: ControllerMpd::getState May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand status May 28 22:19:07 volumio-living-room volumio[963]: info: May 28 22:19:07 volumio-living-room volumio[963]: ---------------------------- MPD announces state update: player May 28 22:19:07 volumio-living-room volumio[963]: info: ControllerMpd::getState May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand status May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand clearerror May 28 22:19:07 volumio-living-room volumio[963]: info: sendMpdCommand status took 24 milliseconds May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::parseState May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand clearerror May 28 22:19:07 volumio-living-room volumio[963]: info: sendMpdCommand status took 27 milliseconds May 28 22:19:07 volumio-living-room volumio[963]: info: sendMpdCommand clearerror took 11 milliseconds May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::parseState May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 22:19:07 volumio-living-room volumio[963]: info: sendMpdCommand playlistinfo took 15 milliseconds May 28 22:19:07 volumio-living-room volumio[963]: info: sendMpdCommand clearerror took 9 milliseconds May 28 22:19:07 volumio-living-room volumio[963]: info: sendMpdCommand playlistinfo took 7 milliseconds May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::parseTrackInfo May 28 22:19:07 volumio-living-room volumio[963]: verbose: ControllerMpd::parseTrackInfo May 28 22:19:07 volumio-living-room volumio[963]: info: ControllerMpd::pushState May 28 22:19:07 volumio-living-room volumio[963]: info: CoreCommandRouter::servicePushState May 28 22:19:07 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:07 volumio-living-room volumio[963]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":324,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Never Entered My Mind","artist":"Miles Davis Quintet","album":"Workin' with the Miles Davis Quintet","uri":"NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac","trackType":"flac"} May 28 22:19:07 volumio-living-room volumio[963]: verbose: CURRENT POSITION 0 May 28 22:19:07 volumio-living-room volumio[963]: info: CoreStateMachine::syncState stateService pause May 28 22:19:07 volumio-living-room volumio[963]: info: CoreStateMachine::syncState currentStatus stop May 28 22:19:07 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:07 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:07 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:19:07 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:07 volumio-living-room volumio[963]: info: ControllerMpd::pushState May 28 22:19:07 volumio-living-room volumio[963]: info: CoreCommandRouter::servicePushState May 28 22:19:07 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:07 volumio-living-room volumio[963]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":324,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Never Entered My Mind","artist":"Miles Davis Quintet","album":"Workin' with the Miles Davis Quintet","uri":"NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac","trackType":"flac"} May 28 22:19:07 volumio-living-room volumio[963]: verbose: CURRENT POSITION 0 May 28 22:19:07 volumio-living-room volumio[963]: info: CoreStateMachine::syncState stateService pause May 28 22:19:07 volumio-living-room volumio[963]: info: CoreStateMachine::syncState currentStatus stop May 28 22:19:07 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:07 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:07 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:07 volumio-living-room volumio[963]: info: ------------------------------ 80ms May 28 22:19:07 volumio-living-room volumio[963]: info: ------------------------------ 73ms May 28 22:19:17 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioGetState May 28 22:19:17 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:21 volumio-living-room volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 22:19:21 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 28 22:19:21 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 22:19:21 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:21 volumio-living-room volumio[963]: info: Getting Alsa Cards List without I2S DAC May 28 22:19:21 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 28 22:19:21 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 22:19:22 volumio-living-room volumio[963]: Invalid card number. May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 28 22:19:22 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 22:19:27 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 22:19:27 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 22:19:27 volumio-living-room volumio[963]: info: Discovery: Getting this device information May 28 22:19:27 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioGetState May 28 22:19:27 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:27 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 22:19:30 volumio-living-room nmbd[1524]: [2025/05/28 22:19:30.348523, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) May 28 22:19:30 volumio-living-room nmbd[1524]: wins_write_database: Can't open /var/lib/samba/wins.dat.1524: Input/output error May 28 22:19:30 volumio-living-room kernel: EXT4-fs error (device mmcblk0p3): __ext4_new_inode:1272: comm nmbd: failed to insert inode 520548: doubly allocated? May 28 22:19:30 volumio-living-room volumio[963]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 28 22:19:30 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 28 22:19:30 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:30 volumio-living-room volumio[963]: info: Disabling I2S DAC: May 28 22:19:30 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC May 28 22:19:30 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:31 volumio-living-room volumio[963]: info: Device 5 does not have any Mixer Control Available May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 28 22:19:31 volumio-living-room volumio[963]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 28 22:19:31 volumio-living-room volumio[963]: info: Disabling external Volume Control May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 22:19:31 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:31 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:31 volumio-living-room volumio[963]: info: Preparing to generate the ALSA configuration file May 28 22:19:31 volumio-living-room volumio[963]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. May 28 22:19:31 volumio-living-room volumio[963]: verbose: New Socket.io Connection to 192.168.1.34:3000 from 192.168.1.221 UA: Dart/3.5 (dart:io) Total Clients: 6 May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 28 22:19:31 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 22:19:31 volumio-living-room sudo[1539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 28 22:19:31 volumio-living-room sudo[1539]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 22:19:31 volumio-living-room sudo[1539]: pam_unix(sudo:session): session closed for user root May 28 22:19:31 volumio-living-room volumio[963]: info: No Overlays Loaded May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioGetState May 28 22:19:34 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:34 volumio-living-room volumio[963]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:34 volumio-living-room volumio[963]: info: Device 5 does not have any Mixer Control Available May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 28 22:19:34 volumio-living-room volumio[963]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 28 22:19:34 volumio-living-room volumio[963]: info: Disabling external Volume Control May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 22:19:34 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:34 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 28 22:19:34 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioGetState May 28 22:19:35 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 28 22:19:35 volumio-living-room volumio[963]: info: CoreStateMachine::getcurrentVolume May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioRetrievevolume May 28 22:19:35 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:35 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:19:35 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:36 volumio-living-room volumio[963]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:36 volumio-living-room volumio[963]: info: Device 5 does not have any Mixer Control Available May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 28 22:19:36 volumio-living-room volumio[963]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 28 22:19:36 volumio-living-room volumio[963]: info: Disabling external Volume Control May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 22:19:36 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:36 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 28 22:19:36 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 22:19:38 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioGetState May 28 22:19:38 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:38 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 28 22:19:38 volumio-living-room volumio[963]: info: CoreStateMachine::getcurrentVolume May 28 22:19:38 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioRetrievevolume May 28 22:19:38 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:38 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:38 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:19:38 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:40 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 28 22:19:40 volumio-living-room volumio[963]: info: CoreStateMachine::getcurrentVolume May 28 22:19:40 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioRetrievevolume May 28 22:19:40 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:40 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:40 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:19:40 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:41 volumio-living-room volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 28 22:19:42 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 22:19:49 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioGetState May 28 22:19:49 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:50 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPlay May 28 22:19:50 volumio-living-room volumio[963]: info: CoreStateMachine::play index undefined May 28 22:19:50 volumio-living-room volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 22:19:50 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:50 volumio-living-room volumio[963]: info: CoreStateMachine::startPlaybackTimer May 28 22:19:50 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand stop May 28 22:19:50 volumio-living-room kernel: EXT4-fs error (device mmcblk0p3) in ext4_free_inode:360: Corrupt filesystem May 28 22:19:50 volumio-living-room volumio[963]: info: May 28 22:19:50 volumio-living-room volumio[963]: ---------------------------- MPD announces state update: player May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand stop took 268 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: info: ControllerMpd::getState May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand status May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand clear May 28 22:19:50 volumio-living-room volumio[963]: info: May 28 22:19:50 volumio-living-room volumio[963]: ---------------------------- MPD announces system playlist update May 28 22:19:50 volumio-living-room volumio[963]: info: Ignoring MPD Status Update May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand status took 5 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand clear took 4 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::parseState May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac" May 28 22:19:50 volumio-living-room volumio[963]: error: updateQueue error: null May 28 22:19:50 volumio-living-room volumio[963]: info: May 28 22:19:50 volumio-living-room volumio[963]: ---------------------------- MPD announces system playlist update May 28 22:19:50 volumio-living-room volumio[963]: info: Ignoring MPD Status Update May 28 22:19:50 volumio-living-room volumio[963]: info: ------------------------------ 10ms May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand playlistinfo took 7 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand add "NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac" took 7 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::parseTrackInfo May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand play May 28 22:19:50 volumio-living-room volumio[963]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 28 22:19:50 volumio-living-room volumio[963]: info: ------------------------------ 23ms May 28 22:19:50 volumio-living-room volumio[963]: info: ------------------------------ 10ms May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand play took 5 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: info: May 28 22:19:50 volumio-living-room volumio[963]: ---------------------------- MPD announces state update: player May 28 22:19:50 volumio-living-room volumio[963]: info: ControllerMpd::getState May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand status May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand clearerror May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand status took 10 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::parseState May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand clearerror took 4 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: info: sendMpdCommand playlistinfo took 3 milliseconds May 28 22:19:50 volumio-living-room volumio[963]: verbose: ControllerMpd::parseTrackInfo May 28 22:19:50 volumio-living-room volumio[963]: info: ControllerMpd::pushState May 28 22:19:50 volumio-living-room volumio[963]: info: CoreCommandRouter::servicePushState May 28 22:19:50 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:50 volumio-living-room volumio[963]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":324,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Never Entered My Mind","artist":"Miles Davis Quintet","album":"Workin' with the Miles Davis Quintet","uri":"NAS/Music01/Music_01/Music/Miles Davis/Miles Davis Quintet - Workin' with the Miles Davis Quintet (1959) [garybx] {24-96} {Analogue Productions 45RPM}/01 - It Never Entered My Mind.flac","trackType":"flac"} May 28 22:19:50 volumio-living-room volumio[963]: verbose: CURRENT POSITION 0 May 28 22:19:50 volumio-living-room volumio[963]: info: CoreStateMachine::syncState stateService pause May 28 22:19:50 volumio-living-room volumio[963]: info: CoreStateMachine::syncState currentStatus stop May 28 22:19:50 volumio-living-room volumio[963]: info: CoreStateMachine::pushState May 28 22:19:50 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:50 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:19:50 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioPushState May 28 22:19:51 volumio-living-room volumio[963]: info: ------------------------------ 38ms May 28 22:19:57 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 22:19:57 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 22:19:57 volumio-living-room volumio[963]: info: Discovery: Getting this device information May 28 22:19:57 volumio-living-room volumio[963]: info: CoreCommandRouter::volumioGetState May 28 22:19:57 volumio-living-room volumio[963]: info: CorePlayQueue::getTrack 0 May 28 22:19:57 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 22:20:07 volumio-living-room kernel: EXT4-fs error (device mmcblk0p3) in ext4_free_inode:360: Corrupt filesystem May 28 22:20:10 volumio-living-room volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 22:20:10 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 28 22:20:10 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 28 22:20:10 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 28 22:20:10 volumio-living-room volumio[963]: info: Received Get System Version May 28 22:20:10 volumio-living-room volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 28 22:20:18 volumio-living-room volumio-remote-updater[536]: No test mode May 28 22:20:18 volumio-living-room volumio-remote-updater[536]: No alpha test mode May 28 22:20:18 volumio-living-room volumio[963]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n\n

NEW ADDITIONS

\n\n","title":"Update v3.812","updateavailable":true} May 28 22:20:18 volumio-living-room volumio[963]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 22:20:18 volumio-living-room volumio[963]: SyntaxError: /data/configuration/plugins.json: Unexpected token May 28 22:20:18 volumio-living-room volumio[963]: in JSON at position 0 May 28 22:20:18 volumio-living-room volumio[963]: at JSON.parse () May 28 22:20:18 volumio-living-room volumio[963]: at Object.readFileSync (/volumio/node_modules/jsonfile/index.js:69:17) May 28 22:20:18 volumio-living-room volumio[963]: at PluginManager.getAllPlugNames (/volumio/app/pluginmanager.js:568:21) May 28 22:20:18 volumio-living-room volumio[963]: at PluginManager.getPluginsMatrix (/volumio/app/pluginmanager.js:592:26) May 28 22:20:18 volumio-living-room volumio[963]: at PluginManager.listPluginsBrokenByNewVersion (/volumio/app/pluginmanager.js:1224:22) May 28 22:20:18 volumio-living-room volumio[963]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:934:60) May 28 22:20:18 volumio-living-room volumio[963]: at Socket.emit (events.js:315:20) May 28 22:20:18 volumio-living-room volumio[963]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 28 22:20:18 volumio-living-room volumio[963]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 28 22:20:18 volumio-living-room volumio[963]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 22:20:18 volumio-living-room volumio[963]: /bin/sh: 1: Syntax error: Unterminated quoted string May 28 22:20:18 volumio-living-room volumio[963]: child_process.js:655 May 28 22:20:18 volumio-living-room volumio[963]: throw err; May 28 22:20:18 volumio-living-room volumio[963]: ^ May 28 22:20:18 volumio-living-room volumio[963]: Error: Command failed: /usr/bin/node /volumio/crashreport.js "/data/configuration/plugins.json: Unexpected token May 28 22:20:18 volumio-living-room volumio[963]: in JSON at position 0" May 28 22:20:18 volumio-living-room volumio[963]: /bin/sh: 1: Syntax error: Unterminated quoted string May 28 22:20:18 volumio-living-room volumio[963]: at checkExecSyncError (child_process.js:616:11) May 28 22:20:18 volumio-living-room volumio[963]: at execSync (child_process.js:652:15) May 28 22:20:18 volumio-living-room volumio[963]: at process. (/volumio/index.js:86:3) May 28 22:20:18 volumio-living-room volumio[963]: at process.emit (events.js:315:20) May 28 22:20:18 volumio-living-room volumio[963]: at process._fatalException (internal/process/execution.js:163:25) { May 28 22:20:18 volumio-living-room volumio[963]: status: 2, May 28 22:20:18 volumio-living-room volumio[963]: signal: null, May 28 22:20:18 volumio-living-room volumio[963]: output: [ May 28 22:20:18 volumio-living-room volumio[963]: null, May 28 22:20:18 volumio-living-room volumio[963]: Buffer(0) [Uint8Array] [], May 28 22:20:18 volumio-living-room volumio[963]: Buffer(53) [Uint8Array] [ May 28 22:20:18 volumio-living-room volumio[963]: 47, 98, 105, 110, 47, 115, 104, 58, 32, 49, May 28 22:20:18 volumio-living-room volumio[963]: 58, 32, 83, 121, 110, 116, 97, 120, 32, 101, May 28 22:20:18 volumio-living-room volumio[963]: 114, 114, 111, 114, 58, 32, 85, 110, 116, 101, May 28 22:20:18 volumio-living-room volumio[963]: 114, 109, 105, 110, 97, 116, 101, 100, 32, 113, May 28 22:20:18 volumio-living-room volumio[963]: 117, 111, 116, 101, 100, 32, 115, 116, 114, 105, May 28 22:20:18 volumio-living-room volumio[963]: 110, 103, 10 May 28 22:20:18 volumio-living-room volumio[963]: ] May 28 22:20:18 volumio-living-room volumio[963]: ], May 28 22:20:18 volumio-living-room volumio[963]: pid: 1582, May 28 22:20:18 volumio-living-room volumio[963]: stdout: Buffer(0) [Uint8Array] [], May 28 22:20:18 volumio-living-room volumio[963]: stderr: Buffer(53) [Uint8Array] [ May 28 22:20:18 volumio-living-room volumio[963]: 47, 98, 105, 110, 47, 115, 104, 58, 32, 49, May 28 22:20:18 volumio-living-room volumio[963]: 58, 32, 83, 121, 110, 116, 97, 120, 32, 101, May 28 22:20:18 volumio-living-room volumio[963]: 114, 114, 111, 114, 58, 32, 85, 110, 116, 101, May 28 22:20:18 volumio-living-room volumio[963]: 114, 109, 105, 110, 97, 116, 101, 100, 32, 113, May 28 22:20:18 volumio-living-room volumio[963]: 117, 111, 116, 101, 100, 32, 115, 116, 114, 105, May 28 22:20:18 volumio-living-room volumio[963]: 110, 103, 10 May 28 22:20:18 volumio-living-room volumio[963]: ] May 28 22:20:18 volumio-living-room volumio[963]: } May 28 22:20:18 volumio-living-room volumio-remote-updater[536]: [2025-05-28 22:20:18] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 28 22:20:18 volumio-living-room volumio-remote-updater[536]: [2025-05-28 22:20:18] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 28 22:20:18 volumio-living-room systemd[1]: volumio.service: Main process exited, code=exited, status=7/NOTRUNNING May 28 22:20:18 volumio-living-room ntfs-3g[1027]: Unmounting /dev/sda1 (Music 480GB) May 28 22:20:18 volumio-living-room systemd[1]: media-240GB.mount: Succeeded. May 28 22:20:18 volumio-living-room systemd[1]: media-Music_480GB.mount: Succeeded. May 28 22:20:18 volumio-living-room systemd[1]: volumio.service: Failed with result 'exit-code'. May 28 22:20:18 volumio-living-room systemd[1]: Started dynamicswap service. May 28 22:20:18 volumio-living-room systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 28 22:20:18 volumio-living-room systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. May 28 22:20:18 volumio-living-room systemd[1]: Stopped Volumio Backend Module. May 28 22:20:18 volumio-living-room systemd[1]: Started Volumio Backend Module. May 28 22:20:18 volumio-living-room systemd[1]: dynamicswap.service: Succeeded. May 28 22:20:23 volumio-living-room volumio[1592]: info: ------------------------------------------- May 28 22:20:23 volumio-living-room volumio[1592]: info: ----- Volumio3 ---- May 28 22:20:23 volumio-living-room volumio[1592]: info: ------------------------------------------- May 28 22:20:23 volumio-living-room volumio[1592]: info: ----- System startup ---- May 28 22:20:23 volumio-living-room volumio[1592]: info: ------------------------------------------- May 28 22:20:23 volumio-living-room volumio-remote-updater[536]: [2025-05-28 22:20:23] [connect] Successful connection May 28 22:20:24 volumio-living-room volumio[1592]: info: MYVOLUMIO Environment detected May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin music_service/airplay_emulation. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin music_service/inputs. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin music_service/mpd. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin music_service/webradio. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin music_service/example_plugin. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin music_service/last_100. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin music_service/upnp_browser. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin audio_interface/outputs. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin audio_interface/upnp. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin audio_interface/alsa_controller. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin miscellanea/alarm-clock. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin miscellanea/albumart. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin miscellanea/appearance. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin miscellanea/wizard. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin miscellanea/my_music. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin user_interface/websocket. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin user_interface/mpdemulation. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin user_interface/rest_api. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin system_controller/updater_comm. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin system_controller/network. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin system_controller/networkfs. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin system_controller/services. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin system_controller/system. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin system_controller/i2s_dacs. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin system_controller/volumiodiscovery. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Found new core plugin system_controller/volumio_command_line_client. Adding it May 28 22:20:25 volumio-living-room volumio[1592]: info: Plugin folders cleanup May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning into folder /volumio/app/plugins/ May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category audio_interface May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category miscellanea May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category music_service May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category plugins.json May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category system_controller May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category user_interface May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning into folder /data/plugins/ May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category audio_interface May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category music_service May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category system_hardware May 28 22:20:25 volumio-living-room volumio[1592]: info: Scanning category user_interface May 28 22:20:25 volumio-living-room volumio[1592]: info: Plugin folders cleanup completed May 28 22:20:25 volumio-living-room volumio[1592]: info: ------------------------------------------- May 28 22:20:25 volumio-living-room volumio[1592]: info: ----- Core plugins startup ---- May 28 22:20:25 volumio-living-room volumio[1592]: info: ------------------------------------------- May 28 22:20:25 volumio-living-room volumio[1592]: info: Loading plugins from folder /volumio/app/plugins/ May 28 22:20:25 volumio-living-room volumio[1592]: info: Adding plugin upnp to MyMusic Plugins May 28 22:20:25 volumio-living-room volumio[1592]: info: Adding plugin airplay_emulation to MyMusic Plugins May 28 22:20:25 volumio-living-room volumio[1592]: info: Adding plugin upnp_browser to MyMusic Plugins May 28 22:20:25 volumio-living-room volumio[1592]: info: Loading plugins from folder /data/plugins/ May 28 22:20:25 volumio-living-room volumio[1592]: info: Loading plugin "system"... May 28 22:20:25 volumio-living-room volumio[1592]: info: No id defined. Creating one May 28 22:20:25 volumio-living-room volumio[1592]: info: Loading plugin "appearance"... May 28 22:20:26 volumio-living-room volumio[1592]: info: Loading plugin "network"... May 28 22:20:26 volumio-living-room volumio[1592]: info: Refreshing Cached IP Addresses May 28 22:20:26 volumio-living-room sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 22:20:26 volumio-living-room sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 22:20:26 volumio-living-room sudo[1611]: pam_unix(sudo:session): session closed for user root May 28 22:20:26 volumio-living-room sudo[1614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 22:20:26 volumio-living-room sudo[1614]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 22:20:26 volumio-living-room volumio[1592]: info: Loading plugin "services"... May 28 22:20:26 volumio-living-room sudo[1614]: pam_unix(sudo:session): session closed for user root May 28 22:20:26 volumio-living-room volumio[1592]: info: Loading plugin "alsa_controller"... May 28 22:20:26 volumio-living-room sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 28 22:20:26 volumio-living-room sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 22:20:26 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 28 22:20:26 volumio-living-room volumio[1592]: info: Loading plugin "wizard"... May 28 22:20:26 volumio-living-room volumio[1592]: info: Loading plugin "volumio_command_line_client"... May 28 22:20:26 volumio-living-room volumio[1592]: info: Loading plugin "upnp"... May 28 22:20:26 volumio-living-room volumio[1592]: info: [1748470826877] Starting Upmpd Daemon May 28 22:20:26 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 22:20:26 volumio-living-room volumio[1592]: info: Loading plugin "my_music"... May 28 22:20:26 volumio-living-room volumio[1592]: info: Loading plugin "mpd"... May 28 22:20:27 volumio-living-room volumio[1592]: info: Creating MPD Configuration file May 28 22:20:27 volumio-living-room volumio[1592]: info: Loading plugin "upnp_browser"... May 28 22:20:27 volumio-living-room sudo[1622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 28 22:20:27 volumio-living-room sudo[1622]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 22:20:27 volumio-living-room sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 28 22:20:27 volumio-living-room sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 22:20:27 volumio-living-room sudo[1622]: pam_unix(sudo:session): session closed for user root May 28 22:20:27 volumio-living-room systemd[1]: musicservicesshield.service: Succeeded. May 28 22:20:27 volumio-living-room systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. May 28 22:20:27 volumio-living-room systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... May 28 22:20:27 volumio-living-room systemd[1]: Stopping Music Player Daemon... May 28 22:20:27 volumio-living-room sudo[1617]: pam_unix(sudo:session): session closed for user root May 28 22:20:28 volumio-living-room volumio[1592]: info: Loading plugin "networkfs"... May 28 22:20:28 volumio-living-room systemd[1]: mpd.service: Succeeded. May 28 22:20:28 volumio-living-room systemd[1]: Stopped Music Player Daemon. May 28 22:20:28 volumio-living-room systemd[1]: Starting Music Player Daemon... May 28 22:20:28 volumio-living-room volumio[1592]: info: Cannot mount NAS Music01 at system boot, trial number 1 ,retrying in 5 seconds May 28 22:20:28 volumio-living-room volumio[1592]: info: Starting Udev Watcher for removable devices May 28 22:20:28 volumio-living-room volumio[1592]: info: Ignoring mount for partition: boot May 28 22:20:28 volumio-living-room volumio[1592]: info: Ignoring mount for partition: volumio May 28 22:20:28 volumio-living-room volumio[1592]: info: Ignoring mount for partition: volumio_data May 28 22:20:28 volumio-living-room volumio[1592]: info: Mounting Device Music_480GB May 28 22:20:29 volumio-living-room sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music_480GB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 28 22:20:29 volumio-living-room sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 22:20:29 volumio-living-room ntfs-3g[1638]: Version 2017.3.23AR.3 integrated FUSE 28 May 28 22:20:29 volumio-living-room ntfs-3g[1638]: Mounted /dev/sda1 (Read-Write, label "Music 480GB", NTFS 3.1) May 28 22:20:29 volumio-living-room ntfs-3g[1638]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 May 28 22:20:29 volumio-living-room ntfs-3g[1638]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 May 28 22:20:29 volumio-living-room ntfs-3g[1638]: Global ownership and permissions enforced, configuration type 7 May 28 22:20:29 volumio-living-room sudo[1635]: pam_unix(sudo:session): session closed for user root May 28 22:20:29 volumio-living-room volumio[1592]: error: Cannot associate FS Label, not mounting May 28 22:20:29 volumio-living-room volumio[1592]: info: Mounting Device 240GB May 28 22:20:29 volumio-living-room sudo[1644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb2 /mnt/USB/240GB -o noatime May 28 22:20:29 volumio-living-room sudo[1644]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 22:20:30 volumio-living-room sudo[1644]: pam_unix(sudo:session): session closed for user root May 28 22:20:30 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 22:20:30 volumio-living-room volumio[1592]: info: Loading plugin "alarm-clock"... May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "airplay_emulation"... May 28 22:20:31 volumio-living-room volumio[1592]: info: Starting Shairport Sync May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "last_100"... May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "webradio"... May 28 22:20:31 volumio-living-room mpd[1629]: exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 28 22:20:31 volumio-living-room mpd[1629]: config: Found database setting without music_directory - disabling database May 28 22:20:31 volumio-living-room mpd[1629]: output: No 'audio_output' defined in config file May 28 22:20:31 volumio-living-room mpd[1629]: output: Attempt to detect audio output device May 28 22:20:31 volumio-living-room mpd[1629]: output: Attempting to detect a alsa audio device May 28 22:20:31 volumio-living-room mpd[1629]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card May 28 22:20:31 volumio-living-room mpd[1629]: alsa_output: Error opening default ALSA device: No such device May 28 22:20:31 volumio-living-room mpd[1629]: output: Attempting to detect a oss audio device May 28 22:20:31 volumio-living-room mpd[1629]: oss_output: Error opening OSS device "/dev/dsp": No such file or directory May 28 22:20:31 volumio-living-room mpd[1629]: oss_output: Error opening OSS device "/dev/sound/dsp": No such file or directory May 28 22:20:31 volumio-living-room mpd[1629]: output: Attempting to detect a pulse audio device May 28 22:20:31 volumio-living-room kernel: EXT4-fs error (device mmcblk0p3) in ext4_free_inode:360: Corrupt filesystem May 28 22:20:31 volumio-living-room mpd[1629]: output: Attempting to detect a jack audio device May 28 22:20:31 volumio-living-room mpd[1629]: output: Successfully detected a jack audio device May 28 22:20:31 volumio-living-room mpd[1629]: exception: Input plugin 'tidal' is unavailable: No Tidal application token configured May 28 22:20:31 volumio-living-room mpd[1629]: exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured May 28 22:20:31 volumio-living-room mpd[1629]: zeroconf: No global port, disabling zeroconf May 28 22:20:31 volumio-living-room systemd[1]: Started Music Player Daemon. May 28 22:20:31 volumio-living-room sudo[1624]: pam_unix(sudo:session): session closed for user root May 28 22:20:31 volumio-living-room systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "i2s_dacs"... May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "volumiodiscovery"... May 28 22:20:31 volumio-living-room volumio[1592]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 28 22:20:31 volumio-living-room volumio[1592]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 22:20:31 volumio-living-room volumio[1592]: *** WARNING *** For more information see May 28 22:20:31 volumio-living-room node[1592]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 28 22:20:31 volumio-living-room volumio[1592]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 28 22:20:31 volumio-living-room volumio[1592]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 22:20:31 volumio-living-room volumio[1592]: *** WARNING *** For more information see May 28 22:20:31 volumio-living-room node[1592]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 22:20:31 volumio-living-room node[1592]: *** WARNING *** For more information see May 28 22:20:31 volumio-living-room node[1592]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 28 22:20:31 volumio-living-room node[1592]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 22:20:31 volumio-living-room node[1592]: *** WARNING *** For more information see May 28 22:20:31 volumio-living-room volumio[1592]: info: Applying required configuration parameters for plugin volumiodiscovery May 28 22:20:31 volumio-living-room volumio[1592]: info: Discovery: Started advertising with name: undefined May 28 22:20:31 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "outputs"... May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "albumart"... May 28 22:20:31 volumio-living-room volumio[1592]: info: Plugin example_plugin is not enabled May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "inputs"... May 28 22:20:31 volumio-living-room volumio[1592]: info: Loading plugin "updater_comm"... May 28 22:20:32 volumio-living-room volumio[1592]: Forking 3 albumart workers May 28 22:20:32 volumio-living-room volumio[1592]: info: Plugin mpdemulation is not enabled May 28 22:20:32 volumio-living-room volumio[1592]: info: Loading plugin "rest_api"... May 28 22:20:32 volumio-living-room volumio[1592]: info: Loading plugin "websocket"... May 28 22:20:32 volumio-living-room volumio[1592]: info: Plugin fusiondsp is not enabled May 28 22:20:32 volumio-living-room volumio[1592]: info: Plugin minidlna is not enabled May 28 22:20:33 volumio-living-room volumio[1592]: info: Plugin music_services_shield is not enabled May 28 22:20:33 volumio-living-room volumio[1592]: info: Plugin Systeminfo is not enabled May 28 22:20:33 volumio-living-room volumio[1592]: info: Plugin randomizer is not enabled May 28 22:20:33 volumio-living-room volumio[1592]: info: Loading i18n strings for locale en May 28 22:20:33 volumio-living-room volumio[1592]: Updating browse sources language May 28 22:20:33 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 22:20:34 volumio-living-room volumio[1652]: cset: --> shielding system active with May 28 22:20:34 volumio-living-room volumio[1652]: cset: "system" cpuset of CPUSPEC(1-3) with 95 tasks running May 28 22:20:34 volumio-living-room volumio[1652]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running May 28 22:20:34 volumio-living-room systemd[1]: Started Shield Volumio Music Services in the User CPU Set. May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::initPlayerControls May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 22:20:34 volumio-living-room volumio[1592]: Express server listening on port 3000 May 28 22:20:34 volumio-living-room volumio[1592]: [Metrics] WebUI: 12s 545.18ms May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreStateMachine::resetVolumioState May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreStateMachine::getcurrentVolume May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::volumioRetrievevolume May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreStateMachine::pushState May 28 22:20:34 volumio-living-room volumio[1592]: info: CorePlayQueue::getTrack 0 May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 22:20:34 volumio-living-room volumio[1592]: info: CoreCommandRouter::volumioPushState May 28 22:20:34 volumio-living-room volumio[1592]: info: Cannot mount NAS Music01 at system boot, trial number 2 ,retrying in 5 seconds May 28 22:20:35 volumio-living-room mpd[1629]: client: [0] opened from local May 28 22:20:35 volumio-living-room volumio[1592]: info: MPD Permissions set May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 1 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34:3000 from 192.168.1.221 UA: Dart/3.5 (dart:io) Total Clients: 2 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 3 May 28 22:20:35 volumio-living-room volumio[1592]: Starting albumart workers May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 4 May 28 22:20:35 volumio-living-room volumio[1592]: Starting albumart workers May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 5 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 6 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 7 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 8 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 9 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 10 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 11 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 12 May 28 22:20:35 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 13 May 28 22:20:35 volumio-living-room volumio[1592]: Starting albumart workers May 28 22:20:36 volumio-living-room volumio-remote-updater[536]: [2025-05-28 22:20:36] [connect] Successful connection May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 14 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 15 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 16 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 17 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 18 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 19 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 20 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 21 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 22 May 28 22:20:45 volumio-living-room volumio[1592]: verbose: New Socket.io Connection to 192.168.1.34 from 192.168.1.221 UA: Mozilla/5.0 (Linux; Android 14; A13 Build/UP1A.231105.001.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Safari/537.36 Total Clients: 23 May 28 22:20:45 volumio-living-room volumio[1592]: info: MPD running with PID1629 May 28 22:20:45 volumio-living-room volumio[1592]: ,establishing connection May 28 22:20:45 volumio-living-room mpd[1629]: client: [1] opened from local May 28 22:20:45 volumio-living-room volumio[1592]: error: Discovery: Generic error: TypeError: argument 8 must be an integer (port) May 28 22:20:45 volumio-living-room volumio[1592]: info: Discovery: Started advertising with name: undefined May 28 22:20:45 volumio-living-room volumio[1592]: info: Cannot mount NAS Music01 at system boot, trial number 3 ,retrying in 5 seconds May 28 22:20:45 volumio-living-room volumio[1592]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 22:20:45 volumio-living-room volumio[1592]: TypeError: Cannot read property 'charAt' of undefined May 28 22:20:45 volumio-living-room volumio[1592]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24) May 28 22:20:45 volumio-living-room volumio[1592]: at listOnTimeout (internal/timers.js:554:17) May 28 22:20:45 volumio-living-room volumio[1592]: at processTimers (internal/timers.js:497:7) May 28 22:20:45 volumio-living-room volumio[1592]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 22:20:46 volumio-living-room sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 22:19 May 28 22:20:46 volumio-living-room sudo[1734]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST" VOLUMIO_VERSION="3.546" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"