-- Logs begin at Fri 2022-04-08 15:29:57 UTC, end at Sat 2025-04-26 03:08:59 UTC. -- Apr 26 03:07:00 opera volumio[1404]: info: Apr 26 03:07:00 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:00 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:00 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:00 opera volumio[1404]: info: sendMpdCommand status took 3 milliseconds Apr 26 03:07:00 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:00 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:00 opera volumio[1404]: info: Apr 26 03:07:00 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:00 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:00 opera volumio[1404]: info: Apr 26 03:07:00 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:00 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:00 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:00 opera volumio[1404]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 26 03:07:00 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:00 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:07:00 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:00 opera volumio[1404]: 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":"128 Kbps","isStreaming":false,"title":"Britney Spears - Baby One More Time","artist":"113.fm Hits 1999","album":null,"uri":"http://75.102.53.58:80/1043","trackType":"58:80/1043"} Apr 26 03:07:00 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:07:00 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:07:00 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:07:00 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:00 opera volumio[1404]: info: ------------------------------ 10ms Apr 26 03:07:00 opera volumio[1404]: info: ------------------------------ 7ms Apr 26 03:07:00 opera volumio[1404]: info: sendMpdCommand status took 6 milliseconds Apr 26 03:07:00 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:00 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:00 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:00 opera volumio[1404]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 26 03:07:00 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:00 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:07:00 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:00 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Britney Spears - Baby One More Time","artist":"113.fm Hits 1999","album":null,"uri":"http://75.102.53.58:80/1043","trackType":"58:80/1043"} Apr 26 03:07:00 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:07:00 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:07:00 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus play Apr 26 03:07:00 opera volumio[1404]: info: Received an update from plugin. extracting info from payload Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 26 03:07:00 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:00 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:00 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:00 opera volumio[1404]: info: ------------------------------ 21ms Apr 26 03:07:00 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:00 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:00 opera volumio[1404]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/J-Pop%20Powerplay%20Kawaii/28bc084d-032b-4888-8d8c-fc860c5decac.jpg' Apr 26 03:07:15 opera volumio[1404]: info: CoreCommandRouter::volumioStop Apr 26 03:07:15 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:15 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:15 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:15 opera volumio[1404]: info: CoreStateMachine::stPlaybackTimer Apr 26 03:07:15 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:15 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:15 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:15 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:15 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:15 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:15 opera volumio[1404]: info: CoreStateMachine::serviceStop Apr 26 03:07:15 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:15 opera volumio[1404]: info: CoreCommandRouter::serviceStop Apr 26 03:07:15 opera volumio[1404]: info: [1745636835078] ControllerWebradio::stop Apr 26 03:07:15 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:15 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:15 opera volumio[1404]: info: Apr 26 03:07:15 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:15 opera volumio[1404]: info: sendMpdCommand stop took 27 milliseconds Apr 26 03:07:15 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:15 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:15 opera volumio[1404]: info: sendMpdCommand status took 0 milliseconds Apr 26 03:07:15 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:15 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:15 opera volumio[1404]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 26 03:07:15 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:15 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:07:15 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:07:15 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:15 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:15 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:15 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:15 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:15 opera volumio[1404]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 26 03:07:15 opera volumio[1404]: info: ------------------------------ 8ms Apr 26 03:07:15 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:17 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:17 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:17 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:07:17 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:17 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:17 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:17 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:07:17 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:07:17 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1810227 Apr 26 03:07:17 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:07:17 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:17 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:17 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:17 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:07:17 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:17 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:17 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:17 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:07:17 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:17 opera volumio[1404]: info: [1745636837803] ControllerWebradio::clearAddPlayTrack Apr 26 03:07:17 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:17 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:17 opera volumio[1404]: info: sendMpdCommand stop took 7 milliseconds Apr 26 03:07:17 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:07:17 opera volumio[1404]: info: Apr 26 03:07:17 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:17 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:17 opera volumio[1404]: info: sendMpdCommand clear took 1 milliseconds Apr 26 03:07:17 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1810227" Apr 26 03:07:17 opera volumio[1404]: error: updateQueue error: null Apr 26 03:07:17 opera volumio[1404]: info: ------------------------------ 1ms Apr 26 03:07:18 opera volumio[1404]: info: Apr 26 03:07:18 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:18 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:18 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1810227" took 248 milliseconds Apr 26 03:07:18 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:07:18 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:07:18 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:07:18 opera volumio[1404]: info: sendMpdCommand play took 1 milliseconds Apr 26 03:07:21 opera volumio[1404]: info: Apr 26 03:07:21 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:21 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:21 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:21 opera volumio[1404]: info: sendMpdCommand status took 24 milliseconds Apr 26 03:07:21 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:21 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:21 opera volumio[1404]: info: Apr 26 03:07:21 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:21 opera volumio[1404]: info: Apr 26 03:07:21 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:21 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:21 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:21 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:21 opera volumio[1404]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 26 03:07:21 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:21 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:07:21 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:21 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"stream","artist":"Radio Kosova e Lire","album":null,"uri":"http://195.201.166.244:8018/stream","trackType":""} Apr 26 03:07:21 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:07:21 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:07:21 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:07:21 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:21 opera volumio[1404]: info: ------------------------------ 34ms Apr 26 03:07:21 opera volumio[1404]: info: sendMpdCommand status took 8 milliseconds Apr 26 03:07:21 opera volumio[1404]: info: ------------------------------ 10ms Apr 26 03:07:21 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:21 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:21 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:21 opera volumio[1404]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 26 03:07:21 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:21 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:07:21 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:21 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"stream","artist":"Radio Kosova e Lire","album":null,"uri":"http://195.201.166.244:8018/stream","trackType":""} Apr 26 03:07:21 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:07:21 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:07:21 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus play Apr 26 03:07:21 opera volumio[1404]: info: Received an update from plugin. extracting info from payload Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 26 03:07:21 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:21 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:21 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:21 opera volumio[1404]: info: ------------------------------ 24ms Apr 26 03:07:21 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:21 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:25 opera volumio[1404]: info: CoreCommandRouter::volumioStop Apr 26 03:07:25 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:25 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:25 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:25 opera volumio[1404]: info: CoreStateMachine::stPlaybackTimer Apr 26 03:07:25 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:25 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:25 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:25 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:25 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:25 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:25 opera volumio[1404]: info: CoreStateMachine::serviceStop Apr 26 03:07:25 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:25 opera volumio[1404]: info: CoreCommandRouter::serviceStop Apr 26 03:07:25 opera volumio[1404]: info: [1745636845317] ControllerWebradio::stop Apr 26 03:07:25 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:25 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:25 opera volumio[1404]: info: Apr 26 03:07:25 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:25 opera volumio[1404]: info: sendMpdCommand stop took 62 milliseconds Apr 26 03:07:25 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:25 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:25 opera volumio[1404]: info: sendMpdCommand status took 0 milliseconds Apr 26 03:07:25 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:25 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:25 opera volumio[1404]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 26 03:07:25 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:25 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:07:25 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:07:25 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:25 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:25 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:25 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:25 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:25 opera volumio[1404]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 26 03:07:25 opera volumio[1404]: info: ------------------------------ 13ms Apr 26 03:07:25 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:27 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:27 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:27 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:07:27 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:27 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:27 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:27 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:07:27 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:07:27 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1812837 Apr 26 03:07:27 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:07:27 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:27 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:27 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:27 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:07:27 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:27 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:27 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:07:27 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:27 opera volumio[1404]: info: [1745636847506] ControllerWebradio::clearAddPlayTrack Apr 26 03:07:27 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:27 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:27 opera volumio[1404]: info: sendMpdCommand stop took 6 milliseconds Apr 26 03:07:27 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:07:27 opera volumio[1404]: info: Apr 26 03:07:27 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:27 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:27 opera volumio[1404]: info: sendMpdCommand clear took 1 milliseconds Apr 26 03:07:27 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1812837" Apr 26 03:07:27 opera volumio[1404]: error: updateQueue error: null Apr 26 03:07:27 opera volumio[1404]: info: ------------------------------ 3ms Apr 26 03:07:27 opera volumio[1404]: info: Apr 26 03:07:27 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:27 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:27 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1812837" took 252 milliseconds Apr 26 03:07:27 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:07:27 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:07:27 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:07:27 opera volumio[1404]: info: sendMpdCommand play took 1 milliseconds Apr 26 03:07:30 opera dhcpd[1437]: DHCPDISCOVER from 48:e7:da:4f:09:1d (opera) via wlan0 Apr 26 03:07:31 opera dhcpd[1437]: DHCPOFFER on 192.168.211.5 to 48:e7:da:4f:09:1d (opera) via wlan0 Apr 26 03:07:35 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:35 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:35 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:07:35 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:35 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:35 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:35 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:07:35 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:07:35 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=720974 Apr 26 03:07:35 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:07:35 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:35 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:35 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:35 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:07:35 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:35 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:35 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:35 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:07:35 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:35 opera volumio[1404]: info: [1745636855789] ControllerWebradio::clearAddPlayTrack Apr 26 03:07:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:35 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:35 opera volumio[1404]: info: Apr 26 03:07:35 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:35 opera volumio[1404]: info: sendMpdCommand stop took 8 milliseconds Apr 26 03:07:35 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:07:35 opera volumio[1404]: info: Apr 26 03:07:35 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:35 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:35 opera volumio[1404]: info: sendMpdCommand status took 1 milliseconds Apr 26 03:07:35 opera volumio[1404]: info: sendMpdCommand clear took 2 milliseconds Apr 26 03:07:35 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=720974" Apr 26 03:07:35 opera volumio[1404]: error: updateQueue error: null Apr 26 03:07:35 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:07:35 opera volumio[1404]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 26 03:07:35 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:35 opera volumio[1404]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 26 03:07:35 opera volumio[1404]: info: ------------------------------ 5ms Apr 26 03:07:36 opera volumio[1404]: info: Apr 26 03:07:36 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:36 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:36 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=720974" took 249 milliseconds Apr 26 03:07:36 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:07:36 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:07:36 opera volumio[1404]: info: ------------------------------ 1ms Apr 26 03:07:36 opera volumio[1404]: info: sendMpdCommand play took 1 milliseconds Apr 26 03:07:40 opera volumio[1404]: info: Apr 26 03:07:40 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:40 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:40 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:40 opera volumio[1404]: info: Apr 26 03:07:40 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:40 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:40 opera volumio[1404]: info: Apr 26 03:07:40 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:40 opera volumio[1404]: info: sendMpdCommand status took 3 milliseconds Apr 26 03:07:40 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:40 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:40 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:40 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:40 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:07:40 opera volumio[1404]: info: sendMpdCommand status took 1 milliseconds Apr 26 03:07:40 opera volumio[1404]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 26 03:07:40 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:40 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:40 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:40 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:07:40 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:07:40 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:40 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"RadioKosovaeLire","artist":"Radio Kosova e Lire","album":null,"uri":"http://listen.radionomy.com:80/RadioKosovaeLire","trackType":""} Apr 26 03:07:40 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:07:40 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:07:40 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:07:40 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:40 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:40 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:40 opera volumio[1404]: info: ------------------------------ 15ms Apr 26 03:07:40 opera volumio[1404]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 26 03:07:40 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:40 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:07:40 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:07:40 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:40 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"RadioKosovaeLire","artist":"Radio Kosova e Lire","album":null,"uri":"http://listen.radionomy.com:80/RadioKosovaeLire","trackType":""} Apr 26 03:07:40 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:07:40 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:07:40 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus play Apr 26 03:07:40 opera volumio[1404]: info: Received an update from plugin. extracting info from payload Apr 26 03:07:40 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:40 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:40 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:40 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:40 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:40 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:40 opera volumio[1404]: info: ------------------------------ 21ms Apr 26 03:07:40 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:40 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:40 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:43 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::stPlaybackTimer Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::serviceStop Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::serviceStop Apr 26 03:07:43 opera volumio[1404]: info: [1745636863623] ControllerWebradio::stop Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:07:43 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1812792 Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:43 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:07:43 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:43 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:07:43 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:43 opera volumio[1404]: info: [1745636863636] ControllerWebradio::clearAddPlayTrack Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:43 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:43 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:43 opera volumio[1404]: info: Apr 26 03:07:43 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:43 opera volumio[1404]: info: sendMpdCommand stop took 64 milliseconds Apr 26 03:07:43 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:43 opera volumio[1404]: info: sendMpdCommand stop took 53 milliseconds Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:07:43 opera volumio[1404]: info: Apr 26 03:07:43 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:43 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:43 opera volumio[1404]: info: sendMpdCommand status took 2 milliseconds Apr 26 03:07:43 opera volumio[1404]: info: sendMpdCommand clear took 2 milliseconds Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1812792" Apr 26 03:07:43 opera volumio[1404]: error: updateQueue error: null Apr 26 03:07:43 opera volumio[1404]: info: Apr 26 03:07:43 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:43 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:43 opera volumio[1404]: info: ------------------------------ 263ms Apr 26 03:07:43 opera volumio[1404]: info: sendMpdCommand playlistinfo took 262 milliseconds Apr 26 03:07:43 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1812792" took 262 milliseconds Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:07:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:07:43 opera volumio[1404]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 26 03:07:43 opera volumio[1404]: info: ------------------------------ 266ms Apr 26 03:07:43 opera volumio[1404]: info: ------------------------------ 3ms Apr 26 03:07:43 opera volumio[1404]: info: sendMpdCommand play took 2 milliseconds Apr 26 03:07:52 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:52 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:52 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:07:52 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:52 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:52 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:52 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:07:52 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:07:52 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99448139 Apr 26 03:07:52 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:07:52 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:52 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:52 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:52 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:07:52 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:52 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:52 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:07:52 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:52 opera volumio[1404]: info: [1745636872507] ControllerWebradio::clearAddPlayTrack Apr 26 03:07:52 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:52 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:52 opera volumio[1404]: info: Apr 26 03:07:52 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:52 opera volumio[1404]: info: sendMpdCommand stop took 8 milliseconds Apr 26 03:07:52 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:52 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:52 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:07:52 opera volumio[1404]: info: Apr 26 03:07:52 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:52 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:52 opera volumio[1404]: info: sendMpdCommand status took 2 milliseconds Apr 26 03:07:52 opera volumio[1404]: info: sendMpdCommand clear took 1 milliseconds Apr 26 03:07:52 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:52 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:52 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99448139" Apr 26 03:07:52 opera volumio[1404]: error: updateQueue error: null Apr 26 03:07:52 opera volumio[1404]: info: ------------------------------ 9ms Apr 26 03:07:52 opera volumio[1404]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 26 03:07:52 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:52 opera volumio[1404]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 26 03:07:52 opera volumio[1404]: info: ------------------------------ 10ms Apr 26 03:07:52 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99448139" took 257 milliseconds Apr 26 03:07:52 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:07:52 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:07:52 opera volumio[1404]: info: Apr 26 03:07:52 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:52 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:52 opera volumio[1404]: info: sendMpdCommand play took 3 milliseconds Apr 26 03:07:52 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:07:59 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:59 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:59 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:07:59 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:59 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:07:59 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:07:59 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:07:59 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:07:59 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1682343 Apr 26 03:07:59 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:07:59 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:07:59 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:07:59 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:07:59 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:07:59 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:59 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:07:59 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:59 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:07:59 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:07:59 opera volumio[1404]: info: [1745636879875] ControllerWebradio::clearAddPlayTrack Apr 26 03:07:59 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:07:59 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:07:59 opera volumio[1404]: info: Apr 26 03:07:59 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:07:59 opera volumio[1404]: info: sendMpdCommand stop took 7 milliseconds Apr 26 03:07:59 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:07:59 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:07:59 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:07:59 opera volumio[1404]: info: Apr 26 03:07:59 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:07:59 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:07:59 opera volumio[1404]: info: sendMpdCommand status took 2 milliseconds Apr 26 03:07:59 opera volumio[1404]: info: sendMpdCommand clear took 2 milliseconds Apr 26 03:07:59 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:07:59 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:07:59 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1682343" Apr 26 03:07:59 opera volumio[1404]: error: updateQueue error: null Apr 26 03:07:59 opera volumio[1404]: info: ------------------------------ 3ms Apr 26 03:07:59 opera volumio[1404]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 26 03:07:59 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:07:59 opera volumio[1404]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 26 03:07:59 opera volumio[1404]: info: ------------------------------ 4ms Apr 26 03:08:00 opera volumio[1404]: info: Apr 26 03:08:00 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:00 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:00 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1682343" took 251 milliseconds Apr 26 03:08:00 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:08:00 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:08:00 opera volumio[1404]: info: ------------------------------ 4ms Apr 26 03:08:00 opera volumio[1404]: info: sendMpdCommand play took 3 milliseconds Apr 26 03:08:01 opera volumio[1404]: info: Apr 26 03:08:01 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:01 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:01 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:01 opera volumio[1404]: info: Apr 26 03:08:01 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:01 opera volumio[1404]: info: sendMpdCommand status took 25 milliseconds Apr 26 03:08:01 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:01 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:01 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:01 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:01 opera volumio[1404]: info: Apr 26 03:08:01 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:01 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:01 opera volumio[1404]: info: sendMpdCommand status took 2 milliseconds Apr 26 03:08:01 opera volumio[1404]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 26 03:08:01 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:01 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:01 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:01 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:01 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:01 opera volumio[1404]: 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":"128 Kbps","isStreaming":false,"title":"Robert Randolph - Big Women","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Apr 26 03:08:01 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:01 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:08:01 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:08:01 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:01 opera volumio[1404]: info: ------------------------------ 32ms Apr 26 03:08:01 opera volumio[1404]: info: ------------------------------ 7ms Apr 26 03:08:01 opera volumio[1404]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 26 03:08:01 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:01 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:01 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:01 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robert Randolph - Big Women","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Apr 26 03:08:01 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:01 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:08:01 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus play Apr 26 03:08:01 opera volumio[1404]: info: Received an update from plugin. extracting info from payload Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 26 03:08:01 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:01 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:01 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:01 opera volumio[1404]: info: ------------------------------ 16ms Apr 26 03:08:01 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:01 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:01 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:05 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::stPlaybackTimer Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::serviceStop Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::serviceStop Apr 26 03:08:05 opera volumio[1404]: info: [1745636885066] ControllerWebradio::stop Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:08:05 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99558108 Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:05 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:08:05 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:05 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:08:05 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:05 opera volumio[1404]: info: [1745636885084] ControllerWebradio::clearAddPlayTrack Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:05 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:05 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:05 opera volumio[1404]: info: Apr 26 03:08:05 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:05 opera volumio[1404]: info: sendMpdCommand stop took 258 milliseconds Apr 26 03:08:05 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:05 opera volumio[1404]: info: sendMpdCommand stop took 239 milliseconds Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:08:05 opera volumio[1404]: info: Apr 26 03:08:05 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:05 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:05 opera volumio[1404]: info: sendMpdCommand status took 7 milliseconds Apr 26 03:08:05 opera volumio[1404]: info: sendMpdCommand clear took 6 milliseconds Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99558108" Apr 26 03:08:05 opera volumio[1404]: error: updateQueue error: null Apr 26 03:08:05 opera volumio[1404]: info: ------------------------------ 5ms Apr 26 03:08:05 opera volumio[1404]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:05 opera volumio[1404]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 26 03:08:05 opera volumio[1404]: info: ------------------------------ 13ms Apr 26 03:08:05 opera volumio[1404]: info: Apr 26 03:08:05 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:05 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:05 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99558108" took 260 milliseconds Apr 26 03:08:05 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:08:05 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:08:05 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:08:05 opera volumio[1404]: info: sendMpdCommand play took 1 milliseconds Apr 26 03:08:08 opera volumio[1404]: info: Apr 26 03:08:08 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:08 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:08 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:08 opera volumio[1404]: info: sendMpdCommand status took 2 milliseconds Apr 26 03:08:08 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:08 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:08 opera volumio[1404]: info: Apr 26 03:08:08 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:08 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:08 opera volumio[1404]: info: Apr 26 03:08:08 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:08 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:08 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:08 opera volumio[1404]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 26 03:08:08 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:08:08 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:08 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:08 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:08 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Syn Cole Dakota - Lights Go Down","artist":"CoolFm Hits Philippines","album":null,"uri":"http://176.9.7.145:8938/stream","trackType":""} Apr 26 03:08:08 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:08 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:08:08 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:08:08 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:08 opera volumio[1404]: info: ------------------------------ 11ms Apr 26 03:08:08 opera volumio[1404]: info: sendMpdCommand status took 8 milliseconds Apr 26 03:08:08 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:08 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:08 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:08 opera volumio[1404]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 26 03:08:08 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:08 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:08 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:08 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":467,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Syn Cole Dakota - Lights Go Down","artist":"CoolFm Hits Philippines","album":null,"uri":"http://176.9.7.145:8938/stream","trackType":""} Apr 26 03:08:08 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:08 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:08:08 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus play Apr 26 03:08:08 opera volumio[1404]: info: Received an update from plugin. extracting info from payload Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 26 03:08:08 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:08 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:08 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:08 opera volumio[1404]: info: ------------------------------ 21ms Apr 26 03:08:08 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:08 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:11 opera volumio[1404]: info: Saving local item radio-favourites Apr 26 03:08:11 opera volumio[1404]: info: Pushing Favourites {"uri":"http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99558108","favourite":false} Apr 26 03:08:18 opera volumio[1404]: info: CoreCommandRouter::volumioStop Apr 26 03:08:18 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:18 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:18 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:18 opera volumio[1404]: info: CoreStateMachine::stPlaybackTimer Apr 26 03:08:18 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:18 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:18 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:18 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:18 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:18 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:18 opera volumio[1404]: info: CoreStateMachine::serviceStop Apr 26 03:08:18 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:18 opera volumio[1404]: info: CoreCommandRouter::serviceStop Apr 26 03:08:18 opera volumio[1404]: info: [1745636898850] ControllerWebradio::stop Apr 26 03:08:18 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:18 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:18 opera volumio[1404]: info: Apr 26 03:08:18 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:18 opera volumio[1404]: info: sendMpdCommand stop took 33 milliseconds Apr 26 03:08:18 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:18 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:18 opera volumio[1404]: info: sendMpdCommand status took 1 milliseconds Apr 26 03:08:18 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:18 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:18 opera volumio[1404]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 26 03:08:18 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:18 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:18 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:18 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:18 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:18 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:18 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:18 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:18 opera volumio[1404]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 26 03:08:18 opera volumio[1404]: info: ------------------------------ 17ms Apr 26 03:08:18 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:20 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:20 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:20 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:08:20 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:20 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:20 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:20 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:08:20 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:08:20 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1884274 Apr 26 03:08:20 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:08:20 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:20 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:20 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:20 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:08:20 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:20 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:20 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:20 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:08:20 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:20 opera volumio[1404]: info: [1745636900859] ControllerWebradio::clearAddPlayTrack Apr 26 03:08:20 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:20 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:20 opera volumio[1404]: info: sendMpdCommand stop took 16 milliseconds Apr 26 03:08:20 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:08:20 opera volumio[1404]: info: Apr 26 03:08:20 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:20 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:20 opera volumio[1404]: info: sendMpdCommand clear took 1 milliseconds Apr 26 03:08:20 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1884274" Apr 26 03:08:20 opera volumio[1404]: error: updateQueue error: null Apr 26 03:08:20 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:08:21 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1884274" took 703 milliseconds Apr 26 03:08:21 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:08:21 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:08:21 opera volumio[1404]: info: sendMpdCommand play took 1 milliseconds Apr 26 03:08:28 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:28 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:28 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:08:28 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:28 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:28 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:28 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:08:28 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:08:28 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99514800 Apr 26 03:08:28 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:08:28 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:28 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:28 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:28 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:08:28 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:28 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:28 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:08:28 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:28 opera volumio[1404]: info: [1745636908409] ControllerWebradio::clearAddPlayTrack Apr 26 03:08:28 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:28 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:28 opera volumio[1404]: info: sendMpdCommand stop took 7 milliseconds Apr 26 03:08:28 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:08:28 opera volumio[1404]: info: Apr 26 03:08:28 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:28 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:28 opera volumio[1404]: info: sendMpdCommand clear took 2 milliseconds Apr 26 03:08:28 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99514800" Apr 26 03:08:28 opera volumio[1404]: error: updateQueue error: null Apr 26 03:08:28 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:08:28 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99514800" took 252 milliseconds Apr 26 03:08:28 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:08:28 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:08:28 opera volumio[1404]: info: Apr 26 03:08:28 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:28 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:28 opera volumio[1404]: info: sendMpdCommand play took 3 milliseconds Apr 26 03:08:28 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:08:30 opera volumio[1404]: info: Apr 26 03:08:30 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:30 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:30 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:30 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 26 03:08:30 opera volumio[1404]: info: sendMpdCommand status took 3 milliseconds Apr 26 03:08:30 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:30 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:30 opera volumio[1404]: info: sendMpdCommand clearerror took 1 milliseconds Apr 26 03:08:30 opera volumio[1404]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 26 03:08:30 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:30 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:30 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:30 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:30 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:30 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:30 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:30 opera volumio[1404]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 51/700) Global RNB","album":null,"uri":"https://login.webinternetradio.com:1340/","trackType":"com:1340/"} Apr 26 03:08:30 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:30 opera volumio[1404]: info: CoreStateMachine::syncState stateService stop Apr 26 03:08:30 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:08:30 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:30 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:30 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:30 opera volumio[1404]: info: No code Apr 26 03:08:30 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:30 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:30 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:30 opera volumio[1404]: info: ------------------------------ 16ms Apr 26 03:08:30 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:30 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:30 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:32 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:32 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:32 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:08:32 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:32 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:32 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:32 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:08:32 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:08:32 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1783668 Apr 26 03:08:32 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:08:32 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:32 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:32 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:32 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:08:32 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:32 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:32 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:08:32 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:32 opera volumio[1404]: info: [1745636912690] ControllerWebradio::clearAddPlayTrack Apr 26 03:08:32 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:32 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:32 opera volumio[1404]: info: sendMpdCommand stop took 7 milliseconds Apr 26 03:08:32 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:08:32 opera volumio[1404]: info: Apr 26 03:08:32 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:32 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:32 opera volumio[1404]: info: sendMpdCommand clear took 1 milliseconds Apr 26 03:08:32 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1783668" Apr 26 03:08:32 opera volumio[1404]: error: updateQueue error: null Apr 26 03:08:32 opera volumio[1404]: info: ------------------------------ 1ms Apr 26 03:08:32 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1783668" took 255 milliseconds Apr 26 03:08:32 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:08:32 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:08:32 opera volumio[1404]: info: Apr 26 03:08:32 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:32 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:32 opera volumio[1404]: info: sendMpdCommand play took 2 milliseconds Apr 26 03:08:32 opera volumio[1404]: info: ------------------------------ 1ms Apr 26 03:08:34 opera dhcpd[1437]: DHCPDISCOVER from 48:e7:da:4f:09:1d (opera) via wlan0 Apr 26 03:08:35 opera dhcpd[1437]: DHCPOFFER on 192.168.211.5 to 48:e7:da:4f:09:1d (opera) via wlan0 Apr 26 03:08:35 opera volumio[1404]: info: Apr 26 03:08:35 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:35 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:35 opera volumio[1404]: info: Apr 26 03:08:35 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:35 opera volumio[1404]: info: sendMpdCommand status took 4 milliseconds Apr 26 03:08:35 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:35 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:35 opera volumio[1404]: info: Apr 26 03:08:35 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:35 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:35 opera volumio[1404]: info: sendMpdCommand status took 3 milliseconds Apr 26 03:08:35 opera volumio[1404]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 26 03:08:35 opera volumio[1404]: info: ------------------------------ 2ms Apr 26 03:08:35 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:35 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:35 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:35 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:35 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:35 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:35 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"10 Years - Novacaine","artist":"1.FM - Alternative Rock X Hits Radio","album":null,"uri":"http://185.33.21.112:80/x_128","trackType":""} Apr 26 03:08:35 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:35 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:08:35 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:08:35 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:35 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:35 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:35 opera volumio[1404]: info: ------------------------------ 19ms Apr 26 03:08:35 opera volumio[1404]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 26 03:08:35 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:35 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:35 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:35 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:35 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"10 Years - Novacaine","artist":"1.FM - Alternative Rock X Hits Radio","album":null,"uri":"http://185.33.21.112:80/x_128","trackType":""} Apr 26 03:08:35 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:35 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:08:35 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus play Apr 26 03:08:35 opera volumio[1404]: info: Received an update from plugin. extracting info from payload Apr 26 03:08:35 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:35 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:35 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:35 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:35 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:35 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:35 opera volumio[1404]: info: ------------------------------ 25ms Apr 26 03:08:35 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:35 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:35 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:43 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::stPlaybackTimer Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::serviceStop Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::serviceStop Apr 26 03:08:43 opera volumio[1404]: info: [1745636923373] ControllerWebradio::stop Apr 26 03:08:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:08:43 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99525423 Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:43 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:08:43 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:43 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:43 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:08:43 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:43 opera volumio[1404]: info: [1745636923384] ControllerWebradio::clearAddPlayTrack Apr 26 03:08:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:43 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:43 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:43 opera volumio[1404]: info: Apr 26 03:08:43 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:43 opera volumio[1404]: info: sendMpdCommand stop took 51 milliseconds Apr 26 03:08:43 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:43 opera volumio[1404]: info: sendMpdCommand stop took 41 milliseconds Apr 26 03:08:43 opera volumio[1404]: info: sendMpdCommand status took 1 milliseconds Apr 26 03:08:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:08:43 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:43 opera volumio[1404]: info: Apr 26 03:08:43 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:43 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:43 opera volumio[1404]: info: sendMpdCommand clear took 1 milliseconds Apr 26 03:08:43 opera volumio[1404]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 26 03:08:43 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99525423" Apr 26 03:08:43 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:43 opera volumio[1404]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 26 03:08:43 opera volumio[1404]: info: ------------------------------ 5ms Apr 26 03:08:43 opera volumio[1404]: error: updateQueue error: null Apr 26 03:08:43 opera volumio[1404]: info: ------------------------------ 3ms Apr 26 03:08:44 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99525423" took 1176 milliseconds Apr 26 03:08:44 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:08:44 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:08:44 opera volumio[1404]: info: Apr 26 03:08:44 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:44 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:44 opera volumio[1404]: info: sendMpdCommand play took 4 milliseconds Apr 26 03:08:44 opera volumio[1404]: info: ------------------------------ 3ms Apr 26 03:08:44 opera volumio[1404]: info: Apr 26 03:08:44 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:44 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:44 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:44 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 26 03:08:44 opera volumio[1404]: info: sendMpdCommand status took 4 milliseconds Apr 26 03:08:44 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:44 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:44 opera volumio[1404]: info: sendMpdCommand clearerror took 2 milliseconds Apr 26 03:08:44 opera volumio[1404]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 26 03:08:44 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:44 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:44 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:44 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:44 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:44 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:44 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:44 opera volumio[1404]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 89/512) SupremeMasterTV","album":null,"uri":"http://65.49.44.66:8000/","trackType":"66:8000/"} Apr 26 03:08:44 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:44 opera volumio[1404]: info: CoreStateMachine::syncState stateService stop Apr 26 03:08:44 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:08:44 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:44 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:44 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:44 opera volumio[1404]: info: No code Apr 26 03:08:44 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:44 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:44 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:44 opera volumio[1404]: info: ------------------------------ 16ms Apr 26 03:08:44 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:44 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:44 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:47 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:47 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:47 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:08:47 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:47 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:47 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:47 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:08:47 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:08:47 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564615 Apr 26 03:08:47 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:08:47 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:47 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:47 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:47 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:08:47 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:47 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:47 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:08:47 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:47 opera volumio[1404]: info: [1745636927521] ControllerWebradio::clearAddPlayTrack Apr 26 03:08:47 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:47 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:47 opera volumio[1404]: info: sendMpdCommand stop took 14 milliseconds Apr 26 03:08:47 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:08:47 opera volumio[1404]: info: Apr 26 03:08:47 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:47 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:47 opera volumio[1404]: info: sendMpdCommand clear took 1 milliseconds Apr 26 03:08:47 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564615" Apr 26 03:08:47 opera volumio[1404]: error: updateQueue error: null Apr 26 03:08:47 opera volumio[1404]: info: ------------------------------ 1ms Apr 26 03:08:47 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564615" took 248 milliseconds Apr 26 03:08:47 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:08:47 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:08:47 opera volumio[1404]: info: Apr 26 03:08:47 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:47 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:47 opera volumio[1404]: info: sendMpdCommand play took 1 milliseconds Apr 26 03:08:47 opera volumio[1404]: info: ------------------------------ 1ms Apr 26 03:08:54 opera volumio[1404]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::ClearQueue Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:54 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:54 opera volumio[1404]: info: CorePlayQueue::clearPlayQueue Apr 26 03:08:54 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:54 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:54 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:54 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::addQueueItems Apr 26 03:08:54 opera volumio[1404]: info: CorePlayQueue::addQueueItems Apr 26 03:08:54 opera volumio[1404]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1867477 Apr 26 03:08:54 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 26 03:08:54 opera volumio[1404]: info: CorePlayQueue::saveQueue Apr 26 03:08:54 opera volumio[1404]: info: CoreCommandRouter::volumioPushQueue Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::updateTrackBlock Apr 26 03:08:54 opera volumio[1404]: info: CorePlayQueue::getTrackBlock Apr 26 03:08:54 opera volumio[1404]: info: CoreCommandRouter::volumioPlay Apr 26 03:08:54 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::play index 0 Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::stop Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:54 opera volumio[1404]: verbose: UNSET VOLATILE Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::play index undefined Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 03:08:54 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:54 opera volumio[1404]: info: CoreStateMachine::startPlaybackTimer Apr 26 03:08:54 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:54 opera volumio[1404]: info: [1745636934937] ControllerWebradio::clearAddPlayTrack Apr 26 03:08:54 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 03:08:54 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:54 opera volumio[1404]: info: Apr 26 03:08:54 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:54 opera volumio[1404]: info: sendMpdCommand stop took 7 milliseconds Apr 26 03:08:54 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:54 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:54 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 03:08:54 opera volumio[1404]: info: Apr 26 03:08:54 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:54 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:54 opera volumio[1404]: info: sendMpdCommand status took 2 milliseconds Apr 26 03:08:54 opera volumio[1404]: info: sendMpdCommand clear took 2 milliseconds Apr 26 03:08:54 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:54 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:54 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1867477" Apr 26 03:08:54 opera volumio[1404]: error: updateQueue error: null Apr 26 03:08:54 opera volumio[1404]: info: ------------------------------ 3ms Apr 26 03:08:54 opera volumio[1404]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 26 03:08:54 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:54 opera volumio[1404]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 26 03:08:54 opera volumio[1404]: info: ------------------------------ 4ms Apr 26 03:08:55 opera volumio[1404]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1867477" took 712 milliseconds Apr 26 03:08:55 opera volumio[1404]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 03:08:55 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand play Apr 26 03:08:55 opera volumio[1404]: info: Apr 26 03:08:55 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:55 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:55 opera volumio[1404]: info: sendMpdCommand play took 4 milliseconds Apr 26 03:08:55 opera volumio[1404]: info: ------------------------------ 4ms Apr 26 03:08:58 opera volumio[1404]: info: Apr 26 03:08:58 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:58 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:58 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:58 opera volumio[1404]: info: Apr 26 03:08:58 opera volumio[1404]: ---------------------------- MPD announces state update: player Apr 26 03:08:58 opera volumio[1404]: info: sendMpdCommand status took 2 milliseconds Apr 26 03:08:58 opera volumio[1404]: info: ControllerMpd::getState Apr 26 03:08:58 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand status Apr 26 03:08:58 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:58 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:58 opera volumio[1404]: info: Apr 26 03:08:58 opera volumio[1404]: ---------------------------- MPD announces system playlist update Apr 26 03:08:58 opera volumio[1404]: info: Ignoring MPD Status Update Apr 26 03:08:58 opera volumio[1404]: info: sendMpdCommand status took 1 milliseconds Apr 26 03:08:58 opera volumio[1404]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 26 03:08:58 opera volumio[1404]: verbose: ControllerMpd::parseState Apr 26 03:08:58 opera volumio[1404]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 03:08:58 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:58 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:58 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:58 opera volumio[1404]: 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":"160 Kbps","isStreaming":false,"title":"Gossec, Francois-Joseph - B-d?r szimf?nia, op.12 - 4 - II. Largo","artist":"Klasszik radio","album":null,"uri":"http://s04.diazol.hu:9600/live.mp3","trackType":"mp3"} Apr 26 03:08:58 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:58 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:08:58 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus stop Apr 26 03:08:58 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:58 opera volumio[1404]: info: ------------------------------ 9ms Apr 26 03:08:58 opera volumio[1404]: info: ------------------------------ 6ms Apr 26 03:08:58 opera volumio[1404]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 26 03:08:58 opera volumio[1404]: verbose: ControllerMpd::parseTrackInfo Apr 26 03:08:58 opera volumio[1404]: info: ControllerMpd::pushState Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::servicePushState Apr 26 03:08:58 opera volumio[1404]: info: CorePlayQueue::getTrack 0 Apr 26 03:08:58 opera volumio[1404]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Gossec, Francois-Joseph - B-d?r szimf?nia, op.12 - 4 - II. Largo","artist":"Klasszik radio","album":null,"uri":"http://s04.diazol.hu:9600/live.mp3","trackType":"mp3"} Apr 26 03:08:58 opera volumio[1404]: verbose: CURRENT POSITION 0 Apr 26 03:08:58 opera volumio[1404]: info: CoreStateMachine::syncState stateService play Apr 26 03:08:58 opera volumio[1404]: info: CoreStateMachine::syncState currentStatus play Apr 26 03:08:58 opera volumio[1404]: info: Received an update from plugin. extracting info from payload Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 26 03:08:58 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:58 opera volumio[1404]: info: CoreStateMachine::pushState Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::volumioPushState Apr 26 03:08:58 opera volumio[1404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 03:08:58 opera volumio[1404]: info: ------------------------------ 23ms Apr 26 03:08:58 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:58 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:58 opera volumio[1404]: info: Updating RAAT Signal Path Apr 26 03:08:58 opera volumio[1404]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 03:08:58 opera volumio[1404]: { Error: connect ETIMEDOUT 202.160.130.117:80 Apr 26 03:08:58 opera volumio[1404]: at Object._errnoException (util.js:1022:11) Apr 26 03:08:58 opera volumio[1404]: at _exceptionWithHostPort (util.js:1044:20) Apr 26 03:08:58 opera volumio[1404]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 26 03:08:58 opera volumio[1404]: code: 'ETIMEDOUT', Apr 26 03:08:58 opera volumio[1404]: errno: 'ETIMEDOUT', Apr 26 03:08:58 opera volumio[1404]: syscall: 'connect', Apr 26 03:08:58 opera volumio[1404]: address: '202.160.130.117', Apr 26 03:08:58 opera volumio[1404]: port: 80 } Apr 26 03:08:58 opera volumio[1404]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 03:08:59 opera sudo[28237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-26 03:07 Apr 26 03:08:59 opera sudo[28237]: 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"