-- Logs begin at Sat 2026-01-10 19:20:49 UTC, end at Sat 2026-01-10 21:08:10 UTC. -- Jan 10 21:07:05 pfxmusic volumio[16713]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jan 10 21:07:05 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 21:07:05 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 21:07:05 pfxmusic volumio[16713]: info: Fetching Streaming Services browse cache Jan 10 21:07:06 pfxmusic sudo[16982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 10 21:07:06 pfxmusic sudo[16982]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 21:07:06 pfxmusic sudo[16986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 10 21:07:06 pfxmusic sudo[16982]: pam_unix(sudo:session): session closed for user root Jan 10 21:07:06 pfxmusic sudo[16986]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 21:07:06 pfxmusic sudo[16986]: pam_unix(sudo:session): session closed for user root Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioGetVisibleSources Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioGetState Jan 10 21:07:07 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioGetQueue Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreStateMachine::getQueue Jan 10 21:07:07 pfxmusic volumio[16713]: info: CorePlayQueue::getQueue Jan 10 21:07:07 pfxmusic volumio[16713]: info: Listing playlists Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 10 21:07:07 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 10 21:07:08 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 21:07:08 pfxmusic volumio[16713]: info: CURURI: artists:// Jan 10 21:07:09 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 10 21:07:13 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jan 10 21:07:13 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand update Jan 10 21:07:29 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 21:07:29 pfxmusic volumio[16713]: info: CURURI: genres:// Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::ClearQueue Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::stop Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 21:07:35 pfxmusic volumio[16713]: UNSET VOLATILE Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::clearPlayQueue Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::saveQueue Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushQueue Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::addQueueItems Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::addQueueItems Jan 10 21:07:35 pfxmusic volumio[16713]: info: Adding Item to queue: genres://Dancehall Jan 10 21:07:35 pfxmusic volumio[16713]: info: Exploding uri genres://Dancehall in service mpd Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::saveQueue Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushQueue Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::updateTrackBlock Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::getTrackBlock Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPlay Jan 10 21:07:35 pfxmusic volumio[16713]: UNSET VOLATILE Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::play index 0 Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::stop Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 21:07:35 pfxmusic volumio[16713]: UNSET VOLATILE Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::play index undefined Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::startPlaybackTimer Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::clearAddPlayTracks NAS/truenas_music/Macka Diamond - Tek Con (Tunda Clap Riddim).mp3 Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 21:07:35 pfxmusic volumio[16713]: info: sendMpdCommand stop took 8 milliseconds Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand clear Jan 10 21:07:35 pfxmusic volumio[16713]: info: Jan 10 21:07:35 pfxmusic volumio[16713]: ---------------------------- MPD announces system playlist update Jan 10 21:07:35 pfxmusic volumio[16713]: info: Ignoring MPD Status Update Jan 10 21:07:35 pfxmusic volumio[16713]: info: sendMpdCommand clear took 11 milliseconds Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand add "NAS/truenas_music/Macka Diamond - Tek Con (Tunda Clap Riddim).mp3" Jan 10 21:07:35 pfxmusic volumio[16713]: error: updateQueue error: null Jan 10 21:07:35 pfxmusic volumio[16713]: info: ------------------------------ 12ms Jan 10 21:07:35 pfxmusic volumio[16713]: info: Jan 10 21:07:35 pfxmusic volumio[16713]: ---------------------------- MPD announces system playlist update Jan 10 21:07:35 pfxmusic volumio[16713]: info: Ignoring MPD Status Update Jan 10 21:07:35 pfxmusic volumio[16713]: info: sendMpdCommand add "NAS/truenas_music/Macka Diamond - Tek Con (Tunda Clap Riddim).mp3" took 30 milliseconds Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand play Jan 10 21:07:35 pfxmusic volumio[16713]: info: ------------------------------ 11ms Jan 10 21:07:35 pfxmusic volumio[16713]: info: sendMpdCommand play took 8 milliseconds Jan 10 21:07:35 pfxmusic volumio[16713]: info: Jan 10 21:07:35 pfxmusic volumio[16713]: ---------------------------- MPD announces state update: player Jan 10 21:07:35 pfxmusic volumio[16713]: info: ControllerMpd::getState Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand status Jan 10 21:07:35 pfxmusic volumio[16713]: info: Jan 10 21:07:35 pfxmusic volumio[16713]: ---------------------------- MPD announces state update: player Jan 10 21:07:35 pfxmusic volumio[16713]: info: ControllerMpd::getState Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand status Jan 10 21:07:35 pfxmusic volumio[16713]: info: sendMpdCommand status took 6 milliseconds Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::parseState Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 21:07:35 pfxmusic volumio[16713]: info: sendMpdCommand status took 14 milliseconds Jan 10 21:07:35 pfxmusic volumio[16713]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::parseState Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::parseTrackInfo Jan 10 21:07:35 pfxmusic volumio[16713]: info: ControllerMpd::pushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::servicePushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":123,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tek Con","artist":"Macka Diamond","album":"Tunda Clap Riddim","uri":"NAS/truenas_music/Macka Diamond - Tek Con (Tunda Clap Riddim).mp3","trackType":"mp3"} Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: CURRENT POSITION 0 Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::syncState stateService play Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::syncState currentStatus stop Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:35 pfxmusic volumio[16713]: info: ------------------------------ 65ms Jan 10 21:07:35 pfxmusic volumio[16713]: info: sendMpdCommand playlistinfo took 40 milliseconds Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: ControllerMpd::parseTrackInfo Jan 10 21:07:35 pfxmusic volumio[16713]: info: ControllerMpd::pushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::servicePushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":123,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tek Con","artist":"Macka Diamond","album":"Tunda Clap Riddim","uri":"NAS/truenas_music/Macka Diamond - Tek Con (Tunda Clap Riddim).mp3","trackType":"mp3"} Jan 10 21:07:35 pfxmusic volumio[16713]: verbose: CURRENT POSITION 0 Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::syncState stateService play Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::syncState currentStatus play Jan 10 21:07:35 pfxmusic volumio[16713]: info: Received an update from plugin. extracting info from payload Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:35 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:35 pfxmusic volumio[16713]: info: ------------------------------ 110ms Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioSeek Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreStateMachine::seek Jan 10 21:07:41 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:41 pfxmusic volumio[16713]: info: TRACKBLOCK {"uri":"music-library/NAS/truenas_music/Macka Diamond - Tek Con (Tunda Clap Riddim).mp3","service":"mpd","name":"Tek Con","artist":"Macka Diamond","album":"Tunda Clap Riddim","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=817&web=Macka%20Diamond/Tunda%20Clap%20Riddim/large&path=%2Fmnt%2FNAS%2Ftruenas_music&metadata=false","duration":123,"trackType":"mp3","samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2} Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreStateMachine::startPlaybackTimer Jan 10 21:07:41 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:41 pfxmusic volumio[16713]: info: ControllerMpd::seek Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:41 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:41 pfxmusic volumio[16713]: error: null Jan 10 21:07:41 pfxmusic volumio[16713]: info: Jan 10 21:07:41 pfxmusic volumio[16713]: ---------------------------- MPD announces state update: player Jan 10 21:07:41 pfxmusic volumio[16713]: info: ControllerMpd::getState Jan 10 21:07:41 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand status Jan 10 21:07:41 pfxmusic volumio[16713]: info: sendMpdCommand status took 1 milliseconds Jan 10 21:07:41 pfxmusic volumio[16713]: verbose: ControllerMpd::parseState Jan 10 21:07:41 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 21:07:41 pfxmusic volumio[16713]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 10 21:07:41 pfxmusic volumio[16713]: verbose: ControllerMpd::parseTrackInfo Jan 10 21:07:41 pfxmusic volumio[16713]: info: ControllerMpd::pushState Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreCommandRouter::servicePushState Jan 10 21:07:41 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:41 pfxmusic volumio[16713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":62000,"duration":123,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tek Con","artist":"Macka Diamond","album":"Tunda Clap Riddim","uri":"NAS/truenas_music/Macka Diamond - Tek Con (Tunda Clap Riddim).mp3","trackType":"mp3"} Jan 10 21:07:41 pfxmusic volumio[16713]: verbose: CURRENT POSITION 0 Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreStateMachine::syncState stateService play Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreStateMachine::syncState currentStatus play Jan 10 21:07:41 pfxmusic volumio[16713]: info: Received an update from plugin. extracting info from payload Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:41 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:41 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:41 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:41 pfxmusic volumio[16713]: info: ------------------------------ 40ms Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioNext Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreStateMachine::next Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreStateMachine::stop Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 21:07:42 pfxmusic volumio[16713]: UNSET VOLATILE Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreStateMachine::stPlaybackTimer Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreStateMachine::updateTrackBlock Jan 10 21:07:42 pfxmusic volumio[16713]: info: CorePlayQueue::getTrackBlock Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:42 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreStateMachine::serviceStop Jan 10 21:07:42 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 0 Jan 10 21:07:42 pfxmusic volumio[16713]: info: CoreCommandRouter::serviceStop Jan 10 21:07:42 pfxmusic volumio[16713]: info: ControllerMpd::stop Jan 10 21:07:42 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand stop took 53 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::play index undefined Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 21:07:43 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 2 Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::startPlaybackTimer Jan 10 21:07:43 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 2 Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::clearAddPlayTracks NAS/truenas_music/Jul 01 2006/pinchers - Up Close Riddim.mp3 Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::updateTrackBlock Jan 10 21:07:43 pfxmusic volumio[16713]: info: CorePlayQueue::getTrackBlock Jan 10 21:07:43 pfxmusic volumio[16713]: info: Jan 10 21:07:43 pfxmusic volumio[16713]: ---------------------------- MPD announces state update: player Jan 10 21:07:43 pfxmusic volumio[16713]: info: ControllerMpd::getState Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand status Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand stop took 21 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand clear Jan 10 21:07:43 pfxmusic volumio[16713]: info: Jan 10 21:07:43 pfxmusic volumio[16713]: ---------------------------- MPD announces system playlist update Jan 10 21:07:43 pfxmusic volumio[16713]: info: Ignoring MPD Status Update Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand status took 10 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand clear took 8 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::parseState Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand add "NAS/truenas_music/Jul 01 2006/pinchers - Up Close Riddim.mp3" Jan 10 21:07:43 pfxmusic volumio[16713]: error: updateQueue error: null Jan 10 21:07:43 pfxmusic volumio[16713]: info: ------------------------------ 11ms Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand add "NAS/truenas_music/Jul 01 2006/pinchers - Up Close Riddim.mp3" took 6 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::parseTrackInfo Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand play Jan 10 21:07:43 pfxmusic volumio[16713]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 10 21:07:43 pfxmusic volumio[16713]: info: ------------------------------ 39ms Jan 10 21:07:43 pfxmusic volumio[16713]: info: Jan 10 21:07:43 pfxmusic volumio[16713]: ---------------------------- MPD announces system playlist update Jan 10 21:07:43 pfxmusic volumio[16713]: info: Ignoring MPD Status Update Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand play took 6 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: info: ------------------------------ 5ms Jan 10 21:07:43 pfxmusic volumio[16713]: info: Jan 10 21:07:43 pfxmusic volumio[16713]: ---------------------------- MPD announces state update: player Jan 10 21:07:43 pfxmusic volumio[16713]: info: ControllerMpd::getState Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand status Jan 10 21:07:43 pfxmusic volumio[16713]: info: Jan 10 21:07:43 pfxmusic volumio[16713]: ---------------------------- MPD announces state update: player Jan 10 21:07:43 pfxmusic volumio[16713]: info: ControllerMpd::getState Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand status Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand status took 5 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::parseState Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand status took 18 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand playlistinfo took 16 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::parseState Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::parseTrackInfo Jan 10 21:07:43 pfxmusic volumio[16713]: info: ControllerMpd::pushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreCommandRouter::servicePushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 2 Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":230,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"pinchers - Up Close Riddim.mp3","artist":"pinchers","album":"Up close Riddim","uri":"NAS/truenas_music/Jul 01 2006/pinchers - Up Close Riddim.mp3","trackType":"mp3"} Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: CURRENT POSITION 2 Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::syncState stateService play Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::syncState currentStatus stop Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 2 Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:43 pfxmusic volumio[16713]: info: ------------------------------ 54ms Jan 10 21:07:43 pfxmusic volumio[16713]: info: sendMpdCommand playlistinfo took 26 milliseconds Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: ControllerMpd::parseTrackInfo Jan 10 21:07:43 pfxmusic volumio[16713]: info: ControllerMpd::pushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreCommandRouter::servicePushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 2 Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":230,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"pinchers - Up Close Riddim.mp3","artist":"pinchers","album":"Up close Riddim","uri":"NAS/truenas_music/Jul 01 2006/pinchers - Up Close Riddim.mp3","trackType":"mp3"} Jan 10 21:07:43 pfxmusic volumio[16713]: verbose: CURRENT POSITION 2 Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::syncState stateService play Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::syncState currentStatus play Jan 10 21:07:43 pfxmusic volumio[16713]: info: Received an update from plugin. extracting info from payload Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 2 Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreStateMachine::pushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CorePlayQueue::getTrack 2 Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreCommandRouter::volumioPushState Jan 10 21:07:43 pfxmusic volumio[16713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 21:07:43 pfxmusic volumio[16713]: info: ------------------------------ 85ms Jan 10 21:07:54 pfxmusic volumio[16713]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Freak%20Out/9362d755-da13-4792-98eb-f2d3516ff028.jpg' Jan 10 21:08:08 pfxmusic volumio[16713]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 21:08:08 pfxmusic volumio[16713]: { Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net lastfm.freetls.fastly.net:80 Jan 10 21:08:08 pfxmusic volumio[16713]: at errnoException (dns.js:50:10) Jan 10 21:08:08 pfxmusic volumio[16713]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:92:26) Jan 10 21:08:08 pfxmusic volumio[16713]: code: 'ENOTFOUND', Jan 10 21:08:08 pfxmusic volumio[16713]: errno: 'ENOTFOUND', Jan 10 21:08:08 pfxmusic volumio[16713]: syscall: 'getaddrinfo', Jan 10 21:08:08 pfxmusic volumio[16713]: hostname: 'lastfm.freetls.fastly.net', Jan 10 21:08:08 pfxmusic volumio[16713]: host: 'lastfm.freetls.fastly.net', Jan 10 21:08:08 pfxmusic volumio[16713]: port: 80 } Jan 10 21:08:08 pfxmusic volumio[16713]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 21:08:09 pfxmusic sudo[17152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-10 21:07 Jan 10 21:08:10 pfxmusic sudo[17152]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"