Nov 05 11:09:01 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:01 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:01 volumio volumio[1029]: info: Listing playlists Nov 05 11:09:01 volumio volumio[1029]: info: Listing playlists Nov 05 11:09:04 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Nov 05 11:09:11 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:11 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:21 volumio sudo[1671]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 05 11:09:21 volumio sudo[1671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 05 11:09:21 volumio sudo[1671]: pam_unix(sudo:session): session closed for user root Nov 05 11:09:21 volumio sudo[1672]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 05 11:09:21 volumio sudo[1672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 05 11:09:21 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:21 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:21 volumio sudo[1672]: pam_unix(sudo:session): session closed for user root Nov 05 11:09:21 volumio volumio[1029]: info: Listing playlists Nov 05 11:09:21 volumio volumio[1029]: info: Listing playlists Nov 05 11:09:21 volumio volumio[1029]: verbose: New Socket.io Connection to 192.168.100.7 from 192.168.100.10 UA: Mozilla/5.0 (X11; Linux x86_64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 5 Nov 05 11:09:22 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:22 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:22 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 05 11:09:22 volumio volumio[1029]: info: CoreCommandRouter::volumioGetVisibleSources Nov 05 11:09:22 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 11:09:22 volumio volumio[1029]: info: Listing playlists Nov 05 11:09:22 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 05 11:09:22 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 05 11:09:22 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 05 11:09:22 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 05 11:09:24 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 05 11:09:24 volumio volumio[1029]: info: Received Get System Info Nov 05 11:09:24 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 05 11:09:24 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 05 11:09:24 volumio volumio[1029]: info: Discovery: Getting this device information Nov 05 11:09:24 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:24 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:24 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 05 11:09:25 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 05 11:09:25 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:25 volumio volumio[1029]: info: CoreCommandRouter::volumioGetQueue Nov 05 11:09:25 volumio volumio[1029]: info: CoreStateMachine::getQueue Nov 05 11:09:25 volumio volumio[1029]: info: CorePlayQueue::getQueue Nov 05 11:09:25 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 05 11:09:25 volumio volumio[1029]: info: Received Get System Info Nov 05 11:09:25 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 05 11:09:25 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 05 11:09:25 volumio volumio[1029]: info: Discovery: Getting this device information Nov 05 11:09:25 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:25 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:25 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 05 11:09:31 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:31 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:31 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 05 11:09:31 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:33 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:33 volumio volumio[1029]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::ClearQueue Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::stop Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 11:09:33 volumio volumio[1029]: info: CorePlayQueue::clearPlayQueue Nov 05 11:09:33 volumio volumio[1029]: info: CorePlayQueue::saveQueue Nov 05 11:09:33 volumio volumio[1029]: info: CoreCommandRouter::volumioPushQueue Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::addQueueItems Nov 05 11:09:33 volumio volumio[1029]: info: CorePlayQueue::addQueueItems Nov 05 11:09:33 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:33 volumio volumio[1029]: info: Adding Item to queue: https://stream9.nadaje.com:8003/live Nov 05 11:09:33 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 05 11:09:33 volumio volumio[1029]: info: CoreCommandRouter::volumioPushQueue Nov 05 11:09:33 volumio volumio[1029]: info: CorePlayQueue::saveQueue Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::updateTrackBlock Nov 05 11:09:33 volumio volumio[1029]: info: CorePlayQueue::getTrackBlock Nov 05 11:09:33 volumio volumio[1029]: info: CoreCommandRouter::volumioPlay Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::play index 0 Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::stop Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::play index undefined Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 11:09:33 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:33 volumio volumio[1029]: info: CoreStateMachine::startPlaybackTimer Nov 05 11:09:33 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:33 volumio volumio[1029]: info: [1762337373852] ControllerWebradio::clearAddPlayTrack Nov 05 11:09:33 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 11:09:33 volumio volumio[1029]: info: sendMpdCommand stop took 43 milliseconds Nov 05 11:09:33 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand clear Nov 05 11:09:33 volumio volumio[1029]: info: Nov 05 11:09:33 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:33 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:33 volumio volumio[1029]: info: sendMpdCommand clear took 22 milliseconds Nov 05 11:09:33 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand load "https://stream9.nadaje.com:8003/live" Nov 05 11:09:33 volumio volumio[1029]: info: Nov 05 11:09:33 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:33 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:33 volumio volumio[1029]: info: Nov 05 11:09:33 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:33 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:33 volumio volumio[1029]: error: updateQueue error: null Nov 05 11:09:33 volumio volumio[1029]: info: ------------------------------ 49ms Nov 05 11:09:35 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand add "https://stream9.nadaje.com:8003/live" Nov 05 11:09:35 volumio volumio[1029]: error: updateQueue error: null Nov 05 11:09:35 volumio volumio[1029]: error: updateQueue error: null Nov 05 11:09:35 volumio volumio[1029]: info: Nov 05 11:09:35 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:35 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:35 volumio volumio[1029]: info: ------------------------------ 1476ms Nov 05 11:09:35 volumio volumio[1029]: info: ------------------------------ 1471ms Nov 05 11:09:35 volumio volumio[1029]: info: sendMpdCommand add "https://stream9.nadaje.com:8003/live" took 13 milliseconds Nov 05 11:09:35 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 05 11:09:35 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand play Nov 05 11:09:35 volumio volumio[1029]: info: Nov 05 11:09:35 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:35 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:35 volumio volumio[1029]: info: Nov 05 11:09:35 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:35 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:35 volumio volumio[1029]: info: ------------------------------ 40ms Nov 05 11:09:35 volumio volumio[1029]: info: sendMpdCommand play took 29 milliseconds Nov 05 11:09:35 volumio volumio[1029]: info: ------------------------------ 29ms Nov 05 11:09:35 volumio volumio[1029]: info: ------------------------------ 14ms Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 35 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 32 milliseconds Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:36 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:36 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 80 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 69 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 51 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 45 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 27 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 16 milliseconds Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:36 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:36 volumio volumio[1029]: 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":null,"isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:36 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:36 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:36 volumio volumio[1029]: 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":null,"isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:36 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:36 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: ------------------------------ 264ms Nov 05 11:09:36 volumio volumio[1029]: info: ------------------------------ 284ms Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:36 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:36 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:36 volumio volumio[1029]: info: Nov 05 11:09:36 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:36 volumio volumio[1029]: info: ------------------------------ 241ms Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 234 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: ------------------------------ 236ms Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 247 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 223 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 217 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 214 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 214 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: ------------------------------ 64ms Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 54 milliseconds Nov 05 11:09:36 volumio volumio[1029]: info: ------------------------------ 44ms Nov 05 11:09:36 volumio volumio[1029]: info: sendMpdCommand status took 54 milliseconds Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:36 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:36 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:36 volumio volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:36 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:36 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:36 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:36 volumio volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:36 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:36 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:36 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:36 volumio volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:36 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:36 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:36 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:36 volumio volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:36 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:36 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:36 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: ------------------------------ 731ms Nov 05 11:09:37 volumio volumio[1029]: info: ------------------------------ 729ms Nov 05 11:09:37 volumio volumio[1029]: info: ------------------------------ 670ms Nov 05 11:09:37 volumio volumio[1029]: info: ------------------------------ 660ms Nov 05 11:09:37 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 539 milliseconds Nov 05 11:09:37 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 538 milliseconds Nov 05 11:09:37 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 524 milliseconds Nov 05 11:09:37 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 522 milliseconds Nov 05 11:09:37 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:37 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:37 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:37 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:37 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:37 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:37 volumio volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:37 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:37 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:37 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:37 volumio volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:37 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:37 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:37 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:37 volumio volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:37 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:37 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:37 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:37 volumio volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:37 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::syncState stateService play Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus play Nov 05 11:09:37 volumio volumio[1029]: info: Received an update from plugin. extracting info from payload Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:37 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:37 volumio volumio[1029]: info: ------------------------------ 1118ms Nov 05 11:09:37 volumio volumio[1029]: info: ------------------------------ 1118ms Nov 05 11:09:37 volumio volumio[1029]: info: ------------------------------ 929ms Nov 05 11:09:37 volumio volumio[1029]: info: ------------------------------ 917ms Nov 05 11:09:39 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 05 11:09:39 volumio volumio[1029]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 05 11:09:39 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 05 11:09:39 volumio volumio[1029]: info: Received Get System Version Nov 05 11:09:39 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 05 11:09:39 volumio volumio[1029]: info: Received Get System Info Nov 05 11:09:39 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 05 11:09:39 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 05 11:09:39 volumio volumio[1029]: info: Discovery: Getting this device information Nov 05 11:09:39 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:39 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 05 11:09:40 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 05 11:09:40 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:41 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:41 volumio volumio[1029]: info: Listing playlists Nov 05 11:09:41 volumio volumio[1029]: info: Listing playlists Nov 05 11:09:42 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 05 11:09:42 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:47 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 05 11:09:47 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:50 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::ClearQueue Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::stop Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::stPlaybackTimer Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::updateTrackBlock Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrackBlock Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::serviceStop Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::serviceStop Nov 05 11:09:50 volumio volumio[1029]: info: [1762337390089] ControllerWebradio::stop Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::clearPlayQueue Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::saveQueue Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushQueue Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::addQueueItems Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::addQueueItems Nov 05 11:09:50 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:09:50 volumio volumio[1029]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s294874 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 05 11:09:50 volumio volumio[1029]: info: Nov 05 11:09:50 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:50 volumio volumio[1029]: info: sendMpdCommand stop took 279 milliseconds Nov 05 11:09:50 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:50 volumio volumio[1029]: info: Nov 05 11:09:50 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:50 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:50 volumio volumio[1029]: info: Nov 05 11:09:50 volumio volumio[1029]: ---------------------------- MPD announces state update: player Nov 05 11:09:50 volumio volumio[1029]: info: ControllerMpd::getState Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Nov 05 11:09:50 volumio volumio[1029]: info: sendMpdCommand status took 32 milliseconds Nov 05 11:09:50 volumio volumio[1029]: info: sendMpdCommand status took 19 milliseconds Nov 05 11:09:50 volumio volumio[1029]: info: sendMpdCommand status took 13 milliseconds Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::parseState Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 11:09:50 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 40 milliseconds Nov 05 11:09:50 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 40 milliseconds Nov 05 11:09:50 volumio volumio[1029]: info: sendMpdCommand playlistinfo took 39 milliseconds Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:50 volumio volumio[1029]: verbose: ControllerMpd::parseTrackInfo Nov 05 11:09:50 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: 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":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:50 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::syncState stateService stop Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: No code Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: 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":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:50 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::syncState stateService stop Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: No code Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: ControllerMpd::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::servicePushState Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: 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":"JANIS JOPLIN - Pearl - Mercedes Benz","artist":"Rockserwis.fm [mp3]","album":null,"uri":"https://stream9.nadaje.com:8003/live","trackType":""} Nov 05 11:09:50 volumio volumio[1029]: verbose: CURRENT POSITION 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::syncState stateService stop Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: No code Nov 05 11:09:50 volumio volumio[1029]: info: CoreStateMachine::pushState Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushState Nov 05 11:09:50 volumio volumio[1029]: info: ------------------------------ 348ms Nov 05 11:09:50 volumio volumio[1029]: info: ------------------------------ 363ms Nov 05 11:09:50 volumio volumio[1029]: info: ------------------------------ 354ms Nov 05 11:09:50 volumio volumio[1029]: info: CoreCommandRouter::volumioPushQueue Nov 05 11:09:50 volumio volumio[1029]: info: CorePlayQueue::saveQueue Nov 05 11:09:51 volumio volumio[1029]: info: CoreStateMachine::updateTrackBlock Nov 05 11:09:51 volumio volumio[1029]: info: CorePlayQueue::getTrackBlock Nov 05 11:09:51 volumio volumio[1029]: info: CoreCommandRouter::volumioPlay Nov 05 11:09:51 volumio volumio[1029]: info: CoreStateMachine::play index 0 Nov 05 11:09:51 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 11:09:51 volumio volumio[1029]: info: CoreStateMachine::stop Nov 05 11:09:51 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 11:09:51 volumio volumio[1029]: info: CoreStateMachine::play index undefined Nov 05 11:09:51 volumio volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 11:09:51 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:51 volumio volumio[1029]: info: CoreStateMachine::startPlaybackTimer Nov 05 11:09:51 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:51 volumio volumio[1029]: info: [1762337391003] ControllerWebradio::clearAddPlayTrack Nov 05 11:09:51 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 11:09:51 volumio volumio[1029]: info: sendMpdCommand stop took 12 milliseconds Nov 05 11:09:51 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand clear Nov 05 11:09:51 volumio volumio[1029]: info: Nov 05 11:09:51 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:51 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:51 volumio volumio[1029]: info: sendMpdCommand clear took 6 milliseconds Nov 05 11:09:51 volumio volumio[1029]: verbose: ControllerMpd::sendMpdCommand load "https://tuneintoradio1.com/public/vfr_80s/playlist.pls" Nov 05 11:09:51 volumio volumio[1029]: info: Nov 05 11:09:51 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:51 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:51 volumio volumio[1029]: info: Nov 05 11:09:51 volumio volumio[1029]: ---------------------------- MPD announces system playlist update Nov 05 11:09:51 volumio volumio[1029]: info: Ignoring MPD Status Update Nov 05 11:09:51 volumio volumio[1029]: error: updateQueue error: null Nov 05 11:09:51 volumio volumio[1029]: info: ------------------------------ 10ms Nov 05 11:09:51 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:09:51 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:09:59 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 05 11:09:59 volumio volumio[1029]: info: Preload queue cleared Nov 05 11:10:01 volumio volumio[1029]: info: CoreCommandRouter::volumioGetState Nov 05 11:10:01 volumio volumio[1029]: info: CorePlayQueue::getTrack 0 Nov 05 11:10:01 volumio volumio[1029]: info: Listing playlists Nov 05 11:10:01 volumio volumio[1029]: info: Listing playlists Nov 05 11:10:05 volumio volumio[1029]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 05 11:10:05 volumio volumio[1029]: info: READ Nov 05 11:10:05 volumio volumio[1029]: Use XMLElement.setAttribute instead Nov 05 11:10:05 volumio volumio[1029]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 11:10:06 volumio volumio[1029]: TypeError: children[i].attr(...).value is not a function Nov 05 11:10:06 volumio volumio[1029]: at /volumio/app/plugins/music_service/webradio/index.js:286:47 Nov 05 11:10:06 volumio volumio[1029]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Nov 05 11:10:06 volumio volumio[1029]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 11:10:08 volumio sudo[1787]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-05 11:09' Nov 05 11:10:08 volumio sudo[1787]: 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="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"