-- Logs begin at Mon 2024-09-30 19:04:29 UTC, end at Tue 2024-10-01 12:06:43 UTC. -- Oct 01 12:05:01 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:05:01 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:05:01 volumio-jur volumiologrotate[905]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 01 12:05:01 volumio-jur volumiologrotate[905]: ls: cannot access 'JUR': No such file or directory Oct 01 12:05:02 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:05:02 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:05:02 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:05:02 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:05:02 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:05:02 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:05:04 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:04 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:14 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:15 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:25 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:25 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:31 volumio-jur sudo[27072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 01 12:05:31 volumio-jur sudo[27072]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 12:05:31 volumio-jur sudo[27072]: pam_unix(sudo:session): session closed for user root Oct 01 12:05:31 volumio-jur sudo[27074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 01 12:05:31 volumio-jur sudo[27074]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 12:05:31 volumio-jur sudo[27074]: pam_unix(sudo:session): session closed for user root Oct 01 12:05:32 volumio-jur volumio[1320]: verbose: New Socket.io Connection to 10.19.31.12 from 10.19.31.126 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetVisibleSources Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetState Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetQueue Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreStateMachine::getQueue Oct 01 12:05:32 volumio-jur volumio[1320]: info: CorePlayQueue::getQueue Oct 01 12:05:32 volumio-jur volumio[1320]: info: Listing playlists Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 01 12:05:32 volumio-jur volumio[1320]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 01 12:05:32 volumio-jur volumio[1320]: info: Received Get System Info Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 12:05:32 volumio-jur volumio[1320]: info: Discovery: Getting this device information Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetState Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetState Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 01 12:05:32 volumio-jur volumio[1320]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 12:05:32 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:05:32 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:05:33 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:05:33 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:05:33 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 01 12:05:33 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 01 12:05:33 volumio-jur volumio[1320]: info: Received Get System Info Oct 01 12:05:33 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 12:05:33 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 12:05:33 volumio-jur volumio[1320]: info: Discovery: Getting this device information Oct 01 12:05:33 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetState Oct 01 12:05:33 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 12:05:33 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 01 12:05:34 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:05:34 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:05:34 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:05:34 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:05:35 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:36 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:37 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 01 12:05:37 volumio-jur volumio[1320]: info: Received Get System Info Oct 01 12:05:37 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 12:05:37 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 12:05:37 volumio-jur volumio[1320]: info: Discovery: Getting this device information Oct 01 12:05:37 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetState Oct 01 12:05:37 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 12:05:41 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 01 12:05:44 volumio-jur volumio[1320]: Searching plugin music_service/webradio Oct 01 12:05:44 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: webradio , search Oct 01 12:05:45 volumio-jur volumio[1320]: info: All search sources collected, pushing search results Oct 01 12:05:45 volumio-jur volumio[1320]: Searching plugin music_service/webradio Oct 01 12:05:45 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: webradio , search Oct 01 12:05:46 volumio-jur volumio[1320]: info: All search sources collected, pushing search results Oct 01 12:05:46 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:46 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:46 volumio-jur volumio[1320]: Searching plugin music_service/webradio Oct 01 12:05:46 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: webradio , search Oct 01 12:05:47 volumio-jur volumio[1320]: info: All search sources collected, pushing search results Oct 01 12:05:50 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 01 12:05:50 volumio-jur volumio[1320]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 01 12:05:50 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 01 12:05:50 volumio-jur volumio[1320]: info: Received Get System Version Oct 01 12:05:50 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 01 12:05:50 volumio-jur volumio[1320]: info: Received Get System Info Oct 01 12:05:50 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 12:05:50 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 12:05:50 volumio-jur volumio[1320]: info: Discovery: Getting this device information Oct 01 12:05:50 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetState Oct 01 12:05:50 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 12:05:54 volumio-jur volumio[1320]: info: Oct 01 12:05:54 volumio-jur volumio[1320]: ---------------------------- MPD announces system playlist update Oct 01 12:05:54 volumio-jur volumio[1320]: info: Ignoring MPD Status Update Oct 01 12:05:54 volumio-jur volumio[1320]: info: Oct 01 12:05:54 volumio-jur volumio[1320]: ---------------------------- MPD announces state update: player Oct 01 12:05:54 volumio-jur volumio[1320]: info: ControllerMpd::getState Oct 01 12:05:54 volumio-jur volumio[1320]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:05:54 volumio-jur volumio[1320]: info: ------------------------------ 3ms Oct 01 12:05:54 volumio-jur volumio[1320]: info: sendMpdCommand status took 3 milliseconds Oct 01 12:05:54 volumio-jur volumio[1320]: verbose: ControllerMpd::parseState Oct 01 12:05:54 volumio-jur volumio[1320]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:05:54 volumio-jur volumio[1320]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 12:05:54 volumio-jur volumio[1320]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:05:54 volumio-jur volumio[1320]: info: ControllerMpd::pushState Oct 01 12:05:54 volumio-jur volumio[1320]: info: CoreCommandRouter::servicePushState Oct 01 12:05:54 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:05:54 volumio-jur volumio[1320]: verbose: STATE SERVICE {"status":"play","position":0,"seek":83165435,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jason Mraz - I'm Yours","artist":"100%NL FM Stream","album":null,"uri":"https://stream.100p.nl?dist=tunein","trackType":""} Oct 01 12:05:54 volumio-jur volumio[1320]: verbose: CURRENT POSITION 0 Oct 01 12:05:54 volumio-jur volumio[1320]: info: CoreStateMachine::syncState stateService play Oct 01 12:05:54 volumio-jur volumio[1320]: info: CoreStateMachine::syncState currentStatus play Oct 01 12:05:54 volumio-jur volumio[1320]: info: Received an update from plugin. extracting info from payload Oct 01 12:05:54 volumio-jur volumio[1320]: info: CoreStateMachine::pushState Oct 01 12:05:54 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 12:05:54 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPushState Oct 01 12:05:54 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output update for this device Oct 01 12:05:54 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output Oct 01 12:05:54 volumio-jur volumio[1320]: info: CoreStateMachine::pushState Oct 01 12:05:54 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPushState Oct 01 12:05:54 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output update for this device Oct 01 12:05:54 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output Oct 01 12:05:54 volumio-jur volumio[1320]: info: ------------------------------ 25ms Oct 01 12:05:54 volumio-jur volumio[1320]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Oct 01 12:05:54 volumio-jur volumio[1320]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Oct 01 12:05:56 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:05:57 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:01 volumio-jur volumiologrotate[905]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 01 12:06:01 volumio-jur volumiologrotate[905]: ls: cannot access 'JUR': No such file or directory Oct 01 12:06:02 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 01 12:06:02 volumio-jur volumio[1320]: info: CURURI: music-library Oct 01 12:06:02 volumio-jur volumio[1320]: error: Failed LSINFO: null Oct 01 12:06:02 volumio-jur volumio[1320]: info: Preload queue cleared Oct 01 12:06:02 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:06:02 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:06:06 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:06:06 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:06:07 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:06:07 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:06:07 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:07 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:10 volumio-jur volumio[1320]: Searching plugin music_service/mpd Oct 01 12:06:10 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 01 12:06:10 volumio-jur volumio[1320]: info: All search sources collected, pushing search results Oct 01 12:06:11 volumio-jur volumio[1320]: Searching plugin music_service/mpd Oct 01 12:06:11 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 01 12:06:11 volumio-jur volumio[1320]: info: All search sources collected, pushing search results Oct 01 12:06:11 volumio-jur volumio[1320]: Searching plugin music_service/mpd Oct 01 12:06:11 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 01 12:06:11 volumio-jur volumio[1320]: info: All search sources collected, pushing search results Oct 01 12:06:17 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:18 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:28 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:28 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:31 volumio-jur volumio[1320]: Searching all installed plugins Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: , search Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Oct 01 12:06:31 volumio-jur volumio[1320]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: webradio , search Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , search Oct 01 12:06:31 volumio-jur volumio[1320]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin smart_inputs Oct 01 12:06:31 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: tidal , search Oct 01 12:06:32 volumio-jur volumio[1320]: info: searchTIDALUri took 740 milliseconds Oct 01 12:06:32 volumio-jur volumio[1320]: info: search took 742 milliseconds Oct 01 12:06:32 volumio-jur volumio[1320]: info: All search sources collected, pushing search results Oct 01 12:06:36 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:06:36 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:06:36 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:06:36 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:06:37 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:06:37 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:06:37 volumio-jur avahi-daemon[908]: avahi_normalize_name() failed. Oct 01 12:06:37 volumio-jur avahi-daemon[908]: avahi_key_new() failed. Oct 01 12:06:38 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:38 volumio-jur kernel: EDID block 0 is all zeroes Oct 01 12:06:39 volumio-jur volumio[1320]: info: Preload queue cleared Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::ClearQueue Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::stop Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::stPlaybackTimer Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::updateTrackBlock Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrackBlock Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::pushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output update for this device Oct 01 12:06:39 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::serviceStop Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::serviceStop Oct 01 12:06:39 volumio-jur volumio[1320]: info: [1727784399468] ControllerWebradio::stop Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::clearPlayQueue Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::saveQueue Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPushQueue Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::addQueueItems Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::addQueueItems Oct 01 12:06:39 volumio-jur volumio[1320]: info: Preload queue cleared Oct 01 12:06:39 volumio-jur volumio[1320]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s310155 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 01 12:06:39 volumio-jur volumio[1320]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Oct 01 12:06:39 volumio-jur volumio[1320]: info: Oct 01 12:06:39 volumio-jur volumio[1320]: ---------------------------- MPD announces state update: player Oct 01 12:06:39 volumio-jur volumio[1320]: info: sendMpdCommand stop took 83 milliseconds Oct 01 12:06:39 volumio-jur volumio[1320]: info: ControllerMpd::getState Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:06:39 volumio-jur volumio[1320]: info: sendMpdCommand status took 6 milliseconds Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: ControllerMpd::parseState Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:06:39 volumio-jur volumio[1320]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:06:39 volumio-jur volumio[1320]: info: ControllerMpd::pushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::servicePushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::pushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output update for this device Oct 01 12:06:39 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:06:39 volumio-jur volumio[1320]: 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":"Jason Mraz - I'm Yours","artist":"100%NL FM Stream","album":null,"uri":"https://stream.100p.nl?dist=tunein","trackType":""} Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: CURRENT POSITION 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::syncState stateService stop Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::syncState currentStatus stop Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::pushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output update for this device Oct 01 12:06:39 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output Oct 01 12:06:39 volumio-jur volumio[1320]: info: No code Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::pushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPushState Oct 01 12:06:39 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output update for this device Oct 01 12:06:39 volumio-jur volumio[1320]: info: MRS: Pushing multiroomSync output Oct 01 12:06:39 volumio-jur volumio[1320]: info: ------------------------------ 43ms Oct 01 12:06:39 volumio-jur volumio[1320]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPushQueue Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::saveQueue Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::updateTrackBlock Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrackBlock Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioPlay Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::play index 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::stop Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::play index undefined Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreStateMachine::startPlaybackTimer Oct 01 12:06:39 volumio-jur volumio[1320]: info: CorePlayQueue::getTrack 0 Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::volumioGetVisibleSources Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 01 12:06:39 volumio-jur volumio[1320]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 01 12:06:39 volumio-jur volumio[1320]: info: METAVOLUMIO: Retrieving similar tracks from metavolumio Oct 01 12:06:39 volumio-jur volumio[1320]: info: [1727784399730] ControllerWebradio::clearAddPlayTrack Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 12:06:39 volumio-jur volumio[1320]: info: sendMpdCommand stop took 11 milliseconds Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: ControllerMpd::sendMpdCommand clear Oct 01 12:06:39 volumio-jur volumio[1320]: info: Oct 01 12:06:39 volumio-jur volumio[1320]: ---------------------------- MPD announces system playlist update Oct 01 12:06:39 volumio-jur volumio[1320]: info: Ignoring MPD Status Update Oct 01 12:06:39 volumio-jur volumio[1320]: info: sendMpdCommand clear took 2 milliseconds Oct 01 12:06:39 volumio-jur volumio[1320]: verbose: ControllerMpd::sendMpdCommand load "https://stream.technolovers.fm/hardcore?ref=tunein" Oct 01 12:06:39 volumio-jur volumio[1320]: error: updateQueue error: null Oct 01 12:06:39 volumio-jur volumio[1320]: info: ------------------------------ 5ms Oct 01 12:06:42 volumio-jur volumio[1320]: info: MRS: STARTING volumioStreaming Oct 01 12:06:42 volumio-jur volumio[1320]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 12:06:42 volumio-jur volumio[1320]: TypeError: Cannot read property 'send' of null Oct 01 12:06:42 volumio-jur volumio[1320]: at Client.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:128:11) Oct 01 12:06:42 volumio-jur volumio[1320]: at Channel.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:34:12) Oct 01 12:06:42 volumio-jur volumio[1320]: at fn.Controller.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:28:16) Oct 01 12:06:42 volumio-jur volumio[1320]: at fn.RequestResponseController.request (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:34:8) Oct 01 12:06:42 volumio-jur volumio[1320]: at fn.MediaController.sessionRequest (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/media.js:91:8) Oct 01 12:06:42 volumio-jur volumio[1320]: at fn.MediaController.stop (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/media.js:107:8) Oct 01 12:06:42 volumio-jur volumio[1320]: at DefaultMediaReceiver.stop (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/default-media-receiver.js:42:19) Oct 01 12:06:42 volumio-jur volumio[1320]: at Timeout._onTimeout (/myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:5002) Oct 01 12:06:42 volumio-jur volumio[1320]: at listOnTimeout (internal/timers.js:557:17) Oct 01 12:06:42 volumio-jur volumio[1320]: at processTimers (internal/timers.js:500:7) Oct 01 12:06:42 volumio-jur volumio[1320]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 12:06:42 volumio-jur sudo[27136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Oct 01 12:06:42 volumio-jur sudo[27136]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 12:06:42 volumio-jur systemd[1]: Stopping VolumioStreamingService... Oct 01 12:06:42 volumio-jur systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Oct 01 12:06:42 volumio-jur systemd[1]: volumioStreaming.service: Succeeded. Oct 01 12:06:42 volumio-jur systemd[1]: Stopped VolumioStreamingService. Oct 01 12:06:42 volumio-jur systemd[1]: Started VolumioStreamingService. Oct 01 12:06:42 volumio-jur sudo[27136]: pam_unix(sudo:session): session closed for user root Oct 01 12:06:42 volumio-jur systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Oct 01 12:06:42 volumio-jur systemd[1]: volumioStreaming.service: Failed with result 'exit-code'. Oct 01 12:06:43 volumio-jur systemd[1]: volumioStreaming.service: Service RestartSec=100ms expired, scheduling restart. Oct 01 12:06:43 volumio-jur systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 1. Oct 01 12:06:43 volumio-jur systemd[1]: Stopped VolumioStreamingService. Oct 01 12:06:43 volumio-jur sudo[27152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 12:05 Oct 01 12:06:43 volumio-jur sudo[27152]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 12:06:43 volumio-jur systemd[1]: Started VolumioStreamingService. 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"