-- Logs begin at Mon 2022-06-20 02:05:42 UTC, end at Mon 2022-06-20 02:08:37 UTC. -- Jun 20 02:07:18 volumio sudo[1462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 20 02:07:18 volumio sudo[1462]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 02:07:18 volumio sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 02:07:18 volumio sudo[1462]: pam_unix(sudo:session): session closed for user root Jun 20 02:07:18 volumio sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 02:07:18 volumio sudo[1464]: pam_unix(sudo:session): session closed for user root Jun 20 02:07:19 volumio sudo[1482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 20 02:07:19 volumio sudo[1482]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 02:07:19 volumio sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 02:07:19 volumio sudo[1482]: pam_unix(sudo:session): session closed for user root Jun 20 02:07:19 volumio sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 02:07:19 volumio sudo[1484]: pam_unix(sudo:session): session closed for user root Jun 20 02:07:20 volumio volumio[969]: info: CoreCommandRouter::volumioGetState Jun 20 02:07:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 20 02:07:20 volumio volumio[969]: info: Listing playlists Jun 20 02:07:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 20 02:07:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 20 02:07:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 20 02:07:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 20 02:07:22 volumio volumio[969]: info: CoreCommandRouter::volumioGetQueue Jun 20 02:07:22 volumio volumio[969]: info: CoreStateMachine::getQueue Jun 20 02:07:22 volumio volumio[969]: info: CorePlayQueue::getQueue Jun 20 02:07:24 volumio volumio[969]: info: CoreCommandRouter::volumioGetVisibleSources Jun 20 02:07:24 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 02:07:26 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jun 20 02:07:30 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jun 20 02:07:39 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 20 02:07:39 volumio volumio[969]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 20 02:07:39 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 20 02:07:39 volumio volumio[969]: info: Received Get System Version Jun 20 02:07:39 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 20 02:07:42 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::ClearQueue Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::stop Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 02:07:49 volumio volumio[969]: verbose: UNSET VOLATILE Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::stPlaybackTimer Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::serviceStop Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::serviceStop Jun 20 02:07:49 volumio volumio[969]: info: [1655690869900] ControllerWebradio::stop Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::clearPlayQueue Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::saveQueue Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::addQueueItems Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::addQueueItems Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/0 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/0 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/1 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/1 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/2 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/2 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/3 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/3 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/4 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/4 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/5 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/5 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/6 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/6 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/7 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/7 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/8 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/8 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/9 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/9 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/10 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/10 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/11 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/11 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/12 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/12 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/13 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/13 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/14 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/14 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: Adding Item to queue: podcast/9/15 Jun 20 02:07:49 volumio volumio[969]: info: Exploding uri podcast/9/15 in service podcast Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::saveQueue Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Jun 20 02:07:49 volumio volumio[969]: info: CoreCommandRouter::volumioPlay Jun 20 02:07:49 volumio volumio[969]: verbose: UNSET VOLATILE Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::play index 0 Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::stop Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 02:07:49 volumio volumio[969]: verbose: UNSET VOLATILE Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::play index undefined Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:49 volumio volumio[969]: info: CoreStateMachine::startPlaybackTimer Jun 20 02:07:49 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Jun 20 02:07:49 volumio volumio[969]: info: sendMpdCommand stop took 79 milliseconds Jun 20 02:07:49 volumio volumio[969]: info: Jun 20 02:07:49 volumio volumio[969]: ---------------------------- MPD announces state update: player Jun 20 02:07:49 volumio volumio[969]: info: ControllerMpd::getState Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:49 volumio volumio[969]: info: sendMpdCommand stop took 31 milliseconds Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clear Jun 20 02:07:49 volumio volumio[969]: info: Jun 20 02:07:49 volumio volumio[969]: ---------------------------- MPD announces system playlist update Jun 20 02:07:49 volumio volumio[969]: info: Ignoring MPD Status Update Jun 20 02:07:49 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Jun 20 02:07:49 volumio volumio[969]: info: sendMpdCommand clear took 3 milliseconds Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand add "https://rf.proxycast.org/9e76e51b-4f01-4297-a602-46ac2204e3e9/13944-27.04.2024-ITEMA_23723811-2024F23002S0118-22.mp3" Jun 20 02:07:49 volumio volumio[969]: error: updateQueue error: null Jun 20 02:07:49 volumio volumio[969]: info: Jun 20 02:07:49 volumio volumio[969]: ---------------------------- MPD announces system playlist update Jun 20 02:07:49 volumio volumio[969]: info: Ignoring MPD Status Update Jun 20 02:07:49 volumio volumio[969]: info: ------------------------------ 8ms Jun 20 02:07:49 volumio volumio[969]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 20 02:07:49 volumio volumio[969]: info: sendMpdCommand add "https://rf.proxycast.org/9e76e51b-4f01-4297-a602-46ac2204e3e9/13944-27.04.2024-ITEMA_23723811-2024F23002S0118-22.mp3" took 5 milliseconds Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Jun 20 02:07:49 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand play Jun 20 02:07:49 volumio volumio[969]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 20 02:07:49 volumio volumio[969]: info: ------------------------------ 17ms Jun 20 02:07:50 volumio volumio[969]: info: ------------------------------ 7ms Jun 20 02:07:50 volumio volumio[969]: info: sendMpdCommand play took 4 milliseconds Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:50 volumio volumio[969]: info: sendMpdCommand status took 2 milliseconds Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:50 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:50 volumio volumio[969]: info: CoreCommandRouter::servicePushState Jun 20 02:07:50 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:50 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"uri":"https://rf.proxycast.org/9e76e51b-4f01-4297-a602-46ac2204e3e9/13944-27.04.2024-ITEMA_23723811-2024F23002S0118-22.mp3","trackType":"Podcast","serviceName":"podcast"} Jun 20 02:07:50 volumio volumio[969]: verbose: CURRENT POSITION 0 Jun 20 02:07:50 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Jun 20 02:07:50 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jun 20 02:07:50 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:50 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:50 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:50 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:50 volumio volumio[969]: info: Jun 20 02:07:50 volumio volumio[969]: ---------------------------- MPD announces state update: player Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:50 volumio volumio[969]: info: ControllerMpd::getState Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 20 02:07:50 volumio volumio[969]: info: sendMpdCommand status took 13 milliseconds Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 20 02:07:50 volumio volumio[969]: info: sendMpdCommand status took 8 milliseconds Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:50 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 20 02:07:50 volumio volumio[969]: info: sendMpdCommand clearerror took 8 milliseconds Jun 20 02:07:50 volumio volumio[969]: info: sendMpdCommand clearerror took 8 milliseconds Jun 20 02:07:50 volumio volumio[969]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 20 02:07:50 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Jun 20 02:07:50 volumio volumio[969]: info: ControllerMpd::pushState Jun 20 02:07:50 volumio volumio[969]: info: CoreCommandRouter::servicePushState Jun 20 02:07:50 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:50 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:50 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:50 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:50 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:50 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current podcast Received mpd Jun 20 02:07:50 volumio volumio[969]: info: ------------------------------ 33ms Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::ClearQueue Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::stop Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 02:07:54 volumio volumio[969]: verbose: UNSET VOLATILE Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::stPlaybackTimer Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::serviceStop Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::serviceStop Jun 20 02:07:54 volumio volumio[969]: info: ControllerMpd::stop Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::clearPlayQueue Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::saveQueue Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::addQueueItems Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::addQueueItems Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/0 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/0 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/1 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/1 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/2 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/2 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/3 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/3 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/4 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/4 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/5 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/5 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/6 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/6 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/7 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/7 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/8 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/8 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/9 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/9 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/10 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/10 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/11 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/11 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/12 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/12 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/13 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/13 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/14 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/14 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: Adding Item to queue: podcast/9/15 Jun 20 02:07:54 volumio volumio[969]: info: Exploding uri podcast/9/15 in service podcast Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::saveQueue Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPlay Jun 20 02:07:54 volumio volumio[969]: verbose: UNSET VOLATILE Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::play index 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::stop Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 02:07:54 volumio volumio[969]: verbose: UNSET VOLATILE Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::play index undefined Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::startPlaybackTimer Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand stop took 74 milliseconds Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand stop took 11 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clear Jun 20 02:07:54 volumio volumio[969]: info: Jun 20 02:07:54 volumio volumio[969]: ---------------------------- MPD announces system playlist update Jun 20 02:07:54 volumio volumio[969]: info: Ignoring MPD Status Update Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand status took 6 milliseconds Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand clear took 5 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand add "https://rf.proxycast.org/63e38395-22b7-4ad6-952a-5aed73ae6c3a/13944-26.04.2024-ITEMA_23722875-2024F22815S0118-22.mp3" Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::servicePushState Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: 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,"uri":"https://rf.proxycast.org/63e38395-22b7-4ad6-952a-5aed73ae6c3a/13944-26.04.2024-ITEMA_23722875-2024F22815S0118-22.mp3","trackType":"Podcast","serviceName":"podcast"} Jun 20 02:07:54 volumio volumio[969]: verbose: CURRENT POSITION 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:54 volumio volumio[969]: info: No code Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:54 volumio volumio[969]: error: updateQueue error: null Jun 20 02:07:54 volumio volumio[969]: info: Jun 20 02:07:54 volumio volumio[969]: ---------------------------- MPD announces system playlist update Jun 20 02:07:54 volumio volumio[969]: info: Ignoring MPD Status Update Jun 20 02:07:54 volumio volumio[969]: info: ------------------------------ 35ms Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand add "https://rf.proxycast.org/63e38395-22b7-4ad6-952a-5aed73ae6c3a/13944-26.04.2024-ITEMA_23722875-2024F22815S0118-22.mp3" took 32 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand play Jun 20 02:07:54 volumio volumio[969]: info: ------------------------------ 7ms Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand play took 6 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand status took 1 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::servicePushState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"uri":"https://rf.proxycast.org/63e38395-22b7-4ad6-952a-5aed73ae6c3a/13944-26.04.2024-ITEMA_23722875-2024F22815S0118-22.mp3","trackType":"Podcast","serviceName":"podcast"} Jun 20 02:07:54 volumio volumio[969]: verbose: CURRENT POSITION 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:54 volumio volumio[969]: info: Jun 20 02:07:54 volumio volumio[969]: ---------------------------- MPD announces state update: player Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:54 volumio volumio[969]: info: ControllerMpd::getState Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand status took 6 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand status took 8 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand status took 8 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::parseState Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand clearerror took 11 milliseconds Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand clearerror took 9 milliseconds Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand clearerror took 9 milliseconds Jun 20 02:07:54 volumio volumio[969]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 20 02:07:54 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Jun 20 02:07:54 volumio volumio[969]: info: ControllerMpd::pushState Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::servicePushState Jun 20 02:07:54 volumio volumio[969]: info: CoreStateMachine::pushState Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Jun 20 02:07:54 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 02:07:54 volumio volumio[969]: info: CorePlayQueue::getTrack 1 Jun 20 02:07:54 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current podcast Received mpd Jun 20 02:07:54 volumio volumio[969]: info: ------------------------------ 29ms Jun 20 02:08:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jun 20 02:08:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jun 20 02:08:36 volumio volumio[969]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 02:08:36 volumio volumio[969]: TypeError: Cannot read property 'title' of undefined Jun 20 02:08:36 volumio volumio[969]: at /data/plugins/music_service/podcast/index.js:421:51 Jun 20 02:08:36 volumio volumio[969]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/podcast/node_modules/rss-parser/lib/utils.js:63:29) Jun 20 02:08:36 volumio volumio[969]: at ontimeout (timers.js:482:11) Jun 20 02:08:36 volumio volumio[969]: at tryOnTimeout (timers.js:317:5) Jun 20 02:08:36 volumio volumio[969]: at Timer.listOnTimeout (timers.js:277:5) Jun 20 02:08:36 volumio volumio[969]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 02:08:37 volumio sudo[1687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2022-06-20 02:07 Jun 20 02:08:37 volumio sudo[1687]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"