-- Logs begin at Mon 2024-05-06 08:50:14 UTC, end at Mon 2024-05-06 09:05:33 UTC. -- May 06 09:04:03 volumio volumio[895]: info: May 06 09:04:03 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:04:03 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:04:03 volumio volumio[895]: info: May 06 09:04:03 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:04:03 volumio volumio[895]: info: ControllerMpd::getState May 06 09:04:03 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:04:03 volumio volumio[895]: info: May 06 09:04:03 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:04:03 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:04:03 volumio volumio[895]: info: May 06 09:04:03 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:04:03 volumio volumio[895]: info: ControllerMpd::getState May 06 09:04:03 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:04:03 volumio volumio[895]: info: ------------------------------ 12ms May 06 09:04:03 volumio volumio[895]: info: sendMpdCommand status took 11 milliseconds May 06 09:04:03 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:04:03 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:04:03 volumio volumio[895]: info: ------------------------------ 11ms May 06 09:04:03 volumio volumio[895]: info: sendMpdCommand status took 6 milliseconds May 06 09:04:03 volumio volumio[895]: info: sendMpdCommand playlistinfo took 3 milliseconds May 06 09:04:03 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:04:03 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:04:03 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:04:03 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:04:03 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:04:03 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45359,"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"} May 06 09:04:03 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:04:03 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:04:03 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:04:03 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:04:03 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:03 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:03 volumio volumio[895]: info: ------------------------------ 53ms May 06 09:04:03 volumio volumio[895]: info: sendMpdCommand playlistinfo took 45 milliseconds May 06 09:04:03 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:04:03 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:04:03 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:04:03 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45359,"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"} May 06 09:04:03 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:04:03 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:04:03 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:04:03 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:04:03 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:03 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:03 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:03 volumio volumio[895]: info: ------------------------------ 97ms May 06 09:04:09 volumio kernel: usb 5-5: device descriptor read/64, error -110 May 06 09:04:19 volumio volumio[895]: info: May 06 09:04:19 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:04:19 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:04:19 volumio volumio[895]: info: May 06 09:04:19 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:04:19 volumio volumio[895]: info: ControllerMpd::getState May 06 09:04:19 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:04:19 volumio volumio[895]: info: May 06 09:04:19 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:04:19 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:04:19 volumio volumio[895]: info: May 06 09:04:19 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:04:19 volumio volumio[895]: info: ControllerMpd::getState May 06 09:04:19 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:04:19 volumio volumio[895]: info: ------------------------------ 22ms May 06 09:04:19 volumio volumio[895]: info: sendMpdCommand status took 10 milliseconds May 06 09:04:19 volumio volumio[895]: info: ------------------------------ 10ms May 06 09:04:19 volumio volumio[895]: info: sendMpdCommand status took 6 milliseconds May 06 09:04:19 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:04:19 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:04:19 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:04:19 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:04:19 volumio volumio[895]: info: sendMpdCommand playlistinfo took 4 milliseconds May 06 09:04:19 volumio volumio[895]: info: sendMpdCommand playlistinfo took 3 milliseconds May 06 09:04:19 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:04:19 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:04:19 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:04:19 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:04:19 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61729,"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"} May 06 09:04:19 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:04:19 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:04:19 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:04:19 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:04:19 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:19 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:19 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:04:19 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:04:19 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61729,"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"} May 06 09:04:19 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:04:19 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:04:19 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:04:19 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:04:19 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:19 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:19 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:19 volumio volumio[895]: info: ------------------------------ 107ms May 06 09:04:19 volumio volumio[895]: info: ------------------------------ 102ms May 06 09:04:25 volumio kernel: usb 5-5: device descriptor read/64, error -110 May 06 09:04:25 volumio kernel: usb usb5-port5: attempt power cycle May 06 09:04:26 volumio kernel: usb 2-5: new high-speed USB device number 114 using ehci-pci May 06 09:04:31 volumio kernel: usb 2-5: device descriptor read/64, error -110 May 06 09:04:36 volumio volumio[895]: info: May 06 09:04:36 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:04:36 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:04:36 volumio volumio[895]: info: May 06 09:04:36 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:04:36 volumio volumio[895]: info: ControllerMpd::getState May 06 09:04:36 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:04:36 volumio volumio[895]: info: May 06 09:04:36 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:04:36 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:04:36 volumio volumio[895]: info: May 06 09:04:36 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:04:36 volumio volumio[895]: info: ControllerMpd::getState May 06 09:04:36 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:04:36 volumio volumio[895]: info: ------------------------------ 7ms May 06 09:04:36 volumio volumio[895]: info: sendMpdCommand status took 5 milliseconds May 06 09:04:36 volumio volumio[895]: info: ------------------------------ 4ms May 06 09:04:36 volumio volumio[895]: info: sendMpdCommand status took 4 milliseconds May 06 09:04:36 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:04:36 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:04:36 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:04:36 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:04:36 volumio volumio[895]: info: sendMpdCommand playlistinfo took 2 milliseconds May 06 09:04:36 volumio volumio[895]: info: sendMpdCommand playlistinfo took 2 milliseconds May 06 09:04:36 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:04:36 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:04:36 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:04:36 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:04:36 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79098,"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"} May 06 09:04:36 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:04:36 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:04:36 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:04:36 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:04:36 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:36 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:36 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:04:36 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:04:36 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79098,"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"} May 06 09:04:36 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:04:36 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:04:36 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:04:36 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:04:36 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:36 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:36 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:37 volumio volumio[895]: info: ------------------------------ 79ms May 06 09:04:37 volumio volumio[895]: info: ------------------------------ 78ms May 06 09:04:47 volumio kernel: usb 2-5: device descriptor read/64, error -110 May 06 09:04:47 volumio kernel: usb 2-5: new high-speed USB device number 115 using ehci-pci May 06 09:04:51 volumio volumio[895]: info: May 06 09:04:51 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:04:51 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:04:51 volumio volumio[895]: info: May 06 09:04:51 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:04:51 volumio volumio[895]: info: ControllerMpd::getState May 06 09:04:51 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:04:51 volumio volumio[895]: info: May 06 09:04:51 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:04:51 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:04:51 volumio volumio[895]: info: May 06 09:04:51 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:04:51 volumio volumio[895]: info: ControllerMpd::getState May 06 09:04:51 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:04:51 volumio volumio[895]: info: ------------------------------ 9ms May 06 09:04:51 volumio volumio[895]: info: sendMpdCommand status took 8 milliseconds May 06 09:04:51 volumio volumio[895]: info: ------------------------------ 7ms May 06 09:04:51 volumio volumio[895]: info: sendMpdCommand status took 3 milliseconds May 06 09:04:51 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:04:51 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:04:51 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:04:51 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:04:51 volumio volumio[895]: info: sendMpdCommand playlistinfo took 3 milliseconds May 06 09:04:51 volumio volumio[895]: info: sendMpdCommand playlistinfo took 2 milliseconds May 06 09:04:51 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:04:51 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:04:51 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:04:51 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:04:51 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93351,"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"} May 06 09:04:51 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:04:51 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:04:51 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:04:51 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:04:51 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:51 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:51 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:04:51 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:04:51 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93351,"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"} May 06 09:04:51 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:04:51 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:04:51 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:04:51 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:04:51 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:51 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:04:51 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:04:51 volumio volumio[895]: info: ------------------------------ 68ms May 06 09:04:51 volumio volumio[895]: info: ------------------------------ 65ms May 06 09:04:52 volumio kernel: usb 2-5: device descriptor read/64, error -110 May 06 09:05:01 volumio kernel: usb 2-5: device descriptor read/64, error -71 May 06 09:05:01 volumio kernel: usb usb2-port5: attempt power cycle May 06 09:05:02 volumio kernel: usb 2-5: new high-speed USB device number 116 using ehci-pci May 06 09:05:05 volumio volumio[895]: info: May 06 09:05:05 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:05:05 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:05:05 volumio volumio[895]: info: May 06 09:05:05 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:05:05 volumio volumio[895]: info: ControllerMpd::getState May 06 09:05:05 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:05:05 volumio volumio[895]: info: May 06 09:05:05 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:05:05 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:05:05 volumio volumio[895]: info: May 06 09:05:05 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:05:05 volumio volumio[895]: info: ControllerMpd::getState May 06 09:05:05 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:05:05 volumio volumio[895]: info: ------------------------------ 11ms May 06 09:05:05 volumio volumio[895]: info: sendMpdCommand status took 10 milliseconds May 06 09:05:05 volumio volumio[895]: info: ------------------------------ 10ms May 06 09:05:05 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:05:05 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:05:05 volumio volumio[895]: info: sendMpdCommand status took 7 milliseconds May 06 09:05:05 volumio volumio[895]: info: sendMpdCommand playlistinfo took 2 milliseconds May 06 09:05:05 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:05:05 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:05:05 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:05:05 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:05:05 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:05:05 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":107843,"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"} May 06 09:05:05 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:05:05 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:05:05 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:05:05 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:05:05 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:05:05 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:05:05 volumio volumio[895]: info: ------------------------------ 49ms May 06 09:05:05 volumio volumio[895]: info: sendMpdCommand playlistinfo took 32 milliseconds May 06 09:05:05 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:05:05 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:05:05 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:05:05 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":107843,"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"} May 06 09:05:05 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:05:05 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:05:05 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:05:05 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:05:05 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:05:05 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:05:05 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:05:05 volumio volumio[895]: info: ------------------------------ 76ms May 06 09:05:06 volumio kernel: usb 2-5: device descriptor read/8, error -71 May 06 09:05:06 volumio kernel: usb 2-5: device descriptor read/8, error -71 May 06 09:05:06 volumio kernel: usb 2-5: new high-speed USB device number 117 using ehci-pci May 06 09:05:11 volumio kernel: usb 2-5: device descriptor read/8, error -110 May 06 09:05:17 volumio kernel: usb 2-5: device descriptor read/8, error -110 May 06 09:05:17 volumio systemd[1]: Starting Cleanup of Temporary Directories... May 06 09:05:17 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. May 06 09:05:17 volumio systemd[1]: Started Cleanup of Temporary Directories. May 06 09:05:17 volumio kernel: usb usb2-port5: unable to enumerate USB device May 06 09:05:17 volumio kernel: usb 5-5: new full-speed USB device number 15 using ohci-pci May 06 09:05:22 volumio volumio[895]: info: May 06 09:05:22 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:05:22 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:05:22 volumio volumio[895]: info: May 06 09:05:22 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:05:22 volumio volumio[895]: info: ControllerMpd::getState May 06 09:05:22 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:05:22 volumio volumio[895]: info: May 06 09:05:22 volumio volumio[895]: ---------------------------- MPD announces system playlist update May 06 09:05:22 volumio volumio[895]: info: Ignoring MPD Status Update May 06 09:05:22 volumio volumio[895]: info: May 06 09:05:22 volumio volumio[895]: ---------------------------- MPD announces state update: player May 06 09:05:22 volumio volumio[895]: info: ControllerMpd::getState May 06 09:05:22 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status May 06 09:05:22 volumio volumio[895]: info: ------------------------------ 8ms May 06 09:05:22 volumio volumio[895]: info: sendMpdCommand status took 4 milliseconds May 06 09:05:22 volumio volumio[895]: info: ------------------------------ 4ms May 06 09:05:22 volumio volumio[895]: info: sendMpdCommand status took 3 milliseconds May 06 09:05:22 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:05:22 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:05:22 volumio volumio[895]: verbose: ControllerMpd::parseState May 06 09:05:22 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 09:05:22 volumio volumio[895]: info: sendMpdCommand playlistinfo took 2 milliseconds May 06 09:05:22 volumio volumio[895]: info: sendMpdCommand playlistinfo took 2 milliseconds May 06 09:05:22 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:05:22 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo May 06 09:05:22 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:05:22 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:05:22 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":124845,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 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"} May 06 09:05:22 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:05:22 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:05:22 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:05:22 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:05:22 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:05:22 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:05:22 volumio volumio[895]: info: ControllerMpd::pushState May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::servicePushState May 06 09:05:22 volumio volumio[895]: info: CorePlayQueue::getTrack 0 May 06 09:05:22 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":124845,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 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"} May 06 09:05:22 volumio volumio[895]: verbose: CURRENT POSITION 0 May 06 09:05:22 volumio volumio[895]: info: CoreStateMachine::syncState stateService play May 06 09:05:22 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play May 06 09:05:22 volumio volumio[895]: info: Received an update from plugin. extracting info from payload May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 06 09:05:22 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:05:22 volumio volumio[895]: info: CoreStateMachine::pushState May 06 09:05:22 volumio volumio[895]: info: CoreCommandRouter::volumioPushState May 06 09:05:22 volumio volumio[895]: info: ------------------------------ 62ms May 06 09:05:22 volumio volumio[895]: info: ------------------------------ 61ms May 06 09:05:32 volumio volumio[895]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 09:05:32 volumio volumio[895]: Error: connect ETIMEDOUT 179.60.193.9:80 May 06 09:05:32 volumio volumio[895]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 06 09:05:32 volumio volumio[895]: errno: -110, May 06 09:05:32 volumio volumio[895]: code: 'ETIMEDOUT', May 06 09:05:32 volumio volumio[895]: syscall: 'connect', May 06 09:05:32 volumio volumio[895]: address: '179.60.193.9', May 06 09:05:32 volumio volumio[895]: port: 80 May 06 09:05:32 volumio volumio[895]: } May 06 09:05:32 volumio volumio[895]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 09:05:33 volumio kernel: usb 5-5: device descriptor read/64, error -110 May 06 09:05:33 volumio sudo[2500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-06 09:04 May 06 09:05:33 volumio sudo[2500]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 04:09:51 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="2fe933ffb50e198f3245fc325fd10b17"