-- Logs begin at Sun 2024-11-24 19:40:58 CET, end at Mon 2024-11-25 14:55:14 CET. -- Nov 25 14:54:08 volumio nmbd[783]: [2024/11/25 14:54:08.782116, 0] ../source3/libsmb/nmblib.c:917(send_udp) Nov 25 14:54:08 volumio nmbd[783]: Packet send failed to 192.168.211.255(138) ERRNO=Invalid argument Nov 25 14:54:33 volumio nmbd[783]: [2024/11/25 14:54:33.805556, 0] ../source3/libsmb/nmblib.c:917(send_udp) Nov 25 14:54:33 volumio nmbd[783]: Packet send failed to 192.168.211.255(138) ERRNO=Invalid argument Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::volumioPlay Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::play index undefined Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::startPlaybackTimer Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 25 14:54:46 volumio volumio[2985]: info: [1732542886367] ControllerWebradio::clearAddPlayTrack Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand stop Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand stop took 1 milliseconds Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand clear Nov 25 14:54:46 volumio volumio[2985]: info: Nov 25 14:54:46 volumio volumio[2985]: ---------------------------- MPD announces system playlist update Nov 25 14:54:46 volumio volumio[2985]: info: Ignoring MPD Status Update Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand clear took 1 milliseconds Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand load "http://live.radio-campus.org:8000/toulouse" Nov 25 14:54:46 volumio volumio[2985]: error: updateQueue error: null Nov 25 14:54:46 volumio volumio[2985]: info: ------------------------------ 1ms Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand add "http://live.radio-campus.org:8000/toulouse" Nov 25 14:54:46 volumio volumio[2985]: info: Nov 25 14:54:46 volumio volumio[2985]: ---------------------------- MPD announces system playlist update Nov 25 14:54:46 volumio volumio[2985]: info: Ignoring MPD Status Update Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand add "http://live.radio-campus.org:8000/toulouse" took 1 milliseconds Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand play Nov 25 14:54:46 volumio volumio[2985]: info: ------------------------------ 2ms Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand play took 2 milliseconds Nov 25 14:54:46 volumio volumio[2985]: info: Nov 25 14:54:46 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:46 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:46 volumio volumio[2985]: info: Nov 25 14:54:46 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand status took 4 milliseconds Nov 25 14:54:46 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand status took 3 milliseconds Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:46 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"toulouse","artist":null,"album":null,"uri":"http://live.radio-campus.org:8000/toulouse","trackType":""} Nov 25 14:54:46 volumio volumio[2985]: verbose: CURRENT POSITION 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::syncState stateService play Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::syncState currentStatus stop Nov 25 14:54:46 volumio volumio[2985]: info: ------------------------------ 12ms Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:46 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"toulouse","artist":null,"album":null,"uri":"http://live.radio-campus.org:8000/toulouse","trackType":""} Nov 25 14:54:46 volumio volumio[2985]: verbose: CURRENT POSITION 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::syncState stateService play Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::syncState currentStatus play Nov 25 14:54:46 volumio volumio[2985]: info: Received an update from plugin. extracting info from payload Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:46 volumio volumio[2985]: info: ------------------------------ 24ms Nov 25 14:54:46 volumio volumio[2985]: info: Nov 25 14:54:46 volumio volumio[2985]: ---------------------------- MPD announces system playlist update Nov 25 14:54:46 volumio volumio[2985]: info: Ignoring MPD Status Update Nov 25 14:54:46 volumio volumio[2985]: info: Nov 25 14:54:46 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:46 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:46 volumio volumio[2985]: info: Nov 25 14:54:46 volumio volumio[2985]: ---------------------------- MPD announces system playlist update Nov 25 14:54:46 volumio volumio[2985]: info: Ignoring MPD Status Update Nov 25 14:54:46 volumio volumio[2985]: info: Nov 25 14:54:46 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:46 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:46 volumio volumio[2985]: info: ------------------------------ 12ms Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand status took 11 milliseconds Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:46 volumio volumio[2985]: info: ------------------------------ 3ms Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand status took 2 milliseconds Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:46 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1227,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"toulouse","artist":"Radio Campus Toulouse","album":null,"uri":"http://live.radio-campus.org:8000/toulouse","trackType":""} Nov 25 14:54:46 volumio volumio[2985]: verbose: CURRENT POSITION 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::syncState stateService play Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::syncState currentStatus play Nov 25 14:54:46 volumio volumio[2985]: info: Received an update from plugin. extracting info from payload Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:46 volumio volumio[2985]: info: ------------------------------ 24ms Nov 25 14:54:46 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 25 14:54:46 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:46 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1227,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"toulouse","artist":"Radio Campus Toulouse","album":null,"uri":"http://live.radio-campus.org:8000/toulouse","trackType":""} Nov 25 14:54:46 volumio volumio[2985]: verbose: CURRENT POSITION 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::syncState stateService play Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::syncState currentStatus play Nov 25 14:54:46 volumio volumio[2985]: info: Received an update from plugin. extracting info from payload Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:46 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:46 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:46 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:46 volumio volumio[2985]: info: ------------------------------ 21ms Nov 25 14:54:50 volumio volumio[2985]: info: Listing playlists Nov 25 14:54:50 volumio volumio[2985]: info: CoreCommandRouter::volumioNext Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::next Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::stop Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::stPlaybackTimer Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::updateTrackBlock Nov 25 14:54:50 volumio volumio[2985]: info: CorePlayQueue::getTrackBlock Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:50 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:50 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 14:54:50 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:50 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:50 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::serviceStop Nov 25 14:54:50 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:50 volumio volumio[2985]: info: CoreCommandRouter::serviceStop Nov 25 14:54:50 volumio volumio[2985]: info: [1732542890748] ControllerWebradio::stop Nov 25 14:54:50 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand stop Nov 25 14:54:50 volumio volumio[2985]: info: Nov 25 14:54:50 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:50 volumio volumio[2985]: info: sendMpdCommand stop took 28 milliseconds Nov 25 14:54:50 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:50 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::play index undefined Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 14:54:50 volumio volumio[2985]: info: CorePlayQueue::getTrack 1 Nov 25 14:54:50 volumio volumio[2985]: info: sendMpdCommand status took 2 milliseconds Nov 25 14:54:50 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:50 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:50 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 25 14:54:50 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:50 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:50 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:50 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:50 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:50 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:50 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:50 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:50 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:50 volumio volumio[2985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 25 14:54:50 volumio volumio[2985]: info: ------------------------------ 9ms Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::volumioPlay Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::play index undefined Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::startPlaybackTimer Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 25 14:54:52 volumio volumio[2985]: info: [1732542892164] ControllerWebradio::clearAddPlayTrack Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand stop Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand stop took 0 milliseconds Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand clear Nov 25 14:54:52 volumio volumio[2985]: info: Nov 25 14:54:52 volumio volumio[2985]: ---------------------------- MPD announces system playlist update Nov 25 14:54:52 volumio volumio[2985]: info: Ignoring MPD Status Update Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand clear took 1 milliseconds Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand load "http://live.radio-campus.org:8000/toulouse" Nov 25 14:54:52 volumio volumio[2985]: error: updateQueue error: null Nov 25 14:54:52 volumio volumio[2985]: info: ------------------------------ 2ms Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand add "http://live.radio-campus.org:8000/toulouse" Nov 25 14:54:52 volumio volumio[2985]: info: Nov 25 14:54:52 volumio volumio[2985]: ---------------------------- MPD announces system playlist update Nov 25 14:54:52 volumio volumio[2985]: info: Ignoring MPD Status Update Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand add "http://live.radio-campus.org:8000/toulouse" took 1 milliseconds Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand play Nov 25 14:54:52 volumio volumio[2985]: info: ------------------------------ 2ms Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand play took 1 milliseconds Nov 25 14:54:52 volumio volumio[2985]: info: Nov 25 14:54:52 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:52 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:52 volumio volumio[2985]: info: Nov 25 14:54:52 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand status took 4 milliseconds Nov 25 14:54:52 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand status took 1 milliseconds Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:52 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"toulouse","artist":null,"album":null,"uri":"http://live.radio-campus.org:8000/toulouse","trackType":""} Nov 25 14:54:52 volumio volumio[2985]: verbose: CURRENT POSITION 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::syncState stateService play Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::syncState currentStatus stop Nov 25 14:54:52 volumio volumio[2985]: info: ------------------------------ 21ms Nov 25 14:54:52 volumio volumio[2985]: info: Nov 25 14:54:52 volumio volumio[2985]: ---------------------------- MPD announces system playlist update Nov 25 14:54:52 volumio volumio[2985]: info: Ignoring MPD Status Update Nov 25 14:54:52 volumio volumio[2985]: info: Nov 25 14:54:52 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 16 milliseconds Nov 25 14:54:52 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:52 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"toulouse","artist":null,"album":null,"uri":"http://live.radio-campus.org:8000/toulouse","trackType":""} Nov 25 14:54:52 volumio volumio[2985]: verbose: CURRENT POSITION 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::syncState stateService play Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::syncState currentStatus play Nov 25 14:54:52 volumio volumio[2985]: info: Received an update from plugin. extracting info from payload Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:52 volumio volumio[2985]: info: ------------------------------ 37ms Nov 25 14:54:52 volumio volumio[2985]: info: Nov 25 14:54:52 volumio volumio[2985]: ---------------------------- MPD announces system playlist update Nov 25 14:54:52 volumio volumio[2985]: info: Ignoring MPD Status Update Nov 25 14:54:52 volumio volumio[2985]: info: Nov 25 14:54:52 volumio volumio[2985]: ---------------------------- MPD announces state update: player Nov 25 14:54:52 volumio volumio[2985]: info: ControllerMpd::getState Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand status Nov 25 14:54:52 volumio volumio[2985]: info: ------------------------------ 21ms Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand status took 19 milliseconds Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:52 volumio volumio[2985]: info: ------------------------------ 11ms Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand status took 11 milliseconds Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::parseState Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:52 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1227,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"toulouse","artist":"Radio Campus Toulouse","album":null,"uri":"http://live.radio-campus.org:8000/toulouse","trackType":""} Nov 25 14:54:52 volumio volumio[2985]: verbose: CURRENT POSITION 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::syncState stateService play Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::syncState currentStatus play Nov 25 14:54:52 volumio volumio[2985]: info: Received an update from plugin. extracting info from payload Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:52 volumio volumio[2985]: info: ------------------------------ 45ms Nov 25 14:54:52 volumio volumio[2985]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 25 14:54:52 volumio volumio[2985]: verbose: ControllerMpd::parseTrackInfo Nov 25 14:54:52 volumio volumio[2985]: info: ControllerMpd::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::servicePushState Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1227,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"toulouse","artist":"Radio Campus Toulouse","album":null,"uri":"http://live.radio-campus.org:8000/toulouse","trackType":""} Nov 25 14:54:52 volumio volumio[2985]: verbose: CURRENT POSITION 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::syncState stateService play Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::syncState currentStatus play Nov 25 14:54:52 volumio volumio[2985]: info: Received an update from plugin. extracting info from payload Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CorePlayQueue::getTrack 0 Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:52 volumio volumio[2985]: info: CoreStateMachine::pushState Nov 25 14:54:52 volumio volumio[2985]: info: CoreCommandRouter::volumioPushState Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output update for this device Nov 25 14:54:52 volumio volumio[2985]: info: MRS: Pushing multiroomSync output Nov 25 14:54:52 volumio volumio[2985]: info: ------------------------------ 38ms Nov 25 14:55:07 volumio volumio[2985]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.13 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 25 14:55:07 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 14:55:07 volumio volumio[2985]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 25 14:55:07 volumio volumio[2985]: info: CoreCommandRouter::volumioGetState Nov 25 14:55:08 volumio volumio[2985]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 14:55:08 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 14:55:08 volumio volumio[2985]: info: Listing playlists Nov 25 14:55:14 volumio volumio[2985]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Nov 25 14:55:14 volumio volumio[2985]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Nov 25 14:55:14 volumio volumio[2985]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 14:55:14 volumio volumio[2985]: TypeError: Cannot read property 'then' of undefined Nov 25 14:55:14 volumio volumio[2985]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Nov 25 14:55:14 volumio volumio[2985]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2274:30) Nov 25 14:55:14 volumio volumio[2985]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1450:26) Nov 25 14:55:14 volumio volumio[2985]: at Socket.emit (events.js:400:28) Nov 25 14:55:14 volumio volumio[2985]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 25 14:55:14 volumio volumio[2985]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Nov 25 14:55:14 volumio volumio[2985]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 14:55:14 volumio sudo[7557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 14:54 Nov 25 14:55:14 volumio sudo[7557]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:11:38 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="932fc3546f7cc8faa2b4d349036752dd"