-- Logs begin at Wed 2025-07-09 14:30:34 UTC, end at Wed 2025-07-09 14:51:06 UTC. -- Jul 09 14:50:00 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:50:00 volumio volumio[1032]: info: CURURI: music-library/INTERNAL Jul 09 14:50:00 volumio volumio[1032]: info: Preload queue cleared Jul 09 14:50:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:50:04 volumio volumio[1032]: info: CURURI: music-library Jul 09 14:50:04 volumio volumio[1032]: info: Preload queue cleared Jul 09 14:50:05 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:50:05 volumio volumio[1032]: info: CURURI: music-library/USB Jul 09 14:50:05 volumio volumio[1032]: info: Preload queue cleared Jul 09 14:50:06 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:50:06 volumio volumio[1032]: info: CURURI: music-library/USB/500g Jul 09 14:50:06 volumio volumio[1032]: info: Preload queue cleared Jul 09 14:50:06 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:50:06 volumio volumio[1032]: info: CURURI: music-library/USB/500g/mp3 Jul 09 14:50:06 volumio volumio[1032]: info: Preload queue cleared Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/亲爱的你啊 (伴奏).flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/亲爱的你啊.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/人无信则不立-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/佘詩曼 - 風車.mp3 Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/冠必正，纽必结-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/四月物语.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/宝藏-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/春日信笺-司南.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/春日信笺（伴奏）-司南.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/杭州地铁-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/水的欢愉-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/薄荷绿-逆时针向.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/西虹市-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/谈情说爱.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/雨林的故事-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/风车 (钢琴翻唱)（翻自 佘诗曼）.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/风车-钢琴.mp4 Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/李焕英笑了-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/咱们村里的送货郎Ⅰ-《我和我的家乡》之《神笔马亮》电影配乐-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/西虹市里的送货郎-彭飞.flac Jul 09 14:50:06 volumio volumio[1032]: info: Preloading song: music-library/USB/500g/mp3/風車 (劇集「宮心計」片尾曲) - Charmaine Sheh 佘詩曼.mp3 Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/亲爱的你啊 (伴奏).flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E4%BB%BB%E7%B4%A0%E6%B1%90//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E4%BA%B2%E7%88%B1%E7%9A%84%E4%BD%A0%E5%95%8A%20(%E4%BC%B4%E5%A5%8F).flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/亲爱的你啊 (伴奏).flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/亲爱的你啊.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E4%BB%BB%E7%B4%A0%E6%B1%90//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E4%BA%B2%E7%88%B1%E7%9A%84%E4%BD%A0%E5%95%8A.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/亲爱的你啊.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/人无信则不立-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E4%BA%BA%E6%97%A0%E4%BF%A1%E5%88%99%E4%B8%8D%E7%AB%8B-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/人无信则不立-彭飞.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/佘詩曼 - 風車.mp3 in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E4%BD%98%E8%A9%A9%E6%9B%BC%20-%20%E9%A2%A8%E8%BB%8A.mp3&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/佘詩曼 - 風車.mp3 Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/冠必正，纽必结-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E5%86%A0%E5%BF%85%E6%AD%A3%EF%BC%8C%E7%BA%BD%E5%BF%85%E7%BB%93-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/冠必正，纽必结-彭飞.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/四月物语.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E6%9E%97%E5%AE%B6%E8%AC%99//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E5%9B%9B%E6%9C%88%E7%89%A9%E8%AF%AD.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/四月物语.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/宝藏-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E5%AE%9D%E8%97%8F-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/宝藏-彭飞.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/春日信笺-司南.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E6%98%A5%E6%97%A5%E4%BF%A1%E7%AC%BA-%E5%8F%B8%E5%8D%97.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/春日信笺-司南.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/春日信笺（伴奏）-司南.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E6%98%A5%E6%97%A5%E4%BF%A1%E7%AC%BA%EF%BC%88%E4%BC%B4%E5%A5%8F%EF%BC%89-%E5%8F%B8%E5%8D%97.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/春日信笺（伴奏）-司南.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/杭州地铁-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E6%9D%AD%E5%B7%9E%E5%9C%B0%E9%93%81-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/杭州地铁-彭飞.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/水的欢愉-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E6%B0%B4%E7%9A%84%E6%AC%A2%E6%84%89-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/水的欢愉-彭飞.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/薄荷绿-逆时针向.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E8%96%84%E8%8D%B7%E7%BB%BF-%E9%80%86%E6%97%B6%E9%92%88%E5%90%91.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/薄荷绿-逆时针向.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/西虹市-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E8%A5%BF%E8%99%B9%E5%B8%82-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/西虹市-彭飞.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/谈情说爱.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E9%83%91%E7%A7%80%E6%96%87//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E8%B0%88%E6%83%85%E8%AF%B4%E7%88%B1.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/谈情说爱.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/雨林的故事-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E9%9B%A8%E6%9E%97%E7%9A%84%E6%95%85%E4%BA%8B-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/雨林的故事-彭飞.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/风车 (钢琴翻唱)（翻自 佘诗曼）.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E9%A3%8E%E8%BD%A6%20(%E9%92%A2%E7%90%B4%E7%BF%BB%E5%94%B1)%EF%BC%88%E7%BF%BB%E8%87%AA%20%E4%BD%98%E8%AF%97%E6%9B%BC%EF%BC%89.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/风车 (钢琴翻唱)（翻自 佘诗曼）.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/风车-钢琴.mp4 in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=//extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E9%A3%8E%E8%BD%A6-%E9%92%A2%E7%90%B4.mp4&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/风车-钢琴.mp4 Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/李焕英笑了-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E/%E4%BD%A0%E5%A5%BD%EF%BC%8C%E6%9D%8E%E7%84%95%E8%8B%B1%20%E7%94%B5%E5%BD%B1%E5%8E%9F%E5%A3%B0%E5%A4%A7%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E6%9D%8E%E7%84%95%E8%8B%B1%E7%AC%91%E4%BA%86-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/李焕英笑了-彭飞.flac Jul 09 14:50:07 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/咱们村里的送货郎Ⅰ-《我和我的家乡》之《神笔马亮》电影配乐-彭飞.flac in service mpd Jul 09 14:50:07 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E/%E6%88%91%E5%92%8C%E6%88%91%E7%9A%84%E5%AE%B6%E4%B9%A1%20%E7%94%B5%E5%BD%B1%E5%8E%9F%E5%A3%B0%E5%A4%A7%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E5%92%B1%E4%BB%AC%E6%9D%91%E9%87%8C%E7%9A%84%E9%80%81%E8%B4%A7%E9%83%8E%E2%85%A0-%E3%80%8A%E6%88%91%E5%92%8C%E6%88%91%E7%9A%84%E5%AE%B6%E4%B9%A1%E3%80%8B%E4%B9%8B%E3%80%8A%E7%A5%9E%E7%AC%94%E9%A9%AC%E4%BA%AE%E3%80%8B%E7%94%B5%E5%BD%B1%E9%85%8D%E4%B9%90-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:07 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/咱们村里的送货郎Ⅰ-《我和我的家乡》之《神笔马亮》电影配乐-彭飞.flac Jul 09 14:50:08 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/西虹市里的送货郎-彭飞.flac in service mpd Jul 09 14:50:08 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=%E5%BD%AD%E9%A3%9E/%E6%8A%93%E5%A8%83%E5%A8%83%20%E7%94%B5%E5%BD%B1%E5%8E%9F%E5%A3%B0%E4%B8%93%E8%BE%91/extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E8%A5%BF%E8%99%B9%E5%B8%82%E9%87%8C%E7%9A%84%E9%80%81%E8%B4%A7%E9%83%8E-%E5%BD%AD%E9%A3%9E.flac&metadata=false Jul 09 14:50:08 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/西虹市里的送货郎-彭飞.flac Jul 09 14:50:08 volumio volumio[1032]: info: Exploding uri music-library/USB/500g/mp3/風車 (劇集「宮心計」片尾曲) - Charmaine Sheh 佘詩曼.mp3 in service mpd Jul 09 14:50:08 volumio volumio[1032]: info: ALBUMART /albumart?cacheid=955&web=Charmaine%20Sheh%20%E4%BD%98%E8%A9%A9%E6%9B%BC/%E9%A2%A8%E8%BB%8A%20(%E5%8A%87%E9%9B%86%E3%80%8C%E5%AE%AE%E5%BF%83%E8%A8%88%E3%80%8D%E7%89%87%E5%B0%BE%E6%9B%B2)/extralarge&path=%2Fmnt%2FUSB%2F500g%2Fmp3%2F%E9%A2%A8%E8%BB%8A%20(%E5%8A%87%E9%9B%86%E3%80%8C%E5%AE%AE%E5%BF%83%E8%A8%88%E3%80%8D%E7%89%87%E5%B0%BE%E6%9B%B2)%20-%20Charmaine%20Sheh%20%E4%BD%98%E8%A9%A9%E6%9B%BC.mp3&metadata=false Jul 09 14:50:08 volumio volumio[1032]: info: URI /mnt/USB/500g/mp3/風車 (劇集「宮心計」片尾曲) - Charmaine Sheh 佘詩曼.mp3 Jul 09 14:50:20 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:20 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:24 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:24 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:27 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 09 14:50:27 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 09 14:50:31 volumio volumio[1032]: info: Enabling plugin fusiondsp Jul 09 14:50:31 volumio volumio[1032]: info: Loading plugin "fusiondsp"... Jul 09 14:50:31 volumio volumio[1032]: info: Preparing to generate the ALSA configuration file Jul 09 14:50:31 volumio volumio[1032]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:50:31 volumio volumio[1032]: info: Reading ALSA contributions from plugins. Jul 09 14:50:31 volumio volumio[1032]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:50:31 volumio volumio[1032]: info: Output device has changed, restarting MPD Jul 09 14:50:31 volumio sudo[6187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:31 volumio sudo[6187]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:31 volumio sudo[6187]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:31 volumio volumio[1032]: info: Output device has changed, restarting Shairport Sync Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:31 volumio sudo[6191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:31 volumio sudo[6191]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:31 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 14:50:31 volumio volumio[1032]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:31 volumio volumio[1032]: info: PLUGIN START: fusiondsp Jul 09 14:50:31 volumio volumio[1032]: info: Loading i18n strings for locale zh Jul 09 14:50:31 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:31 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:31 volumio volumio[1032]: info: Plugin fusiondsp has duplicated i18n key SAVE. It is ignored. Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: FusionDsp - mixtype--------------------- Software Jul 09 14:50:31 volumio volumio[1032]: info: Preparing to generate the ALSA configuration file Jul 09 14:50:31 volumio volumio[1032]: info: Done. Jul 09 14:50:31 volumio volumio[1032]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:50:31 volumio volumio[1032]: info: Reading ALSA contributions from plugins. Jul 09 14:50:31 volumio volumio[1032]: info: MPD Permissions set Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: Starting Shairport Sync Jul 09 14:50:31 volumio sudo[6196]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:50:31 volumio sudo[6196]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:31 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::volumioPause Jul 09 14:50:31 volumio volumio[1032]: info: CoreStateMachine::pause Jul 09 14:50:31 volumio volumio[1032]: info: mpdhttpout --- Volumio set on pause Jul 09 14:50:31 volumio volumio[1032]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Jul 09 14:50:31 volumio volumio[1032]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:50:31 volumio volumio[1032]: info: Output device has changed, restarting MPD Jul 09 14:50:31 volumio sudo[6196]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:31 volumio sudo[6204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:31 volumio sudo[6204]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:31 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:31 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:31 volumio sudo[6209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:31 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:31 volumio sudo[6209]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:31 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:31 volumio sudo[6209]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:31 volumio sudo[6204]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:31 volumio volumio[1032]: info: Output device has changed, restarting Shairport Sync Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:31 volumio sudo[6213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:31 volumio sudo[6213]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:31 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 09 14:50:31 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:31 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:31 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:31 volumio volumio[1032]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:31 volumio volumio[1032]: info: MPD Permissions set Jul 09 14:50:31 volumio volumio[1032]: info: Shairport-Sync Started Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:31 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:31 volumio volumio[1032]: info: Starting Shairport Sync Jul 09 14:50:31 volumio sudo[6220]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:50:31 volumio sudo[6220]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:31 volumio sudo[6220]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:31 volumio sudo[6230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:31 volumio sudo[6230]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:31 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:31 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:31 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:31 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:31 volumio sudo[6230]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:31 volumio volumio[1032]: info: Shairport-Sync Started Jul 09 14:50:32 volumio mpd[6229]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 14:50:32 volumio mpd[6229]: output: No 'audio_output' defined in config file Jul 09 14:50:32 volumio volumio[1032]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Jul 09 14:50:32 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:32 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:32 volumio volumio[1032]: info: CoreCommandRouter::volumioPause Jul 09 14:50:32 volumio volumio[1032]: info: CoreStateMachine::pause Jul 09 14:50:32 volumio volumio[1032]: info: mpdhttpout --- Volumio set on pause Jul 09 14:50:32 volumio mpd[6229]: output: Successfully detected a sndio audio device Jul 09 14:50:32 volumio mpd[6229]: zeroconf: No global port, disabling zeroconf Jul 09 14:50:32 volumio systemd[1]: Started Music Player Daemon. Jul 09 14:50:32 volumio sudo[6213]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:32 volumio sudo[6191]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:32 volumio volumio[1032]: error: MPD error: The expression evaluated to a falsy value: Jul 09 14:50:32 volumio volumio[1032]: assert.ok(self.idling) Jul 09 14:50:32 volumio volumio[1032]: error: The expression evaluated to a falsy value: Jul 09 14:50:32 volumio volumio[1032]: assert.ok(self.idling) Jul 09 14:50:32 volumio volumio[1032]: error: updateQueue error: null Jul 09 14:50:33 volumio volumio[1032]: info: camilladsp service started and running in background, instance 1 Jul 09 14:50:33 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:33 volumio volumio[1032]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 09 14:50:33 volumio volumio[1032]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 09 14:50:33 volumio volumio[1032]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 09 14:50:33 volumio volumio[1032]: info: FusionDsp loaded Jul 09 14:50:33 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:33 volumio sudo[6262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 09 14:50:33 volumio sudo[6262]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:33 volumio volumio[1032]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 09 14:50:33 volumio volumio[1032]: info: Adding Signal Path Element [object Object] Jul 09 14:50:33 volumio volumio[1032]: info: Adding fusiondspeq DSP Signal Path Element Jul 09 14:50:33 volumio volumio[1032]: info: FusionDsp - ---- installed callbackRead Jul 09 14:50:33 volumio volumio[1032]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:50:33 volumio sudo[6262]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:33 volumio volumio[1032]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 09 14:50:33 volumio volumio[1032]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jul 09 14:50:33 volumio volumio[1032]: at onErrorNT (internal/child_process.js:472:16) Jul 09 14:50:33 volumio volumio[1032]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jul 09 14:50:33 volumio volumio[1032]: at runNextTicks (internal/process/task_queues.js:64:3) Jul 09 14:50:33 volumio volumio[1032]: at listOnTimeout (internal/timers.js:526:9) Jul 09 14:50:33 volumio volumio[1032]: at processTimers (internal/timers.js:500:7) { Jul 09 14:50:33 volumio volumio[1032]: errno: -2, Jul 09 14:50:33 volumio volumio[1032]: code: 'ENOENT', Jul 09 14:50:33 volumio volumio[1032]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 09 14:50:33 volumio volumio[1032]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 09 14:50:33 volumio volumio[1032]: spawnargs: [ Jul 09 14:50:33 volumio volumio[1032]: '-p', Jul 09 14:50:33 volumio volumio[1032]: 9876, Jul 09 14:50:33 volumio volumio[1032]: '-o', Jul 09 14:50:33 volumio volumio[1032]: '/tmp/camilladsp.log', Jul 09 14:50:33 volumio volumio[1032]: '-l', Jul 09 14:50:33 volumio volumio[1032]: 'warn', Jul 09 14:50:33 volumio volumio[1032]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 09 14:50:33 volumio volumio[1032]: ] Jul 09 14:50:33 volumio volumio[1032]: } Jul 09 14:50:33 volumio volumio[1032]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:50:33 volumio sudo[6273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 14:49 Jul 09 14:50:33 volumio sudo[6273]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:33 volumio sudo[6273]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:34 volumio volumio-remote-updater[761]: [2025-07-09 14:50:34] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 09 14:50:34 volumio volumio-remote-updater[761]: [2025-07-09 14:50:34] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 09 14:50:34 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 09 14:50:34 volumio sudo[5140]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:34 volumio sudo[5114]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:34 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 09 14:50:34 volumio systemd[1]: Started dynamicswap service. Jul 09 14:50:34 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 09 14:50:35 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 09 14:50:35 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jul 09 14:50:35 volumio systemd[1]: Started dynamicswap service. Jul 09 14:50:35 volumio systemd[1]: Stopped Volumio Backend Module. Jul 09 14:50:35 volumio systemd[1]: Started Volumio Backend Module. Jul 09 14:50:35 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 09 14:50:35 volumio volumio[6287]: info: ------------------------------------------- Jul 09 14:50:35 volumio volumio[6287]: info: ----- Volumio3 ---- Jul 09 14:50:35 volumio volumio[6287]: info: ------------------------------------------- Jul 09 14:50:35 volumio volumio[6287]: info: ----- System startup ---- Jul 09 14:50:35 volumio volumio[6287]: info: ------------------------------------------- Jul 09 14:50:35 volumio volumio[6287]: info: MYVOLUMIO Environment detected Jul 09 14:50:35 volumio volumio[6287]: info: Plugin folders cleanup Jul 09 14:50:35 volumio volumio[6287]: info: Scanning into folder /volumio/app/plugins/ Jul 09 14:50:35 volumio volumio[6287]: info: Scanning category audio_interface Jul 09 14:50:35 volumio volumio[6287]: info: Scanning category miscellanea Jul 09 14:50:35 volumio volumio[6287]: info: Scanning category music_service Jul 09 14:50:35 volumio volumio[6287]: info: Scanning category plugins.json Jul 09 14:50:35 volumio volumio[6287]: info: Scanning category system_controller Jul 09 14:50:35 volumio volumio[6287]: info: Scanning category user_interface Jul 09 14:50:35 volumio volumio[6287]: info: Scanning into folder /data/plugins/ Jul 09 14:50:35 volumio volumio[6287]: info: Scanning category audio_interface Jul 09 14:50:35 volumio volumio[6287]: info: Plugin folders cleanup completed Jul 09 14:50:35 volumio volumio[6287]: info: ------------------------------------------- Jul 09 14:50:35 volumio volumio[6287]: info: ----- Core plugins startup ---- Jul 09 14:50:35 volumio volumio[6287]: info: ------------------------------------------- Jul 09 14:50:35 volumio volumio[6287]: info: Loading plugins from folder /volumio/app/plugins/ Jul 09 14:50:35 volumio volumio[6287]: info: Adding plugin upnp to MyMusic Plugins Jul 09 14:50:35 volumio volumio[6287]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 09 14:50:35 volumio volumio[6287]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 09 14:50:35 volumio volumio[6287]: info: Loading plugins from folder /data/plugins/ Jul 09 14:50:35 volumio volumio[6287]: info: Loading plugin "system"... Jul 09 14:50:35 volumio volumio[6287]: info: Loading plugin "appearance"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "network"... Jul 09 14:50:36 volumio volumio[6287]: info: Refreshing Cached IP Addresses Jul 09 14:50:36 volumio sudo[6313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 09 14:50:36 volumio sudo[6313]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:36 volumio sudo[6313]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:36 volumio sudo[6315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 09 14:50:36 volumio sudo[6315]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "services"... Jul 09 14:50:36 volumio sudo[6315]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "alsa_controller"... Jul 09 14:50:36 volumio sudo[6329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 09 14:50:36 volumio sudo[6329]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:36 volumio sudo[6329]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:36 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "wizard"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "networkfs"... Jul 09 14:50:36 volumio volumio[6287]: info: Starting Udev Watcher for removable devices Jul 09 14:50:36 volumio volumio[6287]: info: Ignoring mount for partition: boot Jul 09 14:50:36 volumio volumio[6287]: info: Ignoring mount for partition: volumio Jul 09 14:50:36 volumio volumio[6287]: info: Ignoring mount for partition: volumio_data Jul 09 14:50:36 volumio volumio[6287]: info: Ignoring mount for partition: 8681-4968 Jul 09 14:50:36 volumio volumio[6287]: info: Ignoring mount for partition: 918d12b7-0ace-4ac3-9a4a-a3e01a26afde Jul 09 14:50:36 volumio volumio[6287]: info: Ignoring mount for partition: 21CC-5DD5 Jul 09 14:50:36 volumio volumio[6287]: info: Ignoring mount for partition: 500g Jul 09 14:50:36 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "volumio_command_line_client"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "upnp"... Jul 09 14:50:36 volumio volumio[6287]: info: [1752072636346] Starting Upmpd Daemon Jul 09 14:50:36 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "my_music"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "mpd"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "upnp_browser"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "alarm-clock"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "airplay_emulation"... Jul 09 14:50:36 volumio volumio[6287]: info: Starting Shairport Sync Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "last_100"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "webradio"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "i2s_dacs"... Jul 09 14:50:36 volumio volumio[6287]: info: I2S DAC not set, start Auto-detection Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "volumiodiscovery"... Jul 09 14:50:36 volumio volumio[6287]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:36 volumio volumio[6287]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:36 volumio volumio[6287]: *** WARNING *** For more information see Jul 09 14:50:36 volumio volumio[6287]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:36 volumio volumio[6287]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:36 volumio node[6287]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:36 volumio volumio[6287]: *** WARNING *** For more information see Jul 09 14:50:36 volumio node[6287]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:36 volumio node[6287]: *** WARNING *** For more information see Jul 09 14:50:36 volumio node[6287]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:36 volumio node[6287]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:36 volumio node[6287]: *** WARNING *** For more information see Jul 09 14:50:36 volumio volumio[6287]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 09 14:50:36 volumio volumio[6287]: info: Discovery: Started advertising with name: Volumio Jul 09 14:50:36 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "outputs"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "albumart"... Jul 09 14:50:36 volumio volumio[6287]: info: Plugin example_plugin is not enabled Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "inputs"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "updater_comm"... Jul 09 14:50:36 volumio volumio[6287]: info: Plugin mpdemulation is not enabled Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "rest_api"... Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "websocket"... Jul 09 14:50:36 volumio volumio[6287]: Forking 3 albumart workers Jul 09 14:50:36 volumio volumio[6287]: info: Starting Socket.io Server version 2.3.0 Jul 09 14:50:36 volumio volumio[6287]: info: Loading plugin "fusiondsp"... Jul 09 14:50:36 volumio volumio[6287]: info: Applying required configuration parameters for plugin fusiondsp Jul 09 14:50:37 volumio volumio[6287]: info: Loading plugin "mpdoutput"... Jul 09 14:50:37 volumio volumio[6287]: Starting albumart workers Jul 09 14:50:37 volumio volumio[6287]: Starting albumart workers Jul 09 14:50:37 volumio volumio[6287]: Starting albumart workers Jul 09 14:50:37 volumio volumio[6287]: info: Loading i18n strings for locale zh Jul 09 14:50:37 volumio volumio[6287]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jul 09 14:50:37 volumio volumio[6287]: Updating browse sources language Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::initPlayerControls Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: Express server listening on port 3000 Jul 09 14:50:37 volumio volumio[6287]: [Metrics] WebUI: 1s 858.30ms Jul 09 14:50:37 volumio volumio[6287]: info: Setting Device type: x86 Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::resetVolumioState Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::getcurrentVolume Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 09 14:50:37 volumio volumio[6287]: info: Completed loading Core Plugins Jul 09 14:50:37 volumio volumio[6287]: info: Preparing to generate the ALSA configuration file Jul 09 14:50:37 volumio volumio[6287]: info: Volumio Network Manager: Network status updated: 1 Jul 09 14:50:37 volumio volumio[6287]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 09 14:50:37 volumio volumio[6287]: wlan0 Interface doesn't support scanning. Jul 09 14:50:37 volumio volumio[6287]: info: Cannot use regular scanning, forcing with ap-force Jul 09 14:50:37 volumio sudo[6407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 09 14:50:37 volumio sudo[6407]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:37 volumio sudo[6407]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:37 volumio volumio[6287]: command failed: No such device (-19) Jul 09 14:50:37 volumio volumio[6287]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 09 14:50:37 volumio volumio[6287]: command failed: No such device (-19) Jul 09 14:50:37 volumio volumio[6287]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jul 09 14:50:37 volumio volumio[6287]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:50:37 volumio volumio[6287]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 09 14:50:37 volumio volumio[6287]: info: Reading ALSA contributions from plugins. Jul 09 14:50:37 volumio volumio[6287]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 09 14:50:37 volumio volumio[6287]: verbose: New Socket.io Connection to 192.168.5.243 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::pushState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::updateTrackBlock Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrackBlock Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 14:50:37 volumio volumio[6287]: info: Reloading queue from file Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::setRepeat null single undefined Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::pushState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::setRandom null Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::pushState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:50:37 volumio volumio[6287]: info: Received Get System Info Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 14:50:37 volumio volumio[6287]: info: Discovery: Getting this device information Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: Listing playlists Jul 09 14:50:37 volumio volumio[6287]: info: CoreStateMachine::pushState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:37 volumio volumio[6287]: info: Discovery: adding 7f240d10-6ef4-45a3-bdfd-00652d7bf104 Jul 09 14:50:37 volumio volumio[6287]: info: Discovery: Found device Volumio Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:37 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:37 volumio volumio[6287]: info: Asound.conf file written Jul 09 14:50:37 volumio sudo[6431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 09 14:50:37 volumio sudo[6431]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:37 volumio sudo[6431]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:37 volumio volumio[6287]: Found hardware: "ICE1712" "ICE1712 - multitrack" "" "0x153b" "0x1138" Jul 09 14:50:37 volumio volumio[6287]: Hardware is initialized using a generic method Jul 09 14:50:37 volumio volumio[6287]: info: Output device has changed, restarting MPD Jul 09 14:50:37 volumio sudo[6436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:37 volumio sudo[6436]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:37 volumio sudo[6436]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:37 volumio volumio[6287]: info: Output device has changed, restarting Shairport Sync Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:37 volumio sudo[6439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:37 volumio sudo[6439]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:37 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 14:50:37 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:37 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:37 volumio volumio[6287]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:37 volumio volumio[6287]: info: ___________ START PLUGINS ___________ Jul 09 14:50:37 volumio volumio[6287]: info: ControllerMpd::onStart: Initializing MPD Jul 09 14:50:37 volumio volumio[6287]: info: Creating MPD Configuration file Jul 09 14:50:37 volumio sudo[6446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:37 volumio sudo[6446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:37 volumio sudo[6446]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:37 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:37 volumio volumio[6287]: info: [1752072637663] CoreMusicLibrary::Adding element 媒体服务器 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:37 volumio sudo[6449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:37 volumio sudo[6449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:37 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 09 14:50:37 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:37 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:37 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:37 volumio volumio[6287]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:37 volumio volumio[6287]: info: [1752072637728] CoreMusicLibrary::Adding element Last_100 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:37 volumio sudo[6453]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:50:37 volumio sudo[6453]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:37 volumio volumio[6287]: info: [1752072637730] CoreMusicLibrary::Adding element Webradio Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:37 volumio volumio[6287]: info: Initializing BBC Radios Jul 09 14:50:37 volumio sudo[6453]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: Loading i18n strings for locale zh Jul 09 14:50:37 volumio volumio[6287]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: FusionDsp - mixtype--------------------- Software Jul 09 14:50:37 volumio volumio[6287]: info: Volumio Calling Home Jul 09 14:50:37 volumio volumio[6287]: info: Preparing to generate the ALSA configuration file Jul 09 14:50:37 volumio volumio[6287]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:50:37 volumio volumio[6287]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 09 14:50:37 volumio volumio[6287]: info: Reading ALSA contributions from plugins. Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:37 volumio volumio[6287]: info: MPD Permissions set Jul 09 14:50:37 volumio volumio[6287]: info: MPD Permissions set Jul 09 14:50:37 volumio volumio[6287]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:37 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:37 volumio volumio[6287]: info: FusionDsp - Jul 09 14:50:38 volumio volumio[6287]: info: FusionDsp - Jul 09 14:50:38 volumio volumio[6287]: info: FusionDsp - undefined Jul 09 14:50:38 volumio volumio[6287]: info: FusionDsp - undefined Jul 09 14:50:38 volumio volumio[6287]: info: Starting Shairport Sync Jul 09 14:50:38 volumio volumio[6287]: info: Starting Shairport Sync Jul 09 14:50:38 volumio sudo[6487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:38 volumio sudo[6487]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:38 volumio volumio[6287]: info: Starting Shairport Sync Jul 09 14:50:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:38 volumio sudo[6490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:38 volumio sudo[6490]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:38 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:38 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:38 volumio sudo[6494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:38 volumio sudo[6494]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:38 volumio volumio[6287]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:50:38 volumio volumio[6287]: info: Output device has changed, restarting MPD Jul 09 14:50:38 volumio sudo[6487]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:38 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 09 14:50:38 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:38 volumio sudo[6497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:38 volumio sudo[6490]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio sudo[6497]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:38 volumio mpd[6460]: Jul 09 14:50 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 14:50:38 volumio volumio[6287]: info: Output device has changed, restarting Shairport Sync Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:38 volumio sudo[6497]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio sudo[6494]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio sudo[6500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:38 volumio sudo[6500]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:38 volumio volumio[6287]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:38 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 09 14:50:38 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:38 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:38 volumio volumio[6287]: info: MPD Permissions set Jul 09 14:50:38 volumio volumio[6287]: info: Shairport-Sync Started Jul 09 14:50:38 volumio volumio[6287]: Error adding Membership: Error: addMembership EINVAL Jul 09 14:50:38 volumio volumio[6287]: info: Shairport-Sync Started Jul 09 14:50:38 volumio volumio[6287]: info: Shairport-Sync Started Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:38 volumio volumio[6287]: info: Starting Shairport Sync Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:38 volumio volumio[6287]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:38 volumio volumio[6287]: info: CoreCommandRouter::volumioPause Jul 09 14:50:38 volumio volumio[6287]: info: CoreStateMachine::pause Jul 09 14:50:38 volumio volumio[6287]: info: mpdhttpout --- Volumio set on pause Jul 09 14:50:38 volumio volumio[6287]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Jul 09 14:50:38 volumio sudo[6516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:38 volumio sudo[6516]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:38 volumio sudo[6508]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:50:38 volumio sudo[6508]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:38 volumio sudo[6508]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:38 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:38 volumio sudo[6516]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio volumio[6287]: info: Shairport-Sync Started Jul 09 14:50:38 volumio volumio[6287]: info: Volumio called home Jul 09 14:50:38 volumio mpd[6519]: Jul 09 14:50 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 14:50:38 volumio systemd[1]: Started Music Player Daemon. Jul 09 14:50:38 volumio sudo[6449]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio sudo[6500]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio sudo[6439]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:38 volumio volumio[6287]: info: Completed starting Core Plugins Jul 09 14:50:38 volumio volumio[6287]: info: ------------------------------------------- Jul 09 14:50:38 volumio volumio[6287]: info: ----- MyVolumio plugins startup ---- Jul 09 14:50:38 volumio volumio[6287]: info: ------------------------------------------- Jul 09 14:50:38 volumio volumio[6287]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 09 14:50:38 volumio volumio[6287]: error: MPD error: The expression evaluated to a falsy value: Jul 09 14:50:38 volumio volumio[6287]: assert.ok(self.idling) Jul 09 14:50:38 volumio volumio[6287]: error: The expression evaluated to a falsy value: Jul 09 14:50:38 volumio volumio[6287]: assert.ok(self.idling) Jul 09 14:50:38 volumio volumio[6287]: info: MPD running with PID6519 Jul 09 14:50:38 volumio volumio[6287]: ,establishing connection Jul 09 14:50:38 volumio volumio[6287]: error: MPD error: The expression evaluated to a falsy value: Jul 09 14:50:38 volumio volumio[6287]: assert.ok(self.idling) Jul 09 14:50:38 volumio volumio[6287]: error: The expression evaluated to a falsy value: Jul 09 14:50:38 volumio volumio[6287]: assert.ok(self.idling) Jul 09 14:50:38 volumio volumio[6287]: error: MPD error: The expression evaluated to a falsy value: Jul 09 14:50:38 volumio volumio[6287]: assert.ok(self.idling) Jul 09 14:50:38 volumio volumio[6287]: error: The expression evaluated to a falsy value: Jul 09 14:50:38 volumio volumio[6287]: assert.ok(self.idling) Jul 09 14:50:38 volumio volumio[6287]: error: updateQueue error: null Jul 09 14:50:39 volumio volumio-remote-updater[761]: [2025-07-09 14:50:39] [connect] Successful connection Jul 09 14:50:39 volumio volumio-remote-updater[761]: [2025-07-09 14:50:39] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1752072639 101 Jul 09 14:50:39 volumio volumio[6287]: 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: 4 Jul 09 14:50:39 volumio volumio[6287]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 09 14:50:39 volumio volumio[6287]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jul 09 14:50:39 volumio volumio[6287]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 09 14:50:39 volumio volumio[6287]: info: camilladsp service started and running in background, instance 1 Jul 09 14:50:39 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:39 volumio volumio[6287]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 09 14:50:39 volumio volumio[6287]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 09 14:50:39 volumio volumio[6287]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 09 14:50:39 volumio volumio[6287]: info: FusionDsp loaded Jul 09 14:50:39 volumio volumio[6287]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:39 volumio volumio[6287]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 09 14:50:39 volumio volumio[6287]: info: Adding Signal Path Element [object Object] Jul 09 14:50:39 volumio volumio[6287]: info: Adding fusiondspeq DSP Signal Path Element Jul 09 14:50:39 volumio sudo[6539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 09 14:50:39 volumio volumio[6287]: info: FusionDsp - ---- installed callbackRead Jul 09 14:50:39 volumio sudo[6539]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:39 volumio volumio[6287]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:50:39 volumio volumio[6287]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 09 14:50:39 volumio volumio[6287]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jul 09 14:50:39 volumio volumio[6287]: at onErrorNT (internal/child_process.js:472:16) Jul 09 14:50:39 volumio volumio[6287]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Jul 09 14:50:39 volumio volumio[6287]: errno: -2, Jul 09 14:50:39 volumio volumio[6287]: code: 'ENOENT', Jul 09 14:50:39 volumio volumio[6287]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 09 14:50:39 volumio volumio[6287]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 09 14:50:39 volumio volumio[6287]: spawnargs: [ Jul 09 14:50:39 volumio volumio[6287]: '-p', Jul 09 14:50:39 volumio volumio[6287]: 9876, Jul 09 14:50:39 volumio volumio[6287]: '-o', Jul 09 14:50:39 volumio volumio[6287]: '/tmp/camilladsp.log', Jul 09 14:50:39 volumio volumio[6287]: '-l', Jul 09 14:50:39 volumio volumio[6287]: 'warn', Jul 09 14:50:39 volumio volumio[6287]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 09 14:50:39 volumio volumio[6287]: ] Jul 09 14:50:39 volumio volumio[6287]: } Jul 09 14:50:39 volumio volumio[6287]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:50:39 volumio sudo[6539]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:40 volumio sudo[6550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 14:49 Jul 09 14:50:40 volumio sudo[6550]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:40 volumio sudo[6550]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:40 volumio volumio-remote-updater[761]: [2025-07-09 14:50:40] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 09 14:50:40 volumio volumio-remote-updater[761]: [2025-07-09 14:50:40] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 09 14:50:40 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 09 14:50:40 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 09 14:50:40 volumio systemd[1]: Started dynamicswap service. Jul 09 14:50:40 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 09 14:50:40 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 09 14:50:40 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jul 09 14:50:40 volumio systemd[1]: Started dynamicswap service. Jul 09 14:50:40 volumio systemd[1]: Stopped Volumio Backend Module. Jul 09 14:50:40 volumio systemd[1]: Started Volumio Backend Module. Jul 09 14:50:40 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 09 14:50:40 volumio volumio[6561]: info: ------------------------------------------- Jul 09 14:50:40 volumio volumio[6561]: info: ----- Volumio3 ---- Jul 09 14:50:40 volumio volumio[6561]: info: ------------------------------------------- Jul 09 14:50:40 volumio volumio[6561]: info: ----- System startup ---- Jul 09 14:50:40 volumio volumio[6561]: info: ------------------------------------------- Jul 09 14:50:41 volumio volumio[6561]: info: MYVOLUMIO Environment detected Jul 09 14:50:41 volumio volumio[6561]: info: Plugin folders cleanup Jul 09 14:50:41 volumio volumio[6561]: info: Scanning into folder /volumio/app/plugins/ Jul 09 14:50:41 volumio volumio[6561]: info: Scanning category audio_interface Jul 09 14:50:41 volumio volumio[6561]: info: Scanning category miscellanea Jul 09 14:50:41 volumio volumio[6561]: info: Scanning category music_service Jul 09 14:50:41 volumio volumio[6561]: info: Scanning category plugins.json Jul 09 14:50:41 volumio volumio[6561]: info: Scanning category system_controller Jul 09 14:50:41 volumio volumio[6561]: info: Scanning category user_interface Jul 09 14:50:41 volumio volumio[6561]: info: Scanning into folder /data/plugins/ Jul 09 14:50:41 volumio volumio[6561]: info: Scanning category audio_interface Jul 09 14:50:41 volumio volumio[6561]: info: Plugin folders cleanup completed Jul 09 14:50:41 volumio volumio[6561]: info: ------------------------------------------- Jul 09 14:50:41 volumio volumio[6561]: info: ----- Core plugins startup ---- Jul 09 14:50:41 volumio volumio[6561]: info: ------------------------------------------- Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugins from folder /volumio/app/plugins/ Jul 09 14:50:41 volumio volumio[6561]: info: Adding plugin upnp to MyMusic Plugins Jul 09 14:50:41 volumio volumio[6561]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 09 14:50:41 volumio volumio[6561]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugins from folder /data/plugins/ Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "system"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "appearance"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "network"... Jul 09 14:50:41 volumio volumio[6561]: info: Refreshing Cached IP Addresses Jul 09 14:50:41 volumio sudo[6634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 09 14:50:41 volumio sudo[6634]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:41 volumio sudo[6634]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:41 volumio sudo[6636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 09 14:50:41 volumio sudo[6636]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "services"... Jul 09 14:50:41 volumio sudo[6636]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "alsa_controller"... Jul 09 14:50:41 volumio sudo[6648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 09 14:50:41 volumio sudo[6648]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:41 volumio sudo[6648]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:41 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "wizard"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "networkfs"... Jul 09 14:50:41 volumio volumio[6561]: info: Starting Udev Watcher for removable devices Jul 09 14:50:41 volumio volumio[6561]: info: Ignoring mount for partition: boot Jul 09 14:50:41 volumio volumio[6561]: info: Ignoring mount for partition: volumio Jul 09 14:50:41 volumio volumio[6561]: info: Ignoring mount for partition: volumio_data Jul 09 14:50:41 volumio volumio[6561]: info: Ignoring mount for partition: 8681-4968 Jul 09 14:50:41 volumio volumio[6561]: info: Ignoring mount for partition: 918d12b7-0ace-4ac3-9a4a-a3e01a26afde Jul 09 14:50:41 volumio volumio[6561]: info: Ignoring mount for partition: 21CC-5DD5 Jul 09 14:50:41 volumio volumio[6561]: info: Ignoring mount for partition: 500g Jul 09 14:50:41 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "volumio_command_line_client"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "upnp"... Jul 09 14:50:41 volumio volumio[6561]: info: [1752072641590] Starting Upmpd Daemon Jul 09 14:50:41 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "my_music"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "mpd"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "upnp_browser"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "alarm-clock"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "airplay_emulation"... Jul 09 14:50:41 volumio volumio[6561]: info: Starting Shairport Sync Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "last_100"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "webradio"... Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "i2s_dacs"... Jul 09 14:50:41 volumio volumio[6561]: info: I2S DAC not set, start Auto-detection Jul 09 14:50:41 volumio volumio[6561]: info: Loading plugin "volumiodiscovery"... Jul 09 14:50:41 volumio volumio[6561]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:41 volumio volumio[6561]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:41 volumio volumio[6561]: *** WARNING *** For more information see Jul 09 14:50:41 volumio volumio[6561]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:41 volumio volumio[6561]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:41 volumio volumio[6561]: *** WARNING *** For more information see Jul 09 14:50:41 volumio node[6561]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:41 volumio node[6561]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:41 volumio node[6561]: *** WARNING *** For more information see Jul 09 14:50:41 volumio node[6561]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:41 volumio node[6561]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:41 volumio node[6561]: *** WARNING *** For more information see Jul 09 14:50:41 volumio volumio[6561]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 09 14:50:44 volumio volumio[6561]: info: Discovery: Started advertising with name: Volumio Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:44 volumio volumio[6561]: info: Loading plugin "outputs"... Jul 09 14:50:44 volumio volumio[6561]: info: Loading plugin "albumart"... Jul 09 14:50:44 volumio volumio[6561]: info: Plugin example_plugin is not enabled Jul 09 14:50:44 volumio volumio[6561]: info: Loading plugin "inputs"... Jul 09 14:50:44 volumio volumio[6561]: info: Loading plugin "updater_comm"... Jul 09 14:50:44 volumio volumio[6561]: info: Plugin mpdemulation is not enabled Jul 09 14:50:44 volumio volumio[6561]: info: Loading plugin "rest_api"... Jul 09 14:50:44 volumio volumio[6561]: Forking 3 albumart workers Jul 09 14:50:44 volumio volumio[6561]: info: Loading plugin "websocket"... Jul 09 14:50:44 volumio volumio[6561]: info: Starting Socket.io Server version 2.3.0 Jul 09 14:50:44 volumio volumio[6561]: info: Loading plugin "fusiondsp"... Jul 09 14:50:44 volumio volumio[6561]: info: Applying required configuration parameters for plugin fusiondsp Jul 09 14:50:44 volumio volumio[6561]: info: Loading plugin "mpdoutput"... Jul 09 14:50:44 volumio volumio[6561]: Starting albumart workers Jul 09 14:50:44 volumio volumio[6561]: Starting albumart workers Jul 09 14:50:44 volumio volumio[6561]: info: Loading i18n strings for locale zh Jul 09 14:50:44 volumio volumio[6561]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jul 09 14:50:44 volumio volumio[6561]: Updating browse sources language Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:44 volumio volumio[6561]: Starting albumart workers Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::initPlayerControls Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: Express server listening on port 3000 Jul 09 14:50:44 volumio volumio[6561]: [Metrics] WebUI: 4s 171.51ms Jul 09 14:50:44 volumio volumio[6561]: info: Setting Device type: x86 Jul 09 14:50:44 volumio volumio[6561]: info: CoreStateMachine::resetVolumioState Jul 09 14:50:44 volumio volumio[6561]: info: CoreStateMachine::getcurrentVolume Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:44 volumio volumio[6561]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 09 14:50:44 volumio volumio[6561]: info: Completed loading Core Plugins Jul 09 14:50:44 volumio volumio[6561]: info: Preparing to generate the ALSA configuration file Jul 09 14:50:44 volumio volumio[6561]: info: Volumio Network Manager: Network status updated: 1 Jul 09 14:50:44 volumio volumio[6561]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 09 14:50:44 volumio volumio[6561]: wlan0 Interface doesn't support scanning. Jul 09 14:50:44 volumio volumio[6561]: info: Cannot use regular scanning, forcing with ap-force Jul 09 14:50:44 volumio sudo[6712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 09 14:50:44 volumio sudo[6712]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:44 volumio sudo[6712]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:44 volumio volumio[6561]: command failed: No such device (-19) Jul 09 14:50:44 volumio volumio[6561]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 09 14:50:44 volumio volumio[6561]: command failed: No such device (-19) Jul 09 14:50:44 volumio volumio[6561]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jul 09 14:50:44 volumio volumio[6561]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:50:44 volumio volumio[6561]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 09 14:50:44 volumio volumio[6561]: info: Reading ALSA contributions from plugins. Jul 09 14:50:44 volumio volumio[6561]: verbose: New Socket.io Connection to 192.168.5.243 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 09 14:50:44 volumio volumio[6561]: verbose: New Socket.io Connection to 192.168.5.243 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 09 14:50:44 volumio volumio[6561]: info: CoreStateMachine::pushState Jul 09 14:50:44 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:44 volumio volumio[6561]: info: CoreStateMachine::updateTrackBlock Jul 09 14:50:44 volumio volumio[6561]: info: CorePlayQueue::getTrackBlock Jul 09 14:50:44 volumio volumio[6561]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 14:50:45 volumio volumio[6561]: info: Reloading queue from file Jul 09 14:50:45 volumio volumio[6561]: info: CoreStateMachine::setRepeat null single undefined Jul 09 14:50:45 volumio volumio[6561]: info: CoreStateMachine::pushState Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:45 volumio volumio[6561]: info: CoreStateMachine::setRandom null Jul 09 14:50:45 volumio volumio[6561]: info: CoreStateMachine::pushState Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:45 volumio volumio[6561]: info: CoreStateMachine::pushState Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:50:45 volumio volumio[6561]: info: Received Get System Info Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 14:50:45 volumio volumio[6561]: info: Discovery: Getting this device information Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:45 volumio volumio-remote-updater[761]: [2025-07-09 14:50:45] [connect] Successful connection Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: Listing playlists Jul 09 14:50:45 volumio volumio-remote-updater[761]: [2025-07-09 14:50:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1752072645 101 Jul 09 14:50:45 volumio volumio[6561]: 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: 3 Jul 09 14:50:45 volumio volumio[6561]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:50:45 volumio volumio[6561]: info: Output device has changed, restarting MPD Jul 09 14:50:45 volumio sudo[6751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:45 volumio sudo[6751]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio sudo[6751]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio volumio[6561]: info: Output device has changed, restarting Shairport Sync Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:45 volumio sudo[6754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:45 volumio sudo[6754]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 14:50:45 volumio volumio[6561]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:45 volumio volumio[6561]: info: ___________ START PLUGINS ___________ Jul 09 14:50:45 volumio volumio[6561]: info: ControllerMpd::onStart: Initializing MPD Jul 09 14:50:45 volumio volumio[6561]: info: Creating MPD Configuration file Jul 09 14:50:45 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:45 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:45 volumio sudo[6761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:45 volumio sudo[6761]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:45 volumio volumio[6561]: info: [1752072645178] CoreMusicLibrary::Adding element 媒体服务器 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:45 volumio sudo[6761]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio sudo[6764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:45 volumio sudo[6764]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:45 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 09 14:50:45 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:45 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:45 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:45 volumio volumio[6561]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:45 volumio volumio[6561]: info: [1752072645249] CoreMusicLibrary::Adding element Last_100 Jul 09 14:50:45 volumio sudo[6767]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:45 volumio volumio[6561]: info: [1752072645250] CoreMusicLibrary::Adding element Webradio Jul 09 14:50:45 volumio sudo[6767]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:45 volumio sudo[6767]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio volumio[6561]: info: Initializing BBC Radios Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: Loading i18n strings for locale zh Jul 09 14:50:45 volumio volumio[6561]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: FusionDsp - mixtype--------------------- Software Jul 09 14:50:45 volumio volumio[6561]: info: Volumio Calling Home Jul 09 14:50:45 volumio volumio[6561]: info: Preparing to generate the ALSA configuration file Jul 09 14:50:45 volumio volumio[6561]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:50:45 volumio volumio[6561]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 09 14:50:45 volumio volumio[6561]: info: Reading ALSA contributions from plugins. Jul 09 14:50:45 volumio volumio[6561]: info: MPD Permissions set Jul 09 14:50:45 volumio volumio[6561]: info: MPD Permissions set Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:45 volumio volumio[6561]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: Starting Shairport Sync Jul 09 14:50:45 volumio volumio[6561]: info: Discovery: adding 7f240d10-6ef4-45a3-bdfd-00652d7bf104 Jul 09 14:50:45 volumio volumio[6561]: info: Discovery: Found device Volumio Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: Starting Shairport Sync Jul 09 14:50:45 volumio sudo[6803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:45 volumio sudo[6803]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio volumio[6561]: info: Starting Shairport Sync Jul 09 14:50:45 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:45 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:45 volumio sudo[6806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:45 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:45 volumio volumio[6561]: info: FusionDsp - Jul 09 14:50:45 volumio sudo[6806]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio sudo[6810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:45 volumio sudo[6810]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:45 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:45 volumio sudo[6803]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 09 14:50:45 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:45 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:45 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:45 volumio sudo[6810]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio sudo[6806]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio volumio[6561]: info: FusionDsp - Jul 09 14:50:45 volumio volumio[6561]: info: FusionDsp - Jul 09 14:50:45 volumio mpd[6775]: Jul 09 14:50 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:45 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:45 volumio volumio[6561]: info: FusionDsp - undefined Jul 09 14:50:45 volumio volumio[6561]: info: FusionDsp - undefined Jul 09 14:50:45 volumio volumio[6561]: info: FusionDsp - undefined Jul 09 14:50:45 volumio volumio[6561]: info: Shairport-Sync Started Jul 09 14:50:45 volumio volumio[6561]: Error adding Membership: Error: addMembership EINVAL Jul 09 14:50:45 volumio volumio[6561]: info: Shairport-Sync Started Jul 09 14:50:45 volumio volumio[6561]: info: Shairport-Sync Started Jul 09 14:50:45 volumio volumio[6561]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:50:45 volumio volumio[6561]: info: Output device has changed, restarting MPD Jul 09 14:50:45 volumio systemd[1]: Started Music Player Daemon. Jul 09 14:50:45 volumio sudo[6754]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio sudo[6764]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio sudo[6818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:45 volumio sudo[6818]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio volumio[6561]: info: Output device has changed, restarting Shairport Sync Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:45 volumio sudo[6818]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:45 volumio sudo[6821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:45 volumio sudo[6821]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:45 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 14:50:45 volumio volumio[6561]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:45 volumio volumio[6561]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 09 14:50:45 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:45 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:45 volumio volumio[6561]: info: MPD Permissions set Jul 09 14:50:45 volumio volumio[6561]: info: Completed starting Core Plugins Jul 09 14:50:45 volumio volumio[6561]: info: ------------------------------------------- Jul 09 14:50:45 volumio volumio[6561]: info: ----- MyVolumio plugins startup ---- Jul 09 14:50:45 volumio volumio[6561]: info: ------------------------------------------- Jul 09 14:50:45 volumio volumio[6561]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 09 14:50:45 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:45 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:46 volumio sudo[6826]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:50:46 volumio sudo[6826]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:46 volumio volumio[6561]: error: Cannot initialize MPD Connection: MPD is not running Jul 09 14:50:46 volumio sudo[6826]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:46 volumio volumio[6561]: info: Starting Shairport Sync Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:46 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioPause Jul 09 14:50:46 volumio volumio[6561]: info: CoreStateMachine::pause Jul 09 14:50:46 volumio volumio[6561]: info: mpdhttpout --- Volumio set on pause Jul 09 14:50:46 volumio volumio[6561]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:46 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:46 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:46 volumio sudo[6838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:46 volumio sudo[6838]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:46 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:50:46 volumio volumio[6561]: info: Received Get System Info Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 14:50:46 volumio volumio[6561]: info: Discovery: Getting this device information Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:46 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:46 volumio volumio[6561]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:46 volumio volumio[6561]: info: Listing playlists Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::volumioGetQueue Jul 09 14:50:46 volumio volumio[6561]: info: CoreStateMachine::getQueue Jul 09 14:50:46 volumio volumio[6561]: info: CorePlayQueue::getQueue Jul 09 14:50:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:46 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:46 volumio sudo[6838]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:46 volumio volumio[6561]: info: Shairport-Sync Started Jul 09 14:50:46 volumio volumio[6561]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:46 volumio volumio[6561]: info: FusionDsp - Jul 09 14:50:46 volumio volumio[6561]: info: FusionDsp - undefined Jul 09 14:50:46 volumio mpd[6836]: Jul 09 14:50 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 14:50:46 volumio systemd[1]: Started Music Player Daemon. Jul 09 14:50:46 volumio sudo[6821]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:46 volumio volumio[6561]: error: MPD error: The expression evaluated to a falsy value: Jul 09 14:50:46 volumio volumio[6561]: assert.ok(self.idling) Jul 09 14:50:46 volumio volumio[6561]: error: The expression evaluated to a falsy value: Jul 09 14:50:46 volumio volumio[6561]: assert.ok(self.idling) Jul 09 14:50:46 volumio volumio[6561]: error: updateQueue error: null Jul 09 14:50:46 volumio volumio[6561]: error: updateQueue error: null Jul 09 14:50:46 volumio volumio[6561]: info: Volumio called home Jul 09 14:50:47 volumio volumio[6561]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 09 14:50:47 volumio volumio[6561]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jul 09 14:50:47 volumio volumio[6561]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 09 14:50:47 volumio volumio[6561]: info: camilladsp service started and running in background, instance 1 Jul 09 14:50:47 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:47 volumio volumio[6561]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 09 14:50:47 volumio volumio[6561]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 09 14:50:47 volumio volumio[6561]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 09 14:50:47 volumio volumio[6561]: info: FusionDsp loaded Jul 09 14:50:47 volumio volumio[6561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:47 volumio sudo[6857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 09 14:50:47 volumio sudo[6857]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:47 volumio volumio[6561]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 09 14:50:47 volumio volumio[6561]: info: Adding Signal Path Element [object Object] Jul 09 14:50:47 volumio volumio[6561]: info: Adding fusiondspeq DSP Signal Path Element Jul 09 14:50:47 volumio volumio[6561]: info: FusionDsp - ---- installed callbackRead Jul 09 14:50:47 volumio volumio[6561]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:50:47 volumio sudo[6857]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:47 volumio volumio[6561]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 09 14:50:47 volumio volumio[6561]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jul 09 14:50:47 volumio volumio[6561]: at onErrorNT (internal/child_process.js:472:16) Jul 09 14:50:47 volumio volumio[6561]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Jul 09 14:50:47 volumio volumio[6561]: errno: -2, Jul 09 14:50:47 volumio volumio[6561]: code: 'ENOENT', Jul 09 14:50:47 volumio volumio[6561]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 09 14:50:47 volumio volumio[6561]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 09 14:50:47 volumio volumio[6561]: spawnargs: [ Jul 09 14:50:47 volumio volumio[6561]: '-p', Jul 09 14:50:47 volumio volumio[6561]: 9876, Jul 09 14:50:47 volumio volumio[6561]: '-o', Jul 09 14:50:47 volumio volumio[6561]: '/tmp/camilladsp.log', Jul 09 14:50:47 volumio volumio[6561]: '-l', Jul 09 14:50:47 volumio volumio[6561]: 'warn', Jul 09 14:50:47 volumio volumio[6561]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 09 14:50:47 volumio volumio[6561]: ] Jul 09 14:50:47 volumio volumio[6561]: } Jul 09 14:50:47 volumio volumio[6561]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:50:47 volumio sudo[6868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 14:49 Jul 09 14:50:47 volumio sudo[6868]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:47 volumio sudo[6868]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:47 volumio volumio-remote-updater[761]: [2025-07-09 14:50:47] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 09 14:50:47 volumio volumio-remote-updater[761]: [2025-07-09 14:50:47] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 09 14:50:47 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 09 14:50:47 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 09 14:50:47 volumio systemd[1]: Started dynamicswap service. Jul 09 14:50:47 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 09 14:50:47 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 09 14:50:47 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jul 09 14:50:47 volumio systemd[1]: Stopped Volumio Backend Module. Jul 09 14:50:47 volumio systemd[1]: Started Volumio Backend Module. Jul 09 14:50:47 volumio systemd[1]: Started dynamicswap service. Jul 09 14:50:47 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 09 14:50:48 volumio volumio[6878]: info: ------------------------------------------- Jul 09 14:50:48 volumio volumio[6878]: info: ----- Volumio3 ---- Jul 09 14:50:48 volumio volumio[6878]: info: ------------------------------------------- Jul 09 14:50:48 volumio volumio[6878]: info: ----- System startup ---- Jul 09 14:50:48 volumio volumio[6878]: info: ------------------------------------------- Jul 09 14:50:48 volumio volumio[6878]: info: MYVOLUMIO Environment detected Jul 09 14:50:48 volumio volumio[6878]: info: Plugin folders cleanup Jul 09 14:50:48 volumio volumio[6878]: info: Scanning into folder /volumio/app/plugins/ Jul 09 14:50:48 volumio volumio[6878]: info: Scanning category audio_interface Jul 09 14:50:48 volumio volumio[6878]: info: Scanning category miscellanea Jul 09 14:50:48 volumio volumio[6878]: info: Scanning category music_service Jul 09 14:50:48 volumio volumio[6878]: info: Scanning category plugins.json Jul 09 14:50:48 volumio volumio[6878]: info: Scanning category system_controller Jul 09 14:50:48 volumio volumio[6878]: info: Scanning category user_interface Jul 09 14:50:48 volumio volumio[6878]: info: Scanning into folder /data/plugins/ Jul 09 14:50:48 volumio volumio[6878]: info: Scanning category audio_interface Jul 09 14:50:48 volumio volumio[6878]: info: Plugin folders cleanup completed Jul 09 14:50:48 volumio volumio[6878]: info: ------------------------------------------- Jul 09 14:50:48 volumio volumio[6878]: info: ----- Core plugins startup ---- Jul 09 14:50:48 volumio volumio[6878]: info: ------------------------------------------- Jul 09 14:50:48 volumio volumio[6878]: info: Loading plugins from folder /volumio/app/plugins/ Jul 09 14:50:48 volumio volumio[6878]: info: Adding plugin upnp to MyMusic Plugins Jul 09 14:50:48 volumio volumio[6878]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 09 14:50:48 volumio volumio[6878]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 09 14:50:48 volumio volumio[6878]: info: Loading plugins from folder /data/plugins/ Jul 09 14:50:48 volumio volumio[6878]: info: Loading plugin "system"... Jul 09 14:50:48 volumio volumio[6878]: info: Loading plugin "appearance"... Jul 09 14:50:48 volumio volumio[6878]: info: Loading plugin "network"... Jul 09 14:50:48 volumio volumio[6878]: info: Refreshing Cached IP Addresses Jul 09 14:50:48 volumio sudo[6905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 09 14:50:48 volumio sudo[6905]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:48 volumio sudo[6905]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:48 volumio sudo[6908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 09 14:50:48 volumio sudo[6908]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:48 volumio volumio[6878]: info: Loading plugin "services"... Jul 09 14:50:48 volumio sudo[6908]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:48 volumio volumio[6878]: info: Loading plugin "alsa_controller"... Jul 09 14:50:49 volumio sudo[6922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 09 14:50:49 volumio sudo[6922]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:49 volumio sudo[6922]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:49 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "wizard"... Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "networkfs"... Jul 09 14:50:49 volumio volumio[6878]: info: Starting Udev Watcher for removable devices Jul 09 14:50:49 volumio volumio[6878]: info: Ignoring mount for partition: boot Jul 09 14:50:49 volumio volumio[6878]: info: Ignoring mount for partition: volumio Jul 09 14:50:49 volumio volumio[6878]: info: Ignoring mount for partition: volumio_data Jul 09 14:50:49 volumio volumio[6878]: info: Ignoring mount for partition: 8681-4968 Jul 09 14:50:49 volumio volumio[6878]: info: Ignoring mount for partition: 918d12b7-0ace-4ac3-9a4a-a3e01a26afde Jul 09 14:50:49 volumio volumio[6878]: info: Ignoring mount for partition: 21CC-5DD5 Jul 09 14:50:49 volumio volumio[6878]: info: Ignoring mount for partition: 500g Jul 09 14:50:49 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "volumio_command_line_client"... Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "upnp"... Jul 09 14:50:49 volumio volumio[6878]: info: [1752072649132] Starting Upmpd Daemon Jul 09 14:50:49 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "my_music"... Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "mpd"... Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "upnp_browser"... Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "alarm-clock"... Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "airplay_emulation"... Jul 09 14:50:49 volumio volumio[6878]: info: Starting Shairport Sync Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "last_100"... Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "webradio"... Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "i2s_dacs"... Jul 09 14:50:49 volumio volumio[6878]: info: I2S DAC not set, start Auto-detection Jul 09 14:50:49 volumio volumio[6878]: info: Loading plugin "volumiodiscovery"... Jul 09 14:50:49 volumio volumio[6878]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:49 volumio volumio[6878]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:49 volumio volumio[6878]: *** WARNING *** For more information see Jul 09 14:50:49 volumio volumio[6878]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:49 volumio volumio[6878]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:49 volumio volumio[6878]: *** WARNING *** For more information see Jul 09 14:50:49 volumio node[6878]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:49 volumio node[6878]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:49 volumio node[6878]: *** WARNING *** For more information see Jul 09 14:50:49 volumio node[6878]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 09 14:50:49 volumio node[6878]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:50:49 volumio node[6878]: *** WARNING *** For more information see Jul 09 14:50:49 volumio volumio[6878]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 09 14:50:50 volumio volumio[6878]: info: Discovery: Started advertising with name: Volumio Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:50:50 volumio volumio[6878]: info: Loading plugin "outputs"... Jul 09 14:50:50 volumio volumio[6878]: info: Loading plugin "albumart"... Jul 09 14:50:50 volumio volumio[6878]: info: Plugin example_plugin is not enabled Jul 09 14:50:50 volumio volumio[6878]: info: Loading plugin "inputs"... Jul 09 14:50:50 volumio volumio[6878]: info: Loading plugin "updater_comm"... Jul 09 14:50:50 volumio volumio[6878]: info: Plugin mpdemulation is not enabled Jul 09 14:50:50 volumio volumio[6878]: info: Loading plugin "rest_api"... Jul 09 14:50:50 volumio volumio[6878]: Forking 3 albumart workers Jul 09 14:50:50 volumio volumio[6878]: info: Loading plugin "websocket"... Jul 09 14:50:50 volumio volumio[6878]: info: Starting Socket.io Server version 2.3.0 Jul 09 14:50:50 volumio volumio[6878]: info: Loading plugin "fusiondsp"... Jul 09 14:50:50 volumio volumio[6878]: info: Applying required configuration parameters for plugin fusiondsp Jul 09 14:50:50 volumio volumio[6878]: info: Loading plugin "mpdoutput"... Jul 09 14:50:50 volumio volumio[6878]: Starting albumart workers Jul 09 14:50:50 volumio volumio[6878]: Starting albumart workers Jul 09 14:50:50 volumio volumio[6878]: Starting albumart workers Jul 09 14:50:50 volumio volumio[6878]: info: Loading i18n strings for locale zh Jul 09 14:50:50 volumio volumio[6878]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jul 09 14:50:50 volumio volumio[6878]: Updating browse sources language Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::initPlayerControls Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:50 volumio volumio[6878]: Express server listening on port 3000 Jul 09 14:50:50 volumio volumio[6878]: [Metrics] WebUI: 2s 561.19ms Jul 09 14:50:50 volumio volumio[6878]: info: Setting Device type: x86 Jul 09 14:50:50 volumio volumio[6878]: info: CoreStateMachine::resetVolumioState Jul 09 14:50:50 volumio volumio[6878]: info: CoreStateMachine::getcurrentVolume Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 14:50:50 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:52 volumio volumio[6878]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 09 14:50:52 volumio volumio[6878]: info: Completed loading Core Plugins Jul 09 14:50:52 volumio volumio[6878]: info: Preparing to generate the ALSA configuration file Jul 09 14:50:52 volumio volumio[6878]: info: Volumio Network Manager: Network status updated: 1 Jul 09 14:50:52 volumio volumio[6878]: info: CoreStateMachine::pushState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:52 volumio volumio[6878]: info: CoreStateMachine::updateTrackBlock Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrackBlock Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 14:50:52 volumio volumio[6878]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 09 14:50:52 volumio volumio[6878]: wlan0 Interface doesn't support scanning. Jul 09 14:50:52 volumio volumio[6878]: info: Cannot use regular scanning, forcing with ap-force Jul 09 14:50:52 volumio sudo[7016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 09 14:50:52 volumio sudo[7016]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:52 volumio sudo[7016]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:52 volumio volumio[6878]: command failed: No such device (-19) Jul 09 14:50:52 volumio volumio[6878]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 09 14:50:52 volumio volumio[6878]: command failed: No such device (-19) Jul 09 14:50:52 volumio volumio[6878]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jul 09 14:50:52 volumio volumio[6878]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:50:52 volumio volumio[6878]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 09 14:50:52 volumio volumio[6878]: info: Reading ALSA contributions from plugins. Jul 09 14:50:52 volumio volumio[6878]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 09 14:50:52 volumio volumio[6878]: verbose: New Socket.io Connection to 192.168.5.243 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 09 14:50:52 volumio volumio[6878]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 09 14:50:52 volumio volumio[6878]: info: CoreStateMachine::pushState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:52 volumio volumio-remote-updater[761]: [2025-07-09 14:50:52] [connect] Successful connection Jul 09 14:50:52 volumio volumio[6878]: info: Reloading queue from file Jul 09 14:50:52 volumio volumio[6878]: info: CoreStateMachine::setRepeat null single undefined Jul 09 14:50:52 volumio volumio[6878]: info: CoreStateMachine::pushState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:52 volumio volumio[6878]: info: CoreStateMachine::setRandom null Jul 09 14:50:52 volumio volumio[6878]: info: CoreStateMachine::pushState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioPushState Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 14:50:52 volumio volumio[6878]: verbose: New Socket.io Connection to 192.168.5.243 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:50:52 volumio volumio[6878]: info: Received Get System Info Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 14:50:52 volumio volumio[6878]: info: Discovery: Getting this device information Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: Listing playlists Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetQueue Jul 09 14:50:52 volumio volumio[6878]: info: CoreStateMachine::getQueue Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getQueue Jul 09 14:50:52 volumio volumio-remote-updater[761]: [2025-07-09 14:50:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1752072652 101 Jul 09 14:50:52 volumio volumio[6878]: 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 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:50:52 volumio volumio[6878]: info: Received Get System Info Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 14:50:52 volumio volumio[6878]: info: Discovery: Getting this device information Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:52 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:52 volumio volumio[6878]: info: Listing playlists Jul 09 14:50:52 volumio volumio[6878]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:50:52 volumio volumio[6878]: info: Output device has changed, restarting MPD Jul 09 14:50:52 volumio sudo[7026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:52 volumio sudo[7026]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:52 volumio sudo[7026]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:52 volumio volumio[6878]: info: Output device has changed, restarting Shairport Sync Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:52 volumio sudo[7029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:52 volumio sudo[7029]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:52 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 14:50:52 volumio volumio[6878]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:52 volumio volumio[6878]: info: ___________ START PLUGINS ___________ Jul 09 14:50:52 volumio volumio[6878]: info: ControllerMpd::onStart: Initializing MPD Jul 09 14:50:52 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:52 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:52 volumio volumio[6878]: info: Creating MPD Configuration file Jul 09 14:50:52 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:52 volumio volumio[6878]: info: [1752072652877] CoreMusicLibrary::Adding element 媒体服务器 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:52 volumio sudo[7036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:52 volumio sudo[7036]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:52 volumio sudo[7036]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:52 volumio sudo[7038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:52 volumio sudo[7038]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:52 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 09 14:50:52 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:52 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:52 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:52 volumio volumio[6878]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:52 volumio volumio[6878]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:52 volumio volumio[6878]: info: [1752072652961] CoreMusicLibrary::Adding element Last_100 Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:50:52 volumio volumio[6878]: info: [1752072652963] CoreMusicLibrary::Adding element Webradio Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:50:52 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:52 volumio volumio[6878]: info: Initializing BBC Radios Jul 09 14:50:52 volumio sudo[7044]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:50:52 volumio sudo[7044]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:52 volumio sudo[7044]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: Loading i18n strings for locale zh Jul 09 14:50:53 volumio volumio[6878]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: FusionDsp - mixtype--------------------- Software Jul 09 14:50:53 volumio volumio[6878]: info: Volumio Calling Home Jul 09 14:50:53 volumio volumio[6878]: info: Preparing to generate the ALSA configuration file Jul 09 14:50:53 volumio volumio[6878]: info: Discovery: adding 7f240d10-6ef4-45a3-bdfd-00652d7bf104 Jul 09 14:50:53 volumio volumio[6878]: info: Discovery: Found device Volumio Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:53 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:53 volumio volumio[6878]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:50:53 volumio volumio[6878]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 09 14:50:53 volumio volumio[6878]: info: Reading ALSA contributions from plugins. Jul 09 14:50:53 volumio volumio[6878]: info: MPD Permissions set Jul 09 14:50:53 volumio volumio[6878]: info: MPD Permissions set Jul 09 14:50:53 volumio volumio[6878]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:50:53 volumio volumio[6878]: info: Starting Shairport Sync Jul 09 14:50:53 volumio volumio[6878]: info: Starting Shairport Sync Jul 09 14:50:53 volumio sudo[7076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:53 volumio sudo[7076]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:53 volumio volumio[6878]: info: Starting Shairport Sync Jul 09 14:50:53 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:53 volumio sudo[7078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:53 volumio sudo[7078]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:53 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:53 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::volumioGetState Jul 09 14:50:53 volumio volumio[6878]: info: CorePlayQueue::getTrack 0 Jul 09 14:50:53 volumio sudo[7081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:50:53 volumio sudo[7081]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:53 volumio volumio[6878]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:50:53 volumio volumio[6878]: info: Output device has changed, restarting MPD Jul 09 14:50:53 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:53 volumio sudo[7076]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:53 volumio sudo[7086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:50:53 volumio sudo[7086]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:53 volumio volumio[6878]: info: Output device has changed, restarting Shairport Sync Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:53 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:50:53 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:50:53 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 09 14:50:53 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:50:53 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:53 volumio sudo[7086]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:53 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:50:53 volumio sudo[7081]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:53 volumio sudo[7078]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:53 volumio sudo[7089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:50:53 volumio sudo[7089]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:53 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 09 14:50:53 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:50:53 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:50:53 volumio volumio[6878]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:50:53 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:50:53 volumio volumio[6878]: info: FusionDsp - Jul 09 14:50:53 volumio sudo[7097]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:50:53 volumio sudo[7097]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:53 volumio sudo[7097]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:53 volumio volumio[6878]: info: FusionDsp - Jul 09 14:50:53 volumio volumio[6878]: info: FusionDsp - Jul 09 14:50:53 volumio volumio[6878]: info: FusionDsp - Jul 09 14:50:53 volumio volumio[6878]: info: FusionDsp - Jul 09 14:50:53 volumio volumio[6878]: info: FusionDsp - Jul 09 14:50:54 volumio mpd[7099]: Jul 09 14:50 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 14:50:54 volumio systemd[1]: Started Music Player Daemon. Jul 09 14:50:54 volumio sudo[7038]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:54 volumio sudo[7029]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:54 volumio sudo[7089]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:57 volumio volumio[6878]: info: FusionDsp - undefined Jul 09 14:50:57 volumio volumio[6878]: info: FusionDsp - undefined Jul 09 14:50:57 volumio volumio[6878]: info: FusionDsp - undefined Jul 09 14:50:57 volumio volumio[6878]: info: FusionDsp - undefined Jul 09 14:50:57 volumio volumio[6878]: info: FusionDsp - undefined Jul 09 14:50:57 volumio volumio[6878]: info: FusionDsp - undefined Jul 09 14:50:57 volumio volumio[6878]: info: MPD Permissions set Jul 09 14:50:57 volumio volumio[6878]: info: Completed starting Core Plugins Jul 09 14:50:57 volumio volumio[6878]: info: ------------------------------------------- Jul 09 14:50:57 volumio volumio[6878]: info: ----- MyVolumio plugins startup ---- Jul 09 14:50:57 volumio volumio[6878]: info: ------------------------------------------- Jul 09 14:50:57 volumio volumio[6878]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 09 14:50:57 volumio volumio[6878]: info: Volumio called home Jul 09 14:50:57 volumio volumio[6878]: info: Shairport-Sync Started Jul 09 14:50:57 volumio volumio[6878]: Error adding Membership: Error: addMembership EINVAL Jul 09 14:50:57 volumio volumio[6878]: info: Shairport-Sync Started Jul 09 14:50:57 volumio volumio[6878]: info: Shairport-Sync Started Jul 09 14:50:59 volumio volumio[6878]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 09 14:50:59 volumio volumio[6878]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jul 09 14:50:59 volumio volumio[6878]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 09 14:50:59 volumio volumio[6878]: info: camilladsp service started and running in background, instance 1 Jul 09 14:50:59 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:50:59 volumio volumio[6878]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 09 14:50:59 volumio volumio[6878]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 09 14:50:59 volumio volumio[6878]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 09 14:50:59 volumio volumio[6878]: info: FusionDsp loaded Jul 09 14:50:59 volumio volumio[6878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:50:59 volumio sudo[7131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 09 14:50:59 volumio sudo[7131]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:50:59 volumio volumio[6878]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 09 14:50:59 volumio volumio[6878]: info: Adding Signal Path Element [object Object] Jul 09 14:50:59 volumio volumio[6878]: info: Adding fusiondspeq DSP Signal Path Element Jul 09 14:50:59 volumio volumio[6878]: info: FusionDsp - ---- installed callbackRead Jul 09 14:50:59 volumio volumio[6878]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:50:59 volumio sudo[7131]: pam_unix(sudo:session): session closed for user root Jul 09 14:50:59 volumio volumio[6878]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 09 14:50:59 volumio volumio[6878]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jul 09 14:50:59 volumio volumio[6878]: at onErrorNT (internal/child_process.js:472:16) Jul 09 14:50:59 volumio volumio[6878]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jul 09 14:50:59 volumio volumio[6878]: at runNextTicks (internal/process/task_queues.js:64:3) Jul 09 14:50:59 volumio volumio[6878]: at listOnTimeout (internal/timers.js:526:9) Jul 09 14:50:59 volumio volumio[6878]: at processTimers (internal/timers.js:500:7) { Jul 09 14:50:59 volumio volumio[6878]: errno: -2, Jul 09 14:50:59 volumio volumio[6878]: code: 'ENOENT', Jul 09 14:50:59 volumio volumio[6878]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 09 14:50:59 volumio volumio[6878]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 09 14:50:59 volumio volumio[6878]: spawnargs: [ Jul 09 14:50:59 volumio volumio[6878]: '-p', Jul 09 14:50:59 volumio volumio[6878]: 9876, Jul 09 14:50:59 volumio volumio[6878]: '-o', Jul 09 14:50:59 volumio volumio[6878]: '/tmp/camilladsp.log', Jul 09 14:50:59 volumio volumio[6878]: '-l', Jul 09 14:50:59 volumio volumio[6878]: 'warn', Jul 09 14:50:59 volumio volumio[6878]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 09 14:50:59 volumio volumio[6878]: ] Jul 09 14:50:59 volumio volumio[6878]: } Jul 09 14:50:59 volumio volumio[6878]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:51:00 volumio sudo[7142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 14:50 Jul 09 14:51:00 volumio sudo[7142]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:00 volumio sudo[7142]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:00 volumio volumio-remote-updater[761]: [2025-07-09 14:51:00] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 09 14:51:00 volumio volumio-remote-updater[761]: [2025-07-09 14:51:00] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 09 14:51:00 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 09 14:51:00 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 09 14:51:00 volumio systemd[1]: Started dynamicswap service. Jul 09 14:51:00 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 09 14:51:00 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 09 14:51:00 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Jul 09 14:51:00 volumio systemd[1]: Stopped Volumio Backend Module. Jul 09 14:51:00 volumio systemd[1]: Started Volumio Backend Module. Jul 09 14:51:00 volumio systemd[1]: Started dynamicswap service. Jul 09 14:51:00 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 09 14:51:01 volumio volumio[7152]: info: ------------------------------------------- Jul 09 14:51:01 volumio volumio[7152]: info: ----- Volumio3 ---- Jul 09 14:51:01 volumio volumio[7152]: info: ------------------------------------------- Jul 09 14:51:01 volumio volumio[7152]: info: ----- System startup ---- Jul 09 14:51:01 volumio volumio[7152]: info: ------------------------------------------- Jul 09 14:51:01 volumio volumio[7152]: info: MYVOLUMIO Environment detected Jul 09 14:51:01 volumio volumio[7152]: info: Plugin folders cleanup Jul 09 14:51:01 volumio volumio[7152]: info: Scanning into folder /volumio/app/plugins/ Jul 09 14:51:01 volumio volumio[7152]: info: Scanning category audio_interface Jul 09 14:51:01 volumio volumio[7152]: info: Scanning category miscellanea Jul 09 14:51:01 volumio volumio[7152]: info: Scanning category music_service Jul 09 14:51:01 volumio volumio[7152]: info: Scanning category plugins.json Jul 09 14:51:01 volumio volumio[7152]: info: Scanning category system_controller Jul 09 14:51:01 volumio volumio[7152]: info: Scanning category user_interface Jul 09 14:51:01 volumio volumio[7152]: info: Scanning into folder /data/plugins/ Jul 09 14:51:01 volumio volumio[7152]: info: Scanning category audio_interface Jul 09 14:51:01 volumio volumio[7152]: info: Plugin folders cleanup completed Jul 09 14:51:01 volumio volumio[7152]: info: ------------------------------------------- Jul 09 14:51:01 volumio volumio[7152]: info: ----- Core plugins startup ---- Jul 09 14:51:01 volumio volumio[7152]: info: ------------------------------------------- Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugins from folder /volumio/app/plugins/ Jul 09 14:51:01 volumio volumio[7152]: info: Adding plugin upnp to MyMusic Plugins Jul 09 14:51:01 volumio volumio[7152]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 09 14:51:01 volumio volumio[7152]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugins from folder /data/plugins/ Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "system"... Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "appearance"... Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "network"... Jul 09 14:51:01 volumio volumio[7152]: info: Refreshing Cached IP Addresses Jul 09 14:51:01 volumio sudo[7179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 09 14:51:01 volumio sudo[7179]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:01 volumio sudo[7179]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:01 volumio sudo[7181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 09 14:51:01 volumio sudo[7181]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "services"... Jul 09 14:51:01 volumio sudo[7181]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "alsa_controller"... Jul 09 14:51:01 volumio sudo[7195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 09 14:51:01 volumio sudo[7195]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:01 volumio sudo[7195]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:01 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "wizard"... Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "networkfs"... Jul 09 14:51:01 volumio volumio[7152]: info: Starting Udev Watcher for removable devices Jul 09 14:51:01 volumio volumio[7152]: info: Ignoring mount for partition: boot Jul 09 14:51:01 volumio volumio[7152]: info: Ignoring mount for partition: volumio Jul 09 14:51:01 volumio volumio[7152]: info: Ignoring mount for partition: volumio_data Jul 09 14:51:01 volumio volumio[7152]: info: Ignoring mount for partition: 8681-4968 Jul 09 14:51:01 volumio volumio[7152]: info: Ignoring mount for partition: 918d12b7-0ace-4ac3-9a4a-a3e01a26afde Jul 09 14:51:01 volumio volumio[7152]: info: Ignoring mount for partition: 21CC-5DD5 Jul 09 14:51:01 volumio volumio[7152]: info: Ignoring mount for partition: 500g Jul 09 14:51:01 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "volumio_command_line_client"... Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "upnp"... Jul 09 14:51:01 volumio volumio[7152]: info: [1752072661890] Starting Upmpd Daemon Jul 09 14:51:01 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "my_music"... Jul 09 14:51:01 volumio volumio[7152]: info: Loading plugin "mpd"... Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "upnp_browser"... Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "alarm-clock"... Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "airplay_emulation"... Jul 09 14:51:02 volumio volumio[7152]: info: Starting Shairport Sync Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "last_100"... Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "webradio"... Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "i2s_dacs"... Jul 09 14:51:02 volumio volumio[7152]: info: I2S DAC not set, start Auto-detection Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "volumiodiscovery"... Jul 09 14:51:02 volumio volumio[7152]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 09 14:51:02 volumio volumio[7152]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:51:02 volumio volumio[7152]: *** WARNING *** For more information see Jul 09 14:51:02 volumio node[7152]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 09 14:51:02 volumio volumio[7152]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 09 14:51:02 volumio volumio[7152]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:51:02 volumio volumio[7152]: *** WARNING *** For more information see Jul 09 14:51:02 volumio node[7152]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:51:02 volumio node[7152]: *** WARNING *** For more information see Jul 09 14:51:02 volumio node[7152]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 09 14:51:02 volumio node[7152]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 09 14:51:02 volumio node[7152]: *** WARNING *** For more information see Jul 09 14:51:02 volumio volumio[7152]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 09 14:51:02 volumio volumio[7152]: info: Discovery: Started advertising with name: Volumio Jul 09 14:51:02 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "outputs"... Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "albumart"... Jul 09 14:51:02 volumio volumio[7152]: info: Plugin example_plugin is not enabled Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "inputs"... Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "updater_comm"... Jul 09 14:51:02 volumio volumio[7152]: Forking 3 albumart workers Jul 09 14:51:02 volumio volumio[7152]: info: Plugin mpdemulation is not enabled Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "rest_api"... Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "websocket"... Jul 09 14:51:02 volumio volumio[7152]: info: Starting Socket.io Server version 2.3.0 Jul 09 14:51:02 volumio volumio[7152]: info: Loading plugin "fusiondsp"... Jul 09 14:51:02 volumio volumio[7152]: info: Applying required configuration parameters for plugin fusiondsp Jul 09 14:51:03 volumio volumio[7152]: info: Loading plugin "mpdoutput"... Jul 09 14:51:03 volumio volumio[7152]: info: Loading i18n strings for locale zh Jul 09 14:51:03 volumio volumio[7152]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jul 09 14:51:03 volumio volumio[7152]: Updating browse sources language Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:51:03 volumio volumio[7152]: Starting albumart workers Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::initPlayerControls Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: Express server listening on port 3000 Jul 09 14:51:03 volumio volumio[7152]: [Metrics] WebUI: 2s 306.05ms Jul 09 14:51:03 volumio volumio[7152]: info: Setting Device type: x86 Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::resetVolumioState Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::getcurrentVolume Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 09 14:51:03 volumio volumio[7152]: info: Completed loading Core Plugins Jul 09 14:51:03 volumio volumio[7152]: info: Preparing to generate the ALSA configuration file Jul 09 14:51:03 volumio volumio[7152]: Starting albumart workers Jul 09 14:51:03 volumio volumio[7152]: Starting albumart workers Jul 09 14:51:03 volumio volumio[7152]: info: Volumio Network Manager: Network status updated: 1 Jul 09 14:51:03 volumio volumio[7152]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 09 14:51:03 volumio volumio[7152]: wlan0 Interface doesn't support scanning. Jul 09 14:51:03 volumio volumio[7152]: info: Cannot use regular scanning, forcing with ap-force Jul 09 14:51:03 volumio sudo[7257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 09 14:51:03 volumio sudo[7257]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:03 volumio sudo[7257]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:03 volumio volumio[7152]: command failed: No such device (-19) Jul 09 14:51:03 volumio volumio[7152]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 09 14:51:03 volumio volumio[7152]: command failed: No such device (-19) Jul 09 14:51:03 volumio volumio[7152]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jul 09 14:51:03 volumio volumio[7152]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:51:03 volumio volumio[7152]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 09 14:51:03 volumio volumio[7152]: info: Reading ALSA contributions from plugins. Jul 09 14:51:03 volumio volumio[7152]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 09 14:51:03 volumio volumio[7152]: verbose: New Socket.io Connection to 192.168.5.243 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 09 14:51:03 volumio volumio[7152]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::pushState Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioPushState Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::updateTrackBlock Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrackBlock Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 14:51:03 volumio volumio[7152]: info: Reloading queue from file Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::setRepeat null single undefined Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::pushState Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioPushState Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::setRandom null Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::pushState Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioPushState Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:51:03 volumio volumio[7152]: info: Received Get System Info Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 14:51:03 volumio volumio[7152]: info: Discovery: Getting this device information Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:03 volumio volumio[7152]: info: Listing playlists Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioGetQueue Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::getQueue Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getQueue Jul 09 14:51:03 volumio volumio[7152]: info: CoreStateMachine::pushState Jul 09 14:51:03 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioPushState Jul 09 14:51:03 volumio volumio[7152]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:51:03 volumio volumio[7152]: info: Output device has changed, restarting MPD Jul 09 14:51:03 volumio sudo[7298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:51:03 volumio volumio[7152]: info: Output device has changed, restarting Shairport Sync Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:03 volumio sudo[7298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:03 volumio sudo[7300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:51:03 volumio sudo[7298]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:03 volumio sudo[7300]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:03 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 14:51:03 volumio volumio[7152]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:51:03 volumio volumio[7152]: info: ___________ START PLUGINS ___________ Jul 09 14:51:03 volumio volumio[7152]: info: ControllerMpd::onStart: Initializing MPD Jul 09 14:51:03 volumio volumio[7152]: info: Creating MPD Configuration file Jul 09 14:51:03 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:51:03 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:51:03 volumio sudo[7308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:51:03 volumio sudo[7308]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:51:03 volumio volumio[7152]: info: [1752072663812] CoreMusicLibrary::Adding element 媒体服务器 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:51:03 volumio sudo[7308]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:03 volumio sudo[7311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:51:03 volumio sudo[7311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:03 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:03 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 09 14:51:03 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:51:03 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:51:03 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:51:03 volumio volumio[7152]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:03 volumio sudo[7314]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:51:03 volumio sudo[7314]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:03 volumio volumio[7152]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:51:03 volumio volumio[7152]: info: [1752072663897] CoreMusicLibrary::Adding element Last_100 Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 14:51:03 volumio volumio[7152]: info: [1752072663899] CoreMusicLibrary::Adding element Webradio Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:51:03 volumio sudo[7314]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:51:03 volumio volumio[7152]: info: Initializing BBC Radios Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: Loading i18n strings for locale zh Jul 09 14:51:03 volumio volumio[7152]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 09 14:51:03 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:03 volumio volumio[7152]: info: FusionDsp - mixtype--------------------- Software Jul 09 14:51:03 volumio volumio[7152]: info: Volumio Calling Home Jul 09 14:51:04 volumio volumio[7152]: info: Preparing to generate the ALSA configuration file Jul 09 14:51:04 volumio volumio[7152]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 09 14:51:04 volumio volumio[7152]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 09 14:51:04 volumio volumio[7152]: info: Reading ALSA contributions from plugins. Jul 09 14:51:04 volumio volumio[7152]: info: MPD Permissions set Jul 09 14:51:04 volumio volumio[7152]: info: MPD Permissions set Jul 09 14:51:04 volumio volumio[7152]: info: Discovery: adding 7f240d10-6ef4-45a3-bdfd-00652d7bf104 Jul 09 14:51:04 volumio volumio[7152]: info: Discovery: Found device Volumio Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:04 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:04 volumio volumio[7152]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: Starting Shairport Sync Jul 09 14:51:04 volumio volumio[7152]: info: Starting Shairport Sync Jul 09 14:51:04 volumio sudo[7348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:51:04 volumio sudo[7348]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:04 volumio volumio[7152]: info: Starting Shairport Sync Jul 09 14:51:04 volumio sudo[7351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:51:04 volumio sudo[7351]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:51:04 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:51:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:04 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:51:04 volumio sudo[7355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:51:04 volumio sudo[7348]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:51:04 volumio sudo[7355]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:51:04 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 09 14:51:04 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:51:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:51:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:51:04 volumio volumio[7152]: info: Asound.conf file unchanged, so no further update is needed Jul 09 14:51:04 volumio volumio[7152]: info: Output device has changed, restarting MPD Jul 09 14:51:04 volumio sudo[7351]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:51:04 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 09 14:51:04 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:51:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:51:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:51:04 volumio sudo[7355]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:04 volumio volumio[7152]: info: Output device has changed, restarting Shairport Sync Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:04 volumio sudo[7362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 14:51:04 volumio sudo[7362]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:04 volumio sudo[7360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 14:51:04 volumio volumio[7152]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 14:51:04 volumio sudo[7360]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:04 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 09 14:51:04 volumio systemd[1]: mpd.service: Succeeded. Jul 09 14:51:04 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 14:51:04 volumio sudo[7360]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:04 volumio volumio[7152]: info: Shairport-Sync Started Jul 09 14:51:04 volumio volumio[7152]: Error adding Membership: Error: addMembership EINVAL Jul 09 14:51:04 volumio volumio[7152]: info: MPD Permissions set Jul 09 14:51:04 volumio volumio[7152]: info: Shairport-Sync Started Jul 09 14:51:04 volumio volumio[7152]: info: Shairport-Sync Started Jul 09 14:51:04 volumio systemd[1]: Starting Music Player Daemon... Jul 09 14:51:04 volumio volumio[7152]: info: FusionDsp - Jul 09 14:51:04 volumio sudo[7370]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 14:51:04 volumio sudo[7370]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:04 volumio sudo[7370]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:04 volumio volumio[7152]: info: FusionDsp - Jul 09 14:51:04 volumio volumio[7152]: info: FusionDsp - Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:51:04 volumio volumio[7152]: info: FusionDsp - undefined Jul 09 14:51:04 volumio volumio[7152]: info: FusionDsp - undefined Jul 09 14:51:04 volumio volumio[7152]: info: FusionDsp - undefined Jul 09 14:51:04 volumio volumio[7152]: info: Volumio called home Jul 09 14:51:04 volumio volumio[7152]: info: Starting Shairport Sync Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:04 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:04 volumio volumio[7152]: info: CoreCommandRouter::volumioPause Jul 09 14:51:04 volumio volumio[7152]: info: CoreStateMachine::pause Jul 09 14:51:04 volumio volumio[7152]: info: mpdhttpout --- Volumio set on pause Jul 09 14:51:04 volumio volumio[7152]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Jul 09 14:51:04 volumio sudo[7380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:51:04 volumio sudo[7380]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:51:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:51:04 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 14:51:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 14:51:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:51:04 volumio sudo[7380]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:04 volumio volumio[7152]: info: Shairport-Sync Started Jul 09 14:51:05 volumio mpd[7372]: Jul 09 14:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 14:51:05 volumio systemd[1]: Started Music Player Daemon. Jul 09 14:51:05 volumio sudo[7311]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:05 volumio sudo[7300]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:05 volumio sudo[7362]: pam_unix(sudo:session): session closed for user root Jul 09 14:51:05 volumio volumio[7152]: info: Completed starting Core Plugins Jul 09 14:51:05 volumio volumio[7152]: info: ------------------------------------------- Jul 09 14:51:05 volumio volumio[7152]: info: ----- MyVolumio plugins startup ---- Jul 09 14:51:05 volumio volumio[7152]: info: ------------------------------------------- Jul 09 14:51:05 volumio volumio[7152]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 09 14:51:05 volumio volumio-remote-updater[761]: [2025-07-09 14:51:05] [connect] Successful connection Jul 09 14:51:05 volumio volumio[7152]: error: MPD error: The expression evaluated to a falsy value: Jul 09 14:51:05 volumio volumio[7152]: assert.ok(self.idling) Jul 09 14:51:05 volumio volumio[7152]: error: The expression evaluated to a falsy value: Jul 09 14:51:05 volumio volumio[7152]: assert.ok(self.idling) Jul 09 14:51:05 volumio volumio[7152]: error: MPD error: The expression evaluated to a falsy value: Jul 09 14:51:05 volumio volumio[7152]: assert.ok(self.idling) Jul 09 14:51:05 volumio volumio[7152]: error: The expression evaluated to a falsy value: Jul 09 14:51:05 volumio volumio[7152]: assert.ok(self.idling) Jul 09 14:51:05 volumio volumio[7152]: error: updateQueue error: null Jul 09 14:51:05 volumio volumio[7152]: info: MPD running with PID7372 Jul 09 14:51:05 volumio volumio[7152]: ,establishing connection Jul 09 14:51:05 volumio volumio-remote-updater[761]: [2025-07-09 14:51:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1752072665 101 Jul 09 14:51:05 volumio volumio[7152]: 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 Jul 09 14:51:05 volumio volumio[7152]: error: updateQueue error: null Jul 09 14:51:05 volumio volumio[7152]: verbose: New Socket.io Connection to 192.168.5.243 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:05 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:05 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:51:05 volumio volumio[7152]: info: Received Get System Info Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 14:51:05 volumio volumio[7152]: info: Discovery: Getting this device information Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:05 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::volumioGetState Jul 09 14:51:05 volumio volumio[7152]: info: CorePlayQueue::getTrack 0 Jul 09 14:51:05 volumio volumio[7152]: info: Listing playlists Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:51:05 volumio volumio[7152]: info: FusionDsp - Jul 09 14:51:05 volumio volumio[7152]: info: FusionDsp - undefined Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:51:05 volumio volumio[7152]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:51:05 volumio volumio[7152]: info: FusionDsp - Jul 09 14:51:05 volumio volumio[7152]: info: FusionDsp - Jul 09 14:51:05 volumio volumio[7152]: info: FusionDsp - Jul 09 14:51:05 volumio volumio[7152]: info: FusionDsp - Jul 09 14:51:06 volumio volumio[7152]: info: FusionDsp - undefined Jul 09 14:51:06 volumio volumio[7152]: info: FusionDsp - undefined Jul 09 14:51:06 volumio volumio[7152]: info: FusionDsp - undefined Jul 09 14:51:06 volumio volumio[7152]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:51:06 volumio volumio[7152]: TypeError: Cannot read property 'off' of undefined Jul 09 14:51:06 volumio volumio[7152]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Jul 09 14:51:06 volumio volumio[7152]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jul 09 14:51:06 volumio volumio[7152]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Jul 09 14:51:06 volumio volumio[7152]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Jul 09 14:51:06 volumio volumio[7152]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Jul 09 14:51:06 volumio volumio[7152]: at Socket.emit (events.js:400:28) Jul 09 14:51:06 volumio volumio[7152]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 09 14:51:06 volumio volumio[7152]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jul 09 14:51:06 volumio volumio[7152]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:51:06 volumio sudo[7400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 14:50 Jul 09 14:51:06 volumio sudo[7400]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"