Oct 15 15:14:02 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:02 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:05 volumio-kojot volumio[1812]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 15:14:05 volumio-kojot volumio[1812]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Oct 15 15:14:05 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 15 15:14:05 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 15 15:14:05 volumio-kojot sudo[22176]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 15 15:14:05 volumio-kojot sudo[22176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:14:05 volumio-kojot sudo[22176]: pam_unix(sudo:session): session closed for user root Oct 15 15:14:05 volumio-kojot sudo[22181]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 15 15:14:05 volumio-kojot sudo[22181]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:14:05 volumio-kojot sudo[22188]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 15 15:14:05 volumio-kojot sudo[22188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:14:05 volumio-kojot sudo[22195]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 15 15:14:05 volumio-kojot sudo[22195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:14:05 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 15 15:14:05 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 15 15:14:05 volumio-kojot sudo[22203]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 15:14:05 volumio-kojot sudo[22203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:14:05 volumio-kojot sudo[22209]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 15:14:05 volumio-kojot sudo[22181]: pam_unix(sudo:session): session closed for user root Oct 15 15:14:05 volumio-kojot sudo[22203]: pam_unix(sudo:session): session closed for user root Oct 15 15:14:05 volumio-kojot sudo[22209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:14:05 volumio-kojot sudo[22214]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 15:14:05 volumio-kojot sudo[22214]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:14:05 volumio-kojot sudo[22188]: pam_unix(sudo:session): session closed for user root Oct 15 15:14:05 volumio-kojot sudo[22195]: pam_unix(sudo:session): session closed for user root Oct 15 15:14:05 volumio-kojot sudo[22209]: pam_unix(sudo:session): session closed for user root Oct 15 15:14:05 volumio-kojot sudo[22214]: pam_unix(sudo:session): session closed for user root Oct 15 15:14:05 volumio-kojot volumio[1812]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 15 15:14:05 volumio-kojot volumio[1812]: wlan0 Interface doesn't support scanning. Oct 15 15:14:05 volumio-kojot volumio[1812]: info: Cannot use regular scanning, forcing with ap-force Oct 15 15:14:05 volumio-kojot sudo[22228]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 15 15:14:05 volumio-kojot sudo[22228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:14:05 volumio-kojot sudo[22228]: pam_unix(sudo:session): session closed for user root Oct 15 15:14:05 volumio-kojot volumio[1812]: command failed: No such device (-19) Oct 15 15:14:05 volumio-kojot volumio[1812]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 15 15:14:05 volumio-kojot volumio[1812]: command failed: No such device (-19) Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Retrieving Cloud Streaming UI Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Getting Tidal Cloud Configuration Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Getting Qobuz Cloud Configuration Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Asking plugin for UI Config Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Getting Spotify Cloud Configuration Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Asking plugin for UI Config Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Saving Spotify Acccount Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Got it Oct 15 15:14:08 volumio-kojot volumio[1812]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Got Tidal Cloud Configuration Oct 15 15:14:08 volumio-kojot volumio[1812]: info: Got it Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetBrowseSources Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetBrowseSources Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetBrowseSources Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 15 15:14:08 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 15 15:14:12 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:12 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:12 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:14:12 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:14:12 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 15 15:14:13 volumio-kojot volumio[1812]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 15:14:16 volumio-kojot volumio[1812]: info: CALLMETHOD: user_interface artwork_one setSettings [object Object] Oct 15 15:14:16 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: artwork_one , setSettings Oct 15 15:14:16 volumio-kojot volumio[1812]: info: [artwork_one] settings {"version":2,"plugin":"user_interface/artwork_one","theme":"light"} Oct 15 15:14:17 volumio-kojot volumio[1812]: info: CALLMETHOD: user_interface artwork_one setSettings [object Object] Oct 15 15:14:17 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: artwork_one , setSettings Oct 15 15:14:17 volumio-kojot volumio[1812]: info: [artwork_one] settings {"version":2,"plugin":"user_interface/artwork_one","theme":"dark"} Oct 15 15:14:17 volumio-kojot volumio[1812]: info: CALLMETHOD: user_interface artwork_one setSettings [object Object] Oct 15 15:14:17 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: artwork_one , setSettings Oct 15 15:14:17 volumio-kojot volumio[1812]: info: [artwork_one] settings {"version":2,"plugin":"user_interface/artwork_one","theme":"system"} Oct 15 15:14:22 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:22 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:32 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:32 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:32 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:14:32 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:14:37 volumio-kojot volumio[1812]: info: CALLMETHOD: user_interface artwork_one setSettings [object Object] Oct 15 15:14:37 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: artwork_one , setSettings Oct 15 15:14:37 volumio-kojot volumio[1812]: info: [artwork_one] settings {"version":2,"plugin":"user_interface/artwork_one","theme":"system","ambient":{"on":true,"delay":2,"layout":"bleed","clock":"24","night":true,"nightFrom":"23:00","nightTo":"07:00","textSize":"m","hideVolume":false}} Oct 15 15:14:42 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:42 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CURURI: artists:// Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CURURI: albums:// Oct 15 15:14:45 volumio-kojot volumio[1812]: info: listAlbums - loading Albums from cache Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CURURI: playlists Oct 15 15:14:45 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:45 volumio-kojot volumio[1812]: info: CURURI: genres:// Oct 15 15:14:47 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:47 volumio-kojot volumio[1812]: info: CURURI: artists:// Oct 15 15:14:47 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://Ace of Base Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A1.Bronski Beat Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://Aaron Heick & John Di Martino Romantic Jazz Trio Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A4.Jimmy Somerville Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://ALEXIS COLE Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://AIR Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://ADAM SANDLER Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A7.Communards Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A-Ha Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A QUESTION OF BALANCE Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://ALLAN TAYLOR Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://10 cc Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A-ha Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://3 Doors Down Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A-HA Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://"Great Western Themes" Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A2.Communards Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://4 Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://Ace Of Base Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A3.Bronski Beat Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A5.Jimmy Somerville Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://10cc Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://ARETHA FRANKLIN Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:49 volumio-kojot volumio[1812]: info: CURURI: artists://A6.Jimmy Somerville Oct 15 15:14:51 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:14:51 volumio-kojot volumio[1812]: info: CURURI: artists://A-HA Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0002 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0003 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0004 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0005 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0006 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0007 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0008 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0009 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0010 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0011 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0012 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0013 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0014 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0015 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0016 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0017 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Preloading song: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0018 Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001 in service mpd Oct 15 15:14:51 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001' Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0002 in service mpd Oct 15 15:14:51 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0002' Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0003 in service mpd Oct 15 15:14:51 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0003' Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0004 in service mpd Oct 15 15:14:51 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0004' Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0005 in service mpd Oct 15 15:14:51 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0005' Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0006 in service mpd Oct 15 15:14:51 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0006' Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0007 in service mpd Oct 15 15:14:51 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0007' Oct 15 15:14:51 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0008 in service mpd Oct 15 15:14:51 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0008' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0009 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0009' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0010 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0010' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0011 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0011' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:52 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0012 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0012' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0013 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0013' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0014 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0014' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0015 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0015' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0016 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0016' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0017 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0017' Oct 15 15:14:52 volumio-kojot volumio[1812]: info: Exploding uri music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0018 in service mpd Oct 15 15:14:52 volumio-kojot volumio[1812]: error: scanFolder - failure to stat '/mnt/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0018' Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::ClearQueue Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::stop Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::stPlaybackTimer Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::updateTrackBlock Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrackBlock Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:14:54 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::serviceStop Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::serviceStop Oct 15 15:14:54 volumio-kojot volumio[1812]: info: ControllerMpd::stop Oct 15 15:14:54 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::clearPlayQueue Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::addQueueItems Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::addQueueItems Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::updateTrackBlock Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrackBlock Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPlay Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::play index 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::addQueueItems Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::addQueueItems Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0002 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0002 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0003 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0003 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0004 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0004 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0005 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0005 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0006 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0006 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0007 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0007 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0008 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0008 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0009 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0009 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0010 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0010 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0011 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0011 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0012 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0012 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0013 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0013 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0014 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0014 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0015 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0015 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0016 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0016 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0017 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0017 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0018 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0018 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::stop Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::play index undefined Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::updateTrackBlock Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrackBlock Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:14:54 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 387 | title: sempl | previous title: sempl Oct 15 15:14:54 volumio-kojot volumio[1812]: info: =================> [timer] is active: true | can continue: false | timer started at: 1792069961083 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: [LastFM] stopping timer, playback has ended. Oct 15 15:14:54 volumio-kojot volumio[1812]: -------------------------------------------------// S T O P P I N G Oct 15 15:14:54 volumio-kojot volumio[1812]: info: Oct 15 15:14:54 volumio-kojot volumio[1812]: ---------------------------- MPD announces state update: player Oct 15 15:14:54 volumio-kojot volumio[1812]: info: sendMpdCommand stop took 6 milliseconds Oct 15 15:14:54 volumio-kojot volumio[1812]: info: ControllerMpd::getState Oct 15 15:14:54 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand status Oct 15 15:14:54 volumio-kojot volumio[1812]: info: sendMpdCommand status took 0 milliseconds Oct 15 15:14:54 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseState Oct 15 15:14:54 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 15:14:54 volumio-kojot volumio[1812]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 15 15:14:54 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseTrackInfo Oct 15 15:14:54 volumio-kojot volumio[1812]: info: ControllerMpd::pushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::servicePushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:14:54 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"sempl","artist":"Dire Straits","album":"On Every Street","uri":"NAS/Tetus_HD_STEREO/FLAC 2.0/Dire Straits - On Every Street/sempl.flac","trackType":"flac"} Oct 15 15:14:54 volumio-kojot volumio[1812]: verbose: CURRENT POSITION 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState stateService stop Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState currentStatus stop Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:14:54 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: No code Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:14:54 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:54 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: ------------------------------ 5ms Oct 15 15:14:54 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:14:54 volumio-kojot volumio[1812]: info: [LastFM] Undefined track duration or too short for scrobbling: 0, 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 0 | title: | previous title: sempl Oct 15 15:14:54 volumio-kojot volumio[1812]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792069961083 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:14:54 volumio-kojot volumio[1812]: info: [LastFM] Undefined track duration or too short for scrobbling: 0, 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 0 | title: | previous title: sempl Oct 15 15:14:54 volumio-kojot volumio[1812]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792069961083 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:14:54 volumio-kojot volumio[1812]: info: [LastFM] Undefined track duration or too short for scrobbling: 0, 0 Oct 15 15:14:54 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 0 | title: | previous title: sempl Oct 15 15:14:54 volumio-kojot volumio[1812]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792069961083 Oct 15 15:14:57 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:57 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:57 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 15 15:14:57 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPlay Oct 15 15:14:57 volumio-kojot volumio[1812]: info: CoreStateMachine::play index undefined Oct 15 15:14:57 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:57 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::ClearQueue Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::stop Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::clearPlayQueue Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::addQueueItems Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::addQueueItems Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::updateTrackBlock Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrackBlock Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPlay Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::play index 0 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::addQueueItems Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::addQueueItems Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0002 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0002 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0003 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0003 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0004 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0004 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0005 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0005 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0006 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0006 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0007 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0007 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0008 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0008 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0009 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0009 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0010 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0010 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0011 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0011 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0012 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0012 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0013 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0013 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0014 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0014 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0015 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0015 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0016 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0016 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0017 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0017 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Adding Item to queue: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0018 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: Using cached record of: music-library/NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0018 Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::stop Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::play index undefined Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CoreStateMachine::updateTrackBlock Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrackBlock Oct 15 15:14:59 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:02 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::ClearQueue Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::stop Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::clearPlayQueue Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::addQueueItems Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::addQueueItems Oct 15 15:15:02 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:15:02 volumio-kojot volumio[1812]: info: Adding Item to queue: artists://A-HA Oct 15 15:15:02 volumio-kojot volumio[1812]: info: Exploding uri artists://A-HA in service mpd Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::updateTrackBlock Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrackBlock Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPlay Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::play index 0 Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::stop Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::play index undefined Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CoreStateMachine::startPlaybackTimer Oct 15 15:15:02 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:02 volumio-kojot volumio[1812]: verbose: ControllerMpd::clearAddPlayTracks NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001 Oct 15 15:15:02 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 15:15:02 volumio-kojot volumio[1812]: info: sendMpdCommand stop took 0 milliseconds Oct 15 15:15:02 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 15:15:02 volumio-kojot volumio[1812]: info: Oct 15 15:15:02 volumio-kojot volumio[1812]: ---------------------------- MPD announces system playlist update Oct 15 15:15:02 volumio-kojot volumio[1812]: info: Ignoring MPD Status Update Oct 15 15:15:02 volumio-kojot volumio[1812]: info: sendMpdCommand clear took 3 milliseconds Oct 15 15:15:02 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand add "NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001" Oct 15 15:15:02 volumio-kojot volumio[1812]: error: updateQueue error: null Oct 15 15:15:02 volumio-kojot volumio[1812]: info: Oct 15 15:15:02 volumio-kojot volumio[1812]: ---------------------------- MPD announces system playlist update Oct 15 15:15:02 volumio-kojot volumio[1812]: info: Ignoring MPD Status Update Oct 15 15:15:02 volumio-kojot volumio[1812]: info: ------------------------------ 1ms Oct 15 15:15:02 volumio-kojot volumio[1812]: info: sendMpdCommand add "NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001" took 0 milliseconds Oct 15 15:15:02 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand play Oct 15 15:15:02 volumio-kojot volumio[1812]: info: ------------------------------ 0ms Oct 15 15:15:02 volumio-kojot volumio[1812]: info: sendMpdCommand play took 1 milliseconds Oct 15 15:15:03 volumio-kojot volumio[1812]: info: Oct 15 15:15:03 volumio-kojot volumio[1812]: ---------------------------- MPD announces state update: player Oct 15 15:15:03 volumio-kojot volumio[1812]: info: ControllerMpd::getState Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand status Oct 15 15:15:03 volumio-kojot volumio[1812]: info: Oct 15 15:15:03 volumio-kojot volumio[1812]: ---------------------------- MPD announces state update: player Oct 15 15:15:03 volumio-kojot volumio[1812]: info: sendMpdCommand status took 27 milliseconds Oct 15 15:15:03 volumio-kojot volumio[1812]: info: ControllerMpd::getState Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand status Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseState Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 15:15:03 volumio-kojot volumio[1812]: info: sendMpdCommand status took 1 milliseconds Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseState Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 15:15:03 volumio-kojot volumio[1812]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 15 15:15:03 volumio-kojot volumio[1812]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseTrackInfo Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseTrackInfo Oct 15 15:15:03 volumio-kojot volumio[1812]: info: ControllerMpd::pushState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreCommandRouter::servicePushState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Velvet","artist":"A-HA","album":"25","uri":"NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001","trackType":""} Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: CURRENT POSITION 0 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState stateService play Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState currentStatus stop Oct 15 15:15:03 volumio-kojot volumio[1812]: info: ControllerMpd::pushState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreCommandRouter::servicePushState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Velvet","artist":"A-HA","album":"25","uri":"NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001","trackType":""} Oct 15 15:15:03 volumio-kojot volumio[1812]: verbose: CURRENT POSITION 0 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState stateService play Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState currentStatus play Oct 15 15:15:03 volumio-kojot volumio[1812]: info: Received an update from plugin. extracting info from payload Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:15:03 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:15:03 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: ------------------------------ 31ms Oct 15 15:15:03 volumio-kojot volumio[1812]: info: ------------------------------ 6ms Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:15:03 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: mpd | duration: 262 | title: Velvet | previous title: sempl Oct 15 15:15:03 volumio-kojot volumio[1812]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792069961083 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] Current track has sufficient metadata: title (Velvet) and artist (A-HA) passed on explicitly Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] Updating now playing Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] starting new timer for 248900 milliseconds [A-HA - Velvet]. Oct 15 15:15:03 volumio-kojot volumio[1812]: -------------------------------------------------// S T A R T I N G Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] Timer started with time stamp 1792070103 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:15:03 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: mpd | duration: 262 | title: Velvet | previous title: Velvet Oct 15 15:15:03 volumio-kojot volumio[1812]: info: =================> [timer] is active: true | can continue: false | timer started at: 1792070103052 Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] Same state as the one previously pushed. No need to do anything... Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] updated "now playing" | artist: A-HA | title: Velvet Oct 15 15:15:03 volumio-kojot volumio[1812]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Velvet","mbid":"04fbff9b-9fbd-3c96-bb2d-183444d00283","url":"https://www.last.fm/music/a-ha/_/Velvet","duration":"216000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"112144","playcount":"658084","artist":{"name":"a-ha","url":"https://www.last.fm/music/a-ha"},"album":{"artist":"a-ha","title":"Minor Earth | Major Sky","url":"https://www.last.fm/music/a-ha/Minor+Earth+%7C+Major+Sky","image":[{"#":"https://lastfm-img.freetls.fastly.net/i/u/34s/8a4149e2149547a58d1f1e150cf7ab9b.png","@":{"size":"small"}},{"#":"https://lastfm-img.freetls.fastly.net/i/u/64s/8a4149e2149547a58d1f1e150cf7ab9b.png","@":{"size":"medium"}},{"#":"https://lastfm-img.freetls.fastly.net/i/u/174s/8a4149e2149547a58d1f1e150cf7ab9b.png","@":{"size":"large"}},{"#":"https://lastfm-img.freetls.fastly.net/i/u/300x300/8a4149e2149547a58d1f1e150cf7ab9b.png","@":{"size":"extralarge"}}]},"userplaycount":"0","userloved":"0","toptags":"","wiki":{"published":"01 Jul 2011, 19:08","summary":"Velvet is a song by Savoy, a band fronted by Paul Waaktaar-Savoy from their first album, Mary Is Coming. Savoy's version was released as a single in the US, but got very little airplay. a-ha's version of Velvet replaced Savoy's guitars with sitars. Their version, the third single from Minor Earth | Major Sky , was released to radio stations in Germany (and in other European countries such as Sweden, Switzerland and Holland) in September 2000 and was released to German record stores on 6 November (one week later in other parts of Europe). Read more on Last.fm.","content":"Velvet is a song by Savoy, a band fronted by Paul Waaktaar-Savoy from their first album, Mary Is Coming. Savoy's version was released as a single in the US, but got very little airplay. a-ha's version of Velvet replaced Savoy's guitars with sitars. Their version, the third single from Minor Earth | Major Sky , was released to radio stations in Germany (and in other European countries such as Sweden, Switzerland and Holland) in September 2000 and was released to German record stores on 6 November (one week later in other parts of Europe). Originally, The Sun Never Shone That Day was to be released in Norway instead of Velvet, but it was later decided that Velvet would also be released in Norway. The backing vocals was performed by Simone Larsen of the Norwegian band D'Sound. World Sales: 300.000 Read more on Last.fm. User-contributed text is available under the Creative Commons By-SA License; additional terms may apply."}}} Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:15:03 volumio-kojot volumio[1812]: info: CURURI: albums://A-HA/25 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::ClearQueue Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::stop Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::stPlaybackTimer Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::updateTrackBlock Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrackBlock Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:15:04 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::serviceStop Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::serviceStop Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ControllerMpd::stop Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::clearPlayQueue Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::addQueueItems Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::addQueueItems Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Preload queue cleared Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Adding Item to queue: artists://A-HA Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Using cached record of: artists://A-HA Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::saveQueue Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::updateTrackBlock Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrackBlock Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPlay Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::play index 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::stop Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::play index undefined Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::startPlaybackTimer Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::clearAddPlayTracks NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001 Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 15:15:04 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:15:04 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 262 | title: Velvet | previous title: Velvet Oct 15 15:15:04 volumio-kojot volumio[1812]: info: =================> [timer] is active: true | can continue: false | timer started at: 1792070103052 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: [LastFM] stopping timer, playback has ended. Oct 15 15:15:04 volumio-kojot volumio[1812]: -------------------------------------------------// S T O P P I N G Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Oct 15 15:15:04 volumio-kojot volumio[1812]: ---------------------------- MPD announces state update: player Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand stop took 5 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ControllerMpd::getState Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand status Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand stop took 2 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Oct 15 15:15:04 volumio-kojot volumio[1812]: ---------------------------- MPD announces system playlist update Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Ignoring MPD Status Update Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand status took 0 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand clear took 0 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseState Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand add "NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001" Oct 15 15:15:04 volumio-kojot volumio[1812]: error: updateQueue error: null Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ------------------------------ 1ms Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseTrackInfo Oct 15 15:15:04 volumio-kojot volumio[1812]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ------------------------------ 1ms Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Oct 15 15:15:04 volumio-kojot volumio[1812]: ---------------------------- MPD announces system playlist update Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Ignoring MPD Status Update Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand add "NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001" took 0 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand play Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ------------------------------ 0ms Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand play took 1 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Oct 15 15:15:04 volumio-kojot volumio[1812]: ---------------------------- MPD announces state update: player Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ControllerMpd::getState Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand status Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Oct 15 15:15:04 volumio-kojot volumio[1812]: ---------------------------- MPD announces state update: player Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand status took 1 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ControllerMpd::getState Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand status Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseState Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand status took 0 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseState Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseTrackInfo Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ControllerMpd::pushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::servicePushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Velvet","artist":"A-HA","album":"25","uri":"NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001","trackType":""} Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: CURRENT POSITION 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState stateService play Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState currentStatus stop Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ------------------------------ 1ms Oct 15 15:15:04 volumio-kojot volumio[1812]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: ControllerMpd::parseTrackInfo Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ControllerMpd::pushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::servicePushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Velvet","artist":"A-HA","album":"25","uri":"NAS/Tetus_HD_STEREO/FLAC 2.0/A-ha - Full Albums Discography/A-ha - 2010 - 25 - The Very Best Of A-Ha (Japan 2CD)/CD2/CDImage.cue/track0001","trackType":""} Oct 15 15:15:04 volumio-kojot volumio[1812]: verbose: CURRENT POSITION 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState stateService play Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::syncState currentStatus play Oct 15 15:15:04 volumio-kojot volumio[1812]: info: Received an update from plugin. extracting info from payload Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:15:04 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreStateMachine::pushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioPushState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:15:04 volumio-kojot volumio[1812]: info: MRS: Pushing multiroomSync output Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:04 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: ------------------------------ 5ms Oct 15 15:15:04 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:15:04 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: mpd | duration: 262 | title: Velvet | previous title: Velvet Oct 15 15:15:04 volumio-kojot volumio[1812]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792070103052 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 15 15:15:04 volumio-kojot volumio[1812]: info: [LastFM] Same state as the one previously pushed. No need to do anything... Oct 15 15:15:04 volumio-kojot volumio[1812]: info: [LastFM] using existing timer Oct 15 15:15:04 volumio-kojot volumio[1812]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: mpd | duration: 262 | title: Velvet | previous title: Velvet Oct 15 15:15:04 volumio-kojot volumio[1812]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792070103052 Oct 15 15:15:04 volumio-kojot volumio[1812]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 15 15:15:04 volumio-kojot volumio[1812]: info: [LastFM] Same state as the one previously pushed. No need to do anything... Oct 15 15:15:12 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:12 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:12 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:15:12 volumio-kojot volumio[1812]: info: Listing playlists Oct 15 15:15:22 volumio-kojot volumio[1812]: info: CoreCommandRouter::volumioGetState Oct 15 15:15:22 volumio-kojot volumio[1812]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:22 volumio-kojot volumio[1812]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:15:22 volumio-kojot volumio[1812]: TypeError: Cannot read properties of null (reading 'slice') Oct 15 15:15:22 volumio-kojot volumio[1812]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Oct 15 15:15:22 volumio-kojot volumio[1812]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Oct 15 15:15:22 volumio-kojot volumio[1812]: at Object.onceWrapper (node:events:629:26) Oct 15 15:15:22 volumio-kojot volumio[1812]: at ClientRequest.emit (node:events:514:28) Oct 15 15:15:22 volumio-kojot volumio[1812]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Oct 15 15:15:22 volumio-kojot volumio[1812]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Oct 15 15:15:22 volumio-kojot volumio[1812]: at TLSSocket.socketOnData (node:_http_client:535:22) Oct 15 15:15:22 volumio-kojot volumio[1812]: at TLSSocket.emit (node:events:514:28) Oct 15 15:15:22 volumio-kojot volumio[1812]: at addChunk (node:internal/streams/readable:343:12) Oct 15 15:15:22 volumio-kojot volumio[1812]: at readableAddChunk (node:internal/streams/readable:316:9) Oct 15 15:15:22 volumio-kojot volumio[1812]: at Readable.push (node:internal/streams/readable:253:10) Oct 15 15:15:22 volumio-kojot volumio[1812]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Oct 15 15:15:22 volumio-kojot volumio[1812]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:15:22 volumio-kojot sudo[22458]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 15:14' Oct 15 15:15:22 volumio-kojot sudo[22458]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:15:22 volumio-kojot sudo[22458]: pam_unix(sudo:session): session closed for user root Oct 15 15:15:22 volumio-kojot qobuz-connect[2333]: 20261015 15:15:22.828 [2333.2333] INFO SampleApp: Socket closed Oct 15 15:15:22 volumio-kojot vtcs[2461]: [2026-10-15 15:15:22.828] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Oct 15 15:15:22 volumio-kojot volumio-remote-updater[776]: [2026-10-15 15:15:22] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 15:15:22 volumio-kojot volumio-remote-updater[776]: [2026-10-15 15:15:22] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 15:15:22 volumio-kojot volumio5-onboarding[1554]: time=2026-10-15T15:15:22.829+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Oct 15 15:15:22 volumio-kojot systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:15:22 volumio-kojot volumio5-onboarding[1554]: time=2026-10-15T15:15:22.830+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 15 15:15:22 volumio-kojot systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 15:15:22 volumio-kojot systemd[1]: volumio.service: Consumed 1min 3.706s CPU time. Oct 15 15:15:22 volumio-kojot systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 15 15:15:22 volumio-kojot systemd[1]: dynamicswap.service: Deactivated successfully. Oct 15 15:15:22 volumio-kojot systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Oct 15 15:15:22 volumio-kojot systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 15 15:15:22 volumio-kojot systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 15 15:15:22 volumio-kojot systemd[1]: volumio.service: Consumed 1min 3.706s CPU time. Oct 15 15:15:22 volumio-kojot systemd[1]: Started volumio.service - Volumio Backend Module. Oct 15 15:15:23 volumio-kojot systemd[1]: dynamicswap.service: Deactivated successfully. Oct 15 15:15:23 volumio-kojot volumio[22496]: info: ------------------------------------------- Oct 15 15:15:23 volumio-kojot volumio[22496]: info: ----- Volumio3 ---- Oct 15 15:15:23 volumio-kojot volumio[22496]: info: ------------------------------------------- Oct 15 15:15:23 volumio-kojot volumio[22496]: info: ----- System startup ---- Oct 15 15:15:23 volumio-kojot volumio[22496]: info: ------------------------------------------- Oct 15 15:15:23 volumio-kojot volumio[22496]: info: MYVOLUMIO Environment detected Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Plugin folders cleanup Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning into folder /volumio/app/plugins/ Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category audio_interface Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category miscellanea Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category music_service Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category plugins.json Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category system_controller Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category user_interface Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning into folder /data/plugins/ Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category audio_interface Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category music_service Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Scanning category user_interface Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Plugin folders cleanup completed Oct 15 15:15:23 volumio-kojot volumio[22496]: info: ------------------------------------------- Oct 15 15:15:23 volumio-kojot volumio[22496]: info: ----- Core plugins startup ---- Oct 15 15:15:23 volumio-kojot volumio[22496]: info: ------------------------------------------- Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Adding plugin upnp to MyMusic Plugins Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugins from folder /data/plugins/ Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "system"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "appearance"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "network"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Refreshing Cached IP Addresses Oct 15 15:15:23 volumio-kojot sudo[22524]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 15:15:23 volumio-kojot sudo[22524]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:15:23 volumio-kojot sudo[22526]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 15:15:23 volumio-kojot sudo[22526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:15:23 volumio-kojot sudo[22524]: pam_unix(sudo:session): session closed for user root Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "services"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "volumio5onboarding"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "alsa_controller"... Oct 15 15:15:23 volumio-kojot sudo[22535]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 15:15:23 volumio-kojot sudo[22535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:15:23 volumio-kojot sudo[22526]: pam_unix(sudo:session): session closed for user root Oct 15 15:15:23 volumio-kojot sudo[22535]: pam_unix(sudo:session): session closed for user root Oct 15 15:15:23 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "wizard"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "networkfs"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Cannot mount NAS Tetus_Jacek_SYNCHRO at system boot, trial number 1 ,retrying in 5 seconds Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Cannot mount NAS Tetus_HD_STEREO at system boot, trial number 1 ,retrying in 5 seconds Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Starting Udev Watcher for removable devices Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Ignoring mount for partition: boot Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Ignoring mount for partition: volumio Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Ignoring mount for partition: volumio_data Oct 15 15:15:23 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "volumio_command_line_client"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "upnp"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: [1792070123630] Starting Upmpd Daemon Oct 15 15:15:23 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "my_music"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "mpd"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "upnp_browser"... Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Starting UPNP Browser Oct 15 15:15:23 volumio-kojot volumio[22496]: info: Loading plugin "alarm-clock"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "airplay_emulation"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Starting Shairport Sync Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "last_100"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "webradio"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "i2s_dacs"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: I2S DAC not set, start Auto-detection Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "volumiodiscovery"... Oct 15 15:15:24 volumio-kojot volumio[22496]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 15:15:24 volumio-kojot volumio[22496]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 15:15:24 volumio-kojot node[22496]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 15:15:24 volumio-kojot volumio[22496]: *** WARNING *** For more information see Oct 15 15:15:24 volumio-kojot volumio[22496]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 15:15:24 volumio-kojot volumio[22496]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 15:15:24 volumio-kojot volumio[22496]: *** WARNING *** For more information see Oct 15 15:15:24 volumio-kojot node[22496]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 15:15:24 volumio-kojot node[22496]: *** WARNING *** For more information see Oct 15 15:15:24 volumio-kojot node[22496]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 15:15:24 volumio-kojot node[22496]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 15:15:24 volumio-kojot node[22496]: *** WARNING *** For more information see Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Discovery: Started advertising with name: Volumio KOJOT Oct 15 15:15:24 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "mixcloud"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "rp2"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "ytmusic"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "artwork_one"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "now_playing"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Plugin stylish_player is not enabled Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "outputs"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "albumart"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Plugin example_plugin is not enabled Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "inputs"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "updater_comm"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Plugin mpdemulation is not enabled Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "rest_api"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "websocket"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Starting Socket.io Server version 1.7.4 Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Plugin audio_keepalive is not enabled Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "mpdoutput"... Oct 15 15:15:24 volumio-kojot volumio[22564]: Forking 3 albumart workers Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "80s80s"... Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Applying required configuration parameters for plugin 80s80s Oct 15 15:15:24 volumio-kojot volumio[22496]: info: [1792070124918] [80s80s] API delay: 2 Oct 15 15:15:24 volumio-kojot volumio[22496]: info: Loading plugin "controradio"... Oct 15 15:15:25 volumio-kojot volumio[22574]: Starting albumart workers Oct 15 15:15:25 volumio-kojot volumio[22576]: Starting albumart workers Oct 15 15:15:25 volumio-kojot volumio[22575]: Starting albumart workers Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Applying required configuration parameters for plugin controradio Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Loading plugin "motherearthradio"... Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Loading plugin "rad357pl"... Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Applying required configuration parameters for plugin rad357pl Oct 15 15:15:25 volumio-kojot volumio[22496]: info: [1792070125123] [rad357pl] API delay: 5 Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Loading plugin "radio_browser"... Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Loading plugin "Systeminfo"... Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Plugin httpcaller is not enabled Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Loading plugin "lastfm"... Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Loading plugin "litgui"... Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Loading i18n strings for locale pl Oct 15 15:15:25 volumio-kojot volumio[22496]: Updating browse sources language Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::initPlayerControls Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: Express server listening on port 3000 Oct 15 15:15:25 volumio-kojot volumio[22496]: [Metrics] WebUI: 2s 235.83ms Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Setting Device type: x86 Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreStateMachine::resetVolumioState Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreStateMachine::getcurrentVolume Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 15:15:25 volumio-kojot volumio[22496]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Completed loading Core Plugins Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Preparing to generate the ALSA configuration file Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Volumio Network Manager: Network status updated: 1 Oct 15 15:15:25 volumio-kojot volumio[22496]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 15 15:15:25 volumio-kojot volumio[22496]: wlan0 Interface doesn't support scanning. Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Cannot use regular scanning, forcing with ap-force Oct 15 15:15:25 volumio-kojot sudo[22628]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 15 15:15:25 volumio-kojot sudo[22628]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 15:15:25 volumio-kojot sudo[22628]: pam_unix(sudo:session): session closed for user root Oct 15 15:15:25 volumio-kojot volumio[22496]: command failed: No such device (-19) Oct 15 15:15:25 volumio-kojot volumio[22496]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 15 15:15:25 volumio-kojot volumio[22496]: command failed: No such device (-19) Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 15 15:15:25 volumio-kojot volumio[22496]: info: VolumeController:: Volume=100 Mute =false Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreStateMachine::pushState Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::volumioPushState Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreStateMachine::updateTrackBlock Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CorePlayQueue::getTrackBlock Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CURURI: playlists Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Listing playlists Oct 15 15:15:25 volumio-kojot volumio[22496]: info: Reloading queue from file Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreStateMachine::setRepeat false single undefined Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreStateMachine::pushState Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::volumioPushState Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreStateMachine::setRandom null Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreStateMachine::pushState Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CorePlayQueue::getTrack 0 Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::volumioPushState Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 15:15:25 volumio-kojot volumio[22496]: info: CURURI: albums:// Oct 15 15:15:25 volumio-kojot volumio[22496]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:15:25 volumio-kojot volumio[22496]: TypeError: Cannot read properties of undefined (reading 'sendCommand') Oct 15 15:15:25 volumio-kojot volumio[22496]: at /volumio/app/plugins/music_service/mpd/index.js:3000:22 Oct 15 15:15:25 volumio-kojot volumio[22496]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 15 15:15:25 volumio-kojot volumio[22496]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:15:25 volumio-kojot sudo[22653]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 15:14' Oct 15 15:15:25 volumio-kojot sudo[22653]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"