-- Logs begin at Fri 2024-08-30 12:50:15 UTC, end at Fri 2024-08-30 15:23:32 UTC. -- Aug 30 15:22:00 kreta volumio[745]: info: Connection to go-librespot Websocket closed Aug 30 15:22:00 kreta volumio[745]: info: Reading package lists... Aug 30 15:22:00 kreta go-librespot[23352]: time="2024-08-30T15:22:00Z" level=debug msg="obtained new client token: AAAUffQS8Xb87BSYVwQf5LwPY47WTSbPZIN0R7E1/XW0JN9fU8nbL4nTX555jA7gvuOBbJYwhiO9hPAD3O8KZGuV+hTCVCRlVyL++uFGXUE41x5K+aQgE9eAvRKJcKFc1bkSvHGjYuYilzVqTaAT6yYurFVJ/cLi8mX/61s2GDMw0Nrk+RosWv/PK3PLjvXn4b2EtX/a8oIlnQUkfvzoFnlWZzf/TZxspcvgnvirv0+gvLWp6NiL8/bdMfDbyDY=" Aug 30 15:22:01 kreta volumio[745]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 30 15:22:01 kreta go-librespot[23352]: time="2024-08-30T15:22:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 15:22:01 kreta go-librespot[23352]: time="2024-08-30T15:22:01Z" level=debug msg="completed keyexchange" Aug 30 15:22:02 kreta sudo[23233]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:02 kreta go-librespot[23352]: time="2024-08-30T15:22:02Z" level=debug msg="completed challenge" Aug 30 15:22:02 kreta go-librespot[23352]: time="2024-08-30T15:22:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:22:02 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:22:02 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:22:05 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:22:05 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66. Aug 30 15:22:05 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:22:05 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:22:05 kreta go-librespot[23358]: Librespot-go daemon starting... Aug 30 15:22:05 kreta go-librespot[23358]: time="2024-08-30T15:22:05Z" level=info msg="generated new device id: 322f05a5bacdf3931efbd5dd7e033b9f9ba652fe" Aug 30 15:22:06 kreta go-librespot[23358]: time="2024-08-30T15:22:06Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:22:07 kreta sudo[22330]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:07 kreta sudo[23372]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/Adafruit_Python_DHT/examples/AdafruitDHT.py 22 3 Aug 30 15:22:07 kreta sudo[23372]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:07 kreta sudo[23373]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Aug 30 15:22:08 kreta sudo[23373]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:08 kreta go-librespot[23358]: time="2024-08-30T15:22:08Z" level=debug msg="obtained new client token: AAB1urmkHX1rZAjTm9ewKN9BAOiM7Xa+4LR7PVayegPjv9mWajXTRz9rw1qaJP1NYOVfsyj9wuXQtAR1HIR46WR1CM/YIq7C1PCBQhr1s4EvQZ16RLcyf/uTsa0omp1sT+ay18n5dVWI0XeVZhxalDHJaHxOmByLwCgFiCdnkX3l98MB01UTmspTPSLy6yPjjHo0ZTNnTsxCDrx5mukd+Zuzuh7AF1SjGCESkCDhq1ZA6GcT/rKw8v1uXh12" Aug 30 15:22:09 kreta go-librespot[23358]: time="2024-08-30T15:22:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 15:22:09 kreta go-librespot[23358]: time="2024-08-30T15:22:09Z" level=debug msg="completed keyexchange" Aug 30 15:22:09 kreta sudo[23236]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:10 kreta go-librespot[23358]: time="2024-08-30T15:22:10Z" level=debug msg="completed challenge" Aug 30 15:22:10 kreta go-librespot[23358]: time="2024-08-30T15:22:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:22:10 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:22:10 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:22:12 kreta sudo[23380]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/Adafruit_Python_DHT/examples/AdafruitDHT.py 22 3 Aug 30 15:22:12 kreta sudo[23380]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:13 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:22:13 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67. Aug 30 15:22:13 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:22:13 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:22:13 kreta go-librespot[23382]: Librespot-go daemon starting... Aug 30 15:22:14 kreta go-librespot[23382]: time="2024-08-30T15:22:14Z" level=info msg="generated new device id: 5ac00689f4f435367d05012398c30ca49ed491c6" Aug 30 15:22:14 kreta go-librespot[23382]: time="2024-08-30T15:22:14Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:22:17 kreta go-librespot[23382]: time="2024-08-30T15:22:17Z" level=debug msg="obtained new client token: AACJ7csbeONcXq+oRki+A0L8WTBSmTe90ZlHPpq+K5Xv0Bl5fYFQRPw+y+OsNxX2qvVI5gkoGP6mbv8L8vvarrnXcmNmGRCNjPd9miftjyk0mpylXXtoXVij2yLoiF+ITYhFZrGxqa748SPwByRIIcNp72rnUIpsm8wk6ePM2gU9GMXjY07IdPFZH0oBxIQpIve3I7auNZSs1l+CBFfLQbuH/ygPGDBjg0kBI3tlIHBqaxeo6dCPE2IjN8Qa7y4=" Aug 30 15:22:18 kreta sudo[23390]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:22:18 kreta sudo[23390]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:18 kreta go-librespot[23382]: time="2024-08-30T15:22:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 15:22:19 kreta go-librespot[23382]: time="2024-08-30T15:22:19Z" level=debug msg="completed keyexchange" Aug 30 15:22:19 kreta go-librespot[23382]: time="2024-08-30T15:22:19Z" level=debug msg="completed challenge" Aug 30 15:22:19 kreta go-librespot[23382]: time="2024-08-30T15:22:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:22:19 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:22:19 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:22:19 kreta sudo[23390]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:20 kreta sudo[23395]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:22:20 kreta sudo[23395]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:22 kreta sudo[23395]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:22 kreta sudo[23398]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:22:22 kreta sudo[23398]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:22 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:22:22 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68. Aug 30 15:22:22 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:22:22 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:22:23 kreta go-librespot[23400]: Librespot-go daemon starting... Aug 30 15:22:23 kreta go-librespot[23400]: time="2024-08-30T15:22:23Z" level=info msg="generated new device id: 5c649e8ce231c626ef71605613768d766f38caf5" Aug 30 15:22:23 kreta go-librespot[23400]: time="2024-08-30T15:22:23Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:22:24 kreta volumio[745]: info: Initializing connection to go-librespot Websocket Aug 30 15:22:24 kreta sudo[23398]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:25 kreta volumio[745]: verbose: New Socket.io Connection to 192.168.1.122:3000 from 192.168.1.227 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 30 15:22:25 kreta volumio[745]: verbose: New Socket.io Connection to 192.168.1.122:3000 from 192.168.1.227 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 30 15:22:25 kreta volumio[745]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.117 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 8 Aug 30 15:22:25 kreta volumio[745]: verbose: New Socket.io Connection to 192.168.1.122:3000 from 192.168.1.227 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Aug 30 15:22:26 kreta volumio[745]: info: Discovery: Connected to remote: 192.168.1.227 Aug 30 15:22:26 kreta go-librespot[23400]: time="2024-08-30T15:22:26Z" level=debug msg="obtained new client token: AAAuDdOll8fV+Hd1l0q1fzue54ewnRRJbhvtlWRdHIqaigctbkR49Ma+Wbnk6+ojpQLmVUmnikky9FFqMQL05k9LuyBQ28QZq/G3PaVZ59sgqlrLX7Q35MMOmYd6uFxPdoh1rXWmzSEJHL+Y8TOI/3i93bY80XpOfW9ti9I8jf4LVOOsvX81zHtu94QICOfFv3sYaEkyPdTe+15T8kfzYvbZII6Ak372ZEG2Hme8spSYDamcVlCkDXqsDgHlgJ8=" Aug 30 15:22:27 kreta go-librespot[23400]: time="2024-08-30T15:22:27Z" level=debug msg="new websocket client" Aug 30 15:22:27 kreta volumio[745]: info: Building dependency tree... Aug 30 15:22:27 kreta volumio[745]: info: Reading state information... Aug 30 15:22:27 kreta volumio[745]: info: 157 packages can be upgraded. Run 'apt list --upgradable' to see them. Aug 30 15:22:27 kreta volumio[745]: info: Reading package lists... Aug 30 15:22:27 kreta volumio[745]: info: Connection to go-librespot Websocket established Aug 30 15:22:27 kreta volumio[745]: verbose: New Socket.io Connection to 192.168.1.122 from 192.168.1.117 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 10 Aug 30 15:22:27 kreta volumio[745]: info: CoreCommandRouter::volumioGetState Aug 30 15:22:27 kreta volumio[745]: info: CorePlayQueue::getTrack 5 Aug 30 15:22:28 kreta go-librespot[23400]: time="2024-08-30T15:22:28Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 15:22:28 kreta volumio[745]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Aug 30 15:22:28 kreta volumio[745]: info: Asound.conf file unchanged, so no further update is needed Aug 30 15:22:28 kreta go-librespot[23400]: time="2024-08-30T15:22:28Z" level=debug msg="completed keyexchange" Aug 30 15:22:28 kreta volumio[745]: info: Output device has changed, restarting MPD Aug 30 15:22:29 kreta go-librespot[23400]: time="2024-08-30T15:22:29Z" level=debug msg="completed challenge" Aug 30 15:22:29 kreta volumio[745]: info: Output device has changed, restarting Shairport Sync Aug 30 15:22:29 kreta volumio[745]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 15:22:29 kreta sudo[23422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 15:22:29 kreta volumio[745]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 15:22:29 kreta sudo[23422]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:30 kreta sudo[23422]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:30 kreta sudo[23436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 15:22:30 kreta sudo[23436]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:30 kreta sudo[23324]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:31 kreta go-librespot[23400]: time="2024-08-30T15:22:31Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:22:31 kreta systemd[1]: Stopping Music Player Daemon... Aug 30 15:22:31 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:22:31 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:22:32 kreta volumio[745]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 15:22:32 kreta volumio[745]: info: PLUGIN START: fusiondsp Aug 30 15:22:33 kreta volumio[745]: info: Loading i18n strings for locale de Aug 30 15:22:33 kreta volumio[745]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 15:22:33 kreta volumio[745]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 15:22:33 kreta volumio[745]: info: FusionDsp - mixtype--------------------- Software Aug 30 15:22:33 kreta volumio[745]: info: Preparing to generate the ALSA configuration file Aug 30 15:22:33 kreta volumio[745]: info: Done. Aug 30 15:22:34 kreta volumio[745]: info: Getting Spotify volume Aug 30 15:22:34 kreta volumio[745]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Aug 30 15:22:34 kreta volumio[745]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 15:22:34 kreta sudo[23333]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:34 kreta volumio[745]: info: Reading ALSA contributions from plugins. Aug 30 15:22:34 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:22:34 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69. Aug 30 15:22:34 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:22:34 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:22:35 kreta go-librespot[23458]: Librespot-go daemon starting... Aug 30 15:22:35 kreta go-librespot[23458]: time="2024-08-30T15:22:35Z" level=info msg="generated new device id: db4339f39e9d9f8ea4901fbb0ba2a9cf468d89ac" Aug 30 15:22:35 kreta go-librespot[23458]: time="2024-08-30T15:22:35Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:22:36 kreta volumio[745]: (node:745) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 15:22:36 kreta volumio[745]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Aug 30 15:22:36 kreta volumio[745]: (node:745) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 789) Aug 30 15:22:36 kreta volumio[745]: info: MPD Permissions set Aug 30 15:22:38 kreta sudo[23479]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/Adafruit_Python_DHT/examples/AdafruitDHT.py 22 3 Aug 30 15:22:38 kreta sudo[23479]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:38 kreta volumio[745]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 30 15:22:38 kreta volumio[745]: info: camilladsp service started and running in background, instance 1 Aug 30 15:22:38 kreta volumio[745]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 15:22:39 kreta volumio[745]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 15:22:39 kreta volumio[745]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 15:22:39 kreta volumio[745]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 15:22:40 kreta volumio[745]: info: FusionDsp loaded Aug 30 15:22:40 kreta volumio[745]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 15:22:40 kreta go-librespot[23458]: time="2024-08-30T15:22:40Z" level=debug msg="obtained new client token: AADGrd1eyENoSOetGJ/okf23kK/3UH7XZM2NMu7xDlUEJ4MCQ5ZSgsHwYgrGK0TT3nI6XwRj7LzKYB91n9HmqsnNgTxx6845/OxOYchECmV3rxUMySH2aMJ3WeyHOVmZCidcpKoXC0k1pAZ776qfj8BuQBLLIJQjSczn95+M+Xl2mqGgPqYM3/M6mRoccFoa+R2q69/V3vsa/X0VSFKxLJi32QBrmHCTBclAg/4urmTZxiRjJLDfCxjSnUcH" Aug 30 15:22:41 kreta go-librespot[23458]: time="2024-08-30T15:22:41Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 30 15:22:41 kreta sudo[23484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 15:22:41 kreta sudo[23484]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:41 kreta go-librespot[23458]: time="2024-08-30T15:22:41Z" level=debug msg="completed keyexchange" Aug 30 15:22:42 kreta volumio[745]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 15:22:42 kreta volumio[745]: info: Adding Signal Path Element [object Object] Aug 30 15:22:42 kreta volumio[745]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 15:22:42 kreta volumio[745]: info: FusionDsp - ---- installed callbackRead Aug 30 15:22:42 kreta go-librespot[23458]: time="2024-08-30T15:22:42Z" level=debug msg="completed challenge" Aug 30 15:22:42 kreta sudo[23484]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:42 kreta go-librespot[23458]: time="2024-08-30T15:22:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:22:42 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:22:42 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:22:42 kreta volumio[745]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 15:22:42 kreta systemd[1]: mpd.service: Succeeded. Aug 30 15:22:42 kreta systemd[1]: Stopped Music Player Daemon. Aug 30 15:22:43 kreta systemd[1]: Starting Music Player Daemon... Aug 30 15:22:43 kreta volumio[745]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 15:22:43 kreta volumio[745]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 15:22:43 kreta volumio[745]: at onErrorNT (internal/child_process.js:465:16) Aug 30 15:22:43 kreta volumio[745]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Aug 30 15:22:43 kreta volumio[745]: at runNextTicks (internal/process/task_queues.js:62:3) Aug 30 15:22:43 kreta volumio[745]: at listOnTimeout (internal/timers.js:523:9) Aug 30 15:22:43 kreta volumio[745]: at processTimers (internal/timers.js:497:7) { Aug 30 15:22:43 kreta volumio[745]: errno: -2, Aug 30 15:22:43 kreta volumio[745]: code: 'ENOENT', Aug 30 15:22:43 kreta volumio[745]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 15:22:43 kreta volumio[745]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 15:22:43 kreta volumio[745]: spawnargs: [ Aug 30 15:22:43 kreta volumio[745]: '-p', Aug 30 15:22:43 kreta volumio[745]: 9876, Aug 30 15:22:43 kreta volumio[745]: '-o', Aug 30 15:22:43 kreta volumio[745]: '/tmp/camilladsp.log', Aug 30 15:22:43 kreta volumio[745]: '-l', Aug 30 15:22:43 kreta volumio[745]: 'warn', Aug 30 15:22:43 kreta volumio[745]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 15:22:43 kreta volumio[745]: ] Aug 30 15:22:43 kreta volumio[745]: } Aug 30 15:22:43 kreta volumio[745]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 15:22:43 kreta sudo[23488]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/Adafruit_Python_DHT/examples/AdafruitDHT.py 22 3 Aug 30 15:22:43 kreta sudo[23488]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:44 kreta sudo[23486]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 15:22:44 kreta sudo[23486]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:44 kreta sudo[23486]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:45 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:22:45 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70. Aug 30 15:22:45 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:22:45 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:22:46 kreta go-librespot[23494]: Librespot-go daemon starting... Aug 30 15:22:46 kreta go-librespot[23494]: time="2024-08-30T15:22:46Z" level=info msg="generated new device id: 1dc15fc762d3cfdf02f611beb153eacf826266dd" Aug 30 15:22:46 kreta go-librespot[23494]: time="2024-08-30T15:22:46Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:22:49 kreta sudo[23501]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:22:49 kreta sudo[23501]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:50 kreta go-librespot[23494]: time="2024-08-30T15:22:50Z" level=debug msg="obtained new client token: AAAPG6Fqld64SQLtGlQ2MY89k3Cxf+kgcf/pN1bJ/ZIsPbqRMm05Cp8Ckl5kcdDiBRYYcP8WO3kuaUfSH+8Dgnm9HadjdaqZtVZnm/rC6xeiaS7W5JyAI6q9fTqH6H4fic5zQNJBK0WGHVWou0ZIicTnpdTiQ902USkr2gjPwgVRr2yRFwSDHjk5+Jkhiv3fDjRFpRy8WSyTbJJmxlSkgQj+/etH2HK9leor+peB2qz8HsXZnv/2KTXQGC29TdM=" Aug 30 15:22:51 kreta go-librespot[23494]: time="2024-08-30T15:22:51Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 15:22:52 kreta sudo[23501]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:52 kreta go-librespot[23494]: time="2024-08-30T15:22:52Z" level=debug msg="completed keyexchange" Aug 30 15:22:53 kreta go-librespot[23494]: time="2024-08-30T15:22:53Z" level=debug msg="completed challenge" Aug 30 15:22:53 kreta go-librespot[23494]: time="2024-08-30T15:22:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:22:53 kreta sudo[23510]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:22:53 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:22:53 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:22:53 kreta sudo[23510]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:53 kreta volumio-remote-updater[395]: [2024-08-30 15:22:53] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Aug 30 15:22:55 kreta sudo[23510]: pam_unix(sudo:session): session closed for user root Aug 30 15:22:56 kreta sudo[23514]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:22:56 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:22:56 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71. Aug 30 15:22:56 kreta sudo[23514]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:22:56 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:22:56 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:22:56 kreta go-librespot[23516]: Librespot-go daemon starting... Aug 30 15:22:57 kreta go-librespot[23516]: time="2024-08-30T15:22:57Z" level=info msg="generated new device id: 9d0a2959aa14ffe979ec580665523158a0667880" Aug 30 15:22:57 kreta go-librespot[23516]: time="2024-08-30T15:22:57Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:22:58 kreta volumio-remote-updater[395]: [2024-08-30 15:22:58] [connect] Successful connection Aug 30 15:22:59 kreta sudo[23514]: pam_unix(sudo:session): session closed for user root Aug 30 15:23:01 kreta go-librespot[23516]: time="2024-08-30T15:23:01Z" level=debug msg="obtained new client token: AAC6rtdeUb6zYdhcmA5pIYwEasM+7W+B9TVgBq9aqMsDSVdwBqV+YuIjDg07XDN3ewY4xtDrzLtCROz0gCYGbvlB/KDAo/4viqQNQJKqDJHS6Fhw20AQL3ZlTTti8tDCsYeEhjh4KyH4Tu+bB/8skM4u98fgP+2xoLH8W4l2szI9keudORpuSzzOWlkmNb4fpVonRNRX53gDoCmv28GaWshhJ2XSBI0y2EPV1KAeaXuxlJs5cEmzsKX6XPIBMP0=" Aug 30 15:23:01 kreta go-librespot[23516]: time="2024-08-30T15:23:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 15:23:02 kreta go-librespot[23516]: time="2024-08-30T15:23:02Z" level=debug msg="completed keyexchange" Aug 30 15:23:03 kreta go-librespot[23516]: time="2024-08-30T15:23:03Z" level=debug msg="completed challenge" Aug 30 15:23:03 kreta go-librespot[23516]: time="2024-08-30T15:23:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:23:03 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:23:03 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:23:03 kreta sudo[23372]: pam_unix(sudo:session): session closed for user root Aug 30 15:23:06 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:23:06 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 72. Aug 30 15:23:06 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:23:06 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:23:06 kreta go-librespot[23524]: Librespot-go daemon starting... Aug 30 15:23:07 kreta go-librespot[23524]: time="2024-08-30T15:23:07Z" level=info msg="generated new device id: a7f948955e5316e7288c0725c592a0e8cdfefeb9" Aug 30 15:23:07 kreta go-librespot[23524]: time="2024-08-30T15:23:07Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:23:09 kreta sudo[23380]: pam_unix(sudo:session): session closed for user root Aug 30 15:23:11 kreta volumio-remote-updater[395]: [2024-08-30 15:23:11] [connect] Successful connection Aug 30 15:23:11 kreta go-librespot[23524]: time="2024-08-30T15:23:11Z" level=debug msg="obtained new client token: AACzTmxhAQpt9lcXr8nnW0i26CMvwIyLP/TBG8iMjIVd7gD5Tkf9vBxDR5fXivle1KzoioktLm9zBheyT+43I6mqIH+HP+ixXROqsuWbop7iwl5oAGnzvP0TZkGwVLasSC+cX5rMjI6sOWyyWrxPF8LLEha/PsAK+PXaN+Kow0kns5s4OvCeRaj1WtmXaDSORU9jGZAFU3wfR5H0Pr5uHdgfBDOrrOSBhkVp3n5zMgMONI3zbCej0FIpCjPxB8c=" Aug 30 15:23:12 kreta go-librespot[23524]: time="2024-08-30T15:23:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 15:23:12 kreta go-librespot[23524]: time="2024-08-30T15:23:12Z" level=debug msg="completed keyexchange" Aug 30 15:23:13 kreta sudo[23540]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/Adafruit_Python_DHT/examples/AdafruitDHT.py 22 3 Aug 30 15:23:13 kreta sudo[23540]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:23:13 kreta go-librespot[23524]: time="2024-08-30T15:23:13Z" level=debug msg="completed challenge" Aug 30 15:23:13 kreta go-librespot[23524]: time="2024-08-30T15:23:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:23:13 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:23:13 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:23:16 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:23:16 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73. Aug 30 15:23:16 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:23:16 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:23:17 kreta go-librespot[23544]: Librespot-go daemon starting... Aug 30 15:23:17 kreta go-librespot[23544]: time="2024-08-30T15:23:17Z" level=info msg="generated new device id: a75afc899acb774ba15d36b63a7da19c081e6b7e" Aug 30 15:23:17 kreta go-librespot[23544]: time="2024-08-30T15:23:17Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:23:18 kreta sudo[23551]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/Adafruit_Python_DHT/examples/AdafruitDHT.py 22 3 Aug 30 15:23:18 kreta sudo[23551]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:23:22 kreta go-librespot[23544]: time="2024-08-30T15:23:22Z" level=debug msg="obtained new client token: AABbVGrDkzAElSTOgNyNqdVmR9meNWEMxju+Jw3gGyTiYy0gtNCmpsuui7rnke9zh6/ls6zAZDIaL9ljVgnuFipq16xEntMOciV2FrzG0inReaGGWZ+hjzimqy9hz2NzjT7eXZKKqg80IN+EwUrTbI+obcLH86wpp6jDM9RHz7Hw207P8F8B34ZYTW/MlDEfmNtrS39ovRoAHMiFrqCBjAiKwid56XBQ19XJIxIkLEHJ65XwfZBllrOjMLt3OPw=" Aug 30 15:23:22 kreta go-librespot[23544]: time="2024-08-30T15:23:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 15:23:23 kreta go-librespot[23544]: time="2024-08-30T15:23:23Z" level=debug msg="completed keyexchange" Aug 30 15:23:24 kreta sudo[23556]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:23:24 kreta sudo[23556]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:23:24 kreta go-librespot[23544]: time="2024-08-30T15:23:24Z" level=debug msg="completed challenge" Aug 30 15:23:24 kreta go-librespot[23544]: time="2024-08-30T15:23:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Aug 30 15:23:24 kreta systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 15:23:24 kreta systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 15:23:25 kreta mpd[23493]: Aug 30 15:23 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 15:23:25 kreta systemd[1]: Started Music Player Daemon. Aug 30 15:23:25 kreta sudo[23436]: pam_unix(sudo:session): session closed for user root Aug 30 15:23:26 kreta sudo[23556]: pam_unix(sudo:session): session closed for user root Aug 30 15:23:26 kreta volumio-remote-updater[395]: [2024-08-30 15:23:26] [connect] Successful connection Aug 30 15:23:27 kreta sudo[23561]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:23:27 kreta sudo[23561]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:23:27 kreta sudo[23563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 15:22 Aug 30 15:23:27 kreta sudo[23563]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 15:23:27 kreta systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 15:23:27 kreta systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74. Aug 30 15:23:27 kreta systemd[1]: Stopped go-librespot Daemon. Aug 30 15:23:27 kreta systemd[1]: Started go-librespot Daemon. Aug 30 15:23:28 kreta sudo[23561]: pam_unix(sudo:session): session closed for user root Aug 30 15:23:30 kreta go-librespot[23566]: Librespot-go daemon starting... Aug 30 15:23:31 kreta go-librespot[23566]: time="2024-08-30T15:23:31Z" level=info msg="generated new device id: 2b9782620a261746c40bb010de6722699fc6fe58" Aug 30 15:23:31 kreta go-librespot[23566]: time="2024-08-30T15:23:31Z" level=debug msg="stored credentials found for 4ght6do84q22rky80rqxdlatk" Aug 30 15:23:32 kreta sudo[23569]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/python /home/volumio/BMP180Code/Adafruit_Python_BMP/examples/simpletest.py Aug 30 15:23:32 kreta sudo[23569]: 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"