-- Logs begin at Sun 2024-04-28 01:42:07 UTC, end at Tue 2024-11-26 12:32:45 UTC. -- Nov 26 12:31:08 opera kernel: sd 1:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=0x08 Nov 26 12:31:08 opera kernel: sd 1:0:0:0: [sda] tag#0 Sense Key : 0x4 [current] [descriptor] Nov 26 12:31:08 opera kernel: sd 1:0:0:0: [sda] tag#0 ASC=0x0 ASCQ=0x0 Nov 26 12:31:08 opera kernel: sd 1:0:0:0: [sda] tag#0 CDB: opcode=0xa1 a1 06 20 00 00 00 00 00 00 e5 00 00 Nov 26 12:31:08 opera kernel: sd 1:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=0x08 Nov 26 12:31:08 opera kernel: sd 1:0:0:0: [sda] tag#0 Sense Key : 0x4 [current] [descriptor] Nov 26 12:31:08 opera kernel: sd 1:0:0:0: [sda] tag#0 ASC=0x0 ASCQ=0x0 Nov 26 12:31:08 opera kernel: sd 1:0:0:0: [sda] tag#0 CDB: opcode=0xa1 a1 06 20 da 00 00 4f c2 00 b0 00 00 Nov 26 12:31:20 opera volumio[1325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/classical/cc8b8292-6cea-4f83-8a44-9b2c6d2a78a5.jpg' Nov 26 12:31:20 opera volumio[1325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/classical/cc8b8292-6cea-4f83-8a44-9b2c6d2a78a5.jpg' Nov 26 12:31:20 opera volumio[1325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/classical/cc8b8292-6cea-4f83-8a44-9b2c6d2a78a5.jpg' Nov 26 12:31:20 opera volumio[1325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/classical/cc8b8292-6cea-4f83-8a44-9b2c6d2a78a5.jpg' Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::ClearQueue Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:23 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::stPlaybackTimer Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::updateTrackBlock Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::getTrackBlock Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::serviceStop Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::serviceStop Nov 26 12:31:23 opera volumio[1325]: info: [1732624283790] ControllerWebradio::stop Nov 26 12:31:23 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::clearPlayQueue Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::addQueueItems Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::addQueueItems Nov 26 12:31:23 opera volumio[1325]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1636415 Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::updateTrackBlock Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::getTrackBlock Nov 26 12:31:23 opera volumio[1325]: info: CoreCommandRouter::volumioPlay Nov 26 12:31:23 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::play index 0 Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:23 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::play index undefined Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:23 opera volumio[1325]: info: CoreStateMachine::startPlaybackTimer Nov 26 12:31:23 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:23 opera volumio[1325]: info: [1732624283802] ControllerWebradio::clearAddPlayTrack Nov 26 12:31:23 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 12:31:23 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:23 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:23 opera volumio[1325]: info: Nov 26 12:31:23 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:23 opera volumio[1325]: info: sendMpdCommand stop took 84 milliseconds Nov 26 12:31:23 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:23 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:23 opera volumio[1325]: info: sendMpdCommand stop took 73 milliseconds Nov 26 12:31:23 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 12:31:23 opera volumio[1325]: info: Nov 26 12:31:23 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:23 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:23 opera volumio[1325]: info: sendMpdCommand status took 2 milliseconds Nov 26 12:31:23 opera volumio[1325]: info: sendMpdCommand clear took 1 milliseconds Nov 26 12:31:23 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:23 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:23 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1636415" Nov 26 12:31:23 opera volumio[1325]: error: updateQueue error: null Nov 26 12:31:23 opera volumio[1325]: info: ------------------------------ 4ms Nov 26 12:31:23 opera volumio[1325]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 12:31:23 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:23 opera volumio[1325]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 12:31:23 opera volumio[1325]: info: ------------------------------ 7ms Nov 26 12:31:25 opera volumio[1325]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1636415" took 1490 milliseconds Nov 26 12:31:25 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 26 12:31:25 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand play Nov 26 12:31:25 opera volumio[1325]: info: Nov 26 12:31:25 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:25 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:25 opera volumio[1325]: info: sendMpdCommand play took 8 milliseconds Nov 26 12:31:25 opera volumio[1325]: info: ------------------------------ 8ms Nov 26 12:31:29 opera volumio[1325]: info: Nov 26 12:31:29 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:29 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:29 opera volumio[1325]: info: Nov 26 12:31:29 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:29 opera volumio[1325]: info: Nov 26 12:31:29 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:29 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:29 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:29 opera volumio[1325]: info: sendMpdCommand status took 1 milliseconds Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:29 opera volumio[1325]: info: Nov 26 12:31:29 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:29 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:29 opera volumio[1325]: info: Nov 26 12:31:29 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:29 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:29 opera volumio[1325]: info: sendMpdCommand status took 3 milliseconds Nov 26 12:31:29 opera volumio[1325]: info: ------------------------------ 4ms Nov 26 12:31:29 opera volumio[1325]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 12:31:29 opera volumio[1325]: info: ------------------------------ 3ms Nov 26 12:31:29 opera volumio[1325]: info: sendMpdCommand status took 2 milliseconds Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:29 opera volumio[1325]: info: ControllerMpd::pushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::servicePushState Nov 26 12:31:29 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:29 opera volumio[1325]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Spandau Ballet - True - Single Edit","artist":"1.FM - Love Classics Radio","album":null,"uri":"http://185.33.21.112:80/loveclassics_32a","trackType":""} Nov 26 12:31:29 opera volumio[1325]: verbose: CURRENT POSITION 0 Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::syncState stateService play Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::syncState currentStatus stop Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:29 opera volumio[1325]: info: ------------------------------ 12ms Nov 26 12:31:29 opera volumio[1325]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 26 12:31:29 opera volumio[1325]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:29 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:29 opera volumio[1325]: info: ControllerMpd::pushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::servicePushState Nov 26 12:31:29 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:29 opera volumio[1325]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Spandau Ballet - True - Single Edit","artist":"1.FM - Love Classics Radio","album":null,"uri":"http://185.33.21.112:80/loveclassics_32a","trackType":""} Nov 26 12:31:29 opera volumio[1325]: verbose: CURRENT POSITION 0 Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::syncState stateService play Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:31:29 opera volumio[1325]: info: Received an update from plugin. extracting info from payload Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:29 opera volumio[1325]: info: ControllerMpd::pushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::servicePushState Nov 26 12:31:29 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:29 opera volumio[1325]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Spandau Ballet - True - Single Edit","artist":"1.FM - Love Classics Radio","album":null,"uri":"http://185.33.21.112:80/loveclassics_32a","trackType":""} Nov 26 12:31:29 opera volumio[1325]: verbose: CURRENT POSITION 0 Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::syncState stateService play Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:31:29 opera volumio[1325]: info: Received an update from plugin. extracting info from payload Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:29 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:29 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:29 opera volumio[1325]: info: ------------------------------ 33ms Nov 26 12:31:29 opera volumio[1325]: info: ------------------------------ 32ms Nov 26 12:31:29 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:29 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:29 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:29 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:29 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:29 opera volumio[1325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/classical/cc8b8292-6cea-4f83-8a44-9b2c6d2a78a5.jpg' Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::ClearQueue Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:32 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::stPlaybackTimer Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::updateTrackBlock Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::getTrackBlock Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::serviceStop Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::serviceStop Nov 26 12:31:32 opera volumio[1325]: info: [1732624292677] ControllerWebradio::stop Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::clearPlayQueue Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::addQueueItems Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::addQueueItems Nov 26 12:31:32 opera volumio[1325]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1636415 Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::updateTrackBlock Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::getTrackBlock Nov 26 12:31:32 opera volumio[1325]: info: CoreCommandRouter::volumioPlay Nov 26 12:31:32 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::play index 0 Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:32 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::play index undefined Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::startPlaybackTimer Nov 26 12:31:32 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:32 opera volumio[1325]: info: [1732624292696] ControllerWebradio::clearAddPlayTrack Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 12:31:32 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:32 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:32 opera volumio[1325]: info: Nov 26 12:31:32 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:32 opera volumio[1325]: info: sendMpdCommand stop took 71 milliseconds Nov 26 12:31:32 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:32 opera volumio[1325]: info: sendMpdCommand stop took 52 milliseconds Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 12:31:32 opera volumio[1325]: info: Nov 26 12:31:32 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:32 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:32 opera volumio[1325]: info: sendMpdCommand status took 4 milliseconds Nov 26 12:31:32 opera volumio[1325]: info: sendMpdCommand clear took 3 milliseconds Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1636415" Nov 26 12:31:32 opera volumio[1325]: error: updateQueue error: null Nov 26 12:31:32 opera volumio[1325]: info: ------------------------------ 5ms Nov 26 12:31:32 opera volumio[1325]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:32 opera volumio[1325]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 12:31:32 opera volumio[1325]: info: ------------------------------ 10ms Nov 26 12:31:32 opera volumio[1325]: info: Nov 26 12:31:32 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:32 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:32 opera volumio[1325]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1636415" took 228 milliseconds Nov 26 12:31:32 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 26 12:31:32 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand play Nov 26 12:31:32 opera volumio[1325]: info: ------------------------------ 2ms Nov 26 12:31:32 opera volumio[1325]: info: sendMpdCommand play took 1 milliseconds Nov 26 12:31:35 opera volumio[1325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/classical/cc8b8292-6cea-4f83-8a44-9b2c6d2a78a5.jpg' Nov 26 12:31:39 opera volumio[1325]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::ClearQueue Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:39 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:39 opera volumio[1325]: info: CorePlayQueue::clearPlayQueue Nov 26 12:31:39 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:39 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:39 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:39 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::addQueueItems Nov 26 12:31:39 opera volumio[1325]: info: CorePlayQueue::addQueueItems Nov 26 12:31:39 opera volumio[1325]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1847171 Nov 26 12:31:39 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 26 12:31:39 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:39 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::updateTrackBlock Nov 26 12:31:39 opera volumio[1325]: info: CorePlayQueue::getTrackBlock Nov 26 12:31:39 opera volumio[1325]: info: CoreCommandRouter::volumioPlay Nov 26 12:31:39 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::play index 0 Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:39 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::play index undefined Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:39 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:39 opera volumio[1325]: info: CoreStateMachine::startPlaybackTimer Nov 26 12:31:39 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:39 opera volumio[1325]: info: [1732624299856] ControllerWebradio::clearAddPlayTrack Nov 26 12:31:39 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 12:31:39 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:39 opera volumio[1325]: info: Nov 26 12:31:39 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:39 opera volumio[1325]: info: sendMpdCommand stop took 14 milliseconds Nov 26 12:31:39 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:39 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:39 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 12:31:39 opera volumio[1325]: info: Nov 26 12:31:39 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:39 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:39 opera volumio[1325]: info: sendMpdCommand status took 2 milliseconds Nov 26 12:31:39 opera volumio[1325]: info: sendMpdCommand clear took 2 milliseconds Nov 26 12:31:39 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:39 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:39 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1847171" Nov 26 12:31:39 opera volumio[1325]: error: updateQueue error: null Nov 26 12:31:39 opera volumio[1325]: info: ------------------------------ 3ms Nov 26 12:31:39 opera volumio[1325]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 26 12:31:39 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:39 opera volumio[1325]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 12:31:39 opera volumio[1325]: info: ------------------------------ 6ms Nov 26 12:31:40 opera volumio[1325]: info: Nov 26 12:31:40 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:40 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:40 opera volumio[1325]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1847171" took 221 milliseconds Nov 26 12:31:40 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 26 12:31:40 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand play Nov 26 12:31:40 opera volumio[1325]: info: ------------------------------ 2ms Nov 26 12:31:40 opera volumio[1325]: info: sendMpdCommand play took 2 milliseconds Nov 26 12:31:43 opera volumio[1325]: info: Nov 26 12:31:43 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:43 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:43 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:43 opera volumio[1325]: info: Nov 26 12:31:43 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:43 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:43 opera volumio[1325]: info: Nov 26 12:31:43 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:43 opera volumio[1325]: info: sendMpdCommand status took 3 milliseconds Nov 26 12:31:43 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:43 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:43 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:43 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:43 opera volumio[1325]: info: ------------------------------ 4ms Nov 26 12:31:43 opera volumio[1325]: info: sendMpdCommand status took 2 milliseconds Nov 26 12:31:43 opera volumio[1325]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 26 12:31:43 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:43 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:43 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:43 opera volumio[1325]: info: ControllerMpd::pushState Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::servicePushState Nov 26 12:31:43 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:43 opera volumio[1325]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Bosut - Journey To The Deep","artist":"1.FM - Deep House Radio","album":null,"uri":"http://185.33.21.112:80/deephouse_64","trackType":""} Nov 26 12:31:43 opera volumio[1325]: verbose: CURRENT POSITION 0 Nov 26 12:31:43 opera volumio[1325]: info: CoreStateMachine::syncState stateService play Nov 26 12:31:43 opera volumio[1325]: info: CoreStateMachine::syncState currentStatus stop Nov 26 12:31:43 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:43 opera volumio[1325]: info: ------------------------------ 14ms Nov 26 12:31:43 opera volumio[1325]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 26 12:31:43 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:43 opera volumio[1325]: info: ControllerMpd::pushState Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::servicePushState Nov 26 12:31:43 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:43 opera volumio[1325]: verbose: STATE SERVICE {"status":"play","position":0,"seek":484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Bosut - Journey To The Deep","artist":"1.FM - Deep House Radio","album":null,"uri":"http://185.33.21.112:80/deephouse_64","trackType":""} Nov 26 12:31:43 opera volumio[1325]: verbose: CURRENT POSITION 0 Nov 26 12:31:43 opera volumio[1325]: info: CoreStateMachine::syncState stateService play Nov 26 12:31:43 opera volumio[1325]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:31:43 opera volumio[1325]: info: Received an update from plugin. extracting info from payload Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 12:31:43 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:43 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:43 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:43 opera volumio[1325]: info: ------------------------------ 20ms Nov 26 12:31:43 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:43 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:43 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::ClearQueue Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:45 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::stPlaybackTimer Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::updateTrackBlock Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::getTrackBlock Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::serviceStop Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::serviceStop Nov 26 12:31:45 opera volumio[1325]: info: [1732624305912] ControllerWebradio::stop Nov 26 12:31:45 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::clearPlayQueue Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::addQueueItems Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::addQueueItems Nov 26 12:31:45 opera volumio[1325]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1823426 Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::updateTrackBlock Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::getTrackBlock Nov 26 12:31:45 opera volumio[1325]: info: CoreCommandRouter::volumioPlay Nov 26 12:31:45 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::play index 0 Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:45 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::play index undefined Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:45 opera volumio[1325]: info: CoreStateMachine::startPlaybackTimer Nov 26 12:31:45 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:45 opera volumio[1325]: info: [1732624305926] ControllerWebradio::clearAddPlayTrack Nov 26 12:31:45 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 12:31:45 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:45 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:46 opera volumio[1325]: info: sendMpdCommand stop took 133 milliseconds Nov 26 12:31:46 opera volumio[1325]: info: Nov 26 12:31:46 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:46 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:46 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:46 opera volumio[1325]: info: sendMpdCommand stop took 120 milliseconds Nov 26 12:31:46 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 12:31:46 opera volumio[1325]: info: Nov 26 12:31:46 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:46 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:46 opera volumio[1325]: info: sendMpdCommand status took 2 milliseconds Nov 26 12:31:46 opera volumio[1325]: info: sendMpdCommand clear took 2 milliseconds Nov 26 12:31:46 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:46 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:46 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1823426" Nov 26 12:31:46 opera volumio[1325]: error: updateQueue error: null Nov 26 12:31:46 opera volumio[1325]: info: ------------------------------ 2ms Nov 26 12:31:46 opera volumio[1325]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 12:31:46 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:46 opera volumio[1325]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 12:31:46 opera volumio[1325]: info: ------------------------------ 5ms Nov 26 12:31:46 opera volumio[1325]: info: Nov 26 12:31:46 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:46 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:46 opera volumio[1325]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1823426" took 233 milliseconds Nov 26 12:31:46 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 26 12:31:46 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand play Nov 26 12:31:46 opera volumio[1325]: info: ------------------------------ 2ms Nov 26 12:31:46 opera volumio[1325]: info: sendMpdCommand play took 1 milliseconds Nov 26 12:31:54 opera volumio[1325]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::ClearQueue Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:54 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:54 opera volumio[1325]: info: CorePlayQueue::clearPlayQueue Nov 26 12:31:54 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:54 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:54 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:54 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::addQueueItems Nov 26 12:31:54 opera volumio[1325]: info: CorePlayQueue::addQueueItems Nov 26 12:31:54 opera volumio[1325]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1863812 Nov 26 12:31:54 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 26 12:31:54 opera volumio[1325]: info: CorePlayQueue::saveQueue Nov 26 12:31:54 opera volumio[1325]: info: CoreCommandRouter::volumioPushQueue Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::updateTrackBlock Nov 26 12:31:54 opera volumio[1325]: info: CorePlayQueue::getTrackBlock Nov 26 12:31:54 opera volumio[1325]: info: CoreCommandRouter::volumioPlay Nov 26 12:31:54 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::play index 0 Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::stop Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:54 opera volumio[1325]: verbose: UNSET VOLATILE Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::play index undefined Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 12:31:54 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::startPlaybackTimer Nov 26 12:31:54 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:54 opera volumio[1325]: info: [1732624314736] ControllerWebradio::clearAddPlayTrack Nov 26 12:31:54 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 12:31:54 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:54 opera volumio[1325]: info: Nov 26 12:31:54 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:54 opera volumio[1325]: info: sendMpdCommand stop took 9 milliseconds Nov 26 12:31:54 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:54 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:54 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 12:31:54 opera volumio[1325]: info: Nov 26 12:31:54 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:54 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:54 opera volumio[1325]: info: sendMpdCommand status took 2 milliseconds Nov 26 12:31:54 opera volumio[1325]: info: sendMpdCommand clear took 3 milliseconds Nov 26 12:31:54 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:54 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:54 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1863812" Nov 26 12:31:54 opera volumio[1325]: error: updateQueue error: null Nov 26 12:31:54 opera volumio[1325]: info: ------------------------------ 2ms Nov 26 12:31:54 opera volumio[1325]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 12:31:54 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:54 opera volumio[1325]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 12:31:54 opera volumio[1325]: info: ------------------------------ 6ms Nov 26 12:31:54 opera volumio[1325]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1863812" took 235 milliseconds Nov 26 12:31:54 opera volumio[1325]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 26 12:31:54 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand play Nov 26 12:31:54 opera volumio[1325]: info: Nov 26 12:31:54 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:54 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:54 opera volumio[1325]: info: sendMpdCommand play took 1 milliseconds Nov 26 12:31:54 opera volumio[1325]: info: ------------------------------ 1ms Nov 26 12:31:58 opera volumio[1325]: info: Nov 26 12:31:58 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:58 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:58 opera volumio[1325]: info: Nov 26 12:31:58 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:58 opera volumio[1325]: info: sendMpdCommand status took 2 milliseconds Nov 26 12:31:58 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:58 opera volumio[1325]: info: Nov 26 12:31:58 opera volumio[1325]: ---------------------------- MPD announces system playlist update Nov 26 12:31:58 opera volumio[1325]: info: Ignoring MPD Status Update Nov 26 12:31:58 opera volumio[1325]: info: Nov 26 12:31:58 opera volumio[1325]: ---------------------------- MPD announces state update: player Nov 26 12:31:58 opera volumio[1325]: info: ControllerMpd::getState Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:31:58 opera volumio[1325]: info: sendMpdCommand status took 2 milliseconds Nov 26 12:31:58 opera volumio[1325]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:58 opera volumio[1325]: info: ControllerMpd::pushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::servicePushState Nov 26 12:31:58 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:58 opera volumio[1325]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"MOZART - Symphony No. 22 in C major, K. 162","artist":"classical","album":null,"uri":"http://185.33.21.112:80/classical_mobile_aac","trackType":""} Nov 26 12:31:58 opera volumio[1325]: verbose: CURRENT POSITION 0 Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::syncState stateService play Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::syncState currentStatus stop Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:58 opera volumio[1325]: info: ------------------------------ 11ms Nov 26 12:31:58 opera volumio[1325]: info: ------------------------------ 8ms Nov 26 12:31:58 opera volumio[1325]: info: sendMpdCommand status took 8 milliseconds Nov 26 12:31:58 opera volumio[1325]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::parseState Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:58 opera volumio[1325]: info: ControllerMpd::pushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::servicePushState Nov 26 12:31:58 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:58 opera volumio[1325]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"MOZART - Symphony No. 22 in C major, K. 162","artist":"classical","album":null,"uri":"http://185.33.21.112:80/classical_mobile_aac","trackType":""} Nov 26 12:31:58 opera volumio[1325]: verbose: CURRENT POSITION 0 Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::syncState stateService play Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:31:58 opera volumio[1325]: info: Received an update from plugin. extracting info from payload Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:58 opera volumio[1325]: info: ------------------------------ 21ms Nov 26 12:31:58 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:58 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:58 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:58 opera volumio[1325]: info: sendMpdCommand playlistinfo took 22 milliseconds Nov 26 12:31:58 opera volumio[1325]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:31:58 opera volumio[1325]: info: ControllerMpd::pushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::servicePushState Nov 26 12:31:58 opera volumio[1325]: info: CorePlayQueue::getTrack 0 Nov 26 12:31:58 opera volumio[1325]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"MOZART - Symphony No. 22 in C major, K. 162","artist":"classical","album":null,"uri":"http://185.33.21.112:80/classical_mobile_aac","trackType":""} Nov 26 12:31:58 opera volumio[1325]: verbose: CURRENT POSITION 0 Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::syncState stateService play Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:31:58 opera volumio[1325]: info: Received an update from plugin. extracting info from payload Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:58 opera volumio[1325]: info: CoreStateMachine::pushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::volumioPushState Nov 26 12:31:58 opera volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:31:58 opera volumio[1325]: info: ------------------------------ 42ms Nov 26 12:31:58 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:31:58 opera volumio[1325]: info: Updating RAAT Signal Path Nov 26 12:32:08 opera volumio[1325]: info: Saving local item radio-favourites Nov 26 12:32:08 opera volumio[1325]: info: Pushing Favourites {"uri":"http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1863812","favourite":false} Nov 26 12:32:45 opera volumio[1325]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 12:32:45 opera volumio[1325]: { Error: connect ETIMEDOUT 108.160.165.9:80 Nov 26 12:32:45 opera volumio[1325]: at Object._errnoException (util.js:1022:11) Nov 26 12:32:45 opera volumio[1325]: at _exceptionWithHostPort (util.js:1044:20) Nov 26 12:32:45 opera volumio[1325]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Nov 26 12:32:45 opera volumio[1325]: code: 'ETIMEDOUT', Nov 26 12:32:45 opera volumio[1325]: errno: 'ETIMEDOUT', Nov 26 12:32:45 opera volumio[1325]: syscall: 'connect', Nov 26 12:32:45 opera volumio[1325]: address: '108.160.165.9', Nov 26 12:32:45 opera volumio[1325]: port: 80 } Nov 26 12:32:45 opera volumio[1325]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 12:32:45 opera sudo[15002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 12:31 Nov 26 12:32:45 opera sudo[15002]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"