-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-09-06 15:46:26 CEST. -- Sep 06 15:45:04 volumio volumio[996]: info: CALLMETHOD: ${plugin_type plugin_name} saveScreensaverConf [object Object] Sep 06 15:45:04 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: plugin_name} , saveScreensaverConf Sep 06 15:45:30 volumio volumio[996]: info: CALLMETHOD: ${plugin_type plugin_name} savePointerConf [object Object] Sep 06 15:45:30 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: plugin_name} , savePointerConf Sep 06 15:45:37 volumio volumio[996]: info: CALLMETHOD: ${plugin_type plugin_name} saveScaleConf [object Object] Sep 06 15:45:37 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: plugin_name} , saveScaleConf Sep 06 15:45:40 volumio volumio[996]: info: CALLMETHOD: ${plugin_type plugin_name} saveVirtualKeyboardConf [object Object] Sep 06 15:45:40 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: plugin_name} , saveVirtualKeyboardConf Sep 06 15:45:52 volumio volumio[996]: info: CoreCommandRouter::volumioStop Sep 06 15:45:52 volumio volumio[996]: info: CoreStateMachine::stop Sep 06 15:45:52 volumio volumio[996]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 15:45:52 volumio volumio[996]: info: CoreStateMachine::stPlaybackTimer Sep 06 15:45:52 volumio volumio[996]: info: CoreStateMachine::updateTrackBlock Sep 06 15:45:52 volumio volumio[996]: info: CorePlayQueue::getTrackBlock Sep 06 15:45:52 volumio volumio[996]: info: CoreStateMachine::pushState Sep 06 15:45:52 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Sep 06 15:45:52 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 15:45:52 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Sep 06 15:45:52 volumio volumio[996]: info: CoreStateMachine::serviceStop Sep 06 15:45:52 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Sep 06 15:45:52 volumio volumio[996]: info: CoreCommandRouter::serviceStop Sep 06 15:45:52 volumio volumio[996]: info: [1725630352033] ControllerWebradio::stop Sep 06 15:45:52 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand stop Sep 06 15:45:52 volumio volumio[996]: info: Sep 06 15:45:52 volumio volumio[996]: ---------------------------- MPD announces state update: player Sep 06 15:45:52 volumio volumio[996]: info: sendMpdCommand stop took 12 milliseconds Sep 06 15:45:52 volumio volumio[996]: info: ControllerMpd::getState Sep 06 15:45:52 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Sep 06 15:45:52 volumio volumio[996]: info: sendMpdCommand status took 1 milliseconds Sep 06 15:45:52 volumio volumio[996]: verbose: ControllerMpd::parseState Sep 06 15:45:52 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 15:45:52 volumio volumio[996]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 15:45:52 volumio volumio[996]: verbose: ControllerMpd::parseTrackInfo Sep 06 15:45:52 volumio volumio[996]: info: ControllerMpd::pushState Sep 06 15:45:52 volumio volumio[996]: info: CoreCommandRouter::servicePushState Sep 06 15:45:52 volumio volumio[996]: info: CoreStateMachine::pushState Sep 06 15:45:52 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Sep 06 15:45:52 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Sep 06 15:45:52 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Sep 06 15:45:52 volumio volumio[996]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 06 15:45:52 volumio volumio[996]: info: ------------------------------ 23ms Sep 06 15:45:58 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 06 15:45:58 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 06 15:46:04 volumio volumio[996]: info: Enabling plugin randomizer Sep 06 15:46:04 volumio volumio[996]: info: Loading plugin "randomizer"... Sep 06 15:46:04 volumio volumio[996]: info: PLUGIN START: randomizer Sep 06 15:46:04 volumio volumio[996]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 06 15:46:04 volumio volumio[996]: info: [1725630364640] CoreMusicLibrary::Adding element Randomizer Sep 06 15:46:04 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 15:46:04 volumio volumio[996]: Cannot find translation for source Randomizer Sep 06 15:46:04 volumio volumio[996]: info: Done. Sep 06 15:46:04 volumio volumio[996]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 06 15:46:05 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 06 15:46:12 volumio volumio[996]: info: CALLMETHOD: user_interface randomizer saveSettings [object Object] Sep 06 15:46:12 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: randomizer , saveSettings Sep 06 15:46:18 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 06 15:46:18 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 06 15:46:23 volumio volumio[996]: info: Enabling plugin fusiondsp Sep 06 15:46:23 volumio volumio[996]: info: Loading plugin "fusiondsp"... Sep 06 15:46:24 volumio volumio[996]: info: Preparing to generate the ALSA configuration file Sep 06 15:46:24 volumio volumio[996]: info: Asound.conf file unchanged, so no further update is needed Sep 06 15:46:24 volumio volumio[996]: info: Output device has changed, restarting MPD Sep 06 15:46:24 volumio sudo[2396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 06 15:46:24 volumio sudo[2396]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 15:46:24 volumio volumio[996]: info: Output device has changed, restarting Shairport Sync Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 15:46:24 volumio sudo[2396]: pam_unix(sudo:session): session closed for user root Sep 06 15:46:24 volumio sudo[2399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 06 15:46:24 volumio sudo[2399]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 15:46:24 volumio volumio[996]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 06 15:46:24 volumio volumio[996]: info: PLUGIN START: fusiondsp Sep 06 15:46:24 volumio systemd[1]: Stopping Music Player Daemon... Sep 06 15:46:24 volumio volumio[996]: info: Loading i18n strings for locale pl Sep 06 15:46:24 volumio systemd[1]: mpd.service: Succeeded. Sep 06 15:46:24 volumio systemd[1]: Stopped Music Player Daemon. Sep 06 15:46:24 volumio volumio[996]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: FusionDsp - mixtype--------------------- Hardware Sep 06 15:46:24 volumio volumio[996]: info: Preparing to generate the ALSA configuration file Sep 06 15:46:24 volumio volumio[996]: info: Done. Sep 06 15:46:24 volumio volumio[996]: info: MPD Permissions set Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 15:46:24 volumio systemd[1]: Starting Music Player Daemon... Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: Asound.conf file unchanged, so no further update is needed Sep 06 15:46:24 volumio volumio[996]: info: Output device has changed, restarting MPD Sep 06 15:46:24 volumio sudo[2411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 06 15:46:24 volumio volumio[996]: info: Output device has changed, restarting Shairport Sync Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 15:46:24 volumio sudo[2411]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 15:46:24 volumio sudo[2411]: pam_unix(sudo:session): session closed for user root Sep 06 15:46:24 volumio sudo[2413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 06 15:46:24 volumio sudo[2413]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 15:46:24 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Sep 06 15:46:24 volumio systemd[1]: mpd.service: Succeeded. Sep 06 15:46:24 volumio systemd[1]: Stopped Music Player Daemon. Sep 06 15:46:24 volumio systemd[1]: Starting Music Player Daemon... Sep 06 15:46:24 volumio volumio[996]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 06 15:46:24 volumio volumio[996]: info: MPD Permissions set Sep 06 15:46:24 volumio volumio[996]: info: Starting Shairport Sync Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio sudo[2421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 06 15:46:24 volumio sudo[2421]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:24 volumio volumio[996]: info: Starting Shairport Sync Sep 06 15:46:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 06 15:46:24 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 06 15:46:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 06 15:46:24 volumio sudo[2429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 06 15:46:24 volumio sudo[2429]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 15:46:24 volumio sudo[2419]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 06 15:46:24 volumio sudo[2419]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 15:46:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 06 15:46:24 volumio sudo[2419]: pam_unix(sudo:session): session closed for user root Sep 06 15:46:24 volumio sudo[2421]: pam_unix(sudo:session): session closed for user root Sep 06 15:46:24 volumio volumio[996]: info: Shairport-Sync Started Sep 06 15:46:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 06 15:46:24 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 06 15:46:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 06 15:46:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 06 15:46:24 volumio sudo[2429]: pam_unix(sudo:session): session closed for user root Sep 06 15:46:24 volumio volumio[996]: info: Shairport-Sync Started Sep 06 15:46:25 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 06 15:46:26 volumio mpd[2433]: Sep 06 15:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 06 15:46:26 volumio systemd[1]: Started Music Player Daemon. Sep 06 15:46:26 volumio sudo[2399]: pam_unix(sudo:session): session closed for user root Sep 06 15:46:26 volumio sudo[2413]: pam_unix(sudo:session): session closed for user root Sep 06 15:46:26 volumio volumio[996]: error: MPD error: The expression evaluated to a falsy value: Sep 06 15:46:26 volumio volumio[996]: assert.ok(self.idling) Sep 06 15:46:26 volumio volumio[996]: error: The expression evaluated to a falsy value: Sep 06 15:46:26 volumio volumio[996]: assert.ok(self.idling) Sep 06 15:46:26 volumio volumio[996]: error: updateQueue error: null Sep 06 15:46:26 volumio volumio[996]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Sep 06 15:46:26 volumio volumio[996]: info: camilladsp service started and running in background, instance 1 Sep 06 15:46:26 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 15:46:26 volumio volumio[996]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 06 15:46:26 volumio volumio[996]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Sep 06 15:46:26 volumio volumio[996]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 06 15:46:26 volumio volumio[996]: info: FusionDsp loaded Sep 06 15:46:26 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 15:46:26 volumio sudo[2450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Sep 06 15:46:26 volumio sudo[2450]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 15:46:26 volumio volumio[996]: info: FusionDsp - Reporting Fusion DSP Enabled Sep 06 15:46:26 volumio volumio[996]: info: Adding Signal Path Element [object Object] Sep 06 15:46:26 volumio volumio[996]: info: Adding fusiondspeq DSP Signal Path Element Sep 06 15:46:26 volumio volumio[996]: info: FusionDsp - ---- installed callbackRead Sep 06 15:46:26 volumio volumio[996]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 15:46:26 volumio sudo[2450]: pam_unix(sudo:session): session closed for user root Sep 06 15:46:26 volumio volumio[996]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Sep 06 15:46:26 volumio volumio[996]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Sep 06 15:46:26 volumio volumio[996]: at onErrorNT (internal/child_process.js:465:16) Sep 06 15:46:26 volumio volumio[996]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Sep 06 15:46:26 volumio volumio[996]: errno: -2, Sep 06 15:46:26 volumio volumio[996]: code: 'ENOENT', Sep 06 15:46:26 volumio volumio[996]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Sep 06 15:46:26 volumio volumio[996]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Sep 06 15:46:26 volumio volumio[996]: spawnargs: [ Sep 06 15:46:26 volumio volumio[996]: '-p', Sep 06 15:46:26 volumio volumio[996]: 9876, Sep 06 15:46:26 volumio volumio[996]: '-o', Sep 06 15:46:26 volumio volumio[996]: '/tmp/camilladsp.log', Sep 06 15:46:26 volumio volumio[996]: '-l', Sep 06 15:46:26 volumio volumio[996]: 'warn', Sep 06 15:46:26 volumio volumio[996]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Sep 06 15:46:26 volumio volumio[996]: ] Sep 06 15:46:26 volumio volumio[996]: } Sep 06 15:46:26 volumio volumio[996]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 15:46:26 volumio sudo[2461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 15:45 Sep 06 15:46:26 volumio sudo[2461]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"