-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Fri 2024-11-29 11:59:35 CST. -- Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="handling play player command from 959640ceadeb0a88d463b09819964a37c7414931" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="resolved context of track" uri="spotify:playlist:37i9dQZF1E4n71JwFu3GnD" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=trace msg="fetched new page 0 with 50 items (list: 50)" uri="spotify:playlist:37i9dQZF1E4n71JwFu3GnD" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="loading track (paused: false, position: 1ms)" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=trace msg="emitting websocket event: will_play" Nov 29 11:58:04 volumio.pi4 volumio[899]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:1Qdnvn4XlmZANCVy3XjrQo","play_origin":"playlist/ondemand"}} Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="selected format OGG_VORBIS_320 (174da3707b114930ba1eb9d29ae4e74d75457fbc)" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="requested aes key for file 174da3707b114930ba1eb9d29ae4e74d75457fbc, gid: 1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="fetched first chunk of 21, total size is 10742884 bytes" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=trace msg="seek to 1ms (diff: 1ms, samples: 44, bytes: 0)" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=info msg="loaded track \"Show Me How to Live\" (paused: false, position: 1ms, duration: 277840ms, prefetched: false)" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="fetched chunk 2/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=trace msg="scheduling prefetch in 247s" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=trace msg="emitting websocket event: metadata" Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="sending successful reply for dealer request" Nov 29 11:58:04 volumio.pi4 volumio[899]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:1Qdnvn4XlmZANCVy3XjrQo","name":"Show Me How to Live","artist_names":["Audioslave"],"album_name":"Audioslave","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02a7292b6863258e889b78d787","position":1,"duration":277840,"release_date":"year:2002 month:11 day:17","track_number":2,"disc_number":1}} Nov 29 11:58:04 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:04-06:00" level=debug msg="fetched chunk 3/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:05 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:05-06:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 29 11:58:05 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:05-06:00" level=trace msg="emitting websocket event: playing" Nov 29 11:58:05 volumio.pi4 volumio[899]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:1Qdnvn4XlmZANCVy3XjrQo","play_origin":"playlist/ondemand"}} Nov 29 11:58:05 volumio.pi4 volumio[899]: SPOTIFY: PUSH STATE SPOTIFY Nov 29 11:58:05 volumio.pi4 volumio[899]: SPOTIFY: {"status":"play","service":"spop","title":"Show Me How to Live","artist":"Audioslave","album":"Audioslave","albumart":"https://i.scdn.co/image/ab67616d00001e02a7292b6863258e889b78d787","uri":"spotify:track:1Qdnvn4XlmZANCVy3XjrQo","trackType":"spotify","seek":1,"duration":277,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Nov 29 11:58:05 volumio.pi4 volumio[899]: info: CoreCommandRouter::servicePushState Nov 29 11:58:05 volumio.pi4 volumio[899]: info: CoreStateMachine::pushState Nov 29 11:58:05 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 11:58:05 volumio.pi4 volumio[899]: info: CoreCommandRouter::volumioPushState Nov 29 11:58:05 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:05-06:00" level=debug msg="fetched chunk 1/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:05 volumio.pi4 volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Nov 29 11:58:05 volumio.pi4 volumio[899]: info: [LastFM] Current track has sufficient metadata: title (Show Me How to Live) and artist (Audioslave) passed on explicitly Nov 29 11:58:05 volumio.pi4 volumio[899]: SPOTIFY: PUSH STATE SPOTIFY Nov 29 11:58:05 volumio.pi4 volumio[899]: SPOTIFY: {"status":"play","service":"spop","title":"Show Me How to Live","artist":"Audioslave","album":"Audioslave","albumart":"https://i.scdn.co/image/ab67616d00001e02a7292b6863258e889b78d787","uri":"spotify:track:1Qdnvn4XlmZANCVy3XjrQo","trackType":"spotify","seek":1,"duration":277,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Nov 29 11:58:05 volumio.pi4 volumio[899]: info: CoreCommandRouter::servicePushState Nov 29 11:58:05 volumio.pi4 volumio[899]: info: CoreStateMachine::pushState Nov 29 11:58:05 volumio.pi4 volumio[899]: info: CoreCommandRouter::volumioPushState Nov 29 11:58:05 volumio.pi4 volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Nov 29 11:58:05 volumio.pi4 volumio[899]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Show Me How To Live","mbid":"62d9d200-5445-4ee9-9541-88345027d0f1","url":"https://www.last.fm/music/Audioslave/_/Show+Me+How+To+Live","duration":"324000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"905036","playcount":"5895527","artist":{"name":"Audioslave","mbid":"020bfbb4-05c3-4c86-b372-17825c262094","url":"https://www.last.fm/music/Audioslave"},"album":{"@":{"position":"2"},"artist":"Audioslave","title":"Audioslave","mbid":"399047ca-8a49-3693-915d-4db57cce2bb7","url":"https://www.last.fm/music/Audioslave/Audioslave","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/ed071004b3a64afb8b2a8397aad1bed4.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/ed071004b3a64afb8b2a8397aad1bed4.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/ed071004b3a64afb8b2a8397aad1bed4.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/ed071004b3a64afb8b2a8397aad1bed4.png","@":{"size":"extralarge"}}]},"userplaycount":"16","userloved":"0","toptags":{"tag":[{"name":"rock","url":"https://www.last.fm/tag/rock"},{"name":"alternative rock","url":"https://www.last.fm/tag/alternative+rock"},{"name":"hard rock","url":"https://www.last.fm/tag/hard+rock"},{"name":"alternative","url":"https://www.last.fm/tag/alternative"},{"name":"Audioslave","url":"https://www.last.fm/tag/Audioslave"}]},"wiki":{"published":"17 Jun 2009, 05:53","summary":"This is from the first album, entitled \"Audioslave\", and it was one of their first singles. The video is based on \"Vanishing Point\", a movie from 1971. Read more on Last.fm.","content":"This is from the first album, entitled \"Audioslave\", and it was one of their first singles. The video is based on \"Vanishing Point\", a movie from 1971. Read more on Last.fm. User-contributed text is available under the Creative Commons By-SA License; additional terms may apply."}}} Nov 29 11:58:18 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:18-06:00" level=debug msg="fetched chunk 4/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:32 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:32-06:00" level=debug msg="fetched chunk 5/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:45 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:45-06:00" level=debug msg="fetched chunk 6/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:58:59 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:58:59-06:00" level=debug msg="fetched chunk 7/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:59:12 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:59:12-06:00" level=debug msg="fetched chunk 8/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:59:25 volumio.pi4 go-librespot[2351]: time="2024-11-29T11:59:25-06:00" level=debug msg="fetched chunk 9/20, size: 524288" uri="spotify:track:1Qdnvn4XlmZANCVy3XjrQo" Nov 29 11:59:31 volumio.pi4 volumio[899]: info: Enabling plugin fusiondsp Nov 29 11:59:31 volumio.pi4 volumio[899]: info: Loading plugin "fusiondsp"... Nov 29 11:59:31 volumio.pi4 volumio[899]: error: Could not copy default configuration to /data/configuration/audio_interface/fusiondsp/config.json Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Preparing to generate the ALSA configuration file Nov 29 11:59:32 volumio.pi4 volumio[899]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Reading ALSA contributions from plugins. Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Asound.conf file written Nov 29 11:59:32 volumio.pi4 sudo[6280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 29 11:59:32 volumio.pi4 sudo[6280]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:32 volumio.pi4 sudo[6280]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Output device has changed, restarting MPD Nov 29 11:59:32 volumio.pi4 sudo[6285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 11:59:32 volumio.pi4 sudo[6285]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Output device has changed, restarting Shairport Sync Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 11:59:32 volumio.pi4 sudo[6285]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:32 volumio.pi4 sudo[6288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 11:59:32 volumio.pi4 sudo[6288]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:32 volumio.pi4 systemd[1]: Stopping Music Player Daemon... Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 11:59:32 volumio.pi4 volumio[899]: info: PLUGIN START: fusiondsp Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Loading i18n strings for locale en Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: FusionDsp - mixtype--------------------- Hardware Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Preparing to generate the ALSA configuration file Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Done. Nov 29 11:59:32 volumio.pi4 volumio[899]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Reading ALSA contributions from plugins. Nov 29 11:59:32 volumio.pi4 volumio[899]: info: MPD Permissions set Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 systemd[1]: mpd.service: Succeeded. Nov 29 11:59:32 volumio.pi4 systemd[1]: Stopped Music Player Daemon. Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Starting Shairport Sync Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Asound.conf file unchanged, so no further update is needed Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Output device has changed, restarting MPD Nov 29 11:59:32 volumio.pi4 systemd[1]: Starting Music Player Daemon... Nov 29 11:59:32 volumio.pi4 sudo[6299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 11:59:32 volumio.pi4 sudo[6299]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:32 volumio.pi4 sudo[6302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 11:59:32 volumio.pi4 sudo[6302]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:32 volumio.pi4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 11:59:32 volumio.pi4 sudo[6302]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Output device has changed, restarting Shairport Sync Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 11:59:32 volumio.pi4 systemd[1]: shairport-sync.service: Succeeded. Nov 29 11:59:32 volumio.pi4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 29 11:59:32 volumio.pi4 sudo[6305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 11:59:32 volumio.pi4 sudo[6305]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:32 volumio.pi4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 11:59:32 volumio.pi4 sudo[6299]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 11:59:32 volumio.pi4 volumio[899]: info: MPD Permissions set Nov 29 11:59:32 volumio.pi4 volumio[899]: info: Shairport-Sync Started Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:32 volumio.pi4 sudo[6297]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 29 11:59:32 volumio.pi4 sudo[6297]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:32 volumio.pi4 sudo[6297]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:32 volumio.pi4 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 29 11:59:32 volumio.pi4 systemd[1]: mpd.service: Succeeded. Nov 29 11:59:32 volumio.pi4 systemd[1]: Stopped Music Player Daemon. Nov 29 11:59:33 volumio.pi4 systemd[1]: Starting Music Player Daemon... Nov 29 11:59:33 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 11:59:33 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:33 volumio.pi4 volumio[899]: info: Starting Shairport Sync Nov 29 11:59:33 volumio.pi4 sudo[6319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 11:59:33 volumio.pi4 sudo[6319]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:33 volumio.pi4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 11:59:33 volumio.pi4 systemd[1]: shairport-sync.service: Succeeded. Nov 29 11:59:33 volumio.pi4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 29 11:59:33 volumio.pi4 sudo[6312]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 29 11:59:33 volumio.pi4 sudo[6312]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:33 volumio.pi4 sudo[6312]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:33 volumio.pi4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 11:59:33 volumio.pi4 sudo[6319]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:33 volumio.pi4 volumio[899]: info: Shairport-Sync Started Nov 29 11:59:33 volumio.pi4 volumio[899]: Configuration write error: Error: ENOENT: no such file or directory, open '/data/configuration/audio_interface/fusiondsp/config.json' Nov 29 11:59:34 volumio.pi4 volumio[899]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 29 11:59:34 volumio.pi4 volumio[899]: info: camilladsp service started and running in background, instance 1 Nov 29 11:59:34 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 11:59:34 volumio.pi4 volumio[899]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent Nov 29 11:59:34 volumio.pi4 volumio[899]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 29 11:59:34 volumio.pi4 volumio[899]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent Nov 29 11:59:34 volumio.pi4 mpd[6325]: Nov 29 11:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 29 11:59:34 volumio.pi4 mpd[6325]: Nov 29 11:59 : exception: Failed to open '/var/lib/mpd/tag_cache': No such file or directory Nov 29 11:59:34 volumio.pi4 systemd[1]: Started Music Player Daemon. Nov 29 11:59:34 volumio.pi4 sudo[6288]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:34 volumio.pi4 sudo[6305]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:34 volumio.pi4 volumio[899]: info: FusionDsp loaded Nov 29 11:59:34 volumio.pi4 volumio[899]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 11:59:34 volumio.pi4 sudo[6341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 29 11:59:34 volumio.pi4 sudo[6341]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 11:59:34 volumio.pi4 volumio[899]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 29 11:59:34 volumio.pi4 volumio[899]: info: Adding Signal Path Element [object Object] Nov 29 11:59:34 volumio.pi4 volumio[899]: info: Adding fusiondspeq DSP Signal Path Element Nov 29 11:59:34 volumio.pi4 volumio[899]: info: FusionDsp - ---- installed callbackRead Nov 29 11:59:34 volumio.pi4 volumio[899]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 11:59:34 volumio.pi4 sudo[6341]: pam_unix(sudo:session): session closed for user root Nov 29 11:59:34 volumio.pi4 volumio[899]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES Nov 29 11:59:34 volumio.pi4 volumio[899]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 29 11:59:34 volumio.pi4 volumio[899]: at onErrorNT (internal/child_process.js:465:16) Nov 29 11:59:34 volumio.pi4 volumio[899]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Nov 29 11:59:34 volumio.pi4 volumio[899]: errno: -13, Nov 29 11:59:34 volumio.pi4 volumio[899]: code: 'EACCES', Nov 29 11:59:34 volumio.pi4 volumio[899]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 29 11:59:34 volumio.pi4 volumio[899]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 29 11:59:34 volumio.pi4 volumio[899]: spawnargs: [ Nov 29 11:59:34 volumio.pi4 volumio[899]: '-p', Nov 29 11:59:34 volumio.pi4 volumio[899]: 9876, Nov 29 11:59:34 volumio.pi4 volumio[899]: '-o', Nov 29 11:59:34 volumio.pi4 volumio[899]: '/tmp/camilladsp.log', Nov 29 11:59:34 volumio.pi4 volumio[899]: '-l', Nov 29 11:59:34 volumio.pi4 volumio[899]: 'warn', Nov 29 11:59:34 volumio.pi4 volumio[899]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 29 11:59:34 volumio.pi4 volumio[899]: ] Nov 29 11:59:34 volumio.pi4 volumio[899]: } Nov 29 11:59:34 volumio.pi4 volumio[899]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 11:59:35 volumio.pi4 sudo[6353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-29 11:58 Nov 29 11:59:35 volumio.pi4 sudo[6353]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"