-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2025-12-17 16:27:17 CST. -- Dec 17 16:26:31 volumio volumio[19293]: info: Preload queue cleared Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::ClearQueue Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::stop Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::stPlaybackTimer Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::updateTrackBlock Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrackBlock Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 14 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::serviceStop Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 14 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::serviceStop Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::stop Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand stop Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::clearPlayQueue Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::saveQueue Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushQueue Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::addQueueItems Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::addQueueItems Dec 17 16:26:31 volumio volumio[19293]: info: Preload queue cleared Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-01 Imagine (Remastered).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-01 Imagine (Remastered).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-02 Walk On (Radio Edit).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-02 Walk On (Radio Edit).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-03 Shelter from the Storm.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-03 Shelter from the Storm.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-04 Around the World (Live).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-04 Around the World (Live).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-05 Born This Way (Starsmith Remix).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-05 Born This Way (Starsmith Remix).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-06 Irreplaceable.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-06 Irreplaceable.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-07 Talking to the Moon (Acoustic P.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-07 Talking to the Moon (Acoustic P.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-08 Firework.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-08 Firework.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-09 Only Girl (In the World).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-09 Only Girl (In the World).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-10 Like I Love You.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-10 Like I Love You.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-11 Miles Away (Live).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-11 Miles Away (Live).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-12 When Love Takes Over (feat. Kel.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-12 When Love Takes Over (feat. Kel.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-13 Love the Way You Lie (feat. Rih.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-13 Love the Way You Lie (feat. Rih.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-14 Human Touch.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-14 Human Touch.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-15 Awake (Live).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-15 Awake (Live).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-16 Better Life.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-16 Better Life.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-17 One Tribe.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-17 One Tribe.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-18 Sober.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-18 Sober.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/1-19 It's OK.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/1-19 It's OK.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-01 I Run to You.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-01 I Run to You.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-02 What Do You Got_.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-02 What Do You Got_.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-03 My Hero.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-03 My Hero.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-04 Man On the Moon (Live).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-04 Man On the Moon (Live).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-05 Save Me (Clean Version).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-05 Save Me (Clean Version).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-06 By Your Side.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-06 By Your Side.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-07 Hold On (Radio Mix).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-07 Hold On (Radio Mix).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-08 Pray (Acoustic).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-08 Pray (Acoustic).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-09 Make You Feel My Love.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-09 Make You Feel My Love.m4a Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushQueue Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::saveQueue Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::updateTrackBlock Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrackBlock Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPlay Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::play index 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::addQueueItems Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::addQueueItems Dec 17 16:26:31 volumio volumio[19293]: info: Preload queue cleared Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-10 If I Could Be Where You Are.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-10 If I Could Be Where You Are.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-11 Don't Let the Sun Go Down On Me.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-11 Don't Let the Sun Go Down On Me.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-12 Waiting On the World to Change.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-12 Waiting On the World to Change.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-13 Teo Torriatte (Let Us Cling Tog.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-13 Teo Torriatte (Let Us Cling Tog.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-14 Use Somebody.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-14 Use Somebody.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-15 Fragile (Live In Berlin).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-15 Fragile (Live In Berlin).m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-16 Better In Time.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-16 Better In Time.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-17 One In a Million.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-17 One In a Million.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-18 Whenever, Wherever.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-18 Whenever, Wherever.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Adding Item to queue: music-library/NAS/Songs for Japan/2-19 Sunrise.m4a Dec 17 16:26:31 volumio volumio[19293]: info: Using cached record of: music-library/NAS/Songs for Japan/2-19 Sunrise.m4a Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::stop Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushQueue Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::saveQueue Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::play index undefined Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::updateTrackBlock Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrackBlock Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::startPlaybackTimer Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::clearAddPlayTracks NAS/Songs for Japan/2-09 Make You Feel My Love.m4a Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand stop Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces state update: player Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand stop took 63 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::getState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand status Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand stop took 11 milliseconds Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand clear Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces state update: player Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::getState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand status Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces state update: player Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::getState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand status Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces system playlist update Dec 17 16:26:31 volumio volumio[19293]: info: Ignoring MPD Status Update Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand status took 27 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand clear took 26 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand status took 8 milliseconds Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand add "NAS/Songs for Japan/2-09 Make You Feel My Love.m4a" Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseState Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::servicePushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 17 16:26:31 volumio volumio[19293]: verbose: CURRENT POSITION 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState stateService stop Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState currentStatus stop Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: No code Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 47ms Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces system playlist update Dec 17 16:26:31 volumio volumio[19293]: info: Ignoring MPD Status Update Dec 17 16:26:31 volumio volumio[19293]: info: touch_display: Setting screensaver timeout to 9007199254740991 seconds. Dec 17 16:26:31 volumio volumio[19293]: error: updateQueue error: null Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces system playlist update Dec 17 16:26:31 volumio volumio[19293]: info: Ignoring MPD Status Update Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand status took 48 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 47ms Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand playlistinfo took 46 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand add "NAS/Songs for Japan/2-09 Make You Feel My Love.m4a" took 46 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 6ms Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseTrackInfo Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand play Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::servicePushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 17 16:26:31 volumio volumio[19293]: verbose: CURRENT POSITION 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState stateService stop Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState currentStatus stop Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: No code Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 93ms Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 118ms Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces system playlist update Dec 17 16:26:31 volumio volumio[19293]: info: Ignoring MPD Status Update Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces system playlist update Dec 17 16:26:31 volumio volumio[19293]: info: Ignoring MPD Status Update Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces state update: player Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 78ms Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand play took 74 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 32ms Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 32ms Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::getState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand status Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces state update: player Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::getState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand status Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces system playlist update Dec 17 16:26:31 volumio volumio[19293]: info: Ignoring MPD Status Update Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces state update: player Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::getState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand status Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand status took 6 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand status took 5 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 6ms Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces state update: player Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::getState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand status Dec 17 16:26:31 volumio volumio[19293]: info: Dec 17 16:26:31 volumio volumio[19293]: ---------------------------- MPD announces state update: player Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::getState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand status Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand status took 9 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand status took 6 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand status took 6 milliseconds Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseTrackInfo Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseTrackInfo Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseState Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::servicePushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":212,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"260 Kbps","isStreaming":false,"title":"Make You Feel My Love","artist":"ADELE","album":"Songs for Japan","uri":"NAS/Songs for Japan/2-09 Make You Feel My Love.m4a","trackType":"m4a"} Dec 17 16:26:31 volumio volumio[19293]: verbose: CURRENT POSITION 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState stateService play Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState currentStatus stop Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::servicePushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":212,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"260 Kbps","isStreaming":false,"title":"Make You Feel My Love","artist":"ADELE","album":"Songs for Japan","uri":"NAS/Songs for Japan/2-09 Make You Feel My Love.m4a","trackType":"m4a"} Dec 17 16:26:31 volumio volumio[19293]: verbose: CURRENT POSITION 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState stateService play Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState currentStatus play Dec 17 16:26:31 volumio volumio[19293]: info: Received an update from plugin. extracting info from payload Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 31ms Dec 17 16:26:31 volumio volumio[19293]: info: ------------------------------ 46ms Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand playlistinfo took 45 milliseconds Dec 17 16:26:31 volumio volumio[19293]: info: sendMpdCommand playlistinfo took 45 milliseconds Dec 17 16:26:31 volumio volumio[19293]: verbose: ControllerMpd::parseTrackInfo Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::servicePushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":212,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"260 Kbps","isStreaming":false,"title":"Make You Feel My Love","artist":"ADELE","album":"Songs for Japan","uri":"NAS/Songs for Japan/2-09 Make You Feel My Love.m4a","trackType":"m4a"} Dec 17 16:26:31 volumio volumio[19293]: verbose: CURRENT POSITION 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState stateService play Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState currentStatus play Dec 17 16:26:31 volumio volumio[19293]: info: Received an update from plugin. extracting info from payload Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::servicePushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":212,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"260 Kbps","isStreaming":false,"title":"Make You Feel My Love","artist":"ADELE","album":"Songs for Japan","uri":"NAS/Songs for Japan/2-09 Make You Feel My Love.m4a","trackType":"m4a"} Dec 17 16:26:31 volumio volumio[19293]: verbose: CURRENT POSITION 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState stateService play Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState currentStatus play Dec 17 16:26:31 volumio volumio[19293]: info: Received an update from plugin. extracting info from payload Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: ControllerMpd::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::servicePushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":212,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"260 Kbps","isStreaming":false,"title":"Make You Feel My Love","artist":"ADELE","album":"Songs for Japan","uri":"NAS/Songs for Japan/2-09 Make You Feel My Love.m4a","trackType":"m4a"} Dec 17 16:26:31 volumio volumio[19293]: verbose: CURRENT POSITION 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState stateService play Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::syncState currentStatus play Dec 17 16:26:31 volumio volumio[19293]: info: Received an update from plugin. extracting info from payload Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:31 volumio volumio[19293]: info: CoreStateMachine::pushState Dec 17 16:26:31 volumio volumio[19293]: info: CorePlayQueue::getTrack 27 Dec 17 16:26:31 volumio volumio[19293]: info: CoreCommandRouter::volumioPushState Dec 17 16:26:32 volumio volumio[19293]: info: ------------------------------ 158ms Dec 17 16:26:32 volumio volumio[19293]: info: ------------------------------ 155ms Dec 17 16:26:32 volumio volumio[19293]: info: ------------------------------ 153ms Dec 17 16:27:17 volumio volumio[19293]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 16:27:17 volumio volumio[19293]: Error: connect ETIMEDOUT 199.59.148.201:443 Dec 17 16:27:17 volumio volumio[19293]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Dec 17 16:27:17 volumio volumio[19293]: errno: -110, Dec 17 16:27:17 volumio volumio[19293]: code: 'ETIMEDOUT', Dec 17 16:27:17 volumio volumio[19293]: syscall: 'connect', Dec 17 16:27:17 volumio volumio[19293]: address: '199.59.148.201', Dec 17 16:27:17 volumio volumio[19293]: port: 443 Dec 17 16:27:17 volumio volumio[19293]: } Dec 17 16:27:17 volumio volumio[19293]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 16:27:17 volumio sudo[20547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-17 16:26 Dec 17 16:27:17 volumio sudo[20547]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"