May 24 17:55:04 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 24 17:55:04 volumio dbus-daemon[553]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.22' (uid=0 pid=1722 comm="timedatectl show --property=NTPSynchronized --valu") May 24 17:55:04 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 24 17:55:04 volumio dbus-daemon[553]: [system] Successfully activated service 'org.freedesktop.timedate1' May 24 17:55:04 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. May 24 17:55:04 volumio setdatetime-helper.sh[1721]: Time is not synchronized. Attempting to sync... May 24 17:55:04 volumio sudo[1730]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Sat, 24 May 2025 08:55:05 GMT#015' May 24 17:55:04 volumio sudo[1730]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 24 17:55:05 volumio setdatetime-helper.sh[1731]: Sat May 24 17:55:05 JST 2025 May 24 17:55:05 volumio sudo[1730]: pam_unix(sudo:session): session closed for user root May 24 17:55:05 volumio setdatetime-helper.sh[1721]: Time synchronized successfully. May 24 17:55:05 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 24 17:55:05 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 24 17:55:29 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState May 24 17:55:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 17:55:32 volumio volumio[1054]: info: Retrieving Cloud Streaming UI May 24 17:55:32 volumio volumio[1054]: info: Getting Tidal Cloud Configuration May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 17:55:32 volumio volumio[1054]: info: Getting Qobuz Cloud Configuration May 24 17:55:32 volumio volumio[1054]: info: Asking plugin for UI Config May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 17:55:32 volumio volumio[1054]: info: Getting Spotify Cloud Configuration May 24 17:55:32 volumio volumio[1054]: info: Asking plugin for UI Config May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 17:55:32 volumio volumio[1054]: info: Saving Spotify Acccount May 24 17:55:32 volumio volumio[1054]: info: Got Tidal Cloud Configuration May 24 17:55:32 volumio volumio[1054]: info: Got it May 24 17:55:32 volumio volumio[1054]: info: Got it May 24 17:55:32 volumio volumio[1054]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 17:55:32 volumio volumio[1054]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::volumioGetBrowseSources May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::volumioGetBrowseSources May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::volumioGetBrowseSources May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 24 17:55:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 24 17:55:34 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. May 24 17:55:36 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 24 17:55:40 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 24 17:55:44 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState May 24 17:55:44 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:55:49 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 24 17:55:49 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 24 17:55:57 volumio volumio[1054]: info: Enabling plugin jp_radio May 24 17:55:57 volumio volumio[1054]: info: Loading plugin "jp_radio"... May 24 17:56:04 volumio volumio[1054]: info: PLUGIN START: jp_radio May 24 17:56:05 volumio volumio[1054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 24 17:56:05 volumio volumio[1054]: info: [1748076965117] CoreMusicLibrary::Adding element RADIKO May 24 17:56:05 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 24 17:56:05 volumio volumio[1054]: Cannot find translation for source RADIKO May 24 17:56:05 volumio volumio[1054]: info: Done. May 24 17:56:05 volumio volumio[1054]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 17:56:12 volumio volumio[1054]: info: JP_Radio::Updating program listings May 24 17:56:12 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 24 17:56:12 volumio dbus-daemon[553]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.24' (uid=0 pid=1842 comm="timedatectl show --property=NTPSynchronized --valu") May 24 17:56:12 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 24 17:56:12 volumio dbus-daemon[553]: [system] Successfully activated service 'org.freedesktop.timedate1' May 24 17:56:12 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. May 24 17:56:12 volumio setdatetime-helper.sh[1841]: Time is not synchronized. Attempting to sync... May 24 17:56:12 volumio sudo[1850]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Sat, 24 May 2025 08:56:13 GMT#015' May 24 17:56:12 volumio sudo[1850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 24 17:56:13 volumio setdatetime-helper.sh[1851]: Sat May 24 17:56:13 JST 2025 May 24 17:56:13 volumio sudo[1850]: pam_unix(sudo:session): session closed for user root May 24 17:56:13 volumio setdatetime-helper.sh[1841]: Time synchronized successfully. May 24 17:56:13 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 24 17:56:13 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 24 17:56:20 volumio volumio[1054]: info: CALLMETHOD: music_service jp_radio saveRadikoAccount [object Object] May 24 17:56:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: jp_radio , saveRadikoAccount May 24 17:56:27 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState May 24 17:56:27 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:28 volumio volumio[1054]: info: CoreCommandRouter::volumioGetQueue May 24 17:56:28 volumio volumio[1054]: info: CoreStateMachine::getQueue May 24 17:56:28 volumio volumio[1054]: info: CorePlayQueue::getQueue May 24 17:56:30 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: jp_radio , handleBrowseUri May 24 17:56:31 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:31 volumio volumio[1054]: info: Preloading song: http://localhost:9000/radiko/ABS May 24 17:56:31 volumio volumio[1054]: info: Preloading song: http://localhost:9000/radiko/AFM May 24 17:56:31 volumio volumio[1054]: info: Preloading song: http://localhost:9000/radiko/JOHK May 24 17:56:31 volumio volumio[1054]: info: Preloading song: http://localhost:9000/radiko/RN1 May 24 17:56:31 volumio volumio[1054]: info: Preloading song: http://localhost:9000/radiko/RN2 May 24 17:56:31 volumio volumio[1054]: info: Preloading song: http://localhost:9000/radiko/JOAK-FM May 24 17:56:31 volumio volumio[1054]: info: Preloading song: http://localhost:9000/radiko/MAJAL May 24 17:56:31 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:31 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:31 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:31 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:31 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:31 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:31 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:33 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioReplaceandPlayItems May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::ClearQueue May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::clearPlayQueue May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::addQueueItems May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::addQueueItems May 24 17:56:33 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:33 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/ABS May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPlay May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::play index 0 May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::addQueueItems May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::addQueueItems May 24 17:56:33 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:33 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/AFM May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:33 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/JOHK May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:33 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/RN1 May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:33 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/RN2 May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:33 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/JOAK-FM May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:33 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/MAJAL May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::play index undefined May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::startPlaybackTimer May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:33 volumio volumio[1054]: info: [1748076993553] ControllerWebradio::clearAddPlayTrack May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand stop took 25 milliseconds May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clear May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:33 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand clear took 5 milliseconds May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand load "http://localhost:9000/radiko/ABS" May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:33 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:33 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:33 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:33 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:33 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 17ms May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand add "http://localhost:9000/radiko/ABS" May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 12ms May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 10ms May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:33 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand add "http://localhost:9000/radiko/ABS" took 7 milliseconds May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService mpd May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand play May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:33 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:33 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 18ms May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand play took 16 milliseconds May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 12ms May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 10ms May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand status took 17 milliseconds May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:33 volumio volumio[1054]: info: May 24 17:56:33 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand status took 72 milliseconds May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand status took 71 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand clearerror took 60 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand status took 58 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 56 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand status took 20 milliseconds May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:33 volumio volumio[1054]: 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":"ABS","artist":null,"album":null,"uri":"http://localhost:9000/radiko/ABS","trackType":""} May 24 17:56:33 volumio volumio[1054]: verbose: CURRENT POSITION 0 May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: No code May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 138ms May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand status took 91 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand clearerror took 80 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand clearerror took 78 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 65 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 64 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 64 milliseconds May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 60 milliseconds May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:33 volumio volumio[1054]: 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":"ABS","artist":null,"album":null,"uri":"http://localhost:9000/radiko/ABS","trackType":""} May 24 17:56:33 volumio volumio[1054]: verbose: CURRENT POSITION 0 May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: No code May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:33 volumio volumio[1054]: 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":"ABS","artist":null,"album":null,"uri":"http://localhost:9000/radiko/ABS","trackType":""} May 24 17:56:33 volumio volumio[1054]: verbose: CURRENT POSITION 0 May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: No code May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:33 volumio volumio[1054]: 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":"ABS","artist":null,"album":null,"uri":"http://localhost:9000/radiko/ABS","trackType":""} May 24 17:56:33 volumio volumio[1054]: verbose: CURRENT POSITION 0 May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: No code May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:33 volumio volumio[1054]: 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":"ABS","artist":null,"album":null,"uri":"http://localhost:9000/radiko/ABS","trackType":""} May 24 17:56:33 volumio volumio[1054]: verbose: CURRENT POSITION 0 May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: No code May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 266ms May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 266ms May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 266ms May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 214ms May 24 17:56:33 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 118 milliseconds May 24 17:56:33 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:33 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 24 17:56:33 volumio volumio[1054]: 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":"ABS","artist":null,"album":null,"uri":"http://localhost:9000/radiko/ABS","trackType":""} May 24 17:56:33 volumio volumio[1054]: verbose: CURRENT POSITION 0 May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: No code May 24 17:56:33 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:33 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:33 volumio volumio[1054]: info: ------------------------------ 249ms May 24 17:56:37 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioReplaceandPlayItems May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::ClearQueue May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::clearPlayQueue May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::addQueueItems May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::addQueueItems May 24 17:56:37 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:37 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/ABS May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:37 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/AFM May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:37 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/JOHK May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPlay May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::play index 2 May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::addQueueItems May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::addQueueItems May 24 17:56:37 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:37 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/RN1 May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:37 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/RN2 May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:37 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/JOAK-FM May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:37 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/MAJAL May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::play index undefined May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::startPlaybackTimer May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:37 volumio volumio[1054]: info: [1748076997053] ControllerWebradio::clearAddPlayTrack May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand stop took 26 milliseconds May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clear May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:37 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand clear took 4 milliseconds May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand load "http://localhost:9000/radiko/JOHK" May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:37 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:37 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:37 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:37 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:37 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 7ms May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand add "http://localhost:9000/radiko/JOHK" May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 6ms May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 5ms May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:37 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand add "http://localhost:9000/radiko/JOHK" took 4 milliseconds May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService mpd May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand play May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:37 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:37 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 11ms May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand play took 8 milliseconds May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 7ms May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 6ms May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand status took 14 milliseconds May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand status took 13 milliseconds May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand status took 12 milliseconds May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:37 volumio volumio[1054]: info: May 24 17:56:37 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand status took 33 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand clearerror took 27 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand clearerror took 26 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand clearerror took 25 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 17 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 16 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 16 milliseconds May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:37 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:37 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: No code May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:37 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:37 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: No code May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:37 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:37 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: No code May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 135ms May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 134ms May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 132ms May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand status took 151 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand status took 150 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand clearerror took 140 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 136 milliseconds May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:37 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:37 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: No code May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 206ms May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 34 milliseconds May 24 17:56:37 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 34 milliseconds May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:37 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:37 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:37 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: No code May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:37 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:37 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: No code May 24 17:56:37 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:37 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 266ms May 24 17:56:37 volumio volumio[1054]: info: ------------------------------ 264ms May 24 17:56:42 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. May 24 17:56:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: jp_radio , handleBrowseUri May 24 17:56:43 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:45 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioReplaceandPlayItems May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::ClearQueue May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::stop May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::clearPlayQueue May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::addQueueItems May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::addQueueItems May 24 17:56:45 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:45 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/ABS May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:45 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/AFM May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:45 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/JOHK May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPlay May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::play index 2 May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::addQueueItems May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::addQueueItems May 24 17:56:45 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:45 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/RN1 May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:45 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/RN2 May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:45 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/JOAK-FM May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:45 volumio volumio[1054]: info: Adding Item to queue: http://localhost:9000/radiko/MAJAL May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::stop May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::play index undefined May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::startPlaybackTimer May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:45 volumio volumio[1054]: info: [1748077005554] ControllerWebradio::clearAddPlayTrack May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::saveQueue May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand stop took 17 milliseconds May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clear May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:45 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand clear took 2 milliseconds May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand load "http://localhost:9000/radiko/JOHK" May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:45 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:45 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:45 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:45 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:45 volumio volumio[1054]: error: updateQueue error: null May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 7ms May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand add "http://localhost:9000/radiko/JOHK" May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 6ms May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 4ms May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:45 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand add "http://localhost:9000/radiko/JOHK" took 3 milliseconds May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService mpd May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand play May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:45 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 24 17:56:45 volumio volumio[1054]: info: Ignoring MPD Status Update May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 9ms May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand play took 7 milliseconds May 24 17:56:45 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 7ms May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 6ms May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:45 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:45 volumio volumio[1054]: info: May 24 17:56:45 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 24 17:56:45 volumio volumio[1054]: info: ControllerMpd::getState May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand status took 12 milliseconds May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand status took 10 milliseconds May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clearerror May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand status took 11 milliseconds May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::parseState May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand clearerror took 18 milliseconds May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand clearerror took 17 milliseconds May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand clearerror took 17 milliseconds May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 8 milliseconds May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 7 milliseconds May 24 17:56:45 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 7 milliseconds May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:45 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 24 17:56:45 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:45 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:45 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: No code May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:45 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:45 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: No code May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: ControllerMpd::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: CorePlayQueue::getTrack 2 May 24 17:56:45 volumio volumio[1054]: 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":"JOHK","artist":null,"album":null,"uri":"http://localhost:9000/radiko/JOHK","trackType":""} May 24 17:56:45 volumio volumio[1054]: verbose: CURRENT POSITION 2 May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: No code May 24 17:56:45 volumio volumio[1054]: info: CoreStateMachine::pushState May 24 17:56:45 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 139ms May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 138ms May 24 17:56:45 volumio volumio[1054]: info: ------------------------------ 137ms May 24 17:56:50 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 24 17:56:50 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 24 17:56:52 volumio volumio[1054]: info: Preload queue cleared May 24 17:56:53 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 24 17:56:55 volumio volumio[1054]: info: JP_Radio::App is listening on port 9000. May 24 17:56:55 volumio volumio[1054]: info: READ May 24 17:56:55 volumio volumio[1054]: Use XMLElement.setAttribute instead May 24 17:56:55 volumio volumio[1054]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 17:56:55 volumio volumio[1054]: TypeError: children[i].attr(...).value is not a function May 24 17:56:55 volumio volumio[1054]: at /volumio/app/plugins/music_service/webradio/index.js:286:47 May 24 17:56:55 volumio volumio[1054]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) May 24 17:56:55 volumio volumio[1054]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 17:56:55 volumio sudo[1940]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-24 17:55' May 24 17:56:55 volumio sudo[1940]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 23 08:02:06 UTC 2025" VOLUMIO_VERSION="0.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="76fa67e30b28261e1dc7c3a89e610b9e"