-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2025-06-07 22:55:21 CEST. -- Jun 07 22:54:04 volumio---koudy volumiologrotate[628]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 07 22:54:04 volumio---koudy volumiologrotate[628]: ls: cannot access '-': No such file or directory Jun 07 22:54:04 volumio---koudy volumiologrotate[628]: ls: cannot access 'KOUDY': No such file or directory Jun 07 22:54:16 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 07 22:54:16 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 07 22:54:16 volumio---koudy volumio[868]: info: Discovery: Getting this device information Jun 07 22:54:16 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:16 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 1 Jun 07 22:54:16 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 22:54:29 volumio---koudy volumio[868]: xcb_connection_has_error() returned true Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 07 22:54:29 volumio---koudy volumio[868]: xcb_connection_has_error() returned true Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 07 22:54:29 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 07 22:54:34 volumio---koudy volumio[868]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jun 07 22:54:34 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jun 07 22:54:34 volumio---koudy sudo[2419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 07 22:54:34 volumio---koudy sudo[2419]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:34 volumio---koudy sudo[2419]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:34 volumio---koudy volumio[868]: info: MPD Permissions set Jun 07 22:54:34 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:34 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:34 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:34 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:34 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:34 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:34 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:34 volumio---koudy sudo[2422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 07 22:54:34 volumio---koudy sudo[2422]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:34 volumio---koudy systemd[1]: Stopping Music Player Daemon... Jun 07 22:54:35 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 07 22:54:35 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:35 volumio---koudy volumio[868]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 07 22:54:35 volumio---koudy systemd[1]: mpd.service: Succeeded. Jun 07 22:54:35 volumio---koudy systemd[1]: Stopped Music Player Daemon. Jun 07 22:54:35 volumio---koudy volumio[868]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 07 22:54:35 volumio---koudy systemd[1]: Starting Music Player Daemon... Jun 07 22:54:35 volumio---koudy volumio[868]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 07 22:54:35 volumio---koudy sudo[2428]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 07 22:54:35 volumio---koudy sudo[2428]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:35 volumio---koudy sudo[2428]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:35 volumio---koudy mpd[2431]: Jun 07 22:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 07 22:54:36 volumio---koudy systemd[1]: Started Music Player Daemon. Jun 07 22:54:36 volumio---koudy sudo[2422]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:36 volumio---koudy volumio[868]: error: updateQueue error: null Jun 07 22:54:41 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPause Jun 07 22:54:41 volumio---koudy volumio[868]: info: CoreStateMachine::pause Jun 07 22:54:41 volumio---koudy volumio[868]: info: CoreStateMachine::stPlaybackTimer Jun 07 22:54:41 volumio---koudy volumio[868]: info: CoreStateMachine::servicePause Jun 07 22:54:41 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 1 Jun 07 22:54:41 volumio---koudy volumio[868]: info: CoreCommandRouter::servicePause Jun 07 22:54:41 volumio---koudy volumio[868]: info: ControllerMpd::pause Jun 07 22:54:41 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand pause Jun 07 22:54:41 volumio---koudy volumio[868]: info: sendMpdCommand pause took 1 milliseconds Jun 07 22:54:42 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPause Jun 07 22:54:42 volumio---koudy volumio[868]: info: CoreStateMachine::pause Jun 07 22:54:45 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPause Jun 07 22:54:45 volumio---koudy volumio[868]: info: CoreStateMachine::pause Jun 07 22:54:45 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPause Jun 07 22:54:45 volumio---koudy volumio[868]: info: CoreStateMachine::pause Jun 07 22:54:45 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 07 22:54:45 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 07 22:54:45 volumio---koudy volumio[868]: info: Discovery: Getting this device information Jun 07 22:54:45 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:45 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 1 Jun 07 22:54:45 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 07 22:54:46 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPause Jun 07 22:54:46 volumio---koudy volumio[868]: info: CoreStateMachine::pause Jun 07 22:54:48 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPause Jun 07 22:54:48 volumio---koudy volumio[868]: info: CoreStateMachine::pause Jun 07 22:54:48 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPause Jun 07 22:54:48 volumio---koudy volumio[868]: info: CoreStateMachine::pause Jun 07 22:54:49 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPrevious Jun 07 22:54:49 volumio---koudy volumio[868]: info: CoreStateMachine::previous Jun 07 22:54:49 volumio---koudy volumio[868]: info: CoreStateMachine::updateTrackBlock Jun 07 22:54:49 volumio---koudy volumio[868]: info: CorePlayQueue::getTrackBlock Jun 07 22:54:49 volumio---koudy volumio[868]: info: CoreStateMachine::serviceClearAddPlay Jun 07 22:54:49 volumio---koudy volumio[868]: info: CoreCommandRouter::serviceClearAddPlayTracks Jun 07 22:54:49 volumio---koudy volumio[868]: error: WARNING: No clearAddPlayTracks method for service mpd Jun 07 22:54:50 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPause Jun 07 22:54:50 volumio---koudy volumio[868]: info: CoreStateMachine::pause Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 22:54:52 volumio---koudy volumio[868]: xcb_connection_has_error() returned true Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 07 22:54:52 volumio---koudy volumio[868]: xcb_connection_has_error() returned true Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 07 22:54:52 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioNext Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::next Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::stop Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::updateTrackBlock Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrackBlock Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::stPlaybackTimer Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::pushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::serviceStop Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::serviceStop Jun 07 22:54:56 volumio---koudy volumio[868]: info: ControllerMpd::stop Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand stop took 7 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::play index undefined Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::startPlaybackTimer Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioGetVisibleSources Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 07 22:54:56 volumio---koudy volumio[868]: info: METAVOLUMIO: Retrieving similar tracks from metavolumio Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Dance - Pop - Rock/Výběr té nejlepší FLAC hudby (CZ-SK-EN-...) z 28.1.2013 - část 2/Richard Muller - Tlakova niz.flac Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::updateTrackBlock Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrackBlock Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand stop took 3 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand clear Jun 07 22:54:56 volumio---koudy volumio[868]: info: Jun 07 22:54:56 volumio---koudy volumio[868]: ---------------------------- MPD announces system playlist update Jun 07 22:54:56 volumio---koudy volumio[868]: info: Ignoring MPD Status Update Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand clear took 1 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Dance - Pop - Rock/Výběr té nejlepší FLAC hudby (CZ-SK-EN-...) z 28.1.2013 - část 2/Richard Muller - Tlakova niz.flac" Jun 07 22:54:56 volumio---koudy volumio[868]: error: updateQueue error: null Jun 07 22:54:56 volumio---koudy volumio[868]: info: Jun 07 22:54:56 volumio---koudy volumio[868]: ---------------------------- MPD announces system playlist update Jun 07 22:54:56 volumio---koudy volumio[868]: info: Ignoring MPD Status Update Jun 07 22:54:56 volumio---koudy volumio[868]: info: ------------------------------ 2ms Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand add "NAS/NAS/Dance - Pop - Rock/Výběr té nejlepší FLAC hudby (CZ-SK-EN-...) z 28.1.2013 - část 2/Richard Muller - Tlakova niz.flac" took 1 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand play Jun 07 22:54:56 volumio---koudy volumio[868]: info: ------------------------------ 1ms Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand play took 1 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: info: Jun 07 22:54:56 volumio---koudy volumio[868]: ---------------------------- MPD announces state update: player Jun 07 22:54:56 volumio---koudy volumio[868]: info: ControllerMpd::getState Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jun 07 22:54:56 volumio---koudy volumio[868]: info: Jun 07 22:54:56 volumio---koudy volumio[868]: ---------------------------- MPD announces state update: player Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand status took 3 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: info: ControllerMpd::getState Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::parseState Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand status took 2 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::parseState Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::parseTrackInfo Jun 07 22:54:56 volumio---koudy volumio[868]: info: ControllerMpd::pushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::servicePushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Richard Muller - Tlakova niz.flac","artist":"Banket","album":"Gold","uri":"NAS/NAS/Dance - Pop - Rock/Výběr té nejlepší FLAC hudby (CZ-SK-EN-...) z 28.1.2013 - část 2/Richard Muller - Tlakova niz.flac","trackType":"flac"} Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: CURRENT POSITION 2 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::syncState stateService play Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::syncState currentStatus stop Jun 07 22:54:56 volumio---koudy volumio[868]: info: ------------------------------ 9ms Jun 07 22:54:56 volumio---koudy volumio[868]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: ControllerMpd::parseTrackInfo Jun 07 22:54:56 volumio---koudy volumio[868]: info: ControllerMpd::pushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::servicePushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Richard Muller - Tlakova niz.flac","artist":"Banket","album":"Gold","uri":"NAS/NAS/Dance - Pop - Rock/Výběr té nejlepší FLAC hudby (CZ-SK-EN-...) z 28.1.2013 - část 2/Richard Muller - Tlakova niz.flac","trackType":"flac"} Jun 07 22:54:56 volumio---koudy volumio[868]: verbose: CURRENT POSITION 2 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::syncState stateService play Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::syncState currentStatus play Jun 07 22:54:56 volumio---koudy volumio[868]: info: Received an update from plugin. extracting info from payload Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::pushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreStateMachine::pushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPushState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:56 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:54:56 volumio---koudy volumio[868]: info: ------------------------------ 28ms Jun 07 22:55:04 volumio---koudy volumiologrotate[628]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 07 22:55:04 volumio---koudy volumiologrotate[628]: ls: cannot access '-': No such file or directory Jun 07 22:55:04 volumio---koudy volumiologrotate[628]: ls: cannot access 'KOUDY': No such file or directory Jun 07 22:55:04 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:04 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: All cached search sources collected Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 22:55:05 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1453 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1469 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1459 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1430 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1504 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1596 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1666 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1816 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1710 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1733 milliseconds Jun 07 22:55:06 volumio---koudy volumio[868]: info: searchQOBUZUri took 1744 milliseconds Jun 07 22:55:07 volumio---koudy volumio[868]: info: searchQOBUZUri took 2133 milliseconds Jun 07 22:55:07 volumio---koudy volumio[868]: info: searchQOBUZUri took 2106 milliseconds Jun 07 22:55:07 volumio---koudy volumio[868]: info: searchQOBUZUri took 2172 milliseconds Jun 07 22:55:07 volumio---koudy volumio[868]: info: searchQOBUZUri took 2211 milliseconds Jun 07 22:55:07 volumio---koudy volumio[868]: info: searchQOBUZUri took 2229 milliseconds Jun 07 22:55:07 volumio---koudy volumio[868]: info: searchQOBUZUri took 2268 milliseconds Jun 07 22:55:07 volumio---koudy volumio[868]: info: searchQOBUZUri took 2530 milliseconds Jun 07 22:55:07 volumio---koudy volumio[868]: info: searchQOBUZUri took 2699 milliseconds Jun 07 22:55:09 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 07 22:55:09 volumio---koudy volumio[868]: info: Preload queue cleared Jun 07 22:55:10 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 07 22:55:10 volumio---koudy volumio[868]: info: Preload queue cleared Jun 07 22:55:10 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 07 22:55:10 volumio---koudy volumio[868]: info: Preload queue cleared Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: All search sources collected, pushing search results Jun 07 22:55:11 volumio---koudy volumio[868]: info: METAVOLUMIO: No new tracks added to queue, Starting fallback strategies Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioGetQueue Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreStateMachine::getQueue Jun 07 22:55:11 volumio---koudy volumio[868]: info: CorePlayQueue::getQueue Jun 07 22:55:11 volumio---koudy volumio[868]: info: METAVOLUMIO: Not Enough elements in Queue to proceed with random queue fallback strategy Jun 07 22:55:11 volumio---koudy volumio[868]: info: METAVOLUMIO: Executing Random Fallback Strategy Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: mpd , getRandomLocalTrack Jun 07 22:55:11 volumio---koudy volumio[868]: info: listAlbums - loading Albums from cache Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioAddQueueItems Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreStateMachine::addQueueItems Jun 07 22:55:11 volumio---koudy volumio[868]: info: CorePlayQueue::addQueueItems Jun 07 22:55:11 volumio---koudy volumio[868]: info: Preload queue cleared Jun 07 22:55:11 volumio---koudy volumio[868]: info: Adding Item to queue: music-library/NAS/NAS/Dance - Pop - Rock/821 Greatest Hit Singles of the 2000s [FLAC] [h33t] - Kitlope/Nelly ft. Kelly Rowland - Dilemma.flac Jun 07 22:55:11 volumio---koudy volumio[868]: info: Exploding uri music-library/NAS/NAS/Dance - Pop - Rock/821 Greatest Hit Singles of the 2000s [FLAC] [h33t] - Kitlope/Nelly ft. Kelly Rowland - Dilemma.flac in service mpd Jun 07 22:55:11 volumio---koudy volumio[868]: info: ALBUMART /albumart?cacheid=385&web=Nelly%20ft.%20Kelly%20Rowland/Hitzone%20Gold%20%5BCD%203%5D/medium&path=%2Fmnt%2FNAS%2FNAS%2FDance%20-%20Pop%20-%20Rock%2F821%20Greatest%20Hit%20Singles%20of%20the%202000s%20%5BFLAC%5D%20%5Bh33t%5D%20-%20Kitlope%2FNelly%20ft.%20Kelly%20Rowland%20-%20Dilemma.flac&metadata=false Jun 07 22:55:11 volumio---koudy volumio[868]: info: URI /mnt/NAS/NAS/Dance - Pop - Rock/821 Greatest Hit Singles of the 2000s [FLAC] [h33t] - Kitlope/Nelly ft. Kelly Rowland - Dilemma.flac Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioPushQueue Jun 07 22:55:11 volumio---koudy volumio[868]: info: CorePlayQueue::saveQueue Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreStateMachine::updateTrackBlock Jun 07 22:55:11 volumio---koudy volumio[868]: info: CorePlayQueue::getTrackBlock Jun 07 22:55:11 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 07 22:55:12 volumio---koudy volumio[868]: info: Preload queue cleared Jun 07 22:55:13 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 07 22:55:13 volumio---koudy volumio[868]: info: Preload queue cleared Jun 07 22:55:15 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 07 22:55:15 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 07 22:55:15 volumio---koudy volumio[868]: info: Discovery: Getting this device information Jun 07 22:55:15 volumio---koudy volumio[868]: info: CoreCommandRouter::volumioGetState Jun 07 22:55:15 volumio---koudy volumio[868]: info: CorePlayQueue::getTrack 2 Jun 07 22:55:15 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 07 22:55:21 volumio---koudy volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 07 22:55:21 volumio---koudy volumio[868]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 22:55:21 volumio---koudy volumio[868]: TypeError: Cannot read property 'length' of undefined Jun 07 22:55:21 volumio---koudy volumio[868]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jun 07 22:55:21 volumio---koudy volumio[868]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jun 07 22:55:21 volumio---koudy volumio[868]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jun 07 22:55:21 volumio---koudy volumio[868]: at Parser.emit (events.js:315:20) Jun 07 22:55:21 volumio---koudy volumio[868]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jun 07 22:55:21 volumio---koudy volumio[868]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jun 07 22:55:21 volumio---koudy volumio[868]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jun 07 22:55:21 volumio---koudy volumio[868]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jun 07 22:55:21 volumio---koudy volumio[868]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jun 07 22:55:21 volumio---koudy volumio[868]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jun 07 22:55:21 volumio---koudy volumio[868]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jun 07 22:55:21 volumio---koudy volumio[868]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jun 07 22:55:21 volumio---koudy volumio[868]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jun 07 22:55:21 volumio---koudy volumio[868]: at IncomingMessage.emit (events.js:327:22) Jun 07 22:55:21 volumio---koudy volumio[868]: at endReadableNT (internal/streams/readable.js:1327:12) Jun 07 22:55:21 volumio---koudy volumio[868]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 07 22:55:21 volumio---koudy volumio[868]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 22:55:21 volumio---koudy sudo[2578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-07 22:54 Jun 07 22:55:21 volumio---koudy sudo[2578]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"