-- Logs begin at Fri 2024-07-26 04:15:50 CEST, end at Fri 2024-07-26 05:05:48 CEST. -- Jul 26 05:04:00 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:04:00 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:04:03 voliera-volumio volumio[3962]: error: [LastFM] track info request failed with error: Track not found Jul 26 05:04:07 voliera-volumio kernel: hwmon hwmon1: Voltage normalised Jul 26 05:04:09 voliera-volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 26 05:04:16 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:04:17 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:04:17 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Jul 26 05:04:20 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Jul 26 05:04:20 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Jul 26 05:04:20 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Jul 26 05:04:20 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Jul 26 05:04:20 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Jul 26 05:04:20 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ------------------------------ 11ms Jul 26 05:04:20 voliera-volumio volumio[3962]: info: sendMpdCommand status took 10 milliseconds Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ------------------------------ 9ms Jul 26 05:04:20 voliera-volumio volumio[3962]: info: sendMpdCommand status took 7 milliseconds Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ------------------------------ 7ms Jul 26 05:04:20 voliera-volumio volumio[3962]: info: sendMpdCommand status took 6 milliseconds Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:04:20 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 05:04:20 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 05:04:20 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":937856,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":937856,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":937856,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:04:20 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:04:20 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ------------------------------ 54ms Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ------------------------------ 52ms Jul 26 05:04:20 voliera-volumio volumio[3962]: info: ------------------------------ 51ms Jul 26 05:04:20 voliera-volumio volumio[3962]: info: [LastFM] Current track has sufficient metadata: title (All about Dance from 2000 till today!) and artist (Dance Wave!) passed on explicitly Jul 26 05:04:26 voliera-volumio volumio[3962]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"All about Dance from 2000 till today!","url":"https://www.last.fm/music/Dance+Wave%21/_/All+about+Dance+from+2000+till+today%21","duration":"0","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"10","playcount":"538","artist":{"name":"Dance Wave!","url":"https://www.last.fm/music/Dance+Wave%21"},"userplaycount":"2","userloved":"0","toptags":""}} Jul 26 05:04:26 voliera-volumio volumio[3962]: info: [LastFM] Updated missing track duration: 0 Jul 26 05:04:28 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:04:36 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:04:36 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:04:36 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Jul 26 05:04:44 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Jul 26 05:04:44 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Jul 26 05:04:44 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Jul 26 05:04:44 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ------------------------------ 4ms Jul 26 05:04:44 voliera-volumio volumio[3962]: info: sendMpdCommand status took 3 milliseconds Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ------------------------------ 2ms Jul 26 05:04:44 voliera-volumio volumio[3962]: info: sendMpdCommand status took 2 milliseconds Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Jul 26 05:04:44 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Jul 26 05:04:44 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:04:44 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 05:04:44 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ------------------------------ 2ms Jul 26 05:04:44 voliera-volumio volumio[3962]: info: sendMpdCommand status took 1 milliseconds Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":953500,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":953500,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ------------------------------ 20ms Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ------------------------------ 19ms Jul 26 05:04:44 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":953500,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:04:44 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:04:44 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:04:44 voliera-volumio volumio[3962]: info: ------------------------------ 26ms Jul 26 05:04:44 voliera-volumio volumio[3962]: info: [LastFM] Current track has sufficient metadata: title (Tracklist: https://dancewave.online) and artist (Dance Wave!) passed on explicitly Jul 26 05:04:50 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:04:51 voliera-volumio kernel: hwmon hwmon1: Voltage normalised Jul 26 05:04:51 voliera-volumio volumio[3962]: error: [LastFM] track info request failed with error: Track not found Jul 26 05:04:53 voliera-volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 26 05:04:55 voliera-volumio volumio[3962]: verbose: New Socket.io Connection to 192.168.100.122:3000 from 192.168.100.120 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 26 05:04:57 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 26 05:04:57 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:04:59 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:04:59 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:05:00 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Jul 26 05:05:06 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Jul 26 05:05:06 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Jul 26 05:05:06 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Jul 26 05:05:06 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Jul 26 05:05:06 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Jul 26 05:05:06 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ------------------------------ 7ms Jul 26 05:05:06 voliera-volumio volumio[3962]: info: sendMpdCommand status took 6 milliseconds Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ------------------------------ 4ms Jul 26 05:05:06 voliera-volumio volumio[3962]: info: sendMpdCommand status took 5 milliseconds Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ------------------------------ 4ms Jul 26 05:05:06 voliera-volumio volumio[3962]: info: sendMpdCommand status took 3 milliseconds Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:06 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 05:05:06 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 05:05:06 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":968757,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":968757,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":968757,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:06 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:06 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ------------------------------ 33ms Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ------------------------------ 30ms Jul 26 05:05:06 voliera-volumio volumio[3962]: info: ------------------------------ 29ms Jul 26 05:05:06 voliera-volumio volumio[3962]: info: [LastFM] Current track has sufficient metadata: title (All about Dance from 2000 till today!) and artist (Dance Wave!) passed on explicitly Jul 26 05:05:09 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:05:12 voliera-volumio volumio[3962]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"All about Dance from 2000 till today!","url":"https://www.last.fm/music/Dance+Wave%21/_/All+about+Dance+from+2000+till+today%21","duration":"0","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"10","playcount":"538","artist":{"name":"Dance Wave!","url":"https://www.last.fm/music/Dance+Wave%21"},"userplaycount":"2","userloved":"0","toptags":""}} Jul 26 05:05:12 voliera-volumio volumio[3962]: info: [LastFM] Updated missing track duration: 0 Jul 26 05:05:13 voliera-volumio kernel: hwmon hwmon1: Voltage normalised Jul 26 05:05:15 voliera-volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Jul 26 05:05:18 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Jul 26 05:05:18 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Jul 26 05:05:18 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Jul 26 05:05:18 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ------------------------------ 4ms Jul 26 05:05:18 voliera-volumio volumio[3962]: info: sendMpdCommand status took 4 milliseconds Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ------------------------------ 3ms Jul 26 05:05:18 voliera-volumio volumio[3962]: info: sendMpdCommand status took 2 milliseconds Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Jul 26 05:05:18 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Jul 26 05:05:18 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:18 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 05:05:18 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ------------------------------ 2ms Jul 26 05:05:18 voliera-volumio volumio[3962]: info: sendMpdCommand status took 2 milliseconds Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":975707,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":975707,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ------------------------------ 25ms Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ------------------------------ 24ms Jul 26 05:05:18 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":975707,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:18 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:18 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:18 voliera-volumio volumio[3962]: info: ------------------------------ 27ms Jul 26 05:05:18 voliera-volumio volumio[3962]: info: [LastFM] Current track has sufficient metadata: title (Dance Wave!) and artist (Dance Wave!) passed on explicitly Jul 26 05:05:20 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:05:24 voliera-volumio kernel: hwmon hwmon1: Voltage normalised Jul 26 05:05:26 voliera-volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 11ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand status took 9 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 8ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand status took 7 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 6ms Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand status took 14 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 11 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984037,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984117,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 53ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 50ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 32 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984117,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 65ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: [LastFM] Current track has sufficient metadata: title (Tracklist: https://dancewave.online) and artist (Dance Wave!) passed on explicitly Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 7ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand status took 6 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 5ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand status took 4 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces system playlist update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Ignoring MPD Status Update Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Jul 26 05:05:27 voliera-volumio volumio[3962]: ---------------------------- MPD announces state update: player Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::getState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand status Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984194,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984194,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 41ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 39ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 34ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand status took 33 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseState Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: ControllerMpd::parseTrackInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ControllerMpd::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::servicePushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CorePlayQueue::getTrack 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984354,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Jul 26 05:05:27 voliera-volumio volumio[3962]: verbose: CURRENT POSITION 0 Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState stateService play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::syncState currentStatus play Jul 26 05:05:27 voliera-volumio volumio[3962]: info: Received an update from plugin. extracting info from payload Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreStateMachine::pushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioPushState Jul 26 05:05:27 voliera-volumio volumio[3962]: info: ------------------------------ 56ms Jul 26 05:05:27 voliera-volumio volumio[3962]: info: [LastFM] Current track has sufficient metadata: title (Dance Wave!) and artist (Dance Wave!) passed on explicitly Jul 26 05:05:31 voliera-volumio volumio[3962]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Dance Wave!","url":"https://www.last.fm/music/Dance+Wave%21/_/Dance+Wave%21","duration":"0","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"4","playcount":"68","artist":{"name":"Dance Wave!","url":"https://www.last.fm/music/Dance+Wave%21"},"userplaycount":"0","userloved":"0","toptags":""}} Jul 26 05:05:31 voliera-volumio volumio[3962]: info: [LastFM] Updated missing track duration: 0 Jul 26 05:05:34 voliera-volumio kernel: hwmon hwmon1: Voltage normalised Jul 26 05:05:40 voliera-volumio volumio[3962]: error: [LastFM] track info request failed with error: Track not found Jul 26 05:05:40 voliera-volumio volumio[3962]: info: CoreCommandRouter::volumioGetState Jul 26 05:05:43 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:05:43 voliera-volumio volumio[3962]: info: Listing playlists Jul 26 05:05:45 voliera-volumio volumio[3962]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Dance Wave!","url":"https://www.last.fm/music/Dance+Wave%21/_/Dance+Wave%21","duration":"0","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"4","playcount":"68","artist":{"name":"Dance Wave!","url":"https://www.last.fm/music/Dance+Wave%21"},"userplaycount":"0","userloved":"0","toptags":""}} Jul 26 05:05:45 voliera-volumio volumio[3962]: info: [LastFM] Updated missing track duration: 0 Jul 26 05:05:45 voliera-volumio volumio[3962]: verbose: New Socket.io Connection to 192.168.100.122:3000 from 192.168.100.121 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jul 26 05:05:45 voliera-volumio volumio[3962]: verbose: New Socket.io Connection to 192.168.100.122:3000 from 192.168.100.123 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 26 05:05:46 voliera-volumio volumio[3962]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 05:05:46 voliera-volumio volumio[3962]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com Jul 26 05:05:46 voliera-volumio volumio[3962]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) { Jul 26 05:05:46 voliera-volumio volumio[3962]: errno: -3007, Jul 26 05:05:46 voliera-volumio volumio[3962]: code: 'ENOTFOUND', Jul 26 05:05:46 voliera-volumio volumio[3962]: syscall: 'getaddrinfo', Jul 26 05:05:46 voliera-volumio volumio[3962]: hostname: 'ws.audioscrobbler.com' Jul 26 05:05:46 voliera-volumio volumio[3962]: } Jul 26 05:05:46 voliera-volumio volumio[3962]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 05:05:47 voliera-volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 26 05:05:48 voliera-volumio sudo[6379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-26 05:04 Jul 26 05:05:48 voliera-volumio sudo[6379]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"