-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-09-06 16:44:02 CEST. --
Sep 06 16:43:00 player volumio[7801]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 6
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 06 16:43:00 player volumio[7801]: info: Starting Shairport Sync
Sep 06 16:43:00 player volumio[7801]: info: Starting Shairport Sync
Sep 06 16:43:00 player sudo[7964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:00 player sudo[7964]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:00 player volumio[7801]: info: Starting Shairport Sync
Sep 06 16:43:00 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:00 player sudo[7968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:00 player sudo[7968]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:00 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:00 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:00 player sudo[7970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:00 player sudo[7970]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:00 player volumio[7801]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:00 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:00 player sudo[7964]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:00 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:00 player systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:00 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:00 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:00 player volumio[7801]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 06 16:43:00 player go-librespot[7952]: time="2024-09-06T16:43:00+02:00" level=debug msg="fetched new accesspoints: [ap2-gew1.spotify.com:4070 ap2-gew1.spotify.com:443 ap2-gew1.spotify.com:80 ap2-guc3.spotify.com:4070 ap2-gue1.spotify.com:443 ap2-gew4.spotify.com:80]"
Sep 06 16:43:00 player go-librespot[7952]: time="2024-09-06T16:43:00+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Sep 06 16:43:00 player go-librespot[7952]: time="2024-09-06T16:43:00+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 06 16:43:00 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:00 player sudo[7970]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:00 player sudo[7968]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:00 player volumio[7801]: info: Received Get System Info
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:00 player volumio[7801]: info: Discovery: Getting this device information
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:00 player volumio[7801]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:00 player volumio[7801]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:00 player volumio[7801]: info: Listing playlists
Sep 06 16:43:00 player go-librespot[7952]: time="2024-09-06T16:43:00+02:00" level=debug msg="zeroconf server listening on port 45113"
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 06 16:43:00 player volumio[7801]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:00 player volumio[7801]: info: Output device has changed, restarting MPD
Sep 06 16:43:00 player volumio[7801]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:00 player sudo[7978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:00 player sudo[7978]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:00 player sudo[7978]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:00 player sudo[7980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:00 player sudo[7980]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:00 player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:00 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:00 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:00 player volumio[7801]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:00 player volumio[7801]: info: Shairport-Sync Started
Sep 06 16:43:00 player volumio[7801]: Error adding Membership: Error: addMembership EINVAL
Sep 06 16:43:00 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:00 player volumio[7801]: info: Shairport-Sync Started
Sep 06 16:43:00 player volumio[7801]: info: Shairport-Sync Started
Sep 06 16:43:00 player volumio[7801]: info: MPD Permissions set
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 06 16:43:00 player volumio[7801]: info: Received Get System Info
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:00 player volumio[7801]: info: Discovery: Getting this device information
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:00 player volumio[7801]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 06 16:43:00 player volumio[7801]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 06 16:43:00 player volumio[7801]: info: Starting Shairport Sync
Sep 06 16:43:00 player sudo[7986]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:00 player sudo[7986]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:00 player sudo[7993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:00 player sudo[7993]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:00 player sudo[7986]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:00 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:00 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:00 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:00 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:00 player sudo[7993]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:01 player volumio[7801]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:43:01 player volumio[7801]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 06 16:43:01 player volumio[7801]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:43:01 player volumio[7801]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Sep 06 16:43:01 player volumio[7801]: info: camilladsp service started and running in background, instance 1
Sep 06 16:43:01 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:01 player volumio[7801]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:43:01 player volumio[7801]: 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 16:43:01 player volumio[7801]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:43:01 player volumio[7801]: info: FusionDsp loaded
Sep 06 16:43:01 player volumio[7801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:01 player sudo[8010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 06 16:43:01 player sudo[8010]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:01 player volumio[7801]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 06 16:43:01 player volumio[7801]: info: Adding Signal Path Element [object Object]
Sep 06 16:43:01 player volumio[7801]: info: Adding fusiondspeq DSP Signal Path Element
Sep 06 16:43:01 player sudo[8010]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:01 player volumio[7801]: info: FusionDsp - ---- installed callbackRead
Sep 06 16:43:01 player volumio[7801]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:01 player volumio[7801]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 06 16:43:01 player volumio[7801]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 06 16:43:01 player volumio[7801]: at onErrorNT (internal/child_process.js:465:16)
Sep 06 16:43:01 player volumio[7801]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Sep 06 16:43:01 player volumio[7801]: at runNextTicks (internal/process/task_queues.js:62:3)
Sep 06 16:43:01 player volumio[7801]: at listOnTimeout (internal/timers.js:523:9)
Sep 06 16:43:01 player volumio[7801]: at processTimers (internal/timers.js:497:7) {
Sep 06 16:43:01 player volumio[7801]: errno: -2,
Sep 06 16:43:01 player volumio[7801]: code: 'ENOENT',
Sep 06 16:43:01 player volumio[7801]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:43:01 player volumio[7801]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:43:01 player volumio[7801]: spawnargs: [
Sep 06 16:43:01 player volumio[7801]: '-p',
Sep 06 16:43:01 player volumio[7801]: 9876,
Sep 06 16:43:01 player volumio[7801]: '-o',
Sep 06 16:43:01 player volumio[7801]: '/tmp/camilladsp.log',
Sep 06 16:43:01 player volumio[7801]: '-l',
Sep 06 16:43:01 player volumio[7801]: 'warn',
Sep 06 16:43:01 player volumio[7801]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 06 16:43:01 player volumio[7801]: ]
Sep 06 16:43:01 player volumio[7801]: }
Sep 06 16:43:01 player volumio[7801]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:02 player sudo[8021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 16:42
Sep 06 16:43:02 player sudo[8021]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:02 player sudo[8021]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:02 player volumio-remote-updater[649]: [2024-09-06 16:43:02] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 06 16:43:02 player volumio-remote-updater[649]: [2024-09-06 16:43:02] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 06 16:43:02 player systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 06 16:43:02 player sudo[7887]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:02 player sudo[7980]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:02 player sudo[7897]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:02 player systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 06 16:43:02 player mpd[7996]: Sep 06 16:43 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 06 16:43:02 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:02 player systemd[1]: Started Music Player Daemon.
Sep 06 16:43:02 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:02 player systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 06 16:43:02 player systemd[1]: volumio.service: Scheduled restart job, restart counter is at 30.
Sep 06 16:43:02 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:02 player systemd[1]: Stopped Volumio Backend Module.
Sep 06 16:43:02 player systemd[1]: Started Volumio Backend Module.
Sep 06 16:43:02 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:04 player volumio[8034]: info: -------------------------------------------
Sep 06 16:43:04 player volumio[8034]: info: ----- Volumio3 ----
Sep 06 16:43:04 player volumio[8034]: info: -------------------------------------------
Sep 06 16:43:04 player volumio[8034]: info: ----- System startup ----
Sep 06 16:43:04 player volumio[8034]: info: -------------------------------------------
Sep 06 16:43:05 player volumio[8034]: info: MYVOLUMIO Environment detected
Sep 06 16:43:05 player volumio[8034]: info: Plugin folders cleanup
Sep 06 16:43:05 player volumio[8034]: info: Scanning into folder /volumio/app/plugins/
Sep 06 16:43:05 player volumio[8034]: info: Scanning category audio_interface
Sep 06 16:43:05 player volumio[8034]: info: Scanning category miscellanea
Sep 06 16:43:05 player volumio[8034]: info: Scanning category music_service
Sep 06 16:43:05 player volumio[8034]: info: Scanning category plugins.json
Sep 06 16:43:05 player volumio[8034]: info: Scanning category system_controller
Sep 06 16:43:05 player volumio[8034]: info: Scanning category user_interface
Sep 06 16:43:05 player volumio[8034]: info: Scanning into folder /data/plugins/
Sep 06 16:43:05 player volumio[8034]: info: Scanning category audio_interface
Sep 06 16:43:05 player volumio[8034]: info: Scanning category music_service
Sep 06 16:43:05 player volumio[8034]: info: Plugin folders cleanup completed
Sep 06 16:43:05 player volumio[8034]: info: -------------------------------------------
Sep 06 16:43:05 player volumio[8034]: info: ----- Core plugins startup ----
Sep 06 16:43:05 player volumio[8034]: info: -------------------------------------------
Sep 06 16:43:05 player volumio[8034]: info: Loading plugins from folder /volumio/app/plugins/
Sep 06 16:43:05 player volumio[8034]: info: Adding plugin upnp to MyMusic Plugins
Sep 06 16:43:05 player volumio[8034]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 06 16:43:05 player volumio[8034]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 06 16:43:05 player volumio[8034]: info: Loading plugins from folder /data/plugins/
Sep 06 16:43:05 player volumio[8034]: info: Loading plugin "system"...
Sep 06 16:43:05 player volumio[8034]: info: Loading plugin "appearance"...
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "network"...
Sep 06 16:43:06 player volumio[8034]: info: Refreshing Cached IP Addresses
Sep 06 16:43:06 player sudo[8060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 06 16:43:06 player sudo[8060]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:06 player sudo[8060]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "services"...
Sep 06 16:43:06 player sudo[8062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 06 16:43:06 player sudo[8062]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "alsa_controller"...
Sep 06 16:43:06 player sudo[8062]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:06 player sudo[8065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 06 16:43:06 player sudo[8065]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:06 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "wizard"...
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "networkfs"...
Sep 06 16:43:06 player volumio[8034]: info: Starting Udev Watcher for removable devices
Sep 06 16:43:06 player volumio[8034]: info: Ignoring mount for partition: boot
Sep 06 16:43:06 player volumio[8034]: info: Ignoring mount for partition: volumio
Sep 06 16:43:06 player volumio[8034]: info: Ignoring mount for partition: volumio_data
Sep 06 16:43:06 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "volumio_command_line_client"...
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "upnp"...
Sep 06 16:43:06 player volumio[8034]: info: [1725633786733] Starting Upmpd Daemon
Sep 06 16:43:06 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "my_music"...
Sep 06 16:43:06 player volumio[8034]: info: Loading plugin "mpd"...
Sep 06 16:43:07 player volumio[8034]: info: Loading plugin "upnp_browser"...
Sep 06 16:43:07 player volumio[8034]: info: Loading plugin "alarm-clock"...
Sep 06 16:43:07 player sudo[8065]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:07 player volumio-remote-updater[649]: [2024-09-06 16:43:07] [connect] Successful connection
Sep 06 16:43:07 player volumio[8034]: info: Loading plugin "airplay_emulation"...
Sep 06 16:43:07 player volumio[8034]: info: Starting Shairport Sync
Sep 06 16:43:07 player volumio[8034]: info: Loading plugin "last_100"...
Sep 06 16:43:07 player volumio[8034]: info: Loading plugin "webradio"...
Sep 06 16:43:07 player volumio[8034]: info: Loading plugin "i2s_dacs"...
Sep 06 16:43:07 player volumio[8034]: info: I2S DAC not set, start Auto-detection
Sep 06 16:43:07 player volumio[8034]: info: Loading plugin "volumiodiscovery"...
Sep 06 16:43:07 player volumio[8034]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:07 player volumio[8034]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:07 player volumio[8034]: *** WARNING *** For more information see
Sep 06 16:43:07 player node[8034]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:07 player volumio[8034]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:07 player volumio[8034]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:07 player volumio[8034]: *** WARNING *** For more information see
Sep 06 16:43:07 player node[8034]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:07 player node[8034]: *** WARNING *** For more information see
Sep 06 16:43:07 player node[8034]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:07 player node[8034]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:07 player node[8034]: *** WARNING *** For more information see
Sep 06 16:43:07 player volumio[8034]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 06 16:43:07 player volumio[8034]: info: Discovery: Started advertising with name: Player
Sep 06 16:43:07 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:07 player volumio[8034]: info: Loading plugin "spop"...
Sep 06 16:43:08 player volumio[8034]: info: Loading plugin "outputs"...
Sep 06 16:43:08 player volumio[8034]: info: Loading plugin "albumart"...
Sep 06 16:43:09 player volumio[8034]: info: Plugin example_plugin is not enabled
Sep 06 16:43:09 player volumio[8034]: info: Loading plugin "inputs"...
Sep 06 16:43:09 player volumio[8034]: info: Loading plugin "updater_comm"...
Sep 06 16:43:09 player volumio[8034]: info: Plugin mpdemulation is not enabled
Sep 06 16:43:09 player volumio[8034]: info: Loading plugin "rest_api"...
Sep 06 16:43:09 player volumio[8034]: info: Loading plugin "websocket"...
Sep 06 16:43:09 player volumio[8034]: info: Starting Socket.io Server version 2.3.0
Sep 06 16:43:09 player volumio[8034]: info: Loading plugin "fusiondsp"...
Sep 06 16:43:09 player volumio[8034]: Forking 3 albumart workers
Sep 06 16:43:09 player volumio[8034]: info: Applying required configuration parameters for plugin fusiondsp
Sep 06 16:43:09 player volumio[8034]: info: Loading i18n strings for locale fr
Sep 06 16:43:09 player volumio[8034]: Updating browse sources language
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::initPlayerControls
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:09 player volumio[8034]: Express server listening on port 3000
Sep 06 16:43:09 player volumio[8034]: [Metrics] WebUI: 5s 817.92ms
Sep 06 16:43:09 player volumio[8034]: info: CoreStateMachine::resetVolumioState
Sep 06 16:43:09 player volumio[8034]: info: CoreStateMachine::getcurrentVolume
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::volumioRetrievevolume
Sep 06 16:43:09 player volumio[8034]: info: CoreStateMachine::pushState
Sep 06 16:43:09 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:09 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:09 player volumio[8034]: info: Cannot read play queue from file
Sep 06 16:43:10 player volumio[8034]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 06 16:43:10 player volumio[8034]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 06 16:43:10 player volumio-remote-updater[649]: [2024-09-06 16:43:10] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725633787 101
Sep 06 16:43:10 player volumio[8034]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3
Sep 06 16:43:10 player volumio[8034]: info: CoreStateMachine::setRepeat null single undefined
Sep 06 16:43:10 player volumio[8034]: info: CoreStateMachine::pushState
Sep 06 16:43:10 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:10 player volumio[8034]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:10 player volumio[8034]: info: CoreStateMachine::setRandom null
Sep 06 16:43:10 player volumio[8034]: info: CoreStateMachine::pushState
Sep 06 16:43:10 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:10 player volumio[8034]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:10 player volumio[8034]: info: Setting Device type: Raspberry PI
Sep 06 16:43:10 player volumio[8034]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Sep 06 16:43:10 player volumio[8034]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Sep 06 16:43:10 player volumio[8034]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Sep 06 16:43:10 player volumio[8034]: Starting albumart workers
Sep 06 16:43:10 player volumio[8034]: Starting albumart workers
Sep 06 16:43:10 player volumio[8034]: info: Completed loading Core Plugins
Sep 06 16:43:10 player volumio[8034]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:10 player volumio[8034]: Starting albumart workers
Sep 06 16:43:10 player volumio[8034]: info: Discovery: adding cdb3bedc-36fc-4bbb-b5fa-1ceec2b4e007
Sep 06 16:43:10 player volumio[8034]: info: Discovery: Found device Player
Sep 06 16:43:10 player volumio[8034]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:10 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:10 player volumio[8034]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:10 player volumio[8034]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:10 player volumio[8034]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:10 player volumio[8034]: info: Output device has changed, restarting MPD
Sep 06 16:43:10 player sudo[8110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 06 16:43:10 player sudo[8110]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:10 player volumio[8034]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:10 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:10 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:10 player sudo[8111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 06 16:43:10 player sudo[8111]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:10 player sudo[8110]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:10 player sudo[8113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:10 player sudo[8113]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:10 player sudo[8111]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:10 player sudo[8113]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:10 player sudo[8118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:10 player sudo[8118]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:10 player systemd[1]: Stopping Music Player Daemon...
Sep 06 16:43:10 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:10 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:10 player volumio[8034]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:10 player volumio[8034]: info: ___________ START PLUGINS ___________
Sep 06 16:43:10 player volumio[8034]: info: ControllerMpd::onStart: Initializing MPD
Sep 06 16:43:10 player volumio[8034]: info: Creating MPD Configuration file
Sep 06 16:43:10 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:10 player volumio[8034]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:10 player volumio[8034]: info: [1725633790950] CoreMusicLibrary::Adding element Serveurs Média
Sep 06 16:43:10 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:10 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:10 player sudo[8126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:11 player sudo[8127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:11 player sudo[8127]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:11 player sudo[8126]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:11 player sudo[8126]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:11 player systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 06 16:43:11 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:11 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:11 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:11 player volumio[8034]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:11 player volumio[8034]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:11 player volumio[8034]: info: [1725633791207] CoreMusicLibrary::Adding element Last_100
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:11 player volumio[8034]: info: [1725633791215] CoreMusicLibrary::Adding element Webradio
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:11 player volumio[8034]: info: Initializing BBC Radios
Sep 06 16:43:11 player sudo[8133]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:11 player sudo[8133]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:11 player sudo[8133]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:11 player volumio[8034]: info: Creating Spotify config file
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:11 player volumio[8034]: info: Loading i18n strings for locale fr
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 06 16:43:11 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:11 player volumio[8034]: info: FusionDsp - mixtype--------------------- None
Sep 06 16:43:11 player volumio[8034]: info: Volumio Calling Home
Sep 06 16:43:11 player volumio[8034]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:11 player volumio[8034]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:11 player volumio[8034]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:11 player volumio[8034]: info: MPD Permissions set
Sep 06 16:43:11 player volumio[8034]: info: MPD Permissions set
Sep 06 16:43:11 player volumio[8034]: info: Volumio called home
Sep 06 16:43:11 player volumio[8034]: info: Spotify config file written
Sep 06 16:43:11 player volumio[8034]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
Sep 06 16:43:12 player sudo[8178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 06 16:43:12 player sudo[8178]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:12 player volumio[8034]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player systemd[1]: Stopping go-librespot Daemon...
Sep 06 16:43:12 player systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:12 player systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 06 16:43:12 player systemd[1]: Stopped go-librespot Daemon.
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player systemd[1]: Started go-librespot Daemon.
Sep 06 16:43:12 player go-librespot[8184]: Librespot-go daemon starting...
Sep 06 16:43:12 player sudo[8178]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player go-librespot[8184]: time="2024-09-06T16:43:12+02:00" level=info msg="generated new device id: ebe9aa95de1ed3f50d4a3d684771c8b65a07ee0c"
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:12 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 06 16:43:12 player volumio[8034]: info: Received Get System Info
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:12 player volumio[8034]: info: Discovery: Getting this device information
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:12 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:12 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:12 player volumio[8034]: info: Listing playlists
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 06 16:43:12 player go-librespot[8184]: time="2024-09-06T16:43:12+02:00" level=debug msg="fetched new accesspoints: [ap2-gew1.spotify.com:4070 ap2-gew1.spotify.com:443 ap2-gew1.spotify.com:80 ap2-guc3.spotify.com:4070 ap2-gue1.spotify.com:443 ap2-gae2.spotify.com:80]"
Sep 06 16:43:12 player go-librespot[8184]: time="2024-09-06T16:43:12+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Sep 06 16:43:12 player go-librespot[8184]: time="2024-09-06T16:43:12+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Sep 06 16:43:12 player go-librespot[8184]: time="2024-09-06T16:43:12+02:00" level=debug msg="zeroconf server listening on port 42303"
Sep 06 16:43:12 player volumio[8034]: info: Starting Shairport Sync
Sep 06 16:43:12 player volumio[8034]: info: Starting Shairport Sync
Sep 06 16:43:12 player volumio[8034]: info: Starting Shairport Sync
Sep 06 16:43:12 player sudo[8197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:12 player sudo[8197]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:12 player sudo[8199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:12 player sudo[8199]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:12 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:12 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:12 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:12 player sudo[8202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:12 player sudo[8202]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:12 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:12 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 06 16:43:12 player volumio[8034]: info: Received Get System Info
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:12 player volumio[8034]: info: Discovery: Getting this device information
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:12 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 06 16:43:12 player sudo[8197]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:12 player volumio[8034]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:12 player volumio[8034]: info: Output device has changed, restarting MPD
Sep 06 16:43:12 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:12 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:12 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:12 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:12 player sudo[8202]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:12 player sudo[8208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:12 player sudo[8208]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:12 player sudo[8208]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:12 player sudo[8199]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:12 player volumio[8034]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:12 player sudo[8211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:12 player sudo[8211]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:12 player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:12 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:12 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:12 player volumio[8034]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:12 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:12 player volumio[8034]: info: Shairport-Sync Started
Sep 06 16:43:12 player volumio[8034]: Error adding Membership: Error: addMembership EINVAL
Sep 06 16:43:12 player volumio[8034]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:12 player volumio[8034]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:12 player volumio[8034]: info: MPD Permissions set
Sep 06 16:43:12 player volumio[8034]: info: Shairport-Sync Started
Sep 06 16:43:12 player volumio[8034]: info: Shairport-Sync Started
Sep 06 16:43:13 player sudo[8219]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:13 player sudo[8219]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:13 player sudo[8219]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: info: Starting Shairport Sync
Sep 06 16:43:13 player sudo[8228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:13 player sudo[8228]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:13 player volumio[8034]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:43:13 player volumio[8034]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 06 16:43:13 player volumio[8034]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:43:13 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:13 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:13 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:13 player volumio[8034]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Sep 06 16:43:13 player volumio[8034]: info: camilladsp service started and running in background, instance 1
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:13 player volumio[8034]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:43:13 player volumio[8034]: 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 16:43:13 player volumio[8034]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:43:13 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:13 player sudo[8228]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:13 player volumio[8034]: info: FusionDsp loaded
Sep 06 16:43:13 player volumio[8034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:13 player sudo[8241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 06 16:43:13 player sudo[8241]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:13 player volumio[8034]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 06 16:43:13 player volumio[8034]: info: Adding Signal Path Element [object Object]
Sep 06 16:43:13 player volumio[8034]: info: Adding fusiondspeq DSP Signal Path Element
Sep 06 16:43:13 player volumio[8034]: info: FusionDsp - ---- installed callbackRead
Sep 06 16:43:13 player volumio[8034]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:13 player sudo[8241]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:13 player volumio[8034]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 06 16:43:13 player volumio[8034]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 06 16:43:13 player volumio[8034]: at onErrorNT (internal/child_process.js:465:16)
Sep 06 16:43:13 player volumio[8034]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Sep 06 16:43:13 player volumio[8034]: at runNextTicks (internal/process/task_queues.js:62:3)
Sep 06 16:43:13 player volumio[8034]: at listOnTimeout (internal/timers.js:523:9)
Sep 06 16:43:13 player volumio[8034]: at processTimers (internal/timers.js:497:7) {
Sep 06 16:43:13 player volumio[8034]: errno: -2,
Sep 06 16:43:13 player volumio[8034]: code: 'ENOENT',
Sep 06 16:43:13 player volumio[8034]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:43:13 player volumio[8034]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:43:13 player volumio[8034]: spawnargs: [
Sep 06 16:43:13 player volumio[8034]: '-p',
Sep 06 16:43:13 player volumio[8034]: 9876,
Sep 06 16:43:13 player volumio[8034]: '-o',
Sep 06 16:43:13 player volumio[8034]: '/tmp/camilladsp.log',
Sep 06 16:43:13 player volumio[8034]: '-l',
Sep 06 16:43:13 player volumio[8034]: 'warn',
Sep 06 16:43:13 player volumio[8034]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 06 16:43:13 player volumio[8034]: ]
Sep 06 16:43:13 player volumio[8034]: }
Sep 06 16:43:13 player volumio[8034]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:14 player sudo[8254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 16:42
Sep 06 16:43:14 player sudo[8254]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:14 player sudo[8254]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:14 player volumio-remote-updater[649]: [2024-09-06 16:43:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 06 16:43:14 player volumio-remote-updater[649]: [2024-09-06 16:43:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 06 16:43:14 player systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 06 16:43:14 player sudo[8127]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:14 player sudo[8211]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:14 player sudo[8118]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:14 player systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 06 16:43:14 player mpd[8222]: Sep 06 16:43 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 06 16:43:14 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:14 player systemd[1]: Started Music Player Daemon.
Sep 06 16:43:14 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:14 player systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 06 16:43:14 player systemd[1]: volumio.service: Scheduled restart job, restart counter is at 31.
Sep 06 16:43:14 player systemd[1]: Stopped Volumio Backend Module.
Sep 06 16:43:14 player systemd[1]: Started Volumio Backend Module.
Sep 06 16:43:14 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:15 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:16 player volumio[8266]: info: -------------------------------------------
Sep 06 16:43:16 player volumio[8266]: info: ----- Volumio3 ----
Sep 06 16:43:16 player volumio[8266]: info: -------------------------------------------
Sep 06 16:43:16 player volumio[8266]: info: ----- System startup ----
Sep 06 16:43:16 player volumio[8266]: info: -------------------------------------------
Sep 06 16:43:17 player volumio[8266]: info: MYVOLUMIO Environment detected
Sep 06 16:43:17 player volumio[8266]: info: Plugin folders cleanup
Sep 06 16:43:17 player volumio[8266]: info: Scanning into folder /volumio/app/plugins/
Sep 06 16:43:17 player volumio[8266]: info: Scanning category audio_interface
Sep 06 16:43:17 player volumio[8266]: info: Scanning category miscellanea
Sep 06 16:43:17 player volumio[8266]: info: Scanning category music_service
Sep 06 16:43:17 player volumio[8266]: info: Scanning category plugins.json
Sep 06 16:43:17 player volumio[8266]: info: Scanning category system_controller
Sep 06 16:43:17 player volumio[8266]: info: Scanning category user_interface
Sep 06 16:43:17 player volumio[8266]: info: Scanning into folder /data/plugins/
Sep 06 16:43:17 player volumio[8266]: info: Scanning category audio_interface
Sep 06 16:43:17 player volumio[8266]: info: Scanning category music_service
Sep 06 16:43:17 player volumio[8266]: info: Plugin folders cleanup completed
Sep 06 16:43:17 player volumio[8266]: info: -------------------------------------------
Sep 06 16:43:17 player volumio[8266]: info: ----- Core plugins startup ----
Sep 06 16:43:17 player volumio[8266]: info: -------------------------------------------
Sep 06 16:43:17 player volumio[8266]: info: Loading plugins from folder /volumio/app/plugins/
Sep 06 16:43:17 player volumio[8266]: info: Adding plugin upnp to MyMusic Plugins
Sep 06 16:43:17 player volumio[8266]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 06 16:43:17 player volumio[8266]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 06 16:43:17 player volumio[8266]: info: Loading plugins from folder /data/plugins/
Sep 06 16:43:17 player volumio[8266]: info: Loading plugin "system"...
Sep 06 16:43:17 player volumio[8266]: info: Loading plugin "appearance"...
Sep 06 16:43:18 player volumio[8266]: info: Loading plugin "network"...
Sep 06 16:43:18 player volumio[8266]: info: Refreshing Cached IP Addresses
Sep 06 16:43:18 player sudo[8293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 06 16:43:18 player sudo[8293]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:18 player sudo[8293]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:18 player volumio[8266]: info: Loading plugin "services"...
Sep 06 16:43:18 player sudo[8295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 06 16:43:18 player sudo[8295]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:18 player volumio[8266]: info: Loading plugin "alsa_controller"...
Sep 06 16:43:18 player sudo[8295]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:18 player sudo[8298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 06 16:43:18 player sudo[8298]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:19 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "wizard"...
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "networkfs"...
Sep 06 16:43:19 player volumio[8266]: info: Starting Udev Watcher for removable devices
Sep 06 16:43:19 player volumio[8266]: info: Ignoring mount for partition: boot
Sep 06 16:43:19 player volumio[8266]: info: Ignoring mount for partition: volumio
Sep 06 16:43:19 player volumio[8266]: info: Ignoring mount for partition: volumio_data
Sep 06 16:43:19 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "volumio_command_line_client"...
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "upnp"...
Sep 06 16:43:19 player volumio[8266]: info: [1725633799086] Starting Upmpd Daemon
Sep 06 16:43:19 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "my_music"...
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "mpd"...
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "upnp_browser"...
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "alarm-clock"...
Sep 06 16:43:19 player volumio-remote-updater[649]: [2024-09-06 16:43:19] [connect] Successful connection
Sep 06 16:43:19 player sudo[8298]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "airplay_emulation"...
Sep 06 16:43:19 player volumio[8266]: info: Starting Shairport Sync
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "last_100"...
Sep 06 16:43:19 player volumio[8266]: info: Loading plugin "webradio"...
Sep 06 16:43:20 player volumio[8266]: info: Loading plugin "i2s_dacs"...
Sep 06 16:43:20 player volumio[8266]: info: I2S DAC not set, start Auto-detection
Sep 06 16:43:20 player volumio[8266]: info: Loading plugin "volumiodiscovery"...
Sep 06 16:43:20 player volumio[8266]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:20 player volumio[8266]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:20 player volumio[8266]: *** WARNING *** For more information see
Sep 06 16:43:20 player node[8266]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:20 player volumio[8266]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:20 player volumio[8266]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:20 player volumio[8266]: *** WARNING *** For more information see
Sep 06 16:43:20 player node[8266]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:20 player node[8266]: *** WARNING *** For more information see
Sep 06 16:43:20 player node[8266]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:20 player node[8266]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:20 player node[8266]: *** WARNING *** For more information see
Sep 06 16:43:20 player volumio[8266]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 06 16:43:20 player volumio[8266]: info: Discovery: Started advertising with name: Player
Sep 06 16:43:20 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:20 player volumio[8266]: info: Loading plugin "spop"...
Sep 06 16:43:21 player volumio[8266]: info: Loading plugin "outputs"...
Sep 06 16:43:21 player volumio[8266]: info: Loading plugin "albumart"...
Sep 06 16:43:21 player volumio[8266]: info: Plugin example_plugin is not enabled
Sep 06 16:43:21 player volumio[8266]: info: Loading plugin "inputs"...
Sep 06 16:43:21 player volumio[8266]: info: Loading plugin "updater_comm"...
Sep 06 16:43:21 player volumio[8266]: info: Plugin mpdemulation is not enabled
Sep 06 16:43:21 player volumio[8266]: info: Loading plugin "rest_api"...
Sep 06 16:43:21 player volumio[8266]: info: Loading plugin "websocket"...
Sep 06 16:43:21 player volumio[8266]: info: Starting Socket.io Server version 2.3.0
Sep 06 16:43:21 player volumio[8266]: info: Loading plugin "fusiondsp"...
Sep 06 16:43:21 player volumio[8266]: Forking 3 albumart workers
Sep 06 16:43:21 player volumio[8266]: info: Applying required configuration parameters for plugin fusiondsp
Sep 06 16:43:21 player volumio[8266]: info: Loading i18n strings for locale fr
Sep 06 16:43:21 player volumio[8266]: Updating browse sources language
Sep 06 16:43:21 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::initPlayerControls
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:22 player volumio[8266]: Express server listening on port 3000
Sep 06 16:43:22 player volumio[8266]: [Metrics] WebUI: 5s 811.45ms
Sep 06 16:43:22 player volumio[8266]: info: CoreStateMachine::resetVolumioState
Sep 06 16:43:22 player volumio[8266]: info: CoreStateMachine::getcurrentVolume
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::volumioRetrievevolume
Sep 06 16:43:22 player volumio[8266]: info: CoreStateMachine::pushState
Sep 06 16:43:22 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: Cannot read play queue from file
Sep 06 16:43:22 player volumio[8266]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 06 16:43:22 player volumio[8266]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 06 16:43:22 player volumio-remote-updater[649]: [2024-09-06 16:43:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725633799 101
Sep 06 16:43:22 player volumio[8266]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3
Sep 06 16:43:22 player volumio[8266]: info: CoreStateMachine::setRepeat null single undefined
Sep 06 16:43:22 player volumio[8266]: info: CoreStateMachine::pushState
Sep 06 16:43:22 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:22 player volumio[8266]: info: CoreStateMachine::setRandom null
Sep 06 16:43:22 player volumio[8266]: info: CoreStateMachine::pushState
Sep 06 16:43:22 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:22 player volumio[8266]: info: Setting Device type: Raspberry PI
Sep 06 16:43:22 player volumio[8266]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Sep 06 16:43:22 player volumio[8266]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Sep 06 16:43:22 player volumio[8266]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:22 player volumio[8266]: info: Discovery: Getting this device information
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:22 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:22 player volumio[8266]: info: Completed loading Core Plugins
Sep 06 16:43:22 player volumio[8266]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:22 player volumio[8266]: info: Discovery: adding cdb3bedc-36fc-4bbb-b5fa-1ceec2b4e007
Sep 06 16:43:22 player volumio[8266]: info: Discovery: Found device Player
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:22 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:22 player volumio[8266]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:22 player volumio[8266]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:22 player volumio[8266]: verbose: New Socket.io Connection to 192.168.1.154:3000 from 192.168.1.124 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:22 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Sep 06 16:43:22 player volumio-remote-updater[649]: No test mode
Sep 06 16:43:22 player volumio-remote-updater[649]: No alpha test mode
Sep 06 16:43:22 player volumio[8266]: Starting albumart workers
Sep 06 16:43:22 player volumio[8266]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:22 player volumio[8266]: info: Output device has changed, restarting MPD
Sep 06 16:43:22 player volumio[8266]: Starting albumart workers
Sep 06 16:43:22 player volumio[8266]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:22 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:22 player volumio[8266]: Starting albumart workers
Sep 06 16:43:22 player sudo[8345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:22 player sudo[8343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:22 player sudo[8345]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:22 player sudo[8343]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:23 player sudo[8343]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:23 player systemd[1]: Stopping Music Player Daemon...
Sep 06 16:43:23 player volumio[8266]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:23 player volumio[8266]: info: ___________ START PLUGINS ___________
Sep 06 16:43:23 player volumio[8266]: info: ControllerMpd::onStart: Initializing MPD
Sep 06 16:43:23 player volumio[8266]: info: Creating MPD Configuration file
Sep 06 16:43:23 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:23 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:23 player sudo[8353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:23 player sudo[8353]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:23 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:23 player sudo[8353]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:23 player volumio[8266]: info: [1725633803188] CoreMusicLibrary::Adding element Serveurs Média
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:23 player sudo[8356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:23 player sudo[8356]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:23 player systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 06 16:43:23 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:23 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:23 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:23 player volumio[8266]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:23 player volumio[8266]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:23 player sudo[8358]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:23 player volumio[8266]: info: [1725633803404] CoreMusicLibrary::Adding element Last_100
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:23 player sudo[8358]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:23 player sudo[8358]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:23 player volumio[8266]: info: [1725633803419] CoreMusicLibrary::Adding element Webradio
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:23 player volumio[8266]: info: Initializing BBC Radios
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:23 player volumio[8266]: info: Creating Spotify config file
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:23 player volumio[8266]: info: Loading i18n strings for locale fr
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 06 16:43:23 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:23 player volumio[8266]: info: FusionDsp - mixtype--------------------- None
Sep 06 16:43:23 player volumio[8266]: info: Volumio Calling Home
Sep 06 16:43:24 player volumio[8266]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:24 player volumio[8266]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:24 player volumio[8266]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:24 player volumio[8266]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Sep 06 16:43:24 player volumio[8266]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Sep 06 16:43:24 player volumio[8266]: info: MPD Permissions set
Sep 06 16:43:24 player volumio[8266]: info: MPD Permissions set
Sep 06 16:43:24 player volumio[8266]: info: Spotify config file written
Sep 06 16:43:24 player volumio[8266]: 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 16:43:24 player sudo[8405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 06 16:43:24 player volumio[8266]: info: Volumio called home
Sep 06 16:43:24 player sudo[8405]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player systemd[1]: Stopping go-librespot Daemon...
Sep 06 16:43:24 player systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:24 player systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 06 16:43:24 player systemd[1]: Stopped go-librespot Daemon.
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:24 player systemd[1]: Started go-librespot Daemon.
Sep 06 16:43:24 player go-librespot[8408]: Librespot-go daemon starting...
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 06 16:43:24 player sudo[8405]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:24 player go-librespot[8408]: time="2024-09-06T16:43:24+02:00" level=info msg="generated new device id: 7d047e133d533e9afaeff116617ba270fa06fac0"
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:24 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:24 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 06 16:43:24 player volumio[8266]: info: Received Get System Info
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:24 player volumio[8266]: info: Discovery: Getting this device information
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:24 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:24 player volumio[8266]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:24 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:24 player volumio[8266]: info: Listing playlists
Sep 06 16:43:24 player go-librespot[8408]: time="2024-09-06T16:43:24+02:00" level=debug msg="fetched new accesspoints: [ap2-gew1.spotify.com:4070 ap2-gew1.spotify.com:443 ap2-gew1.spotify.com:80 ap2-guc3.spotify.com:4070 ap2-gue1.spotify.com:443 ap2-gae2.spotify.com:80]"
Sep 06 16:43:24 player go-librespot[8408]: time="2024-09-06T16:43:24+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Sep 06 16:43:24 player go-librespot[8408]: time="2024-09-06T16:43:24+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Sep 06 16:43:24 player volumio[8266]: info: Starting Shairport Sync
Sep 06 16:43:24 player go-librespot[8408]: time="2024-09-06T16:43:24+02:00" level=debug msg="zeroconf server listening on port 37583"
Sep 06 16:43:24 player volumio[8266]: info: Starting Shairport Sync
Sep 06 16:43:24 player sudo[8424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:24 player sudo[8424]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:24 player volumio[8266]: info: Starting Shairport Sync
Sep 06 16:43:24 player sudo[8426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:24 player sudo[8426]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:24 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:24 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:24 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:25 player volumio[8266]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:25 player volumio[8266]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:25 player sudo[8430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:25 player sudo[8430]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:25 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:25 player volumio[8266]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 06 16:43:25 player volumio[8266]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:25 player volumio[8266]: info: Output device has changed, restarting MPD
Sep 06 16:43:25 player sudo[8424]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:25 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:25 player systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:25 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:25 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:25 player volumio[8266]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:25 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:25 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:25 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:25 player sudo[8426]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:25 player sudo[8430]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:25 player sudo[8435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:25 player sudo[8435]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:25 player sudo[8438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:25 player sudo[8438]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:25 player sudo[8435]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:25 player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:25 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:25 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:25 player volumio[8266]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:25 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:25 player volumio[8266]: info: MPD Permissions set
Sep 06 16:43:25 player volumio[8266]: info: Shairport-Sync Started
Sep 06 16:43:25 player volumio[8266]: Error adding Membership: Error: addMembership EINVAL
Sep 06 16:43:25 player volumio[8266]: info: Shairport-Sync Started
Sep 06 16:43:25 player volumio[8266]: info: Shairport-Sync Started
Sep 06 16:43:25 player sudo[8446]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:25 player sudo[8446]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:25 player sudo[8446]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:26 player volumio[8266]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:43:26 player volumio[8266]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 06 16:43:26 player volumio[8266]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:43:26 player volumio[8266]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Sep 06 16:43:26 player volumio[8266]: info: camilladsp service started and running in background, instance 1
Sep 06 16:43:26 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:26 player volumio[8266]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:43:26 player volumio[8266]: 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 16:43:26 player volumio[8266]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:43:26 player volumio[8266]: info: FusionDsp loaded
Sep 06 16:43:26 player volumio[8266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:26 player sudo[8461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 06 16:43:26 player sudo[8461]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:26 player volumio[8266]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 06 16:43:26 player volumio[8266]: info: Adding Signal Path Element [object Object]
Sep 06 16:43:26 player volumio[8266]: info: Adding fusiondspeq DSP Signal Path Element
Sep 06 16:43:26 player volumio[8266]: info: FusionDsp - ---- installed callbackRead
Sep 06 16:43:26 player volumio[8266]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:26 player sudo[8461]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:26 player volumio[8266]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 06 16:43:26 player volumio[8266]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 06 16:43:26 player volumio[8266]: at onErrorNT (internal/child_process.js:465:16)
Sep 06 16:43:26 player volumio[8266]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Sep 06 16:43:26 player volumio[8266]: at runNextTicks (internal/process/task_queues.js:62:3)
Sep 06 16:43:26 player volumio[8266]: at listOnTimeout (internal/timers.js:523:9)
Sep 06 16:43:26 player volumio[8266]: at processTimers (internal/timers.js:497:7) {
Sep 06 16:43:26 player volumio[8266]: errno: -2,
Sep 06 16:43:26 player volumio[8266]: code: 'ENOENT',
Sep 06 16:43:26 player volumio[8266]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:43:26 player volumio[8266]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:43:26 player volumio[8266]: spawnargs: [
Sep 06 16:43:26 player volumio[8266]: '-p',
Sep 06 16:43:26 player volumio[8266]: 9876,
Sep 06 16:43:26 player volumio[8266]: '-o',
Sep 06 16:43:26 player volumio[8266]: '/tmp/camilladsp.log',
Sep 06 16:43:26 player volumio[8266]: '-l',
Sep 06 16:43:26 player volumio[8266]: 'warn',
Sep 06 16:43:26 player volumio[8266]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 06 16:43:26 player volumio[8266]: ]
Sep 06 16:43:26 player volumio[8266]: }
Sep 06 16:43:26 player volumio[8266]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:26 player sudo[8472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 16:42
Sep 06 16:43:26 player sudo[8472]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:27 player sudo[8472]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:27 player volumio-remote-updater[649]: [2024-09-06 16:43:27] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 06 16:43:27 player volumio-remote-updater[649]: [2024-09-06 16:43:27] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 06 16:43:27 player systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 06 16:43:27 player sudo[8345]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:27 player sudo[8438]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:27 player sudo[8356]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:27 player systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 06 16:43:27 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:27 player systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 06 16:43:27 player systemd[1]: volumio.service: Scheduled restart job, restart counter is at 32.
Sep 06 16:43:27 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:27 player systemd[1]: Stopped Volumio Backend Module.
Sep 06 16:43:27 player systemd[1]: Started Volumio Backend Module.
Sep 06 16:43:27 player mpd[8450]: Sep 06 16:43 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 06 16:43:27 player systemd[1]: Started Music Player Daemon.
Sep 06 16:43:29 player volumio[8482]: info: -------------------------------------------
Sep 06 16:43:29 player volumio[8482]: info: ----- Volumio3 ----
Sep 06 16:43:29 player volumio[8482]: info: -------------------------------------------
Sep 06 16:43:29 player volumio[8482]: info: ----- System startup ----
Sep 06 16:43:29 player volumio[8482]: info: -------------------------------------------
Sep 06 16:43:30 player volumio[8482]: info: MYVOLUMIO Environment detected
Sep 06 16:43:30 player volumio[8482]: info: Plugin folders cleanup
Sep 06 16:43:30 player volumio[8482]: info: Scanning into folder /volumio/app/plugins/
Sep 06 16:43:30 player volumio[8482]: info: Scanning category audio_interface
Sep 06 16:43:30 player volumio[8482]: info: Scanning category miscellanea
Sep 06 16:43:30 player volumio[8482]: info: Scanning category music_service
Sep 06 16:43:30 player volumio[8482]: info: Scanning category plugins.json
Sep 06 16:43:30 player volumio[8482]: info: Scanning category system_controller
Sep 06 16:43:30 player volumio[8482]: info: Scanning category user_interface
Sep 06 16:43:30 player volumio[8482]: info: Scanning into folder /data/plugins/
Sep 06 16:43:30 player volumio[8482]: info: Scanning category audio_interface
Sep 06 16:43:30 player volumio[8482]: info: Scanning category music_service
Sep 06 16:43:30 player volumio[8482]: info: Plugin folders cleanup completed
Sep 06 16:43:30 player volumio[8482]: info: -------------------------------------------
Sep 06 16:43:30 player volumio[8482]: info: ----- Core plugins startup ----
Sep 06 16:43:30 player volumio[8482]: info: -------------------------------------------
Sep 06 16:43:30 player volumio[8482]: info: Loading plugins from folder /volumio/app/plugins/
Sep 06 16:43:30 player volumio[8482]: info: Adding plugin upnp to MyMusic Plugins
Sep 06 16:43:30 player volumio[8482]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 06 16:43:30 player volumio[8482]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 06 16:43:30 player volumio[8482]: info: Loading plugins from folder /data/plugins/
Sep 06 16:43:30 player volumio[8482]: info: Loading plugin "system"...
Sep 06 16:43:30 player volumio[8482]: info: Loading plugin "appearance"...
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "network"...
Sep 06 16:43:31 player volumio[8482]: info: Refreshing Cached IP Addresses
Sep 06 16:43:31 player sudo[8505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 06 16:43:31 player sudo[8505]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "services"...
Sep 06 16:43:31 player sudo[8505]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:31 player sudo[8507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 06 16:43:31 player sudo[8507]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "alsa_controller"...
Sep 06 16:43:31 player sudo[8507]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:31 player sudo[8510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 06 16:43:31 player sudo[8510]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:31 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "wizard"...
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "networkfs"...
Sep 06 16:43:31 player volumio[8482]: info: Starting Udev Watcher for removable devices
Sep 06 16:43:31 player volumio[8482]: info: Ignoring mount for partition: boot
Sep 06 16:43:31 player volumio[8482]: info: Ignoring mount for partition: volumio
Sep 06 16:43:31 player volumio[8482]: info: Ignoring mount for partition: volumio_data
Sep 06 16:43:31 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "volumio_command_line_client"...
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "upnp"...
Sep 06 16:43:31 player volumio[8482]: info: [1725633811384] Starting Upmpd Daemon
Sep 06 16:43:31 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "my_music"...
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "mpd"...
Sep 06 16:43:31 player volumio[8482]: info: Loading plugin "upnp_browser"...
Sep 06 16:43:32 player volumio[8482]: info: Loading plugin "alarm-clock"...
Sep 06 16:43:32 player sudo[8510]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:32 player volumio-remote-updater[649]: [2024-09-06 16:43:32] [connect] Successful connection
Sep 06 16:43:32 player volumio[8482]: info: Loading plugin "airplay_emulation"...
Sep 06 16:43:32 player volumio[8482]: info: Starting Shairport Sync
Sep 06 16:43:32 player volumio[8482]: info: Loading plugin "last_100"...
Sep 06 16:43:32 player volumio[8482]: info: Loading plugin "webradio"...
Sep 06 16:43:32 player volumio[8482]: info: Loading plugin "i2s_dacs"...
Sep 06 16:43:32 player volumio[8482]: info: I2S DAC not set, start Auto-detection
Sep 06 16:43:32 player volumio[8482]: info: Loading plugin "volumiodiscovery"...
Sep 06 16:43:32 player volumio[8482]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:32 player node[8482]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:32 player volumio[8482]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:32 player node[8482]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:32 player volumio[8482]: *** WARNING *** For more information see
Sep 06 16:43:32 player node[8482]: *** WARNING *** For more information see
Sep 06 16:43:32 player volumio[8482]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:32 player node[8482]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:32 player volumio[8482]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:32 player node[8482]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:32 player volumio[8482]: *** WARNING *** For more information see
Sep 06 16:43:32 player node[8482]: *** WARNING *** For more information see
Sep 06 16:43:32 player volumio[8482]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 06 16:43:32 player volumio[8482]: info: Discovery: Started advertising with name: Player
Sep 06 16:43:32 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:32 player volumio[8482]: info: Loading plugin "spop"...
Sep 06 16:43:33 player volumio[8482]: info: Loading plugin "outputs"...
Sep 06 16:43:33 player volumio[8482]: info: Loading plugin "albumart"...
Sep 06 16:43:33 player volumio[8482]: info: Plugin example_plugin is not enabled
Sep 06 16:43:33 player volumio[8482]: info: Loading plugin "inputs"...
Sep 06 16:43:33 player volumio[8482]: info: Loading plugin "updater_comm"...
Sep 06 16:43:33 player volumio[8482]: info: Plugin mpdemulation is not enabled
Sep 06 16:43:33 player volumio[8482]: info: Loading plugin "rest_api"...
Sep 06 16:43:33 player volumio[8482]: info: Loading plugin "websocket"...
Sep 06 16:43:33 player volumio[8482]: info: Starting Socket.io Server version 2.3.0
Sep 06 16:43:33 player volumio[8482]: info: Loading plugin "fusiondsp"...
Sep 06 16:43:34 player volumio[8482]: Forking 3 albumart workers
Sep 06 16:43:34 player volumio[8482]: info: Applying required configuration parameters for plugin fusiondsp
Sep 06 16:43:34 player volumio[8482]: info: Loading i18n strings for locale fr
Sep 06 16:43:34 player volumio[8482]: Updating browse sources language
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::initPlayerControls
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:34 player volumio[8482]: Express server listening on port 3000
Sep 06 16:43:34 player volumio[8482]: [Metrics] WebUI: 5s 857.92ms
Sep 06 16:43:34 player volumio[8482]: info: CoreStateMachine::resetVolumioState
Sep 06 16:43:34 player volumio[8482]: info: CoreStateMachine::getcurrentVolume
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::volumioRetrievevolume
Sep 06 16:43:34 player volumio[8482]: info: CoreStateMachine::pushState
Sep 06 16:43:34 player volumio[8482]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:34 player volumio[8482]: info: Cannot read play queue from file
Sep 06 16:43:34 player volumio[8482]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 06 16:43:34 player volumio[8482]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 06 16:43:34 player volumio[8482]: verbose: New Socket.io Connection to 192.168.1.154:3000 from 192.168.1.124 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3
Sep 06 16:43:34 player volumio-remote-updater[649]: [2024-09-06 16:43:34] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725633812 101
Sep 06 16:43:34 player volumio[8482]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:34 player volumio[8482]: info: Discovery: Getting this device information
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:34 player volumio[8482]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:34 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:35 player volumio[8482]: info: CoreStateMachine::setRepeat null single undefined
Sep 06 16:43:35 player volumio[8482]: info: CoreStateMachine::pushState
Sep 06 16:43:35 player volumio[8482]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:35 player volumio[8482]: info: CoreStateMachine::setRandom null
Sep 06 16:43:35 player volumio[8482]: info: CoreStateMachine::pushState
Sep 06 16:43:35 player volumio[8482]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:35 player volumio[8482]: info: Setting Device type: Raspberry PI
Sep 06 16:43:35 player volumio[8482]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Sep 06 16:43:35 player volumio[8482]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Sep 06 16:43:35 player volumio[8482]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Sep 06 16:43:35 player volumio[8482]: info: Completed loading Core Plugins
Sep 06 16:43:35 player volumio[8482]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:35 player volumio[8482]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:35 player volumio[8482]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:35 player volumio[8482]: info: Discovery: adding cdb3bedc-36fc-4bbb-b5fa-1ceec2b4e007
Sep 06 16:43:35 player volumio[8482]: info: Discovery: Found device Player
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:35 player volumio[8482]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:35 player volumio[8482]: Starting albumart workers
Sep 06 16:43:35 player volumio[8482]: Starting albumart workers
Sep 06 16:43:35 player volumio[8482]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:35 player volumio[8482]: info: Output device has changed, restarting MPD
Sep 06 16:43:35 player volumio[8482]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:35 player sudo[8593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:35 player sudo[8593]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:35 player sudo[8593]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:35 player sudo[8595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:35 player sudo[8595]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:35 player volumio[8482]: Starting albumart workers
Sep 06 16:43:35 player volumio[8482]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:35 player volumio[8482]: info: ___________ START PLUGINS ___________
Sep 06 16:43:35 player systemd[1]: Stopping Music Player Daemon...
Sep 06 16:43:35 player volumio[8482]: info: ControllerMpd::onStart: Initializing MPD
Sep 06 16:43:35 player volumio[8482]: info: Creating MPD Configuration file
Sep 06 16:43:35 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:35 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:35 player volumio[8482]: info: [1725633815487] CoreMusicLibrary::Adding element Serveurs Média
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:35 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:35 player sudo[8601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:35 player sudo[8601]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:35 player sudo[8604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:35 player sudo[8604]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:35 player sudo[8601]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:35 player systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 06 16:43:35 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:35 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:35 player volumio[8482]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:35 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:35 player volumio[8482]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:35 player volumio[8482]: info: [1725633815732] CoreMusicLibrary::Adding element Last_100
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:35 player volumio[8482]: info: [1725633815738] CoreMusicLibrary::Adding element Webradio
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:35 player volumio[8482]: info: Initializing BBC Radios
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:35 player sudo[8610]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:35 player sudo[8610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:35 player sudo[8610]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:35 player volumio[8482]: info: Creating Spotify config file
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:35 player volumio[8482]: info: Loading i18n strings for locale fr
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 06 16:43:35 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:35 player volumio[8482]: info: FusionDsp - mixtype--------------------- None
Sep 06 16:43:35 player volumio[8482]: info: Volumio Calling Home
Sep 06 16:43:36 player volumio[8482]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:36 player volumio[8482]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:36 player volumio[8482]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:36 player volumio[8482]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Sep 06 16:43:36 player volumio[8482]: info: MPD Permissions set
Sep 06 16:43:36 player volumio[8482]: info: MPD Permissions set
Sep 06 16:43:36 player volumio[8482]: info: Volumio called home
Sep 06 16:43:36 player volumio[8482]: info: Spotify config file written
Sep 06 16:43:36 player volumio[8482]: 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 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player sudo[8639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 06 16:43:36 player sudo[8639]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:36 player systemd[1]: Stopping go-librespot Daemon...
Sep 06 16:43:36 player systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:36 player systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 06 16:43:36 player systemd[1]: Stopped go-librespot Daemon.
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player systemd[1]: Started go-librespot Daemon.
Sep 06 16:43:36 player go-librespot[8649]: Librespot-go daemon starting...
Sep 06 16:43:36 player sudo[8639]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:36 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:36 player go-librespot[8649]: time="2024-09-06T16:43:36+02:00" level=info msg="generated new device id: 5b102ac0907b084482bb17644fbea72830362d4e"
Sep 06 16:43:36 player volumio[8482]: info: Starting Shairport Sync
Sep 06 16:43:36 player volumio[8482]: info: Starting Shairport Sync
Sep 06 16:43:36 player go-librespot[8649]: time="2024-09-06T16:43:36+02:00" level=debug msg="fetched new accesspoints: [ap2-gew1.spotify.com:4070 ap2-gew1.spotify.com:443 ap2-gew1.spotify.com:80 ap2-guc3.spotify.com:4070 ap2-gew4.spotify.com:443 ap2-gae2.spotify.com:80]"
Sep 06 16:43:36 player go-librespot[8649]: time="2024-09-06T16:43:36+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Sep 06 16:43:36 player go-librespot[8649]: time="2024-09-06T16:43:36+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Sep 06 16:43:36 player volumio[8482]: info: Starting Shairport Sync
Sep 06 16:43:36 player sudo[8675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:36 player sudo[8675]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:36 player sudo[8677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:36 player sudo[8677]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:37 player go-librespot[8649]: time="2024-09-06T16:43:37+02:00" level=debug msg="zeroconf server listening on port 39841"
Sep 06 16:43:37 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:37 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:37 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:37 player volumio[8482]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:37 player sudo[8681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:37 player sudo[8681]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:37 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:37 player volumio[8482]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:37 player volumio[8482]: info: Output device has changed, restarting MPD
Sep 06 16:43:37 player sudo[8675]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:37 player volumio[8482]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:37 player sudo[8685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:37 player sudo[8685]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:37 player sudo[8685]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:37 player sudo[8677]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:37 player sudo[8688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:37 player sudo[8688]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:37 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:37 player systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:37 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:37 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:37 player volumio[8482]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:37 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:37 player sudo[8681]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:37 player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:37 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:37 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:37 player volumio[8482]: info: MPD Permissions set
Sep 06 16:43:37 player volumio[8482]: info: Shairport-Sync Started
Sep 06 16:43:37 player volumio[8482]: Error adding Membership: Error: addMembership EINVAL
Sep 06 16:43:37 player volumio[8482]: info: Shairport-Sync Started
Sep 06 16:43:37 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:37 player volumio[8482]: info: Shairport-Sync Started
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:37 player volumio[8482]: info: Starting Shairport Sync
Sep 06 16:43:37 player sudo[8703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:43:37 player sudo[8703]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:37 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:43:37 player sudo[8695]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:37 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:43:37 player sudo[8695]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:37 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:37 player sudo[8695]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:37 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:43:37 player sudo[8703]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:37 player volumio[8482]: info: Shairport-Sync Started
Sep 06 16:43:37 player volumio[8482]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:43:37 player volumio[8482]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 06 16:43:37 player volumio[8482]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:43:38 player volumio[8482]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Sep 06 16:43:38 player volumio[8482]: info: camilladsp service started and running in background, instance 1
Sep 06 16:43:38 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:38 player volumio[8482]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:43:38 player volumio[8482]: 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 16:43:38 player volumio[8482]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:43:38 player volumio[8482]: info: FusionDsp loaded
Sep 06 16:43:38 player volumio[8482]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:38 player sudo[8720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 06 16:43:38 player sudo[8720]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:38 player volumio[8482]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 06 16:43:38 player volumio[8482]: info: Adding Signal Path Element [object Object]
Sep 06 16:43:38 player volumio[8482]: info: Adding fusiondspeq DSP Signal Path Element
Sep 06 16:43:38 player volumio[8482]: info: FusionDsp - ---- installed callbackRead
Sep 06 16:43:38 player volumio[8482]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:38 player sudo[8720]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:38 player volumio[8482]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 06 16:43:38 player volumio[8482]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 06 16:43:38 player volumio[8482]: at onErrorNT (internal/child_process.js:465:16)
Sep 06 16:43:38 player volumio[8482]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Sep 06 16:43:38 player volumio[8482]: errno: -2,
Sep 06 16:43:38 player volumio[8482]: code: 'ENOENT',
Sep 06 16:43:38 player volumio[8482]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:43:38 player volumio[8482]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:43:38 player volumio[8482]: spawnargs: [
Sep 06 16:43:38 player volumio[8482]: '-p',
Sep 06 16:43:38 player volumio[8482]: 9876,
Sep 06 16:43:38 player volumio[8482]: '-o',
Sep 06 16:43:38 player volumio[8482]: '/tmp/camilladsp.log',
Sep 06 16:43:38 player volumio[8482]: '-l',
Sep 06 16:43:38 player volumio[8482]: 'warn',
Sep 06 16:43:38 player volumio[8482]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 06 16:43:38 player volumio[8482]: ]
Sep 06 16:43:38 player volumio[8482]: }
Sep 06 16:43:38 player volumio[8482]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:38 player sudo[8731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 16:42
Sep 06 16:43:38 player sudo[8731]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:39 player sudo[8731]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:39 player volumio-remote-updater[649]: [2024-09-06 16:43:39] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 06 16:43:39 player volumio-remote-updater[649]: [2024-09-06 16:43:39] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 06 16:43:39 player systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 06 16:43:39 player sudo[8688]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:39 player sudo[8604]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:39 player sudo[8595]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:39 player systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 06 16:43:39 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:39 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:39 player mpd[8707]: Sep 06 16:43 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 06 16:43:39 player systemd[1]: Started Music Player Daemon.
Sep 06 16:43:39 player systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 06 16:43:39 player systemd[1]: volumio.service: Scheduled restart job, restart counter is at 33.
Sep 06 16:43:39 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:39 player systemd[1]: Stopped Volumio Backend Module.
Sep 06 16:43:39 player systemd[1]: Started Volumio Backend Module.
Sep 06 16:43:39 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:41 player volumio[8744]: info: -------------------------------------------
Sep 06 16:43:41 player volumio[8744]: info: ----- Volumio3 ----
Sep 06 16:43:41 player volumio[8744]: info: -------------------------------------------
Sep 06 16:43:41 player volumio[8744]: info: ----- System startup ----
Sep 06 16:43:41 player volumio[8744]: info: -------------------------------------------
Sep 06 16:43:42 player volumio[8744]: info: MYVOLUMIO Environment detected
Sep 06 16:43:42 player volumio[8744]: info: Plugin folders cleanup
Sep 06 16:43:42 player volumio[8744]: info: Scanning into folder /volumio/app/plugins/
Sep 06 16:43:42 player volumio[8744]: info: Scanning category audio_interface
Sep 06 16:43:42 player volumio[8744]: info: Scanning category miscellanea
Sep 06 16:43:42 player volumio[8744]: info: Scanning category music_service
Sep 06 16:43:42 player volumio[8744]: info: Scanning category plugins.json
Sep 06 16:43:42 player volumio[8744]: info: Scanning category system_controller
Sep 06 16:43:42 player volumio[8744]: info: Scanning category user_interface
Sep 06 16:43:42 player volumio[8744]: info: Scanning into folder /data/plugins/
Sep 06 16:43:42 player volumio[8744]: info: Scanning category audio_interface
Sep 06 16:43:42 player volumio[8744]: info: Scanning category music_service
Sep 06 16:43:42 player volumio[8744]: info: Plugin folders cleanup completed
Sep 06 16:43:42 player volumio[8744]: info: -------------------------------------------
Sep 06 16:43:42 player volumio[8744]: info: ----- Core plugins startup ----
Sep 06 16:43:42 player volumio[8744]: info: -------------------------------------------
Sep 06 16:43:42 player volumio[8744]: info: Loading plugins from folder /volumio/app/plugins/
Sep 06 16:43:42 player volumio[8744]: info: Adding plugin upnp to MyMusic Plugins
Sep 06 16:43:42 player volumio[8744]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 06 16:43:42 player volumio[8744]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 06 16:43:42 player volumio[8744]: info: Loading plugins from folder /data/plugins/
Sep 06 16:43:42 player volumio[8744]: info: Loading plugin "system"...
Sep 06 16:43:42 player volumio[8744]: info: Loading plugin "appearance"...
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "network"...
Sep 06 16:43:43 player volumio[8744]: info: Refreshing Cached IP Addresses
Sep 06 16:43:43 player sudo[8770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 06 16:43:43 player sudo[8770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "services"...
Sep 06 16:43:43 player sudo[8772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 06 16:43:43 player sudo[8770]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:43 player sudo[8772]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "alsa_controller"...
Sep 06 16:43:43 player sudo[8772]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:43 player sudo[8775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 06 16:43:43 player sudo[8775]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:43 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "wizard"...
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "networkfs"...
Sep 06 16:43:43 player volumio[8744]: info: Starting Udev Watcher for removable devices
Sep 06 16:43:43 player volumio[8744]: info: Ignoring mount for partition: boot
Sep 06 16:43:43 player volumio[8744]: info: Ignoring mount for partition: volumio
Sep 06 16:43:43 player volumio[8744]: info: Ignoring mount for partition: volumio_data
Sep 06 16:43:43 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "volumio_command_line_client"...
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "upnp"...
Sep 06 16:43:43 player volumio[8744]: info: [1725633823571] Starting Upmpd Daemon
Sep 06 16:43:43 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "my_music"...
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "mpd"...
Sep 06 16:43:43 player volumio[8744]: info: Loading plugin "upnp_browser"...
Sep 06 16:43:44 player volumio-remote-updater[649]: [2024-09-06 16:43:44] [connect] Successful connection
Sep 06 16:43:44 player volumio[8744]: info: Loading plugin "alarm-clock"...
Sep 06 16:43:44 player sudo[8775]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:44 player volumio[8744]: info: Loading plugin "airplay_emulation"...
Sep 06 16:43:44 player volumio[8744]: info: Starting Shairport Sync
Sep 06 16:43:44 player volumio[8744]: info: Loading plugin "last_100"...
Sep 06 16:43:44 player volumio[8744]: info: Loading plugin "webradio"...
Sep 06 16:43:44 player volumio[8744]: info: Loading plugin "i2s_dacs"...
Sep 06 16:43:44 player volumio[8744]: info: I2S DAC not set, start Auto-detection
Sep 06 16:43:44 player volumio[8744]: info: Loading plugin "volumiodiscovery"...
Sep 06 16:43:44 player volumio[8744]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:44 player volumio[8744]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:44 player volumio[8744]: *** WARNING *** For more information see
Sep 06 16:43:44 player node[8744]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:44 player volumio[8744]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:44 player volumio[8744]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:44 player volumio[8744]: *** WARNING *** For more information see
Sep 06 16:43:44 player node[8744]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:44 player node[8744]: *** WARNING *** For more information see
Sep 06 16:43:44 player node[8744]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:44 player node[8744]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:44 player node[8744]: *** WARNING *** For more information see
Sep 06 16:43:44 player volumio[8744]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 06 16:43:44 player volumio[8744]: info: Discovery: Started advertising with name: Player
Sep 06 16:43:44 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:44 player volumio[8744]: info: Loading plugin "spop"...
Sep 06 16:43:45 player volumio[8744]: info: Loading plugin "outputs"...
Sep 06 16:43:45 player volumio[8744]: info: Loading plugin "albumart"...
Sep 06 16:43:45 player volumio[8744]: info: Plugin example_plugin is not enabled
Sep 06 16:43:45 player volumio[8744]: info: Loading plugin "inputs"...
Sep 06 16:43:45 player volumio[8744]: info: Loading plugin "updater_comm"...
Sep 06 16:43:45 player volumio[8744]: info: Plugin mpdemulation is not enabled
Sep 06 16:43:45 player volumio[8744]: info: Loading plugin "rest_api"...
Sep 06 16:43:46 player volumio[8744]: info: Loading plugin "websocket"...
Sep 06 16:43:46 player volumio[8744]: info: Starting Socket.io Server version 2.3.0
Sep 06 16:43:46 player volumio[8744]: info: Loading plugin "fusiondsp"...
Sep 06 16:43:46 player volumio[8744]: Forking 3 albumart workers
Sep 06 16:43:46 player volumio[8744]: info: Applying required configuration parameters for plugin fusiondsp
Sep 06 16:43:46 player volumio[8744]: info: Loading i18n strings for locale fr
Sep 06 16:43:46 player volumio[8744]: Updating browse sources language
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::initPlayerControls
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:46 player volumio[8744]: Express server listening on port 3000
Sep 06 16:43:46 player volumio[8744]: [Metrics] WebUI: 5s 781.66ms
Sep 06 16:43:46 player volumio[8744]: info: CoreStateMachine::resetVolumioState
Sep 06 16:43:46 player volumio[8744]: info: CoreStateMachine::getcurrentVolume
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::volumioRetrievevolume
Sep 06 16:43:46 player volumio[8744]: info: CoreStateMachine::pushState
Sep 06 16:43:46 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:46 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:46 player volumio[8744]: info: Cannot read play queue from file
Sep 06 16:43:46 player volumio[8744]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 06 16:43:46 player volumio-remote-updater[649]: [2024-09-06 16:43:46] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725633824 101
Sep 06 16:43:46 player volumio[8744]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2
Sep 06 16:43:46 player volumio[8744]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 3
Sep 06 16:43:47 player volumio[8744]: info: CoreStateMachine::setRepeat null single undefined
Sep 06 16:43:47 player volumio[8744]: info: CoreStateMachine::pushState
Sep 06 16:43:47 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:47 player volumio[8744]: info: CoreStateMachine::setRandom null
Sep 06 16:43:47 player volumio[8744]: info: CoreStateMachine::pushState
Sep 06 16:43:47 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:47 player volumio[8744]: info: Setting Device type: Raspberry PI
Sep 06 16:43:47 player volumio[8744]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Sep 06 16:43:47 player volumio[8744]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Sep 06 16:43:47 player volumio[8744]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 06 16:43:47 player volumio[8744]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 06 16:43:47 player volumio[8744]: info: Received Get System Version
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:47 player volumio[8744]: info: Received Get System Info
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:47 player volumio[8744]: info: Discovery: Getting this device information
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:47 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:47 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:47 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 06 16:43:47 player volumio[8744]: info: Received Get System Info
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 16:43:47 player volumio[8744]: info: Discovery: Getting this device information
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:47 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:47 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:47 player volumio[8744]: info: Listing playlists
Sep 06 16:43:47 player volumio[8744]: info: Completed loading Core Plugins
Sep 06 16:43:47 player volumio[8744]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:47 player volumio[8744]: Starting albumart workers
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 06 16:43:47 player volumio[8744]: info: Discovery: adding cdb3bedc-36fc-4bbb-b5fa-1ceec2b4e007
Sep 06 16:43:47 player volumio[8744]: info: Discovery: Found device Player
Sep 06 16:43:47 player volumio[8744]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:47 player volumio[8744]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:47 player volumio[8744]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:47 player volumio[8744]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:47 player volumio[8744]: Starting albumart workers
Sep 06 16:43:47 player volumio[8744]: Starting albumart workers
Sep 06 16:43:48 player volumio[8744]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:48 player volumio[8744]: info: Output device has changed, restarting MPD
Sep 06 16:43:48 player sudo[8843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:48 player sudo[8843]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:48 player volumio[8744]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:48 player sudo[8843]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:48 player sudo[8846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:48 player sudo[8846]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:48 player systemd[1]: Stopping Music Player Daemon...
Sep 06 16:43:48 player volumio[8744]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:48 player volumio[8744]: info: ___________ START PLUGINS ___________
Sep 06 16:43:48 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:48 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:48 player volumio[8744]: info: ControllerMpd::onStart: Initializing MPD
Sep 06 16:43:48 player volumio[8744]: info: Creating MPD Configuration file
Sep 06 16:43:48 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:48 player sudo[8853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:48 player sudo[8853]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:48 player sudo[8853]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:48 player volumio[8744]: info: [1725633828794] CoreMusicLibrary::Adding element Serveurs Média
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:48 player sudo[8856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:48 player sudo[8856]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:48 player systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 06 16:43:48 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:48 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:48 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:48 player volumio[8744]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:48 player sudo[8858]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:48 player sudo[8858]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:48 player volumio[8744]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:48 player volumio[8744]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:49 player volumio[8744]: info: [1725633829000] CoreMusicLibrary::Adding element Last_100
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:49 player sudo[8858]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:49 player volumio[8744]: info: [1725633829005] CoreMusicLibrary::Adding element Webradio
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:49 player volumio[8744]: info: Initializing BBC Radios
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: Creating Spotify config file
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: Loading i18n strings for locale fr
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: FusionDsp - mixtype--------------------- None
Sep 06 16:43:49 player volumio[8744]: info: Volumio Calling Home
Sep 06 16:43:49 player volumio[8744]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:49 player volumio[8744]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:49 player volumio[8744]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:49 player volumio[8744]: info: MPD Permissions set
Sep 06 16:43:49 player volumio[8744]: info: MPD Permissions set
Sep 06 16:43:49 player volumio[8744]: info: Volumio called home
Sep 06 16:43:49 player volumio[8744]: info: Spotify config file written
Sep 06 16:43:49 player volumio[8744]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Sep 06 16:43:49 player sudo[8881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player sudo[8881]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player systemd[1]: Stopping go-librespot Daemon...
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:43:49 player systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player systemd[1]: Stopped go-librespot Daemon.
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:49 player volumio[8744]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:49 player go-librespot[8887]: Librespot-go daemon starting...
Sep 06 16:43:49 player systemd[1]: Started go-librespot Daemon.
Sep 06 16:43:49 player go-librespot[8887]: time="2024-09-06T16:43:49+02:00" level=info msg="generated new device id: 4c0c59fef9fe58639bd95abeb8b5f124d0a626eb"
Sep 06 16:43:49 player sudo[8881]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:49 player volumio[8744]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:49 player volumio[8744]: TypeError: Cannot read property 'off' of undefined
Sep 06 16:43:49 player volumio[8744]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15)
Sep 06 16:43:49 player volumio[8744]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Sep 06 16:43:49 player volumio[8744]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8)
Sep 06 16:43:49 player volumio[8744]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1537:29)
Sep 06 16:43:49 player volumio[8744]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1387:47)
Sep 06 16:43:49 player volumio[8744]: at Socket.emit (events.js:315:20)
Sep 06 16:43:49 player volumio[8744]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Sep 06 16:43:49 player volumio[8744]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Sep 06 16:43:49 player volumio[8744]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:43:49 player go-librespot[8887]: time="2024-09-06T16:43:49+02:00" level=debug msg="fetched new accesspoints: [ap2-gew1.spotify.com:4070 ap2-gew1.spotify.com:443 ap2-gew1.spotify.com:80 ap2-guc3.spotify.com:4070 ap2-gue1.spotify.com:443 ap2-gew4.spotify.com:80]"
Sep 06 16:43:49 player go-librespot[8887]: time="2024-09-06T16:43:49+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Sep 06 16:43:49 player go-librespot[8887]: time="2024-09-06T16:43:49+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Sep 06 16:43:49 player go-librespot[8887]: time="2024-09-06T16:43:49+02:00" level=debug msg="zeroconf server listening on port 41731"
Sep 06 16:43:50 player sudo[8908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 16:42
Sep 06 16:43:50 player sudo[8908]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:50 player sudo[8908]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:50 player mpd[8866]: Sep 06 16:43 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 06 16:43:50 player systemd[1]: Started Music Player Daemon.
Sep 06 16:43:50 player sudo[8856]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:50 player sudo[8846]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:51 player volumio-remote-updater[649]: [2024-09-06 16:43:51] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 06 16:43:51 player volumio-remote-updater[649]: [2024-09-06 16:43:51] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 06 16:43:51 player systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 06 16:43:51 player systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 06 16:43:51 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:51 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:51 player systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 06 16:43:51 player systemd[1]: volumio.service: Scheduled restart job, restart counter is at 34.
Sep 06 16:43:51 player systemd[1]: Stopped Volumio Backend Module.
Sep 06 16:43:51 player systemd[1]: Started Volumio Backend Module.
Sep 06 16:43:51 player systemd[1]: Started dynamicswap service.
Sep 06 16:43:51 player systemd[1]: dynamicswap.service: Succeeded.
Sep 06 16:43:53 player volumio[8923]: info: -------------------------------------------
Sep 06 16:43:53 player volumio[8923]: info: ----- Volumio3 ----
Sep 06 16:43:53 player volumio[8923]: info: -------------------------------------------
Sep 06 16:43:53 player volumio[8923]: info: ----- System startup ----
Sep 06 16:43:53 player volumio[8923]: info: -------------------------------------------
Sep 06 16:43:54 player volumio[8923]: info: MYVOLUMIO Environment detected
Sep 06 16:43:54 player volumio[8923]: info: Plugin folders cleanup
Sep 06 16:43:54 player volumio[8923]: info: Scanning into folder /volumio/app/plugins/
Sep 06 16:43:54 player volumio[8923]: info: Scanning category audio_interface
Sep 06 16:43:54 player volumio[8923]: info: Scanning category miscellanea
Sep 06 16:43:54 player volumio[8923]: info: Scanning category music_service
Sep 06 16:43:54 player volumio[8923]: info: Scanning category plugins.json
Sep 06 16:43:54 player volumio[8923]: info: Scanning category system_controller
Sep 06 16:43:54 player volumio[8923]: info: Scanning category user_interface
Sep 06 16:43:54 player volumio[8923]: info: Scanning into folder /data/plugins/
Sep 06 16:43:54 player volumio[8923]: info: Scanning category audio_interface
Sep 06 16:43:54 player volumio[8923]: info: Scanning category music_service
Sep 06 16:43:54 player volumio[8923]: info: Plugin folders cleanup completed
Sep 06 16:43:54 player volumio[8923]: info: -------------------------------------------
Sep 06 16:43:54 player volumio[8923]: info: ----- Core plugins startup ----
Sep 06 16:43:54 player volumio[8923]: info: -------------------------------------------
Sep 06 16:43:54 player volumio[8923]: info: Loading plugins from folder /volumio/app/plugins/
Sep 06 16:43:54 player volumio[8923]: info: Adding plugin upnp to MyMusic Plugins
Sep 06 16:43:54 player volumio[8923]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 06 16:43:54 player volumio[8923]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 06 16:43:54 player volumio[8923]: info: Loading plugins from folder /data/plugins/
Sep 06 16:43:54 player volumio[8923]: info: Loading plugin "system"...
Sep 06 16:43:54 player volumio[8923]: info: Loading plugin "appearance"...
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "network"...
Sep 06 16:43:55 player volumio[8923]: info: Refreshing Cached IP Addresses
Sep 06 16:43:55 player sudo[8950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 06 16:43:55 player sudo[8950]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:55 player sudo[8950]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:55 player sudo[8952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 06 16:43:55 player sudo[8952]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "services"...
Sep 06 16:43:55 player sudo[8952]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "alsa_controller"...
Sep 06 16:43:55 player sudo[8955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 06 16:43:55 player sudo[8955]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:55 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "wizard"...
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "networkfs"...
Sep 06 16:43:55 player volumio[8923]: info: Starting Udev Watcher for removable devices
Sep 06 16:43:55 player volumio[8923]: info: Ignoring mount for partition: boot
Sep 06 16:43:55 player volumio[8923]: info: Ignoring mount for partition: volumio
Sep 06 16:43:55 player volumio[8923]: info: Ignoring mount for partition: volumio_data
Sep 06 16:43:55 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "volumio_command_line_client"...
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "upnp"...
Sep 06 16:43:55 player volumio[8923]: info: [1725633835497] Starting Upmpd Daemon
Sep 06 16:43:55 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "my_music"...
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "mpd"...
Sep 06 16:43:55 player volumio[8923]: info: Loading plugin "upnp_browser"...
Sep 06 16:43:56 player volumio[8923]: info: Loading plugin "alarm-clock"...
Sep 06 16:43:56 player sudo[8955]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:56 player volumio-remote-updater[649]: [2024-09-06 16:43:56] [connect] Successful connection
Sep 06 16:43:56 player volumio[8923]: info: Loading plugin "airplay_emulation"...
Sep 06 16:43:56 player volumio[8923]: info: Starting Shairport Sync
Sep 06 16:43:56 player volumio[8923]: info: Loading plugin "last_100"...
Sep 06 16:43:56 player volumio[8923]: info: Loading plugin "webradio"...
Sep 06 16:43:56 player volumio[8923]: info: Loading plugin "i2s_dacs"...
Sep 06 16:43:56 player volumio[8923]: info: I2S DAC not set, start Auto-detection
Sep 06 16:43:56 player volumio[8923]: info: Loading plugin "volumiodiscovery"...
Sep 06 16:43:56 player volumio[8923]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:56 player volumio[8923]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:56 player volumio[8923]: *** WARNING *** For more information see
Sep 06 16:43:56 player node[8923]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:56 player volumio[8923]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:56 player volumio[8923]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:56 player volumio[8923]: *** WARNING *** For more information see
Sep 06 16:43:56 player node[8923]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:56 player node[8923]: *** WARNING *** For more information see
Sep 06 16:43:56 player node[8923]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 06 16:43:56 player node[8923]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 06 16:43:56 player node[8923]: *** WARNING *** For more information see
Sep 06 16:43:56 player volumio[8923]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 06 16:43:56 player volumio[8923]: info: Discovery: Started advertising with name: Player
Sep 06 16:43:56 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 06 16:43:56 player volumio[8923]: info: Loading plugin "spop"...
Sep 06 16:43:57 player volumio[8923]: info: Loading plugin "outputs"...
Sep 06 16:43:57 player volumio[8923]: info: Loading plugin "albumart"...
Sep 06 16:43:57 player volumio[8923]: info: Plugin example_plugin is not enabled
Sep 06 16:43:57 player volumio[8923]: info: Loading plugin "inputs"...
Sep 06 16:43:57 player volumio[8923]: info: Loading plugin "updater_comm"...
Sep 06 16:43:57 player volumio[8923]: info: Plugin mpdemulation is not enabled
Sep 06 16:43:57 player volumio[8923]: info: Loading plugin "rest_api"...
Sep 06 16:43:57 player volumio[8923]: info: Loading plugin "websocket"...
Sep 06 16:43:57 player volumio[8923]: info: Starting Socket.io Server version 2.3.0
Sep 06 16:43:57 player volumio[8923]: info: Loading plugin "fusiondsp"...
Sep 06 16:43:58 player volumio[8923]: Forking 3 albumart workers
Sep 06 16:43:58 player volumio[8923]: info: Applying required configuration parameters for plugin fusiondsp
Sep 06 16:43:58 player volumio[8923]: info: Loading i18n strings for locale fr
Sep 06 16:43:58 player volumio[8923]: Updating browse sources language
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::initPlayerControls
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:58 player volumio[8923]: Express server listening on port 3000
Sep 06 16:43:58 player volumio[8923]: [Metrics] WebUI: 5s 792.53ms
Sep 06 16:43:58 player volumio[8923]: info: CoreStateMachine::resetVolumioState
Sep 06 16:43:58 player volumio[8923]: info: CoreStateMachine::getcurrentVolume
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::volumioRetrievevolume
Sep 06 16:43:58 player volumio[8923]: info: CoreStateMachine::pushState
Sep 06 16:43:58 player volumio[8923]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:58 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:58 player volumio[8923]: info: Cannot read play queue from file
Sep 06 16:43:58 player volumio[8923]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 06 16:43:58 player volumio[8923]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 06 16:43:58 player volumio-remote-updater[649]: [2024-09-06 16:43:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725633836 101
Sep 06 16:43:58 player volumio[8923]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3
Sep 06 16:43:58 player volumio[8923]: verbose: New Socket.io Connection to 192.168.1.154 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
Sep 06 16:43:59 player volumio[8923]: info: CoreStateMachine::setRepeat null single undefined
Sep 06 16:43:59 player volumio[8923]: info: CoreStateMachine::pushState
Sep 06 16:43:59 player volumio[8923]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:59 player volumio[8923]: info: CoreStateMachine::setRandom null
Sep 06 16:43:59 player volumio[8923]: info: CoreStateMachine::pushState
Sep 06 16:43:59 player volumio[8923]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::volumioPushState
Sep 06 16:43:59 player volumio[8923]: info: Setting Device type: Raspberry PI
Sep 06 16:43:59 player volumio[8923]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Sep 06 16:43:59 player volumio[8923]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Sep 06 16:43:59 player volumio[8923]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Sep 06 16:43:59 player volumio[8923]: info: Completed loading Core Plugins
Sep 06 16:43:59 player volumio[8923]: info: Preparing to generate the ALSA configuration file
Sep 06 16:43:59 player volumio[8923]: info: Discovery: adding cdb3bedc-36fc-4bbb-b5fa-1ceec2b4e007
Sep 06 16:43:59 player volumio[8923]: info: Discovery: Found device Player
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::volumioGetState
Sep 06 16:43:59 player volumio[8923]: info: CorePlayQueue::getTrack 0
Sep 06 16:43:59 player volumio[8923]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:43:59 player volumio[8923]: info: Reading ALSA contributions from plugins.
Sep 06 16:43:59 player volumio[8923]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:43:59 player volumio[8923]: info: Output device has changed, restarting MPD
Sep 06 16:43:59 player volumio[8923]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:59 player sudo[9001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:59 player sudo[9001]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:59 player sudo[9001]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:59 player sudo[9002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:59 player sudo[9002]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:59 player volumio[8923]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:59 player volumio[8923]: info: ___________ START PLUGINS ___________
Sep 06 16:43:59 player volumio[8923]: info: ControllerMpd::onStart: Initializing MPD
Sep 06 16:43:59 player volumio[8923]: info: Creating MPD Configuration file
Sep 06 16:43:59 player volumio[8923]: Starting albumart workers
Sep 06 16:43:59 player systemd[1]: Stopping Music Player Daemon...
Sep 06 16:43:59 player volumio[8923]: Starting albumart workers
Sep 06 16:43:59 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:59 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:59 player volumio[8923]: info: [1725633839398] CoreMusicLibrary::Adding element Serveurs Média
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:59 player volumio[8923]: Starting albumart workers
Sep 06 16:43:59 player sudo[9010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:43:59 player sudo[9010]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:59 player sudo[9010]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:59 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:59 player sudo[9011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:43:59 player sudo[9011]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:59 player systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 06 16:43:59 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:43:59 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:43:59 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:43:59 player volumio[8923]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:59 player volumio[8923]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:59 player volumio[8923]: info: [1725633839653] CoreMusicLibrary::Adding element Last_100
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 06 16:43:59 player volumio[8923]: info: [1725633839659] CoreMusicLibrary::Adding element Webradio
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:59 player sudo[9018]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:43:59 player sudo[9018]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:43:59 player sudo[9018]: pam_unix(sudo:session): session closed for user root
Sep 06 16:43:59 player volumio[8923]: info: Initializing BBC Radios
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:43:59 player volumio[8923]: info: Creating Spotify config file
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:59 player volumio[8923]: info: Loading i18n strings for locale fr
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 06 16:43:59 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:43:59 player volumio[8923]: info: FusionDsp - mixtype--------------------- None
Sep 06 16:43:59 player volumio[8923]: info: Volumio Calling Home
Sep 06 16:44:00 player volumio[8923]: info: Preparing to generate the ALSA configuration file
Sep 06 16:44:00 player volumio[8923]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 06 16:44:00 player volumio[8923]: info: Reading ALSA contributions from plugins.
Sep 06 16:44:00 player volumio[8923]: info: MPD Permissions set
Sep 06 16:44:00 player volumio[8923]: info: MPD Permissions set
Sep 06 16:44:00 player volumio[8923]: info: Volumio called home
Sep 06 16:44:00 player volumio[8923]: info: Spotify config file written
Sep 06 16:44:00 player volumio[8923]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Sep 06 16:44:00 player sudo[9046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 06 16:44:00 player sudo[9046]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player systemd[1]: Stopping go-librespot Daemon...
Sep 06 16:44:00 player systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:44:00 player systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 06 16:44:00 player systemd[1]: Stopped go-librespot Daemon.
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player systemd[1]: Started go-librespot Daemon.
Sep 06 16:44:00 player go-librespot[9056]: Librespot-go daemon starting...
Sep 06 16:44:00 player sudo[9046]: pam_unix(sudo:session): session closed for user root
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:44:00 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:00 player go-librespot[9056]: time="2024-09-06T16:44:00+02:00" level=info msg="generated new device id: 1324ac33d11a9cdd10e0680485945e3ab453de11"
Sep 06 16:44:00 player volumio[8923]: info: Starting Shairport Sync
Sep 06 16:44:00 player volumio[8923]: info: Starting Shairport Sync
Sep 06 16:44:00 player volumio[8923]: info: Starting Shairport Sync
Sep 06 16:44:01 player sudo[9082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:44:01 player sudo[9082]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:01 player sudo[9083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:44:01 player sudo[9083]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:01 player sudo[9086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:44:01 player sudo[9086]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:01 player go-librespot[9056]: time="2024-09-06T16:44:01+02:00" level=debug msg="fetched new accesspoints: [ap2-gew1.spotify.com:4070 ap2-gew1.spotify.com:443 ap2-gew1.spotify.com:80 ap2-guc3.spotify.com:4070 ap2-gue1.spotify.com:443 ap2-gew4.spotify.com:80]"
Sep 06 16:44:01 player go-librespot[9056]: time="2024-09-06T16:44:01+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Sep 06 16:44:01 player go-librespot[9056]: time="2024-09-06T16:44:01+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::volumioGetState
Sep 06 16:44:01 player volumio[8923]: info: CorePlayQueue::getTrack 0
Sep 06 16:44:01 player go-librespot[9056]: time="2024-09-06T16:44:01+02:00" level=debug msg="zeroconf server listening on port 44631"
Sep 06 16:44:01 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:44:01 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:44:01 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:44:01 player volumio[8923]: info: Asound.conf file unchanged, so no further update is needed
Sep 06 16:44:01 player volumio[8923]: info: Output device has changed, restarting MPD
Sep 06 16:44:01 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:44:01 player sudo[9086]: pam_unix(sudo:session): session closed for user root
Sep 06 16:44:01 player sudo[9083]: pam_unix(sudo:session): session closed for user root
Sep 06 16:44:01 player sudo[9082]: pam_unix(sudo:session): session closed for user root
Sep 06 16:44:01 player volumio[8923]: info: Output device has changed, restarting Shairport Sync
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:44:01 player sudo[9092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 06 16:44:01 player sudo[9095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 06 16:44:01 player sudo[9092]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:01 player sudo[9095]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:01 player sudo[9092]: pam_unix(sudo:session): session closed for user root
Sep 06 16:44:01 player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 06 16:44:01 player systemd[1]: mpd.service: Succeeded.
Sep 06 16:44:01 player systemd[1]: Stopped Music Player Daemon.
Sep 06 16:44:01 player volumio[8923]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 06 16:44:01 player systemd[1]: Starting Music Player Daemon...
Sep 06 16:44:01 player volumio[8923]: info: MPD Permissions set
Sep 06 16:44:01 player volumio[8923]: info: Shairport-Sync Started
Sep 06 16:44:01 player volumio[8923]: Error adding Membership: Error: addMembership EINVAL
Sep 06 16:44:01 player volumio[8923]: info: Shairport-Sync Started
Sep 06 16:44:01 player volumio[8923]: info: Shairport-Sync Started
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:01 player volumio[8923]: info: Starting Shairport Sync
Sep 06 16:44:01 player sudo[9109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 06 16:44:01 player sudo[9109]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:01 player sudo[9102]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 06 16:44:01 player sudo[9102]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:01 player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 06 16:44:01 player systemd[1]: shairport-sync.service: Succeeded.
Sep 06 16:44:01 player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:44:01 player sudo[9102]: pam_unix(sudo:session): session closed for user root
Sep 06 16:44:01 player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 06 16:44:01 player sudo[9109]: pam_unix(sudo:session): session closed for user root
Sep 06 16:44:01 player volumio[8923]: info: Shairport-Sync Started
Sep 06 16:44:02 player volumio[8923]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:44:02 player volumio[8923]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 06 16:44:02 player volumio[8923]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 06 16:44:02 player volumio[8923]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Sep 06 16:44:02 player volumio[8923]: info: camilladsp service started and running in background, instance 1
Sep 06 16:44:02 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 06 16:44:02 player volumio[8923]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:44:02 player volumio[8923]: 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 16:44:02 player volumio[8923]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 06 16:44:02 player volumio[8923]: info: FusionDsp loaded
Sep 06 16:44:02 player volumio[8923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 16:44:02 player sudo[9126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 06 16:44:02 player sudo[9126]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 16:44:02 player volumio[8923]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 06 16:44:02 player volumio[8923]: info: Adding Signal Path Element [object Object]
Sep 06 16:44:02 player volumio[8923]: info: Adding fusiondspeq DSP Signal Path Element
Sep 06 16:44:02 player volumio[8923]: info: FusionDsp - ---- installed callbackRead
Sep 06 16:44:02 player sudo[9126]: pam_unix(sudo:session): session closed for user root
Sep 06 16:44:02 player volumio[8923]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:44:02 player volumio[8923]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 06 16:44:02 player volumio[8923]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 06 16:44:02 player volumio[8923]: at onErrorNT (internal/child_process.js:465:16)
Sep 06 16:44:02 player volumio[8923]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Sep 06 16:44:02 player volumio[8923]: errno: -2,
Sep 06 16:44:02 player volumio[8923]: code: 'ENOENT',
Sep 06 16:44:02 player volumio[8923]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:44:02 player volumio[8923]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 06 16:44:02 player volumio[8923]: spawnargs: [
Sep 06 16:44:02 player volumio[8923]: '-p',
Sep 06 16:44:02 player volumio[8923]: 9876,
Sep 06 16:44:02 player volumio[8923]: '-o',
Sep 06 16:44:02 player volumio[8923]: '/tmp/camilladsp.log',
Sep 06 16:44:02 player volumio[8923]: '-l',
Sep 06 16:44:02 player volumio[8923]: 'warn',
Sep 06 16:44:02 player volumio[8923]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 06 16:44:02 player volumio[8923]: ]
Sep 06 16:44:02 player volumio[8923]: }
Sep 06 16:44:02 player volumio[8923]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 16:44:02 player sudo[9137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 16:43
Sep 06 16:44:02 player sudo[9137]: 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"