-- Logs begin at Mon 2024-08-19 11:49:45 UTC, end at Fri 2024-08-30 11:58:54 UTC. -- Aug 30 11:57:12 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:12 volumio volumio[26617]: info: CURURI: music-library/USB Aug 30 11:57:12 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:12 volumio volumio[26617]: info: CURURI: music-library/USB Aug 30 11:57:12 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:12 volumio volumio[26617]: info: CURURI: music-library/USB Aug 30 11:57:12 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:12 volumio volumio[26617]: info: CURURI: music-library/USB Aug 30 11:57:12 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:12 volumio volumio[26617]: info: CURURI: music-library/USB Aug 30 11:57:13 volumio volumio[26617]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ramin%20Djawadi/Game%20Of%20Thrones/a63ff048-17ca-49e6-82fc-ed472fc97e35.png' Aug 30 11:57:13 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:13 volumio volumio[26617]: info: CURURI: music-library/USB/My Passport Aug 30 11:57:14 volumio volumio[26617]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/R%C3%A9gine%20Crespin/Berlioz%3A%20Les%20Nuits%20D%27Ete%3B%20Rimsky-Korsakov%3A%20Scheherazade%3B%20Debussy%3B%20Poulenc%3A%20Songs/5b00478d-47ad-410a-8e0b-3daa0580f1a8.jpg' Aug 30 11:57:15 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:15 volumio volumio[26617]: info: CURURI: music-library/USB/My Passport/AIFF 2.6T Aug 30 11:57:18 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:18 volumio volumio[26617]: info: CURURI: music-library/USB/My Passport/AIFF 2.6T/3.Pop Aug 30 11:57:35 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 11:57:35 volumio volumio[26617]: info: CURURI: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1 Aug 30 11:57:36 volumio volumio[26617]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 30 11:57:36 volumio volumio[26617]: info: CoreStateMachine::ClearQueue Aug 30 11:57:36 volumio volumio[26617]: info: CoreStateMachine::stop Aug 30 11:57:36 volumio volumio[26617]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:57:36 volumio volumio[26617]: UNSET VOLATILE Aug 30 11:57:36 volumio volumio[26617]: info: CorePlayQueue::clearPlayQueue Aug 30 11:57:36 volumio volumio[26617]: info: CorePlayQueue::saveQueue Aug 30 11:57:36 volumio volumio[26617]: info: CoreCommandRouter::volumioPushState Aug 30 11:57:36 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:57:36 volumio volumio[26617]: info: CoreCommandRouter::volumioPushQueue Aug 30 11:57:36 volumio volumio[26617]: info: CoreStateMachine::addQueueItems Aug 30 11:57:36 volumio volumio[26617]: info: CorePlayQueue::addQueueItems Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-01 Eye of the Tiger.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-01 Eye of the Tiger.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-02 The Final Countdown.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-02 The Final Countdown.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-03 Fighter.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-03 Fighter.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-04 U + Ur Hand.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-04 U + Ur Hand.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-05 Heavy Cross.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-05 Heavy Cross.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-06 Holding Out for a Hero.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-06 Holding Out for a Hero.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-07 Girlfriend (Radio Edit).aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-07 Girlfriend (Radio Edit).aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-08 Waka Waka (This Time for Africa.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-08 Waka Waka (This Time for Africa.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-09 Fire Burning (Radio Edit).aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-09 Fire Burning (Radio Edit).aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-10 I See You Baby (Fatboy Slim Rad.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-10 I See You Baby (Fatboy Slim Rad.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-11 Hey Ya! (Radio Mix _ Club Mix).aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-11 Hey Ya! (Radio Mix _ Club Mix).aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-12 Gonna Make You Sweat (Everybody.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-12 Gonna Make You Sweat (Everybody.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-13 Can You Feel It.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-13 Can You Feel It.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-14 When the Going Gets Tough, the.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-14 When the Going Gets Tough, the.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-15 Bat Out of Hell.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-15 Bat Out of Hell.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-16 Danger Zone.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-16 Danger Zone.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-17 Don't Stop Believin'.aif Aug 30 11:57:36 volumio volumio[26617]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-17 Don't Stop Believin'.aif in service mpd Aug 30 11:57:36 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Survivor/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-01%20Eye%20of%20the%20Tiger.aif&metadata=false Aug 30 11:57:36 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-01 Eye of the Tiger.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Europe/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-02%20The%20Final%20Countdown.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-02 The Final Countdown.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Christina%20Aguilera/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-03%20Fighter.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-03 Fighter.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=P!nk/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-04%20U%20%2B%20Ur%20Hand.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-04 U + Ur Hand.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Gossip/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-05%20Heavy%20Cross.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-05 Heavy Cross.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Bonnie%20Tyler/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-06%20Holding%20Out%20for%20a%20Hero.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-06 Holding Out for a Hero.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Avril%20Lavigne/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-07%20Girlfriend%20(Radio%20Edit).aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-07 Girlfriend (Radio Edit).aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Shakira/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-08%20Waka%20Waka%20(This%20Time%20for%20Africa.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-08 Waka Waka (This Time for Africa.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Sean%20Kingston/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-09%20Fire%20Burning%20(Radio%20Edit).aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-09 Fire Burning (Radio Edit).aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Groove%20Armada/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-10%20I%20See%20You%20Baby%20(Fatboy%20Slim%20Rad.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-10 I See You Baby (Fatboy Slim Rad.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Outkast/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-11%20Hey%20Ya!%20(Radio%20Mix%20_%20Club%20Mix).aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-11 Hey Ya! (Radio Mix _ Club Mix).aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=C%2BC%20Music%20Factory/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-12%20Gonna%20Make%20You%20Sweat%20(Everybody.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-12 Gonna Make You Sweat (Everybody.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=The%20Jacksons/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-13%20Can%20You%20Feel%20It.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-13 Can You Feel It.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Billy%20Ocean/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-14%20When%20the%20Going%20Gets%20Tough%2C%20the.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-14 When the Going Gets Tough, the.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Meat%20Loaf/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-15%20Bat%20Out%20of%20Hell.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-15 Bat Out of Hell.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Kenny%20Loggins/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-16%20Danger%20Zone.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-16 Danger Zone.aif Aug 30 11:57:37 volumio volumio[26617]: info: ALBUMART /albumart?cacheid=744&web=Journey/Pure...%20Fitness%20CD1/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FPure...%20Fitness%20CD1%2F1-17%20Don't%20Stop%20Believin'.aif&metadata=false Aug 30 11:57:37 volumio volumio[26617]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-17 Don't Stop Believin'.aif Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::saveQueue Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::volumioPushQueue Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::updateTrackBlock Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::getTrackBlock Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::volumioPlay Aug 30 11:57:37 volumio volumio[26617]: UNSET VOLATILE Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::play index 0 Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::stop Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:57:37 volumio volumio[26617]: UNSET VOLATILE Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::play index undefined Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::getTrack 0 Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::startPlaybackTimer Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::getTrack 0 Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::clearAddPlayTracks USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-01 Eye of the Tiger.aif Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 11:57:37 volumio volumio[26617]: info: Aug 30 11:57:37 volumio volumio[26617]: ---------------------------- MPD announces state update: player Aug 30 11:57:37 volumio volumio[26617]: info: ControllerMpd::getState Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand clear Aug 30 11:57:37 volumio volumio[26617]: info: Aug 30 11:57:37 volumio volumio[26617]: ---------------------------- MPD announces system playlist update Aug 30 11:57:37 volumio volumio[26617]: info: Ignoring MPD Status Update Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::parseState Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand add "USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-01 Eye of the Tiger.aif" Aug 30 11:57:37 volumio volumio[26617]: error: updateQueue error: null Aug 30 11:57:37 volumio volumio[26617]: info: Aug 30 11:57:37 volumio volumio[26617]: ---------------------------- MPD announces system playlist update Aug 30 11:57:37 volumio volumio[26617]: info: Ignoring MPD Status Update Aug 30 11:57:37 volumio volumio[26617]: info: ------------------------------ 12ms Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand play Aug 30 11:57:37 volumio volumio[26617]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 30 11:57:37 volumio volumio[26617]: info: ------------------------------ 27ms Aug 30 11:57:37 volumio volumio[26617]: info: ------------------------------ 11ms Aug 30 11:57:37 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Aug 30 11:57:37 volumio volumio[26617]: info: Aug 30 11:57:37 volumio volumio[26617]: ---------------------------- MPD announces state update: player Aug 30 11:57:37 volumio volumio[26617]: info: ControllerMpd::getState Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:57:37 volumio volumio[26617]: info: Aug 30 11:57:37 volumio volumio[26617]: ---------------------------- MPD announces state update: player Aug 30 11:57:37 volumio volumio[26617]: info: ControllerMpd::getState Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::parseState Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::parseState Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:57:37 volumio volumio[26617]: info: ControllerMpd::pushState Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::servicePushState Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::getTrack 0 Aug 30 11:57:37 volumio volumio[26617]: verbose: STATE SERVICE {"status":"play","position":0,"seek":557,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Eye of the Tiger","artist":"Survivor","album":"Pure... Fitness CD1","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-01 Eye of the Tiger.aif","trackType":"aif"} Aug 30 11:57:37 volumio volumio[26617]: verbose: CURRENT POSITION 0 Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::syncState stateService play Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::syncState currentStatus stop Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::pushState Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::getTrack 0 Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::volumioPushState Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:57:37 volumio volumio[26617]: info: ------------------------------ 31ms Aug 30 11:57:37 volumio volumio[26617]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:57:37 volumio volumio[26617]: info: ControllerMpd::pushState Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::servicePushState Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::getTrack 0 Aug 30 11:57:37 volumio volumio[26617]: verbose: STATE SERVICE {"status":"play","position":0,"seek":557,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Eye of the Tiger","artist":"Survivor","album":"Pure... Fitness CD1","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Pure... Fitness CD1/1-01 Eye of the Tiger.aif","trackType":"aif"} Aug 30 11:57:37 volumio volumio[26617]: verbose: CURRENT POSITION 0 Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::syncState stateService play Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::syncState currentStatus play Aug 30 11:57:37 volumio volumio[26617]: info: Received an update from plugin. extracting info from payload Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::pushState Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::getTrack 0 Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::volumioPushState Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:57:37 volumio volumio[26617]: info: CoreStateMachine::pushState Aug 30 11:57:37 volumio volumio[26617]: info: CorePlayQueue::getTrack 0 Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::volumioPushState Aug 30 11:57:37 volumio volumio[26617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:57:37 volumio volumio[26617]: info: ------------------------------ 43ms Aug 30 11:58:04 volumio volumio[26617]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 11:58:04 volumio volumio[26617]: { Error: connect ETIMEDOUT 31.13.81.4:443 Aug 30 11:58:04 volumio volumio[26617]: at Object._errnoException (util.js:1022:11) Aug 30 11:58:04 volumio volumio[26617]: at _exceptionWithHostPort (util.js:1044:20) Aug 30 11:58:04 volumio volumio[26617]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Aug 30 11:58:04 volumio volumio[26617]: code: 'ETIMEDOUT', Aug 30 11:58:04 volumio volumio[26617]: errno: 'ETIMEDOUT', Aug 30 11:58:04 volumio volumio[26617]: syscall: 'connect', Aug 30 11:58:04 volumio volumio[26617]: address: '31.13.81.4', Aug 30 11:58:04 volumio volumio[26617]: port: 443 } Aug 30 11:58:04 volumio volumio[26617]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 11:58:05 volumio sudo[27052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 11:57 Aug 30 11:58:05 volumio sudo[27052]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:05 volumio sudo[27052]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:09 volumio volumio-remote-updater[736]: [2024-08-30 11:58:09] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Aug 30 11:58:09 volumio volumio-remote-updater[736]: [2024-08-30 11:58:09] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Aug 30 11:58:09 volumio volumio-remote-updater[736]: [2024-08-30 11:58:09] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Aug 30 11:58:09 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Aug 30 11:58:09 volumio systemd[1]: Unit volumio.service entered failed state. Aug 30 11:58:09 volumio systemd[1]: Starting dynamicswap service... Aug 30 11:58:09 volumio systemd[1]: Started dynamicswap service. Aug 30 11:58:10 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Aug 30 11:58:10 volumio systemd[1]: Starting dynamicswap service... Aug 30 11:58:10 volumio systemd[1]: Started dynamicswap service. Aug 30 11:58:10 volumio systemd[1]: Stopping Volumio Backend Module... Aug 30 11:58:10 volumio systemd[1]: Starting Volumio Backend Module... Aug 30 11:58:10 volumio systemd[1]: Started Volumio Backend Module. Aug 30 11:58:12 volumio volumio[27079]: info: ------------------------------------------- Aug 30 11:58:12 volumio volumio[27079]: info: ----- Volumio2 ---- Aug 30 11:58:12 volumio volumio[27079]: info: ------------------------------------------- Aug 30 11:58:12 volumio volumio[27079]: info: ----- System startup ---- Aug 30 11:58:12 volumio volumio[27079]: info: ------------------------------------------- Aug 30 11:58:13 volumio volumio[27079]: info: MYVOLUMIO Environment detected Aug 30 11:58:13 volumio volumio[27079]: info: Plugin folders cleanup Aug 30 11:58:13 volumio volumio[27079]: info: Scanning into folder /volumio/app/plugins/ Aug 30 11:58:13 volumio volumio[27079]: info: Scanning category audio_interface Aug 30 11:58:13 volumio volumio[27079]: info: Scanning category miscellanea Aug 30 11:58:13 volumio volumio[27079]: info: Scanning category music_service Aug 30 11:58:13 volumio volumio[27079]: info: Scanning category plugins.json Aug 30 11:58:13 volumio volumio[27079]: info: Scanning category system_controller Aug 30 11:58:13 volumio volumio[27079]: info: Scanning category user_interface Aug 30 11:58:13 volumio volumio[27079]: info: Scanning into folder /data/plugins/ Aug 30 11:58:13 volumio volumio[27079]: info: Plugin folders cleanup completed Aug 30 11:58:13 volumio volumio[27079]: info: ------------------------------------------- Aug 30 11:58:13 volumio volumio[27079]: info: ----- Core plugins startup ---- Aug 30 11:58:13 volumio volumio[27079]: info: ------------------------------------------- Aug 30 11:58:13 volumio volumio[27079]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 11:58:13 volumio volumio[27079]: info: Adding plugin upnp to MyMusic Plugins Aug 30 11:58:13 volumio volumio[27079]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 11:58:13 volumio volumio[27079]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 11:58:13 volumio volumio[27079]: info: Loading plugins from folder /data/plugins/ Aug 30 11:58:13 volumio volumio[27079]: info: Loading plugin "system"... Aug 30 11:58:13 volumio volumio[27079]: info: Loading plugin "appearance"... Aug 30 11:58:14 volumio volumio[27079]: info: Loading plugin "network"... Aug 30 11:58:14 volumio volumio[27079]: info: Refreshing Cached IP Addresses Aug 30 11:58:14 volumio sudo[27104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 11:58:14 volumio volumio[27079]: info: Loading plugin "services"... Aug 30 11:58:14 volumio sudo[27104]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:14 volumio volumio[27079]: info: Loading plugin "alsa_controller"... Aug 30 11:58:14 volumio sudo[27104]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:14 volumio sudo[27108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 11:58:14 volumio sudo[27108]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:14 volumio sudo[27108]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:14 volumio volumio[27079]: info: Loading plugin "wizard"... Aug 30 11:58:14 volumio volumio[27079]: info: Loading plugin "volumio_command_line_client"... Aug 30 11:58:14 volumio volumio[27079]: info: Loading plugin "upnp"... Aug 30 11:58:14 volumio volumio[27079]: info: [1725019094938] Starting Upmpd Daemon Aug 30 11:58:14 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 11:58:14 volumio volumio-remote-updater[736]: [2024-08-30 11:58:14] [connect] Successful connection Aug 30 11:58:14 volumio volumio[27079]: info: Loading plugin "my_music"... Aug 30 11:58:14 volumio volumio[27079]: info: Loading plugin "mpd"... Aug 30 11:58:15 volumio volumio[27079]: info: Loading plugin "upnp_browser"... Aug 30 11:58:15 volumio volumio[27079]: info: Loading plugin "networkfs"... Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "alarm-clock"... Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "airplay_emulation"... Aug 30 11:58:16 volumio volumio[27079]: info: Starting Shairport Sync Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "last_100"... Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "webradio"... Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "i2s_dacs"... Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "volumiodiscovery"... Aug 30 11:58:16 volumio volumio[27079]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 11:58:16 volumio node[27079]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 11:58:16 volumio node[27079]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 11:58:16 volumio node[27079]: *** WARNING *** For more information see Aug 30 11:58:16 volumio node[27079]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 11:58:16 volumio node[27079]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 11:58:16 volumio node[27079]: *** WARNING *** For more information see Aug 30 11:58:16 volumio volumio[27079]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 11:58:16 volumio volumio[27079]: *** WARNING *** For more information see Aug 30 11:58:16 volumio volumio[27079]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 11:58:16 volumio volumio[27079]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 11:58:16 volumio volumio[27079]: *** WARNING *** For more information see Aug 30 11:58:16 volumio volumio[27079]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 11:58:16 volumio volumio[27079]: Discovery: StartAdv! undefined Aug 30 11:58:16 volumio volumio[27079]: Discovery: Started advertising... Volumio - undefined Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "outputs"... Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "albumart"... Aug 30 11:58:16 volumio volumio[27079]: info: Plugin example_plugin is not enabled Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "inputs"... Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "updater_comm"... Aug 30 11:58:16 volumio volumio[27079]: info: Plugin mpdemulation is not enabled Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "rest_api"... Aug 30 11:58:16 volumio volumio[27079]: info: Loading plugin "websocket"... Aug 30 11:58:16 volumio volumio[27079]: info: ___________ START PLUGINS ___________ Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 11:58:16 volumio volumio[27079]: info: [1725019096797] CoreMusicLibrary::Adding element Media Servers Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:58:16 volumio volumio[27079]: Forking 3 albumart workers Aug 30 11:58:16 volumio volumio[27079]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 11:58:16 volumio volumio[27079]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 11:58:16 volumio volumio[27079]: info: [1725019096953] CoreMusicLibrary::Adding element Last_100 Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 11:58:16 volumio volumio[27079]: info: [1725019096959] CoreMusicLibrary::Adding element Webradio Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:58:16 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 11:58:16 volumio volumio[27079]: info: ------------------------------------------- Aug 30 11:58:16 volumio volumio[27079]: info: ----- MyVolumio plugins startup ---- Aug 30 11:58:16 volumio volumio[27079]: info: ------------------------------------------- Aug 30 11:58:16 volumio volumio[27079]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 30 11:58:16 volumio volumio[27079]: info: Loading i18n strings for locale zh Aug 30 11:58:17 volumio volumio[27079]: Updating browse sources language Aug 30 11:58:17 volumio volumio[27079]: Cannot find translation for sourceMedia Servers Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::initPlayerControls Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: info: BOOT COMPLETED Aug 30 11:58:17 volumio volumio[27079]: [Metrics] CommandRouter: 4s 786.02ms Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 11:58:17 volumio volumio[27079]: aplay: main:722: audio open error: Device or resource busy Aug 30 11:58:17 volumio volumio[27079]: Cannot play startup sound Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::Close All Modals sent Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::Close All Modals sent Aug 30 11:58:17 volumio volumio[27079]: Express server listening on port 3000 Aug 30 11:58:17 volumio volumio[27079]: [Metrics] WebUI: 5s 526.56ms Aug 30 11:58:17 volumio volumio[27079]: Volumio Calling Home Aug 30 11:58:17 volumio volumio[27079]: info: CoreStateMachine::resetVolumioState Aug 30 11:58:17 volumio volumio[27079]: info: CoreStateMachine::getcurrentVolume Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 11:58:17 volumio volumio[27079]: info: CoreStateMachine::pushState Aug 30 11:58:17 volumio volumio[27079]: info: CorePlayQueue::getTrack 0 Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::volumioPushState Aug 30 11:58:17 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:58:17 volumio volumio[27079]: info: Setting Device type: Raspberry PI Aug 30 11:58:17 volumio volumio[27079]: info: MPD running with PID1309 Aug 30 11:58:17 volumio volumio[27079]: ,establishing connection Aug 30 11:58:17 volumio volumio-remote-updater[736]: [2024-08-30 11:58:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1725019094 101 Aug 30 11:58:17 volumio volumio[27079]: Starting albumart workers Aug 30 11:58:17 volumio volumio[27079]: Starting albumart workers Aug 30 11:58:17 volumio volumio[27079]: Starting albumart workers Aug 30 11:58:18 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 30 11:58:18 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 30 11:58:18 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 30 11:58:18 volumio volumio[27079]: info: Reloading queue from file Aug 30 11:58:18 volumio volumio[27079]: info: CoreStateMachine::setRepeat true single undefined Aug 30 11:58:18 volumio volumio[27079]: info: CoreStateMachine::pushState Aug 30 11:58:18 volumio volumio[27079]: info: CorePlayQueue::getTrack 0 Aug 30 11:58:18 volumio volumio[27079]: info: CoreCommandRouter::volumioPushState Aug 30 11:58:18 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:58:18 volumio volumio[27079]: info: CoreStateMachine::setRandom null Aug 30 11:58:18 volumio volumio[27079]: info: CoreStateMachine::pushState Aug 30 11:58:18 volumio volumio[27079]: info: CorePlayQueue::getTrack 0 Aug 30 11:58:18 volumio volumio[27079]: info: CoreCommandRouter::volumioPushState Aug 30 11:58:18 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:58:18 volumio volumio[27079]: info: Starting Shairport Sync Aug 30 11:58:18 volumio volumio[27079]: info: Starting Shairport Sync Aug 30 11:58:18 volumio sudo[27172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 11:58:18 volumio sudo[27172]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:18 volumio sudo[27175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 11:58:18 volumio sudo[27175]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 11:58:18 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Aug 30 11:58:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 11:58:18 volumio sudo[27172]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 11:58:18 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Aug 30 11:58:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 11:58:18 volumio sudo[27175]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:18 volumio volumio[27079]: info: Shairport-Sync Started Aug 30 11:58:18 volumio volumio[27079]: Error adding Membership: Error: addMembership EINVAL Aug 30 11:58:18 volumio volumio[27079]: Discovery: adding ca56ecb6-5934-421c-b552-a193d4b9bddc Aug 30 11:58:18 volumio volumio[27079]: info: mDNS: Found device Volumio Aug 30 11:58:18 volumio volumio[27079]: info: CoreCommandRouter::volumioGetState Aug 30 11:58:18 volumio volumio[27079]: info: CorePlayQueue::getTrack 0 Aug 30 11:58:18 volumio volumio[27079]: info: Shairport-Sync Started Aug 30 11:58:20 volumio volumio[27079]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/A-Lin/%E4%BB%A5%E5%89%8D%2C%E4%BB%A5%E5%BE%8C/95b85cd0-bfad-4651-acd4-b18538b14b5b.jpg' Aug 30 11:58:20 volumio volumio[27079]: info: CoreCommandRouter::volumioGetState Aug 30 11:58:20 volumio volumio[27079]: info: CorePlayQueue::getTrack 0 Aug 30 11:58:21 volumio volumio[27079]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 11:58:21 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:58:21 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 11:58:21 volumio volumio[27079]: info: CoreCommandRouter::volumioGetState Aug 30 11:58:21 volumio volumio[27079]: info: CorePlayQueue::getTrack 0 Aug 30 11:58:21 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 11:58:21 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 11:58:23 volumio volumio[27079]: Discovery: this is already registered, ca56ecb6-5934-421c-b552-a193d4b9bddc Aug 30 11:58:23 volumio volumio[27079]: info: mDNS: Found device Volumio Aug 30 11:58:23 volumio volumio[27079]: info: CoreCommandRouter::volumioGetState Aug 30 11:58:23 volumio volumio[27079]: info: CorePlayQueue::getTrack 0 Aug 30 11:58:25 volumio sudo[27238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 11:58:25 volumio sudo[27238]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:25 volumio sudo[27238]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:25 volumio sudo[27242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 11:58:25 volumio sudo[27242]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:25 volumio sudo[27242]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:27 volumio sudo[27259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 30 11:58:27 volumio sudo[27259]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:27 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 30 11:58:27 volumio sudo[27259]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:27 volumio volumio[27079]: info: Upmpdcli Daemon Started Aug 30 11:58:28 volumio volumio[27079]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=f507dfabb2d58c7adf310f61ec4c9948" http://updates.volumio.org:7070/downloader-v1/track-device Aug 30 11:58:28 volumio volumio[27079]: % Total % Received % Xferd Average Speed Time Time Time Current Aug 30 11:58:28 volumio volumio[27079]: Dload Upload Total Spent Left Speed Aug 30 11:58:28 volumio volumio[27079]: [235B blob data] Aug 30 11:58:28 volumio volumio[27079]: retrying in 5 seconds, trial 0 Aug 30 11:58:28 volumio volumio[27079]: Volumio Calling Home Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 30 11:58:29 volumio volumio[27079]: info: Adding plugin bluetooth to MyMusic Plugins Aug 30 11:58:29 volumio volumio[27079]: info: Adding plugin cd_controller to MyMusic Plugins Aug 30 11:58:29 volumio volumio[27079]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 30 11:58:29 volumio volumio[27079]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 30 11:58:31 volumio volumio[27079]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 30 11:58:33 volumio volumio[27079]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 30 11:58:33 volumio volumio[27079]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 30 11:58:33 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 11:58:33 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 11:58:33 volumio volumio[27079]: info: Starting MyVolumio Remote Streaming Endpoints Aug 30 11:58:33 volumio volumio[27079]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 30 11:58:33 volumio volumio[27079]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 30 11:58:33 volumio volumio[27079]: info: Streaming services startup Aug 30 11:58:33 volumio volumio[27079]: info: Starting Streaming Daemon Aug 30 11:58:33 volumio volumio[27079]: info: MyVolumio not started Aug 30 11:58:33 volumio volumio[27079]: info: Initializing device activation check Aug 30 11:58:33 volumio sudo[27271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 30 11:58:33 volumio sudo[27271]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 11:58:33 volumio volumio[27079]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 30 11:58:33 volumio systemd[1]: Stopping Volumio Streaming Daemon... Aug 30 11:58:33 volumio systemd[1]: Starting Volumio Streaming Daemon... Aug 30 11:58:33 volumio systemd[1]: Started Volumio Streaming Daemon. Aug 30 11:58:33 volumio sudo[27271]: pam_unix(sudo:session): session closed for user root Aug 30 11:58:33 volumio volumio-streaming-daemon[27277]: ############################ Aug 30 11:58:33 volumio volumio-streaming-daemon[27277]: # Volumio Streaming Daemon # Aug 30 11:58:33 volumio volumio-streaming-daemon[27277]: # Running on port 7777 # Aug 30 11:58:33 volumio volumio-streaming-daemon[27277]: ############################ Aug 30 11:58:33 volumio volumio-streaming-daemon[27277]: Environment: production Aug 30 11:58:39 volumio volumio-streaming-daemon[27277]: Environment: production Aug 30 11:58:43 volumio volumio[27079]: info: Fetching Streaming Services browse cache Aug 30 11:58:45 volumio volumio[27079]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Aug 30 11:58:45 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:58:45 volumio volumio[27079]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Aug 30 11:58:45 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:58:45 volumio volumio[27079]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=f507dfabb2d58c7adf310f61ec4c9948" http://updates.volumio.org:7070/downloader-v1/track-device Aug 30 11:58:45 volumio volumio[27079]: % Total % Received % Xferd Average Speed Time Time Time Current Aug 30 11:58:45 volumio volumio[27079]: Dload Upload Total Spent Left Speed Aug 30 11:58:45 volumio volumio[27079]: [235B blob data] Aug 30 11:58:45 volumio volumio[27079]: retrying in 5 seconds, trial 1 Aug 30 11:58:45 volumio volumio[27079]: Volumio Calling Home Aug 30 11:58:50 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 11:58:50 volumio volumio[27079]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 11:58:53 volumio volumio[27079]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 11:58:53 volumio volumio[27079]: { Error: connect ETIMEDOUT 103.73.161.52:443 Aug 30 11:58:53 volumio volumio[27079]: at Object._errnoException (util.js:1022:11) Aug 30 11:58:53 volumio volumio[27079]: at _exceptionWithHostPort (util.js:1044:20) Aug 30 11:58:53 volumio volumio[27079]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Aug 30 11:58:53 volumio volumio[27079]: code: 'ETIMEDOUT', Aug 30 11:58:53 volumio volumio[27079]: errno: 'ETIMEDOUT', Aug 30 11:58:53 volumio volumio[27079]: syscall: 'connect', Aug 30 11:58:53 volumio volumio[27079]: address: '103.73.161.52', Aug 30 11:58:53 volumio volumio[27079]: port: 443 } Aug 30 11:58:53 volumio volumio[27079]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 11:58:54 volumio sudo[27326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 11:57 Aug 30 11:58:54 volumio sudo[27326]: 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="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"