-- Logs begin at Sat 2024-10-26 13:16:18 UTC, end at Sat 2024-10-26 13:20:57 UTC. -- Oct 26 13:19:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 13:19:06 volumio volumio[958]: info: CURURI: music-library/USB Oct 26 13:19:10 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 13:19:10 volumio volumio[958]: info: CURURI: music-library/USB Oct 26 13:19:10 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 13:19:10 volumio volumio[958]: info: CURURI: music-library/USB Oct 26 13:19:11 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 13:19:11 volumio volumio[958]: info: CURURI: music-library/USB Oct 26 13:19:19 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Oct 26 13:19:19 volumio volumio[958]: info: [1729948759953] [80s80s] handleBrowseUri curUri: 80s80s Oct 26 13:19:22 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Oct 26 13:19:22 volumio volumio[958]: info: [1729948762176] [80s80s] handleBrowseUri curUri: 80s80s/eighties Oct 26 13:19:22 volumio volumio[958]: info: [1729948762177] [80s80s] getRadioContent url: eighties Oct 26 13:19:32 volumio volumio[958]: info: CoreCommandRouter::volumioAddQueueItems Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::addQueueItems Oct 26 13:19:32 volumio volumio[958]: info: CorePlayQueue::addQueueItems Oct 26 13:19:32 volumio volumio[958]: info: Adding Item to queue: webeighties/0 Oct 26 13:19:32 volumio volumio[958]: info: Exploding uri webeighties/0 in service 80s80s Oct 26 13:19:32 volumio volumio[958]: info: [1729948772240] [80s80s] explodeUri: webeighties/0 Oct 26 13:19:32 volumio volumio[958]: info: CorePlayQueue::saveQueue Oct 26 13:19:32 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Oct 26 13:19:32 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Oct 26 13:19:32 volumio volumio[958]: info: CoreCommandRouter::volumioPlay Oct 26 13:19:32 volumio volumio[958]: UNSET VOLATILE Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::play index 4200 Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::stop Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 13:19:32 volumio volumio[958]: UNSET VOLATILE Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::play index undefined Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 13:19:32 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:19:32 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Oct 26 13:19:32 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:19:32 volumio volumio[958]: info: [1729948772808] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/web/mp3-192/volumio Oct 26 13:19:32 volumio volumio[958]: info: [1729948772810] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=2 Oct 26 13:19:33 volumio volumio[958]: info: [1729948773368] [80s80s] received new event containing 2 songs. Oct 26 13:19:33 volumio volumio[958]: info: ControllerMpd::sendMpdCommand stop Oct 26 13:19:44 volumio systemd[1]: mpd.service stop-final-sigterm timed out. Killing. Oct 26 13:19:44 volumio systemd[1]: mpd.service: main process exited, code=killed, status=9/KILL Oct 26 13:19:44 volumio systemd[1]: Failed to start Music Player Daemon. Oct 26 13:19:44 volumio systemd[1]: Unit mpd.service entered failed state. Oct 26 13:19:44 volumio systemd[1]: Starting Music Player Daemon... Oct 26 13:20:31 volumio volumio[958]: info: No input data Oct 26 13:20:52 volumio kernel: usb 1-1.2: USB disconnect, device number 4 Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553265 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141384 Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141384 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142417, async page read Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553266 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553267 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553268 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141384 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142417, async page read Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141384 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142417, async page read Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141392 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142418, async page read Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553269 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553270 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553271 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141392 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142418, async page read Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141392 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142418, async page read Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141392 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142418, async page read Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553272 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553274 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553275 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141400 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142419, async page read Oct 26 13:20:54 volumio kernel: print_req_error: I/O error, dev sda, sector 1141400 Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142419, async page read Oct 26 13:20:54 volumio kernel: Buffer I/O error on dev sda1, logical block 142419, async page read Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553276 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553277 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553278 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553279 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553280 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553281 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553282 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read of MFT, mft=553283 count=1 br=-1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to read vcn 0x45: Input/output error Oct 26 13:20:54 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Oct 26 13:20:54 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Oct 26 13:20:54 volumio udisks-glue[569]: Device file /dev/sda1 unmounted from /media/VortexBox Backup Oct 26 13:20:54 volumio udisks-glue[569]: Device file /dev/sda1 removed Oct 26 13:20:54 volumio udisks-glue[569]: Device file /dev/sda removed Oct 26 13:20:54 volumio ntfs-3g[773]: Unmounting /dev/sda1 (VortexBox Backup) Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to sync device /dev/sda1: Input/output error Oct 26 13:20:54 volumio ntfs-3g[773]: Failed to close volume /dev/sda1: Input/output error Oct 26 13:20:54 volumio systemd[1]: Started Music Player Daemon. Oct 26 13:20:54 volumio systemd[1]: Starting Multi-User System. Oct 26 13:20:54 volumio systemd[1]: Reached target Multi-User System. Oct 26 13:20:54 volumio systemd[1]: Starting Graphical Interface. Oct 26 13:20:54 volumio systemd[1]: Reached target Graphical Interface. Oct 26 13:20:54 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 26 13:20:54 volumio volumio[958]: Upnp client error: Error: This socket has been ended by the other party Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: Upnp client error: Error: This socket has been ended by the other party Oct 26 13:20:54 volumio volumio[958]: Upnp client error: Error: This socket has been ended by the other party Oct 26 13:20:54 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 26 13:20:54 volumio systemd[1]: Startup finished in 9.369s (kernel) + 4min 16.839s (userspace) = 4min 26.208s. Oct 26 13:20:54 volumio volumio[958]: info: Oct 26 13:20:54 volumio volumio[958]: info: parsing response... Oct 26 13:20:54 volumio volumio[958]: info: parsing response... Oct 26 13:20:54 volumio volumio[958]: info: parsing response... Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand update Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand clear Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand clear Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: Upnp client error: Error: This socket has been ended by the other party Oct 26 13:20:54 volumio volumio[958]: Upnp client error: Error: This socket has been ended by the other party Oct 26 13:20:54 volumio udisks-glue[569]: Updating DB (#2) ... Oct 26 13:20:54 volumio udisks-glue[569]: volume: 40% repeat: off random: off single: off consume: off Oct 26 13:20:54 volumio udisks-glue[569]: Updating DB (#3) ... Oct 26 13:20:54 volumio udisks-glue[569]: volume: 40% repeat: off random: off single: off consume: off Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:54 volumio volumio[958]: info: Oct 26 13:20:54 volumio volumio[958]: ---------------------------- MPD announces state update: update Oct 26 13:20:54 volumio volumio[958]: info: MPD Database updated - AlbumList cache refreshed Oct 26 13:20:54 volumio volumio[958]: info: Oct 26 13:20:54 volumio volumio[958]: ---------------------------- MPD announces state update: database Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:54 volumio volumio[958]: info: Oct 26 13:20:54 volumio volumio[958]: ---------------------------- MPD announces state update: update Oct 26 13:20:54 volumio volumio[958]: info: Oct 26 13:20:54 volumio volumio[958]: ---------------------------- MPD announces system playlist update Oct 26 13:20:54 volumio volumio[958]: info: Ignoring MPD Status Update Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:54 volumio volumio[958]: info: Oct 26 13:20:54 volumio volumio[958]: ---------------------------- MPD announces state update: update Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::getState Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:54 volumio volumio[958]: info: parsing response... Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::getState Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::getState Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:54 volumio volumio[958]: info: parsing response... Oct 26 13:20:54 volumio volumio[958]: info: parsing response... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::getState Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand add "USB/VortexBox Backup/storage/music/flac/Barbara_-_Master_Serie_-_Vol._1/01_L'aigle_noir.flac" Oct 26 13:20:54 volumio volumio[958]: info: [1729948854977] [80s80s] adding url: http://streams.80s80s.de/web/mp3-192/volumio Oct 26 13:20:54 volumio volumio[958]: info: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:54 volumio volumio[958]: info: sending command... Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:55 volumio volumio[958]: info: Oct 26 13:20:55 volumio volumio[958]: ---------------------------- MPD announces state update: update Oct 26 13:20:55 volumio volumio[958]: info: Oct 26 13:20:55 volumio volumio[958]: info: Oct 26 13:20:55 volumio volumio[958]: ---------------------------- MPD announces system playlist update Oct 26 13:20:55 volumio volumio[958]: info: Ignoring MPD Status Update Oct 26 13:20:55 volumio volumio[958]: info: sending command... Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::getState Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::sendMpdCommand status Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: ------------------------------ 337ms Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: sending command... Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio volumio[958]: info: Command Router : Notfying DB Updatefalse Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::Close All Modals sent Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio volumio[958]: info: Command Router : Notfying DB Updatefalse Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::Close All Modals sent Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio volumio[958]: info: Command Router : Notfying DB Updatefalse Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::Close All Modals sent Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::sendMpdCommand play Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::servicePushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::syncState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::getState Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::servicePushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::syncState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::getState Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 13:20:55 volumio sudo[1346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 13:20:55 volumio volumio[958]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::servicePushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::syncState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::getState Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 13:20:55 volumio sudo[1346]: pam_unix(sudo:session): session closed for user root Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 26 13:20:55 volumio sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::servicePushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::syncState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::getState Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 13:20:55 volumio sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 13:20:55 volumio sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 13:20:55 volumio sudo[1351]: pam_unix(sudo:session): session closed for user root Oct 26 13:20:55 volumio sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 13:20:55 volumio sudo[1357]: pam_unix(sudo:session): session closed for user root Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 26 13:20:55 volumio volumio[958]: info: sending command... Oct 26 13:20:55 volumio sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 13:20:55 volumio volumio[958]: info: ------------------------------ 593ms Oct 26 13:20:55 volumio volumio[958]: info: ------------------------------ 591ms Oct 26 13:20:55 volumio volumio[958]: info: ------------------------------ 592ms Oct 26 13:20:55 volumio volumio[958]: info: ------------------------------ 588ms Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: ------------------------------ 271ms Oct 26 13:20:55 volumio sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 13:20:55 volumio volumio[958]: info: parsing response... Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio sudo[1370]: pam_unix(sudo:session): session closed for user root Oct 26 13:20:55 volumio volumio[958]: info: Command Router : Notfying DB Updatefalse Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::Close All Modals sent Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::parseState Oct 26 13:20:55 volumio volumio[958]: info: [1729948855582] [80s80s] Pushing the next song state: The The - This Is the Day Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::getState Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::servicePushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::syncState Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music/v4/68/d7/c4/68d7c452-b9d0-fa64-52b3-9550b1637b72/source/600x600bb.jpg","name":"The The - This Is the Day","title":"This Is the Day","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"260","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 26 13:20:55 volumio volumio[958]: info: CURRENT POSITION 4200 Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::getState Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 13:20:55 volumio volumio[958]: info: ControllerMpd::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::servicePushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::syncState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::pushState Oct 26 13:20:55 volumio volumio[958]: info: CoreStateMachine::getState Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Oct 26 13:20:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 13:20:55 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 13:20:55 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 26 13:20:55 volumio volumio[958]: info: [1729948855641] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Oct 26 13:20:55 volumio sudo[1385]: pam_unix(sudo:session): session closed for user root Oct 26 13:20:55 volumio sudo[1390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 13:20:55 volumio volumio[958]: info: ------------------------------ 378ms Oct 26 13:20:55 volumio sudo[1390]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 13:20:55 volumio sudo[1390]: pam_unix(sudo:session): session closed for user root Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 4200 Oct 26 13:20:55 volumio volumio[958]: info: CorePlayQueue::getTrack 3098 Oct 26 13:20:56 volumio kernel: usb 1-1.2: new high-speed USB device number 6 using dwc_otg Oct 26 13:20:56 volumio kernel: usb 1-1.2: New USB device found, idVendor=0bc2, idProduct=331a, bcdDevice= 9.15 Oct 26 13:20:56 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Oct 26 13:20:56 volumio kernel: usb 1-1.2: Product: Expansion Desk Oct 26 13:20:56 volumio kernel: usb 1-1.2: Manufacturer: Seagate Oct 26 13:20:56 volumio kernel: usb 1-1.2: SerialNumber: 2HC015KJ Oct 26 13:20:56 volumio kernel: usb 1-1.2: The driver for the USB controller dwc_otg_hcd does not support scatter-gather which is Oct 26 13:20:56 volumio kernel: usb 1-1.2: required by the UAS driver. Please try an other USB controller if you wish to use UAS. Oct 26 13:20:56 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Oct 26 13:20:56 volumio kernel: usb-storage 1-1.2:1.0: Quirks match for vid 0bc2 pid 331a: 10000000 Oct 26 13:20:56 volumio kernel: scsi host0: usb-storage 1-1.2:1.0 Oct 26 13:20:56 volumio volumio[958]: info: [1729948856755] [80s80s] Failed to query api, status code: 404 Oct 26 13:20:56 volumio volumio[958]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 13:20:56 volumio volumio[958]: ReferenceError: station is not defined Oct 26 13:20:56 volumio volumio[958]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Oct 26 13:20:56 volumio volumio[958]: at Object.onceWrapper (events.js:315:30) Oct 26 13:20:56 volumio volumio[958]: at emitOne (events.js:116:13) Oct 26 13:20:56 volumio volumio[958]: at ClientRequest.emit (events.js:211:7) Oct 26 13:20:56 volumio volumio[958]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Oct 26 13:20:56 volumio volumio[958]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Oct 26 13:20:56 volumio volumio[958]: at Socket.socketOnData (_http_client.js:440:20) Oct 26 13:20:56 volumio volumio[958]: at emitOne (events.js:116:13) Oct 26 13:20:56 volumio volumio[958]: at Socket.emit (events.js:211:7) Oct 26 13:20:56 volumio volumio[958]: at addChunk (_stream_readable.js:263:12) Oct 26 13:20:56 volumio volumio[958]: at readableAddChunk (_stream_readable.js:250:11) Oct 26 13:20:56 volumio volumio[958]: at Socket.Readable.push (_stream_readable.js:208:10) Oct 26 13:20:56 volumio volumio[958]: at TCP.onread (net.js:607:20) Oct 26 13:20:56 volumio volumio[958]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 13:20:57 volumio kernel: usb 1-1.2: USB disconnect, device number 6 Oct 26 13:20:57 volumio kernel: usb 1-1.2: new high-speed USB device number 7 using dwc_otg Oct 26 13:20:57 volumio sudo[1428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 13:19 Oct 26 13:20:57 volumio sudo[1428]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="6c3e4fa86d5413587e5bfd2f824b888a0ddfaa8b" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="b78ecf1a48254ce8eadcc4803b4fff49030ca2e5" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 18 15:58:42 CEST 2019" VOLUMIO_VERSION="2.657" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="ff0b4ec11fd1765611cb6e93a4e1e737"