-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2025-05-25 09:04:11 CST. -- May 25 09:03:16 smsl-n100 volumio[5647]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 09:03:16 smsl-n100 volumio[5647]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 09:03:16 smsl-n100 volumio[5647]: info: Discovery: Getting this device information May 25 09:03:16 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioGetState May 25 09:03:16 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:16 smsl-n100 volumio[5647]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 09:03:24 smsl-n100 volumio[5647]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' May 25 09:03:24 smsl-n100 volumio[5647]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioSeek May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::seek May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: TRACKBLOCK {"uri":"mnt/USB/MUSIC_BKUP/taobaoo/AA_Hi Res Classic FLAC/Fazil Say - Beethoven_Piano Sonatas Nos 30, 31 & 32 (2020) [24-96]/14. Piano Sonata No. 32 in C Minor, Op. 111 II. Arietta (Adagio molto semplice e cantabile).flac","service":"mpd","name":"14 - Piano Sonata No. 32 in C Minor, Op. 111: II. Arietta (Adagio molto semplice e cantabile)","artist":"Fazil Say","album":"Beethoven: Piano Sonatas Nos 30, 31 & 32","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=257&web=Fazil%20Say/Beethoven%3A%20Piano%20Sonatas%20Nos%2030%2C%2031%20%26%2032/extralarge&path=%2FUSB%2FMUSIC_BKUP%2Ftaobaoo%2FAA_Hi%20Res%20Classic%20FLAC%2FFazil%20Say%20-%20Beethoven_Piano%20Sonatas%20Nos%2030%2C%2031%20%26%2032%20(2020)%20%5B24-96%5D&metadata=false","duration":929,"samplerate":"96 kHz","bitdepth":"24 bit","trackType":"flac","channels":2} May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::startPlaybackTimer May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioGetVisibleSources May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 25 09:03:26 smsl-n100 volumio[5647]: info: ControllerMpd::seek May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioPushState May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output update for this device May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output May 25 09:03:26 smsl-n100 volumio[5647]: error: null May 25 09:03:26 smsl-n100 volumio[5647]: info: May 25 09:03:26 smsl-n100 volumio[5647]: ---------------------------- MPD announces state update: player May 25 09:03:26 smsl-n100 volumio[5647]: info: ControllerMpd::getState May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::sendMpdCommand status May 25 09:03:26 smsl-n100 volumio[5647]: info: May 25 09:03:26 smsl-n100 volumio[5647]: ---------------------------- MPD announces state update: player May 25 09:03:26 smsl-n100 volumio[5647]: info: ControllerMpd::getState May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::sendMpdCommand status May 25 09:03:26 smsl-n100 volumio[5647]: info: May 25 09:03:26 smsl-n100 volumio[5647]: ---------------------------- MPD announces state update: player May 25 09:03:26 smsl-n100 volumio[5647]: info: ControllerMpd::getState May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::sendMpdCommand status May 25 09:03:26 smsl-n100 volumio[5647]: info: sendMpdCommand status took 21 milliseconds May 25 09:03:26 smsl-n100 volumio[5647]: info: sendMpdCommand status took 15 milliseconds May 25 09:03:26 smsl-n100 volumio[5647]: info: sendMpdCommand status took 15 milliseconds May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::parseState May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::parseState May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::parseState May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 09:03:26 smsl-n100 volumio[5647]: info: sendMpdCommand playlistinfo took 18 milliseconds May 25 09:03:26 smsl-n100 volumio[5647]: info: sendMpdCommand playlistinfo took 18 milliseconds May 25 09:03:26 smsl-n100 volumio[5647]: info: sendMpdCommand playlistinfo took 16 milliseconds May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::parseTrackInfo May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::parseTrackInfo May 25 09:03:26 smsl-n100 volumio[5647]: verbose: ControllerMpd::parseTrackInfo May 25 09:03:26 smsl-n100 volumio[5647]: info: ControllerMpd::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::servicePushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: verbose: STATE SERVICE {"status":"play","position":0,"seek":549000,"duration":929,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1943 Kbps","isStreaming":false,"title":"Piano Sonata No. 32 in C Minor, Op. 111: II. Arietta (Adagio molto semplice e cantabile)","artist":"Fazil Say","album":"Beethoven: Piano Sonatas Nos 30, 31 & 32","uri":"USB/MUSIC_BKUP/taobaoo/AA_Hi Res Classic FLAC/Fazil Say - Beethoven_Piano Sonatas Nos 30, 31 & 32 (2020) [24-96]/14. Piano Sonata No. 32 in C Minor, Op. 111 II. Arietta (Adagio molto semplice e cantabile).flac","trackType":"flac"} May 25 09:03:26 smsl-n100 volumio[5647]: verbose: CURRENT POSITION 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::syncState stateService play May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::syncState currentStatus play May 25 09:03:26 smsl-n100 volumio[5647]: info: Received an update from plugin. extracting info from payload May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioPushState May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output update for this device May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioPushState May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output update for this device May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output May 25 09:03:26 smsl-n100 volumio[5647]: info: ControllerMpd::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::servicePushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: verbose: STATE SERVICE {"status":"play","position":0,"seek":549000,"duration":929,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1943 Kbps","isStreaming":false,"title":"Piano Sonata No. 32 in C Minor, Op. 111: II. Arietta (Adagio molto semplice e cantabile)","artist":"Fazil Say","album":"Beethoven: Piano Sonatas Nos 30, 31 & 32","uri":"USB/MUSIC_BKUP/taobaoo/AA_Hi Res Classic FLAC/Fazil Say - Beethoven_Piano Sonatas Nos 30, 31 & 32 (2020) [24-96]/14. Piano Sonata No. 32 in C Minor, Op. 111 II. Arietta (Adagio molto semplice e cantabile).flac","trackType":"flac"} May 25 09:03:26 smsl-n100 volumio[5647]: verbose: CURRENT POSITION 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::syncState stateService play May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::syncState currentStatus play May 25 09:03:26 smsl-n100 volumio[5647]: info: Received an update from plugin. extracting info from payload May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioPushState May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output update for this device May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioPushState May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output update for this device May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output May 25 09:03:26 smsl-n100 volumio[5647]: info: ControllerMpd::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::servicePushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: verbose: STATE SERVICE {"status":"play","position":0,"seek":549000,"duration":929,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1943 Kbps","isStreaming":false,"title":"Piano Sonata No. 32 in C Minor, Op. 111: II. Arietta (Adagio molto semplice e cantabile)","artist":"Fazil Say","album":"Beethoven: Piano Sonatas Nos 30, 31 & 32","uri":"USB/MUSIC_BKUP/taobaoo/AA_Hi Res Classic FLAC/Fazil Say - Beethoven_Piano Sonatas Nos 30, 31 & 32 (2020) [24-96]/14. Piano Sonata No. 32 in C Minor, Op. 111 II. Arietta (Adagio molto semplice e cantabile).flac","trackType":"flac"} May 25 09:03:26 smsl-n100 volumio[5647]: verbose: CURRENT POSITION 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::syncState stateService play May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::syncState currentStatus play May 25 09:03:26 smsl-n100 volumio[5647]: info: Received an update from plugin. extracting info from payload May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioPushState May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output update for this device May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreStateMachine::pushState May 25 09:03:26 smsl-n100 volumio[5647]: info: CorePlayQueue::getTrack 13 May 25 09:03:26 smsl-n100 volumio[5647]: info: CoreCommandRouter::volumioPushState May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output update for this device May 25 09:03:26 smsl-n100 volumio[5647]: info: MRS: Pushing multiroomSync output May 25 09:03:26 smsl-n100 volumio[5647]: info: ------------------------------ 272ms May 25 09:03:26 smsl-n100 volumio[5647]: info: ------------------------------ 267ms May 25 09:03:26 smsl-n100 volumio[5647]: info: ------------------------------ 263ms May 25 09:03:29 smsl-n100 volumio[5647]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 09:03:29 smsl-n100 volumio[5647]: Error: connect ETIMEDOUT 69.63.184.142:80 May 25 09:03:29 smsl-n100 volumio[5647]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 25 09:03:29 smsl-n100 volumio[5647]: errno: -110, May 25 09:03:29 smsl-n100 volumio[5647]: code: 'ETIMEDOUT', May 25 09:03:29 smsl-n100 volumio[5647]: syscall: 'connect', May 25 09:03:29 smsl-n100 volumio[5647]: address: '69.63.184.142', May 25 09:03:29 smsl-n100 volumio[5647]: port: 80 May 25 09:03:29 smsl-n100 volumio[5647]: } May 25 09:03:29 smsl-n100 volumio[5647]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 09:03:30 smsl-n100 sudo[10020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 09:02 May 25 09:03:30 smsl-n100 sudo[10020]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:30 smsl-n100 sudo[10020]: pam_unix(sudo:session): session closed for user root May 25 09:03:31 smsl-n100 volumio-remote-updater[549]: [2025-05-25 09:03:31] [info] asio async_read_at_least error: system:104 (Connection reset by peer) May 25 09:03:31 smsl-n100 volumio-remote-updater[549]: [2025-05-25 09:03:31] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) May 25 09:03:31 smsl-n100 volumio-remote-updater[549]: [2025-05-25 09:03:31] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] May 25 09:03:31 smsl-n100 systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 25 09:03:31 smsl-n100 ntfs-3g[5708]: Unmounting /dev/sda2 (MUSIC BKUP) May 25 09:03:31 smsl-n100 systemd[1]: media-MUSIC_BKUP.mount: Succeeded. May 25 09:03:31 smsl-n100 systemd[1]: volumio.service: Failed with result 'exit-code'. May 25 09:03:31 smsl-n100 systemd[1]: Started dynamicswap service. May 25 09:03:31 smsl-n100 systemd[1]: dynamicswap.service: Succeeded. May 25 09:03:31 smsl-n100 systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 25 09:03:31 smsl-n100 systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. May 25 09:03:31 smsl-n100 systemd[1]: Started dynamicswap service. May 25 09:03:31 smsl-n100 systemd[1]: Stopped Volumio Backend Module. May 25 09:03:31 smsl-n100 systemd[1]: Started Volumio Backend Module. May 25 09:03:31 smsl-n100 systemd[1]: dynamicswap.service: Succeeded. May 25 09:03:35 smsl-n100 volumio[10038]: info: ------------------------------------------- May 25 09:03:35 smsl-n100 volumio[10038]: info: ----- Volumio3 ---- May 25 09:03:35 smsl-n100 volumio[10038]: info: ------------------------------------------- May 25 09:03:35 smsl-n100 volumio[10038]: info: ----- System startup ---- May 25 09:03:35 smsl-n100 volumio[10038]: info: ------------------------------------------- May 25 09:03:36 smsl-n100 volumio[10038]: info: MYVOLUMIO Environment detected May 25 09:03:36 smsl-n100 volumio[10038]: info: Plugin folders cleanup May 25 09:03:36 smsl-n100 volumio[10038]: info: Scanning into folder /volumio/app/plugins/ May 25 09:03:36 smsl-n100 volumio[10038]: info: Scanning category audio_interface May 25 09:03:36 smsl-n100 volumio[10038]: info: Scanning category miscellanea May 25 09:03:36 smsl-n100 volumio[10038]: info: Scanning category music_service May 25 09:03:36 smsl-n100 volumio[10038]: info: Scanning category plugins.json May 25 09:03:36 smsl-n100 volumio[10038]: info: Scanning category system_controller May 25 09:03:36 smsl-n100 volumio[10038]: info: Scanning category user_interface May 25 09:03:36 smsl-n100 volumio[10038]: info: Scanning into folder /data/plugins/ May 25 09:03:36 smsl-n100 volumio[10038]: info: Plugin folders cleanup completed May 25 09:03:36 smsl-n100 volumio[10038]: info: ------------------------------------------- May 25 09:03:36 smsl-n100 volumio-remote-updater[549]: [2025-05-25 09:03:36] [connect] Successful connection May 25 09:03:36 smsl-n100 volumio[10038]: info: ----- Core plugins startup ---- May 25 09:03:36 smsl-n100 volumio[10038]: info: ------------------------------------------- May 25 09:03:36 smsl-n100 volumio[10038]: info: Loading plugins from folder /volumio/app/plugins/ May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin bluetooth to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin multiroom to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin upnp to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin metavolumio to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin airplay_emulation to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin cd_controller to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin raat to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin smart_inputs to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin tidalconnect to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Adding plugin upnp_browser to MyMusic Plugins May 25 09:03:36 smsl-n100 volumio[10038]: info: Loading plugins from folder /data/plugins/ May 25 09:03:36 smsl-n100 volumio[10038]: info: Loading plugin "system"... May 25 09:03:36 smsl-n100 volumio[10038]: info: Loading plugin "appearance"... May 25 09:03:38 smsl-n100 volumio[10038]: info: Loading plugin "network"... May 25 09:03:38 smsl-n100 volumio[10038]: info: Refreshing Cached IP Addresses May 25 09:03:38 smsl-n100 sudo[10068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 09:03:38 smsl-n100 sudo[10068]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:38 smsl-n100 sudo[10068]: pam_unix(sudo:session): session closed for user root May 25 09:03:38 smsl-n100 volumio[10038]: info: Loading plugin "services"... May 25 09:03:38 smsl-n100 sudo[10070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 09:03:38 smsl-n100 sudo[10070]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:38 smsl-n100 volumio[10038]: info: Loading plugin "alsa_controller"... May 25 09:03:38 smsl-n100 sudo[10070]: pam_unix(sudo:session): session closed for user root May 25 09:03:38 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 09:03:38 smsl-n100 volumio[10038]: info: Loading plugin "wizard"... May 25 09:03:38 smsl-n100 volumio[10038]: info: Loading plugin "networkfs"... May 25 09:03:38 smsl-n100 volumio[10038]: info: Starting Udev Watcher for removable devices May 25 09:03:38 smsl-n100 volumio[10038]: info: Ignoring mount for partition: boot May 25 09:03:38 smsl-n100 volumio[10038]: info: Ignoring mount for partition: volumio May 25 09:03:38 smsl-n100 volumio[10038]: info: Ignoring mount for partition: volumio_data May 25 09:03:38 smsl-n100 volumio[10038]: error: Cannot associate FS Label, not mounting May 25 09:03:38 smsl-n100 volumio[10038]: info: Mounting Device MUSIC_BKUP May 25 09:03:38 smsl-n100 sudo[10094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/MUSIC_BKUP -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 25 09:03:38 smsl-n100 sudo[10094]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:43 smsl-n100 ntfs-3g[10097]: Version 2017.3.23AR.3 integrated FUSE 28 May 25 09:03:43 smsl-n100 ntfs-3g[10097]: Mounted /dev/sda2 (Read-Write, label "MUSIC BKUP", NTFS 3.1) May 25 09:03:43 smsl-n100 ntfs-3g[10097]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 May 25 09:03:43 smsl-n100 ntfs-3g[10097]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 May 25 09:03:43 smsl-n100 ntfs-3g[10097]: Global ownership and permissions enforced, configuration type 7 May 25 09:03:43 smsl-n100 sudo[10094]: pam_unix(sudo:session): session closed for user root May 25 09:03:43 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 09:03:43 smsl-n100 volumio[10038]: info: Loading plugin "volumio_command_line_client"... May 25 09:03:43 smsl-n100 volumio[10038]: info: Loading plugin "upnp"... May 25 09:03:43 smsl-n100 volumio[10038]: info: [1748135023660] Starting Upmpd Daemon May 25 09:03:43 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 09:03:43 smsl-n100 volumio[10038]: info: Loading plugin "my_music"... May 25 09:03:43 smsl-n100 volumio[10038]: info: Loading plugin "mpd"... May 25 09:03:44 smsl-n100 volumio[10038]: info: Loading plugin "upnp_browser"... May 25 09:03:44 smsl-n100 volumio[10038]: info: Loading plugin "bluetooth"... May 25 09:03:45 smsl-n100 volumio[10038]: info: [1748135025201] Starting BluetoothController May 25 09:03:45 smsl-n100 volumio[10038]: info: Loading plugin "alarm-clock"... May 25 09:03:45 smsl-n100 volumio[10038]: info: Loading plugin "manifestui"... May 25 09:03:45 smsl-n100 volumio[10038]: info: Loading plugin "metavolumio"... May 25 09:03:47 smsl-n100 volumio[10038]: info: Loading plugin "airplay_emulation"... May 25 09:03:47 smsl-n100 volumio[10038]: info: Starting Shairport Sync May 25 09:03:47 smsl-n100 volumio[10038]: info: Loading plugin "cd_controller"... May 25 09:03:48 smsl-n100 volumio[10038]: info: Loading plugin "last_100"... May 25 09:03:48 smsl-n100 volumio[10038]: info: Plugin raat is not enabled May 25 09:03:48 smsl-n100 volumio[10038]: info: Loading plugin "streaming_services"... May 25 09:03:49 smsl-n100 volumio-remote-updater[549]: [2025-05-25 09:03:49] [connect] Successful connection May 25 09:03:49 smsl-n100 volumio[10038]: info: Starting Streaming Service Transparent Proxy May 25 09:03:50 smsl-n100 volumio[10038]: info: Plugin tidalconnect is not enabled May 25 09:03:50 smsl-n100 volumio[10038]: info: Loading plugin "webradio"... May 25 09:03:50 smsl-n100 volumio[10038]: info: Loading plugin "i2s_dacs"... May 25 09:03:50 smsl-n100 volumio[10038]: info: I2S DAC not set, start Auto-detection May 25 09:03:50 smsl-n100 volumio[10038]: info: Loading plugin "volumiodiscovery"... May 25 09:03:50 smsl-n100 volumio[10038]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 09:03:50 smsl-n100 volumio[10038]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 09:03:50 smsl-n100 node[10038]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 09:03:50 smsl-n100 volumio[10038]: *** WARNING *** For more information see May 25 09:03:50 smsl-n100 volumio[10038]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 09:03:50 smsl-n100 volumio[10038]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 09:03:50 smsl-n100 volumio[10038]: *** WARNING *** For more information see May 25 09:03:50 smsl-n100 node[10038]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 09:03:50 smsl-n100 node[10038]: *** WARNING *** For more information see May 25 09:03:50 smsl-n100 node[10038]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 09:03:50 smsl-n100 node[10038]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 09:03:50 smsl-n100 node[10038]: *** WARNING *** For more information see May 25 09:03:50 smsl-n100 volumio[10038]: info: Applying required configuration parameters for plugin volumiodiscovery May 25 09:03:50 smsl-n100 volumio[10038]: info: Discovery: Started advertising with name: SMSL N100 May 25 09:03:50 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 09:03:50 smsl-n100 volumio[10038]: info: Loading plugin "multiroom"... May 25 09:03:52 smsl-n100 volumio[10038]: STREAMING PROXY: Starting server on port 3245 May 25 09:03:52 smsl-n100 volumio[10038]: Node JS runtime: 14 May 25 09:03:52 smsl-n100 volumio[10038]: info: Applying required configuration parameters for plugin multiroom May 25 09:03:52 smsl-n100 sudo[10165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom May 25 09:03:52 smsl-n100 sudo[10165]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:52 smsl-n100 sudo[10165]: pam_unix(sudo:session): session closed for user root May 25 09:03:53 smsl-n100 volumio[10038]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists May 25 09:03:53 smsl-n100 volumio[10038]: info: MRS: MultiRoom plugin initialized May 25 09:03:53 smsl-n100 volumio[10038]: info: MRS: STOPPING SNAPCLIENT May 25 09:03:53 smsl-n100 volumio[10038]: info: MRS: Snap server stop May 25 09:03:53 smsl-n100 sudo[10181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient May 25 09:03:53 smsl-n100 sudo[10181]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:53 smsl-n100 volumio[10038]: info: MRS: STOPPING volumioStreaming May 25 09:03:53 smsl-n100 sudo[10183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver May 25 09:03:53 smsl-n100 sudo[10183]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:53 smsl-n100 sudo[10181]: pam_unix(sudo:session): session closed for user root May 25 09:03:53 smsl-n100 sudo[10186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming May 25 09:03:53 smsl-n100 sudo[10186]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:53 smsl-n100 volumio[10038]: info: Loading plugin "outputs"... May 25 09:03:53 smsl-n100 volumio[10038]: info: Loading plugin "albumart"... May 25 09:03:53 smsl-n100 sudo[10189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 25 09:03:53 smsl-n100 sudo[10183]: pam_unix(sudo:session): session closed for user root May 25 09:03:53 smsl-n100 sudo[10189]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:03:53 smsl-n100 sudo[10189]: pam_unix(sudo:session): session closed for user root May 25 09:03:53 smsl-n100 volumio[10038]: info: Plugin example_plugin is not enabled May 25 09:03:53 smsl-n100 volumio[10038]: info: Loading plugin "hi_res_audio"... May 25 09:03:53 smsl-n100 sudo[10186]: pam_unix(sudo:session): session closed for user root May 25 09:03:54 smsl-n100 volumio[10038]: Forking 3 albumart workers May 25 09:03:56 smsl-n100 volumio[10038]: Starting albumart workers May 25 09:03:56 smsl-n100 volumio[10038]: Starting albumart workers May 25 09:03:56 smsl-n100 volumio[10038]: Starting albumart workers May 25 09:03:56 smsl-n100 volumio[10038]: info: Applying required configuration parameters for plugin hi_res_audio May 25 09:03:56 smsl-n100 volumio[10038]: info: Loading plugin "inputs"... May 25 09:03:57 smsl-n100 volumio[10038]: info: Loading plugin "qobuz"... May 25 09:03:59 smsl-n100 volumio[10038]: info: Loading plugin "smart_inputs"... May 25 09:03:59 smsl-n100 volumio[10038]: info: Loading plugin "tidal"... May 25 09:04:01 smsl-n100 volumio[10038]: info: Loading plugin "oem_helper"... May 25 09:04:03 smsl-n100 volumio[10038]: info: Applying required configuration parameters for plugin oem_helper May 25 09:04:03 smsl-n100 volumio[10038]: info: Loading plugin "smslcontrol"... May 25 09:04:03 smsl-n100 volumio[10038]: info: Adding this device properties May 25 09:04:03 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties May 25 09:04:03 smsl-n100 volumio[10038]: info: Setting Additional Device Volumio Properties: [object Object] May 25 09:04:03 smsl-n100 volumio[10038]: info: Loading plugin "updater_comm"... May 25 09:04:03 smsl-n100 volumio[10038]: info: Plugin mpdemulation is not enabled May 25 09:04:03 smsl-n100 volumio[10038]: info: Loading plugin "rest_api"... May 25 09:04:03 smsl-n100 volumio[10038]: info: Loading plugin "websocket"... May 25 09:04:03 smsl-n100 volumio[10038]: info: Starting Socket.io Server version 2.3.0 May 25 09:04:03 smsl-n100 volumio[10038]: info: Loading i18n strings for locale ja May 25 09:04:03 smsl-n100 volumio[10038]: Updating browse sources language May 25 09:04:03 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 09:04:04 smsl-n100 volumio-remote-updater[549]: [2025-05-25 09:04:04] [connect] Successful connection May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::initPlayerControls May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 09:04:04 smsl-n100 volumio[10038]: Express server listening on port 3000 May 25 09:04:04 smsl-n100 volumio[10038]: [Metrics] WebUI: 30s 307.41ms May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreStateMachine::resetVolumioState May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreStateMachine::getcurrentVolume May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioRetrievevolume May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:04 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:04 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 09:04:04 smsl-n100 sudo[10273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 09:04:04 smsl-n100 sudo[10273]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:04 smsl-n100 sudo[10273]: pam_unix(sudo:session): session closed for user root May 25 09:04:04 smsl-n100 sudo[10276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 09:04:04 smsl-n100 volumio[10038]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' May 25 09:04:04 smsl-n100 volumio[10038]: info: Completed loading Core Plugins May 25 09:04:04 smsl-n100 sudo[10276]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:04 smsl-n100 volumio[10038]: info: Preparing to generate the ALSA configuration file May 25 09:04:04 smsl-n100 sudo[10276]: pam_unix(sudo:session): session closed for user root May 25 09:04:04 smsl-n100 volumio[10038]: info: Volumio Network Manager: Network status updated: 1 May 25 09:04:04 smsl-n100 volumio[10038]: info: MRS: Removed streaming files May 25 09:04:04 smsl-n100 volumio[10038]: info: MRS: volumioStreaming STOPPED May 25 09:04:04 smsl-n100 volumio[10038]: info: MRS: SNAPSERVER STOPPED May 25 09:04:04 smsl-n100 volumio[10038]: info: MRS: SNAPCLIENT STOPPED May 25 09:04:04 smsl-n100 volumio[10038]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision May 25 09:04:04 smsl-n100 volumio[10038]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 25 09:04:04 smsl-n100 volumio[10038]: info: Reading ALSA contributions from plugins. May 25 09:04:04 smsl-n100 volumio[10038]: verbose: New Socket.io Connection to 192.168.0.100 from 192.168.0.102 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 1 May 25 09:04:04 smsl-n100 volumio[10038]: verbose: New Socket.io Connection to 192.168.0.100 from 192.168.0.102 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 2 May 25 09:04:05 smsl-n100 volumio[10038]: verbose: New Socket.io Connection to 192.168.0.100 from 192.168.0.102 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 3 May 25 09:04:05 smsl-n100 volumio[10038]: verbose: New Socket.io Connection to 192.168.0.100 from 192.168.0.102 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 4 May 25 09:04:05 smsl-n100 volumio-remote-updater[549]: [2025-05-25 09:04:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748135044 101 May 25 09:04:05 smsl-n100 volumio[10038]: 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: 5 May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 09:04:05 smsl-n100 volumio[10038]: info: Discovery: Getting this device information May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioGetState May 25 09:04:05 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 09:04:05 smsl-n100 volumio[10038]: info: Reloading queue from file May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreStateMachine::setRepeat true single undefined May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:05 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreStateMachine::setRandom null May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:05 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:05 smsl-n100 volumio[10038]: info: Setting Device type: NanoPi NEO 3 May 25 09:04:05 smsl-n100 volumio[10038]: verbose: New Socket.io Connection to 192.168.0.100 from 192.168.0.102 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 6 May 25 09:04:05 smsl-n100 sudo[10284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 25 09:04:05 smsl-n100 sudo[10284]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioGetState May 25 09:04:05 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 25 09:04:05 smsl-n100 volumio[10038]: info: Asound.conf file unchanged, so no further update is needed May 25 09:04:05 smsl-n100 sudo[10284]: pam_unix(sudo:session): session closed for user root May 25 09:04:05 smsl-n100 volumio[10038]: info: Output device has changed, restarting MPD May 25 09:04:05 smsl-n100 sudo[10287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 25 09:04:05 smsl-n100 sudo[10287]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:05 smsl-n100 sudo[10287]: pam_unix(sudo:session): session closed for user root May 25 09:04:05 smsl-n100 volumio[10038]: info: Output device has changed, restarting Shairport Sync May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 09:04:05 smsl-n100 sudo[10290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 25 09:04:05 smsl-n100 sudo[10290]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:05 smsl-n100 systemd[1]: Stopping Music Player Daemon... May 25 09:04:05 smsl-n100 volumio[10038]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 09:04:05 smsl-n100 volumio[10038]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 25 09:04:05 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:05 smsl-n100 systemd[1]: mpd.service: Succeeded. May 25 09:04:05 smsl-n100 systemd[1]: Stopped Music Player Daemon. May 25 09:04:05 smsl-n100 volumio[10038]: info: ___________ START PLUGINS ___________ May 25 09:04:05 smsl-n100 systemd[1]: Starting Music Player Daemon... May 25 09:04:05 smsl-n100 volumio[10038]: info: ControllerMpd::onStart: Initializing MPD May 25 09:04:05 smsl-n100 volumio[10038]: info: Creating MPD Configuration file May 25 09:04:05 smsl-n100 sudo[10300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 25 09:04:05 smsl-n100 sudo[10300]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:05 smsl-n100 sudo[10300]: pam_unix(sudo:session): session closed for user root May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 09:04:06 smsl-n100 volumio[10038]: info: [1748135046004] CoreMusicLibrary::Adding element DLNAサーバー May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 09:04:06 smsl-n100 sudo[10303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 25 09:04:06 smsl-n100 sudo[10303]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 09:04:06 smsl-n100 sudo[10297]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 25 09:04:06 smsl-n100 sudo[10297]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:06 smsl-n100 sudo[10297]: pam_unix(sudo:session): session closed for user root May 25 09:04:06 smsl-n100 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM May 25 09:04:06 smsl-n100 systemd[1]: mpd.service: Succeeded. May 25 09:04:06 smsl-n100 systemd[1]: Stopped Music Player Daemon. May 25 09:04:06 smsl-n100 systemd[1]: Starting Music Player Daemon... May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding METAVOLUMIO REST API Endpoints May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 09:04:06 smsl-n100 sudo[10306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name SMSL N100 May 25 09:04:06 smsl-n100 sudo[10306]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:06 smsl-n100 sudo[10306]: pam_unix(sudo:session): session closed for user root May 25 09:04:06 smsl-n100 volumio[10038]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 09:04:06 smsl-n100 sudo[10307]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 25 09:04:06 smsl-n100 sudo[10307]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:06 smsl-n100 sudo[10307]: pam_unix(sudo:session): session closed for user root May 25 09:04:06 smsl-n100 volumio[10038]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 09:04:06 smsl-n100 volumio[10038]: info: Preparing CD Folders May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding CD REST API Endpoints May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller May 25 09:04:06 smsl-n100 volumio[10038]: info: Starting UDEV Watcher for CD May 25 09:04:06 smsl-n100 volumio[10038]: info: Detecting CD presence with UDEV May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 09:04:06 smsl-n100 volumio[10038]: info: [1748135046422] CoreMusicLibrary::Adding element Last_100 May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 09:04:06 smsl-n100 volumio[10038]: info: Streaming services startup May 25 09:04:06 smsl-n100 volumio[10038]: info: Starting Streaming Daemon May 25 09:04:06 smsl-n100 sudo[10318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 25 09:04:06 smsl-n100 sudo[10318]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:06 smsl-n100 sudo[10318]: pam_unix(sudo:session): session closed for user root May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 09:04:06 smsl-n100 volumio[10038]: info: [1748135046587] CoreMusicLibrary::Adding element Webradio May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 09:04:06 smsl-n100 volumio[10038]: info: Initializing BBC Radios May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus May 25 09:04:06 smsl-n100 volumio[10038]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 25 09:04:06 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:06 smsl-n100 volumio[10038]: error: Hi Res Audio Failed Login: Missing Login Data May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding HIGHRESAUDIO REST API Endpoints May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio May 25 09:04:06 smsl-n100 volumio[10038]: info: Initializing Serial Communication on port /dev/ttyS1 May 25 09:04:06 smsl-n100 volumio[10038]: info: Touch Event Listener Process Starting May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding inputs REST Endpoints May 25 09:04:06 smsl-n100 volumio[10038]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs May 25 09:04:06 smsl-n100 volumio[10038]: info: Scanning Audio Inputs May 25 09:04:06 smsl-n100 sudo[10338]: pam_unix(sudo:auth): conversation failed May 25 09:04:06 smsl-n100 sudo[10338]: pam_unix(sudo:auth): auth could not identify password for [volumio] May 25 09:04:07 smsl-n100 volumio[10038]: info: Checking against Known Cards name May 25 09:04:07 smsl-n100 volumio[10038]: info: Adding Server instance for streaming May 25 09:04:07 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 09:04:07 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 09:04:07 smsl-n100 volumio[10038]: info: Initializing GPIOs May 25 09:04:07 smsl-n100 volumio[10038]: info: Starting Button Listener May 25 09:04:07 smsl-n100 volumio[10038]: info: Turning off Green LED May 25 09:04:07 smsl-n100 volumio[10038]: info: Tuning on Blue LED May 25 09:04:07 smsl-n100 volumio[10038]: info: Signaling System Ready May 25 09:04:07 smsl-n100 volumio[10038]: info: Volumio Calling Home May 25 09:04:07 smsl-n100 volumio[10038]: info: Stopping AccessToken refresher cron for QOBUZ May 25 09:04:07 smsl-n100 volumio[10038]: info: AccessToken refresher cron started for QOBUZ May 25 09:04:07 smsl-n100 volumio[10038]: info: Stopping AccessToken refresher cron May 25 09:04:07 smsl-n100 volumio[10038]: info: AccessToken refresher cron started May 25 09:04:07 smsl-n100 volumio[10038]: info: Adding TIDAL REST API Endpoints May 25 09:04:07 smsl-n100 volumio[10038]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal May 25 09:04:07 smsl-n100 volumio[10038]: info: Adding QOBUZ REST API Endpoints May 25 09:04:07 smsl-n100 volumio[10038]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz May 25 09:04:07 smsl-n100 volumio[10038]: info: Serial port opened successfully May 25 09:04:07 smsl-n100 volumio[10038]: info: Sending serial start messages May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: Reporting MCU Network Status: 1 May 25 09:04:08 smsl-n100 volumio[10038]: info: Touch Event Listener Process Closed May 25 09:04:08 smsl-n100 volumio[10038]: error: Cannot start Volumio Streaming Daemon May 25 09:04:08 smsl-n100 volumio[10038]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 25 09:04:08 smsl-n100 volumio[10038]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 25 09:04:08 smsl-n100 volumio[10038]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'SMSL N100' May 25 09:04:08 smsl-n100 volumio[10038]: Can't get device info: No such device May 25 09:04:08 smsl-n100 volumio[10038]: info: MPD Permissions set May 25 09:04:08 smsl-n100 volumio[10038]: info: MPD Permissions set May 25 09:04:08 smsl-n100 volumio[10038]: info: Upmpdcli Daemon Started May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride May 25 09:04:08 smsl-n100 volumio[10038]: info: Setting Device Volume Override May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 25 09:04:08 smsl-n100 volumio[10038]: info: Updating Volume Controller Parameters: Device: 5 Name: XU208 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 25 09:04:08 smsl-n100 volumio[10038]: info: Disabling external Volume Control May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:08 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: MAXVOL, message: May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:08 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:08 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: MAXVOL, message: May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:08 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: MAXVOL, message: May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 1, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 25 09:04:08 smsl-n100 volumio[10038]: info: Volumio called home May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:08 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:08 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: MAXVOL, message: May 25 09:04:08 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:08 smsl-n100 volumio[10038]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 25 09:04:09 smsl-n100 volumio[10038]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 09:04:09 smsl-n100 sudo[10385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service May 25 09:04:09 smsl-n100 sudo[10385]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:09 smsl-n100 sudo[10385]: pam_unix(sudo:session): session closed for user root May 25 09:04:09 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 25 09:04:09 smsl-n100 systemd[1]: mpd.service: Failed with result 'protocol'. May 25 09:04:09 smsl-n100 systemd[1]: Failed to start Music Player Daemon. May 25 09:04:09 smsl-n100 volumio[10038]: info: Starting Shairport Sync May 25 09:04:09 smsl-n100 sudo[10303]: pam_unix(sudo:session): session closed for user root May 25 09:04:09 smsl-n100 sudo[10290]: pam_unix(sudo:session): session closed for user root May 25 09:04:09 smsl-n100 systemd[1]: Starting Music Player Daemon... May 25 09:04:09 smsl-n100 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM May 25 09:04:09 smsl-n100 systemd[1]: mpd.service: Succeeded. May 25 09:04:09 smsl-n100 volumio[10038]: info: Starting Shairport Sync May 25 09:04:09 smsl-n100 systemd[1]: Stopped Music Player Daemon. May 25 09:04:09 smsl-n100 systemd[1]: Starting Music Player Daemon... May 25 09:04:09 smsl-n100 sudo[10392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 09:04:09 smsl-n100 sudo[10392]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:09 smsl-n100 volumio[10038]: info: Starting Shairport Sync May 25 09:04:09 smsl-n100 sudo[10396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 09:04:09 smsl-n100 sudo[10396]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:09 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 25 09:04:09 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. May 25 09:04:09 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 25 09:04:09 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:09 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:09 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:09 smsl-n100 sudo[10399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 09:04:09 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:09 smsl-n100 sudo[10399]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:09 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: MAXVOL, message: May 25 09:04:09 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:09 smsl-n100 volumio[10038]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 25 09:04:09 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:09 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:09 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:09 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:09 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: MAXVOL, message: May 25 09:04:09 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:09 smsl-n100 volumio[10038]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 25 09:04:09 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 25 09:04:09 smsl-n100 sudo[10396]: pam_unix(sudo:session): session closed for user root May 25 09:04:09 smsl-n100 sudo[10392]: pam_unix(sudo:session): session closed for user root May 25 09:04:09 smsl-n100 sudo[10393]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 25 09:04:09 smsl-n100 sudo[10393]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 09:04:09 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 25 09:04:09 smsl-n100 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM May 25 09:04:09 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. May 25 09:04:09 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 25 09:04:09 smsl-n100 sudo[10393]: pam_unix(sudo:session): session closed for user root May 25 09:04:09 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 25 09:04:09 smsl-n100 sudo[10399]: pam_unix(sudo:session): session closed for user root May 25 09:04:09 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioGetState May 25 09:04:09 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:09 smsl-n100 volumio[10038]: info: Volumio BT Module successfully started May 25 09:04:10 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioGetState May 25 09:04:10 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:10 smsl-n100 volumio[10038]: info: Shairport-Sync Started May 25 09:04:10 smsl-n100 volumio[10038]: Error adding Membership: Error: addMembership EINVAL May 25 09:04:10 smsl-n100 volumio[10038]: info: Shairport-Sync Started May 25 09:04:10 smsl-n100 volumio[10038]: info: Shairport-Sync Started May 25 09:04:10 smsl-n100 volumio[10038]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service May 25 09:04:10 smsl-n100 volumio[10038]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. May 25 09:04:10 smsl-n100 volumio[10038]: See "systemctl status mpd.service" and "journalctl -xe" for details. May 25 09:04:10 smsl-n100 volumio[10038]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service May 25 09:04:10 smsl-n100 volumio[10038]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. May 25 09:04:10 smsl-n100 volumio[10038]: See "systemctl status mpd.service" and "journalctl -xe" for details. May 25 09:04:10 smsl-n100 volumio[10038]: info: Completed starting Core Plugins May 25 09:04:10 smsl-n100 volumio[10038]: info: ------------------------------------------- May 25 09:04:10 smsl-n100 volumio[10038]: info: ----- MyVolumio plugins startup ---- May 25 09:04:10 smsl-n100 volumio[10038]: info: ------------------------------------------- May 25 09:04:10 smsl-n100 volumio[10038]: info: [MyVolumio PluginManager] Fetching plans data.... May 25 09:04:10 smsl-n100 volumio[10038]: info: CoreStateMachine::pushState May 25 09:04:10 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:10 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioPushState May 25 09:04:10 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:10 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: MAXVOL, message: May 25 09:04:10 smsl-n100 volumio[10038]: error: Serial API: Failed to decode command: 100, message: undefined May 25 09:04:10 smsl-n100 volumio[10038]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 25 09:04:10 smsl-n100 volumio[10038]: info: Discovery: adding 86a95ab1-cc29-4683-a5de-ac9dc889ffe0 May 25 09:04:10 smsl-n100 volumio[10038]: info: Discovery: Found device SMSL N100 May 25 09:04:10 smsl-n100 volumio[10038]: info: CoreCommandRouter::volumioGetState May 25 09:04:10 smsl-n100 volumio[10038]: info: CorePlayQueue::getTrack 0 May 25 09:04:10 smsl-n100 volumio[10038]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 09:04:10 smsl-n100 volumio[10038]: Error: The value NaN is not a number May 25 09:04:10 smsl-n100 volumio[10038]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) May 25 09:04:10 smsl-n100 volumio[10038]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) May 25 09:04:10 smsl-n100 volumio[10038]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) May 25 09:04:10 smsl-n100 volumio[10038]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) May 25 09:04:10 smsl-n100 volumio[10038]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) May 25 09:04:10 smsl-n100 volumio[10038]: at Browser.emit (events.js:400:28) May 25 09:04:10 smsl-n100 volumio[10038]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) May 25 09:04:10 smsl-n100 volumio[10038]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) May 25 09:04:10 smsl-n100 volumio[10038]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) May 25 09:04:10 smsl-n100 volumio[10038]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) May 25 09:04:10 smsl-n100 volumio[10038]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 May 25 09:04:10 smsl-n100 volumio[10038]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) May 25 09:04:10 smsl-n100 volumio[10038]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) May 25 09:04:10 smsl-n100 volumio[10038]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 09:04:11 smsl-n100 sudo[10418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 09:03 May 25 09:04:11 smsl-n100 sudo[10418]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"