-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2026-01-13 19:04:54 CET. --
Jan 13 19:03:28 volumio volumio[980]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/randomizer/volumio/buster/armhf
Jan 13 19:03:29 volumio volumio[980]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/randomizer/volumio/buster/armhf
Jan 13 19:03:29 volumio volumio[980]: info: Folder /tmp/plugins removed
Jan 13 19:03:30 volumio volumio[980]: info: Check plugin dependencies
Jan 13 19:03:30 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 13 19:03:30 volumio volumio[980]: info: Checking if plugin already exists
Jan 13 19:03:30 volumio volumio[980]: info: Rename folder
Jan 13 19:03:30 volumio volumio[980]: info: Folder /tmp/downloaded_plugin.zip removed
Jan 13 19:03:30 volumio volumio[980]: info: Move to category
Jan 13 19:03:32 volumio volumio[980]: info: Checking if install.sh is present
Jan 13 19:03:32 volumio volumio[980]: info: Executing install.sh
Jan 13 19:03:32 volumio sudo[3102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/randomizer/install.sh
Jan 13 19:03:32 volumio sudo[3102]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:03:32 volumio volumio[980]: info: Installing randomizer Dependencies
Jan 13 19:03:32 volumio sudo[3102]: pam_unix(sudo:session): session closed for user root
Jan 13 19:03:32 volumio volumio[980]: Plugin install end detected on script
Jan 13 19:03:32 volumio volumio[980]: info: Install script completed
Jan 13 19:03:32 volumio volumio[980]: info: Adding reference to registry
Jan 13 19:03:32 volumio volumio[980]: info: Done installing plugin.
Jan 13 19:03:32 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 13 19:03:32 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jan 13 19:03:32 volumio volumio[980]: info: Folder /tmp/plugins removed
Jan 13 19:03:32 volumio volumio[980]: info: Folder /tmp/downloaded_plugin.zip removed
Jan 13 19:03:32 volumio volumio[980]: info: Folder /data/temp removed
Jan 13 19:03:34 volumio volumio[980]: info: Enabling plugin randomizer
Jan 13 19:03:34 volumio volumio[980]: info: Loading plugin "randomizer"...
Jan 13 19:03:35 volumio volumio[980]: info: PLUGIN START: randomizer
Jan 13 19:03:35 volumio volumio[980]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 13 19:03:35 volumio volumio[980]: info: [1768327415296] CoreMusicLibrary::Adding element Randomizer
Jan 13 19:03:35 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 13 19:03:35 volumio volumio[980]: Cannot find translation for source YouTube2
Jan 13 19:03:35 volumio volumio[980]: Cannot find translation for source Randomizer
Jan 13 19:03:35 volumio volumio[980]: info: Done.
Jan 13 19:03:35 volumio volumio[980]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12
Jan 13 19:03:36 volumio volumio[980]: info: Enabling plugin randomizer
Jan 13 19:03:36 volumio volumio[980]: info: Loading plugin "randomizer"...
Jan 13 19:03:36 volumio volumio[980]: info: Applying required configuration parameters for plugin randomizer
Jan 13 19:03:36 volumio volumio[980]: info: PLUGIN START: randomizer
Jan 13 19:03:36 volumio volumio[980]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 13 19:03:36 volumio volumio[980]: info: [1768327416584] CoreMusicLibrary::Adding element Randomizer
Jan 13 19:03:36 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 13 19:03:36 volumio volumio[980]: Cannot find translation for source YouTube2
Jan 13 19:03:36 volumio volumio[980]: Cannot find translation for source Randomizer
Jan 13 19:03:36 volumio volumio[980]: info: Done.
Jan 13 19:03:36 volumio volumio[980]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13
Jan 13 19:03:38 volumio volumio[980]: info: Enabling plugin randomizer
Jan 13 19:03:38 volumio volumio[980]: info: Loading plugin "randomizer"...
Jan 13 19:03:38 volumio volumio[980]: info: Applying required configuration parameters for plugin randomizer
Jan 13 19:03:38 volumio volumio[980]: info: PLUGIN START: randomizer
Jan 13 19:03:38 volumio volumio[980]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 13 19:03:38 volumio volumio[980]: info: [1768327418995] CoreMusicLibrary::Adding element Randomizer
Jan 13 19:03:38 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 13 19:03:38 volumio volumio[980]: Cannot find translation for source YouTube2
Jan 13 19:03:38 volumio volumio[980]: Cannot find translation for source Randomizer
Jan 13 19:03:39 volumio volumio[980]: info: Done.
Jan 13 19:03:39 volumio volumio[980]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14
Jan 13 19:03:54 volumio volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 13 19:04:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 13 19:04:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jan 13 19:04:39 volumio volumio[980]: info: CoreCommandRouter::volumioGetState
Jan 13 19:04:39 volumio volumio[980]: info: CorePlayQueue::getTrack 0
Jan 13 19:04:44 volumio volumio[980]: info: CoreCommandRouter::volumioGetQueue
Jan 13 19:04:44 volumio volumio[980]: info: CoreStateMachine::getQueue
Jan 13 19:04:44 volumio volumio[980]: info: CorePlayQueue::getQueue
Jan 13 19:04:45 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 13 19:04:45 volumio volumio[980]: info: CURURI: music-library
Jan 13 19:04:46 volumio volumio[980]: info: Preload queue cleared
Jan 13 19:04:47 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 13 19:04:47 volumio volumio[980]: info: CURURI: music-library/USB
Jan 13 19:04:48 volumio volumio[980]: info: Preload queue cleared
Jan 13 19:04:48 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 13 19:04:48 volumio volumio[980]: info: CURURI: music-library/USB/NEW
Jan 13 19:04:48 volumio volumio[980]: info: Preload queue cleared
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/A Kind Of Magic.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Another One Bites The Dust.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Bijou.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Breakthru.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Flash´s Theme.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Friends will be Friends.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Headlong.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/I Wan´t To Break Free.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/I Was Born To Love You.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Innuendo.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/One Vision.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Radio Gaga.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Somebody To Love.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/The Invisible Man.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Barcelona (Freddie Mercury & Montserrat Caballé).mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/01 tu jardin con enanitos.mp3
Jan 13 19:04:48 volumio volumio[980]: info: Preloading song: music-library/USB/NEW/Living On My Own(Extended Mix).mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/A Kind Of Magic.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FA%20Kind%20Of%20Magic.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/A Kind Of Magic.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Another One Bites The Dust.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FAnother%20One%20Bites%20The%20Dust.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Another One Bites The Dust.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Bijou.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FBijou.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Bijou.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Breakthru.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FBreakthru.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Breakthru.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Flash´s Theme.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FFlash%C2%B4s%20Theme.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Flash´s Theme.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Friends will be Friends.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FFriends%20will%20be%20Friends.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Friends will be Friends.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Headlong.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FHeadlong.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Headlong.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/I Wan´t To Break Free.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FI%20Wan%C2%B4t%20To%20Break%20Free.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/I Wan´t To Break Free.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/I Was Born To Love You.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FI%20Was%20Born%20To%20Love%20You.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/I Was Born To Love You.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Innuendo.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FInnuendo.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Innuendo.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/One Vision.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FOne%20Vision.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/One Vision.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Radio Gaga.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FRadio%20Gaga.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Radio Gaga.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Somebody To Love.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FSomebody%20To%20Love.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Somebody To Love.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/The Invisible Man.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=//extralarge&path=%2Fmnt%2FUSB%2FNEW%2FThe%20Invisible%20Man.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/The Invisible Man.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Barcelona (Freddie Mercury & Montserrat Caballé).mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=Queen/Greatest%20Hits%20III/extralarge&path=%2Fmnt%2FUSB%2FNEW%2FBarcelona%20(Freddie%20Mercury%20%26%20Montserrat%20Caball%C3%A9).mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Barcelona (Freddie Mercury & Montserrat Caballé).mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/01 tu jardin con enanitos.mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=Melendi/Lagrimas%20Desordenadas/extralarge&path=%2Fmnt%2FUSB%2FNEW%2F01%20tu%20jardin%20con%20enanitos.mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/01 tu jardin con enanitos.mp3
Jan 13 19:04:49 volumio volumio[980]: info: Exploding uri music-library/USB/NEW/Living On My Own(Extended Mix).mp3 in service mpd
Jan 13 19:04:49 volumio volumio[980]: info: ALBUMART /albumart?cacheid=190&web=Freddy%20Mercury%20(Queen)/Untitled%20-%20New%20CD%20(11)/extralarge&path=%2Fmnt%2FUSB%2FNEW%2FLiving%20On%20My%20Own(Extended%20Mix).mp3&metadata=false
Jan 13 19:04:49 volumio volumio[980]: info: URI /mnt/USB/NEW/Living On My Own(Extended Mix).mp3
Jan 13 19:04:51 volumio volumio[980]: info: Preload queue cleared
Jan 13 19:04:51 volumio volumio[980]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::ClearQueue
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::stop
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::clearPlayQueue
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::saveQueue
Jan 13 19:04:51 volumio volumio[980]: info: CoreCommandRouter::volumioPushQueue
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::addQueueItems
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::addQueueItems
Jan 13 19:04:51 volumio volumio[980]: info: Preload queue cleared
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/A Kind Of Magic.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/A Kind Of Magic.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Another One Bites The Dust.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Another One Bites The Dust.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Bijou.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Bijou.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Breakthru.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Breakthru.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Flash´s Theme.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Flash´s Theme.mp3
Jan 13 19:04:51 volumio volumio[980]: info: CoreCommandRouter::volumioPushQueue
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::saveQueue
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::getTrackBlock
Jan 13 19:04:51 volumio volumio[980]: info: CoreCommandRouter::volumioPlay
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::play index 4
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::addQueueItems
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::addQueueItems
Jan 13 19:04:51 volumio volumio[980]: info: Preload queue cleared
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Friends will be Friends.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Friends will be Friends.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Headlong.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Headlong.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/I Wan´t To Break Free.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/I Wan´t To Break Free.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/I Was Born To Love You.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/I Was Born To Love You.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Innuendo.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Innuendo.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/One Vision.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/One Vision.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Radio Gaga.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Radio Gaga.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Somebody To Love.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Somebody To Love.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/The Invisible Man.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/The Invisible Man.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Barcelona (Freddie Mercury & Montserrat Caballé).mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Barcelona (Freddie Mercury & Montserrat Caballé).mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/01 tu jardin con enanitos.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/01 tu jardin con enanitos.mp3
Jan 13 19:04:51 volumio volumio[980]: info: Adding Item to queue: music-library/USB/NEW/Living On My Own(Extended Mix).mp3
Jan 13 19:04:51 volumio volumio[980]: info: Using cached record of: music-library/USB/NEW/Living On My Own(Extended Mix).mp3
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::stop
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 13 19:04:51 volumio volumio[980]: info: CoreCommandRouter::volumioPushQueue
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::saveQueue
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::play index undefined
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::getTrackBlock
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:51 volumio volumio[980]: info: CoreStateMachine::startPlaybackTimer
Jan 13 19:04:51 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::clearAddPlayTracks USB/NEW/Flash´s Theme.mp3
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand stop
Jan 13 19:04:51 volumio volumio[980]: info: sendMpdCommand stop took 23 milliseconds
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand clear
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces system playlist update
Jan 13 19:04:51 volumio volumio[980]: info: Ignoring MPD Status Update
Jan 13 19:04:51 volumio volumio[980]: info: sendMpdCommand clear took 4 milliseconds
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand add "USB/NEW/Flash´s Theme.mp3"
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces system playlist update
Jan 13 19:04:51 volumio volumio[980]: info: Ignoring MPD Status Update
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces system playlist update
Jan 13 19:04:51 volumio volumio[980]: info: Ignoring MPD Status Update
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces system playlist update
Jan 13 19:04:51 volumio volumio[980]: info: Ignoring MPD Status Update
Jan 13 19:04:51 volumio volumio[980]: error: updateQueue error: null
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces system playlist update
Jan 13 19:04:51 volumio volumio[980]: info: Ignoring MPD Status Update
Jan 13 19:04:51 volumio volumio[980]: info: ------------------------------ 13ms
Jan 13 19:04:51 volumio volumio[980]: info: sendMpdCommand add "USB/NEW/Flash´s Theme.mp3" took 10 milliseconds
Jan 13 19:04:51 volumio volumio[980]: info: ------------------------------ 9ms
Jan 13 19:04:51 volumio volumio[980]: info: ------------------------------ 8ms
Jan 13 19:04:51 volumio volumio[980]: info: ------------------------------ 7ms
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand play
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces system playlist update
Jan 13 19:04:51 volumio volumio[980]: info: Ignoring MPD Status Update
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces system playlist update
Jan 13 19:04:51 volumio volumio[980]: info: Ignoring MPD Status Update
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces system playlist update
Jan 13 19:04:51 volumio volumio[980]: info: Ignoring MPD Status Update
Jan 13 19:04:51 volumio volumio[980]: error: Upnp client error: Error: This socket has been ended by the other party
Jan 13 19:04:51 volumio volumio[980]: info: ------------------------------ 13ms
Jan 13 19:04:51 volumio volumio[980]: info: sendMpdCommand play took 9 milliseconds
Jan 13 19:04:51 volumio volumio[980]: info: ------------------------------ 8ms
Jan 13 19:04:51 volumio volumio[980]: info: ------------------------------ 8ms
Jan 13 19:04:51 volumio volumio[980]: info: ------------------------------ 6ms
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces state update: player
Jan 13 19:04:51 volumio volumio[980]: info: ControllerMpd::getState
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces state update: player
Jan 13 19:04:51 volumio volumio[980]: info: ControllerMpd::getState
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces state update: player
Jan 13 19:04:51 volumio volumio[980]: info: ControllerMpd::getState
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status
Jan 13 19:04:51 volumio volumio[980]: info:
Jan 13 19:04:51 volumio volumio[980]: ---------------------------- MPD announces state update: player
Jan 13 19:04:51 volumio volumio[980]: info: ControllerMpd::getState
Jan 13 19:04:51 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand status took 792 milliseconds
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 13 19:04:52 volumio volumio[980]: info:
Jan 13 19:04:52 volumio volumio[980]: ---------------------------- MPD announces state update: player
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::getState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status
Jan 13 19:04:52 volumio volumio[980]: info:
Jan 13 19:04:52 volumio volumio[980]: ---------------------------- MPD announces state update: player
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::getState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status
Jan 13 19:04:52 volumio volumio[980]: info:
Jan 13 19:04:52 volumio volumio[980]: ---------------------------- MPD announces state update: player
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::getState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status
Jan 13 19:04:52 volumio volumio[980]: info:
Jan 13 19:04:52 volumio volumio[980]: ---------------------------- MPD announces state update: player
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::getState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand status took 804 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand status took 803 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand status took 801 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand status took 8 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand status took 7 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand status took 5 milliseconds
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseTrackInfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::servicePushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Flash´s Theme.mp3","artist":null,"album":null,"uri":"USB/NEW/Flash´s Theme.mp3","trackType":"mp3"}
Jan 13 19:04:52 volumio volumio[980]: verbose: CURRENT POSITION 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState stateService play
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop
Jan 13 19:04:52 volumio volumio[980]: info: ------------------------------ 826ms
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand status took 19 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseState
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseTrackInfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseTrackInfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseTrackInfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseTrackInfo
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseTrackInfo
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::servicePushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Flash´s Theme.mp3","artist":null,"album":null,"uri":"USB/NEW/Flash´s Theme.mp3","trackType":"mp3"}
Jan 13 19:04:52 volumio volumio[980]: verbose: CURRENT POSITION 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState stateService play
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play
Jan 13 19:04:52 volumio volumio[980]: info: Received an update from plugin. extracting info from payload
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::servicePushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Flash´s Theme.mp3","artist":null,"album":null,"uri":"USB/NEW/Flash´s Theme.mp3","trackType":"mp3"}
Jan 13 19:04:52 volumio volumio[980]: verbose: CURRENT POSITION 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState stateService play
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play
Jan 13 19:04:52 volumio volumio[980]: info: Received an update from plugin. extracting info from payload
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::servicePushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Flash´s Theme.mp3","artist":null,"album":null,"uri":"USB/NEW/Flash´s Theme.mp3","trackType":"mp3"}
Jan 13 19:04:52 volumio volumio[980]: verbose: CURRENT POSITION 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState stateService play
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play
Jan 13 19:04:52 volumio volumio[980]: info: Received an update from plugin. extracting info from payload
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::servicePushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Flash´s Theme.mp3","artist":null,"album":null,"uri":"USB/NEW/Flash´s Theme.mp3","trackType":"mp3"}
Jan 13 19:04:52 volumio volumio[980]: verbose: CURRENT POSITION 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState stateService play
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play
Jan 13 19:04:52 volumio volumio[980]: info: Received an update from plugin. extracting info from payload
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::servicePushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Flash´s Theme.mp3","artist":null,"album":null,"uri":"USB/NEW/Flash´s Theme.mp3","trackType":"mp3"}
Jan 13 19:04:52 volumio volumio[980]: verbose: CURRENT POSITION 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState stateService play
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play
Jan 13 19:04:52 volumio volumio[980]: info: Received an update from plugin. extracting info from payload
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::servicePushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Flash´s Theme.mp3","artist":null,"album":null,"uri":"USB/NEW/Flash´s Theme.mp3","trackType":"mp3"}
Jan 13 19:04:52 volumio volumio[980]: verbose: CURRENT POSITION 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState stateService play
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play
Jan 13 19:04:52 volumio volumio[980]: info: Received an update from plugin. extracting info from payload
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:52 volumio volumio[980]: info: ------------------------------ 1195ms
Jan 13 19:04:52 volumio volumio[980]: info: ------------------------------ 1195ms
Jan 13 19:04:52 volumio volumio[980]: info: ------------------------------ 1197ms
Jan 13 19:04:52 volumio volumio[980]: info: ------------------------------ 406ms
Jan 13 19:04:52 volumio volumio[980]: info: ------------------------------ 418ms
Jan 13 19:04:52 volumio volumio[980]: info: ------------------------------ 418ms
Jan 13 19:04:52 volumio volumio[980]: info: sendMpdCommand playlistinfo took 398 milliseconds
Jan 13 19:04:52 volumio volumio[980]: verbose: ControllerMpd::parseTrackInfo
Jan 13 19:04:52 volumio volumio[980]: info: ControllerMpd::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::servicePushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Flash´s Theme.mp3","artist":null,"album":null,"uri":"USB/NEW/Flash´s Theme.mp3","trackType":"mp3"}
Jan 13 19:04:52 volumio volumio[980]: verbose: CURRENT POSITION 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState stateService play
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play
Jan 13 19:04:52 volumio volumio[980]: info: Received an update from plugin. extracting info from payload
Jan 13 19:04:52 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:52 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:52 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:53 volumio volumio[980]: info: CoreStateMachine::pushState
Jan 13 19:04:53 volumio volumio[980]: info: CorePlayQueue::getTrack 4
Jan 13 19:04:53 volumio volumio[980]: info: CoreCommandRouter::volumioPushState
Jan 13 19:04:53 volumio volumio[980]: info: ------------------------------ 492ms
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio sudo[3293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3293]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio sudo[3286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3286]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio sudo[3288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3288]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio sudo[3291]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio sudo[3295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3295]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio sudo[3301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3301]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio sudo[3305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio sudo[3308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3308]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio sudo[3312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3312]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio sudo[3315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3315]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio sudo[3318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3318]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio systemd[1]: Started peppymeterbasic Daemon.
Jan 13 19:04:53 volumio sudo[3295]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3293]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3291]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3286]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3288]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio sudo[3301]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio volumio[980]: info: PeppyMeterBasic ---peppymeterbasic status play
Jan 13 19:04:53 volumio sudo[3322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3322]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio sudo[3324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio sudo[3324]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio sudo[3328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Jan 13 19:04:53 volumio volumio[980]: info: [ASDebug] CurState: play PrevState: stop
Jan 13 19:04:53 volumio volumio[980]: info: [ASDebug] Togle GPIO: ON
Jan 13 19:04:53 volumio sudo[3328]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 13 19:04:53 volumio volumio[980]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 13 19:04:53 volumio sudo[3322]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3308]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3305]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3315]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3312]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio volumio[980]: Error: ESPIPE: invalid seek, write
Jan 13 19:04:53 volumio volumio[980]: at Object.writeSync (fs.js:711:3)
Jan 13 19:04:53 volumio volumio[980]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8)
Jan 13 19:04:53 volumio volumio[980]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:207:23)
Jan 13 19:04:53 volumio volumio[980]: at AmpSwitchController.parseStatus (/data/plugins/system_controller/ampswitch/index.js:190:86)
Jan 13 19:04:53 volumio volumio[980]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Jan 13 19:04:53 volumio volumio[980]: at Socket.onevent (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:278:10)
Jan 13 19:04:53 volumio volumio[980]: at Socket.onpacket (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:236:12)
Jan 13 19:04:53 volumio volumio[980]: at Manager. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Jan 13 19:04:53 volumio volumio[980]: at Manager.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Jan 13 19:04:53 volumio volumio[980]: at Manager.ondecoded (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:349:8)
Jan 13 19:04:53 volumio volumio[980]: at Decoder. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Jan 13 19:04:53 volumio volumio[980]: at Decoder.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Jan 13 19:04:53 volumio volumio[980]: at Decoder.add (/data/plugins/system_controller/ampswitch/node_modules/socket.io-parser/index.js:254:12)
Jan 13 19:04:53 volumio volumio[980]: at Manager.ondata (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:339:16)
Jan 13 19:04:53 volumio volumio[980]: at Socket. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Jan 13 19:04:53 volumio volumio[980]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) {
Jan 13 19:04:53 volumio volumio[980]: errno: -29,
Jan 13 19:04:53 volumio volumio[980]: syscall: 'write',
Jan 13 19:04:53 volumio volumio[980]: code: 'ESPIPE'
Jan 13 19:04:53 volumio volumio[980]: }
Jan 13 19:04:53 volumio sudo[3318]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio volumio[980]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 13 19:04:53 volumio sudo[3324]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:53 volumio sudo[3328]: pam_unix(sudo:session): session closed for user root
Jan 13 19:04:54 volumio sudo[3339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-13 19:03
Jan 13 19:04:54 volumio sudo[3339]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"