-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Fri 2024-07-12 23:49:04 +07. -- Jul 12 23:48:02 volumio volumio[906]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf Jul 12 23:48:06 volumio volumio[906]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf Jul 12 23:48:06 volumio volumio[906]: info: Folder /tmp/plugins removed Jul 12 23:48:08 volumio volumio[906]: info: Check plugin dependencies Jul 12 23:48:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 12 23:48:08 volumio volumio[906]: info: Checking if plugin already exists Jul 12 23:48:08 volumio volumio[906]: info: Rename folder Jul 12 23:48:08 volumio volumio[906]: info: Folder /tmp/downloaded_plugin.zip removed Jul 12 23:48:08 volumio volumio[906]: info: Move to category Jul 12 23:48:09 volumio volumio[906]: info: Checking if install.sh is present Jul 12 23:48:09 volumio volumio[906]: info: Executing install.sh Jul 12 23:48:09 volumio sudo[17032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/ytmusic/install.sh Jul 12 23:48:09 volumio sudo[17032]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:09 volumio sudo[17032]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:09 volumio volumio[906]: info: YouTube Music plugin installed Jul 12 23:48:09 volumio volumio[906]: Plugin install end detected on script Jul 12 23:48:09 volumio volumio[906]: info: Install script completed Jul 12 23:48:09 volumio volumio[906]: info: Adding reference to registry Jul 12 23:48:09 volumio volumio[906]: info: Done installing plugin. Jul 12 23:48:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 12 23:48:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 12 23:48:09 volumio volumio[906]: info: Folder /tmp/plugins removed Jul 12 23:48:09 volumio volumio[906]: info: Folder /tmp/downloaded_plugin.zip removed Jul 12 23:48:09 volumio volumio[906]: info: Folder /data/temp removed Jul 12 23:48:11 volumio ntpd[834]: Soliciting pool server 2402:4e00:1800:f800:0:9c01:9d85:dfa Jul 12 23:48:14 volumio volumio[906]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytcr/volumio/buster/armhf Jul 12 23:48:18 volumio volumio[906]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytcr/volumio/buster/armhf Jul 12 23:48:18 volumio volumio[906]: info: Folder /tmp/plugins removed Jul 12 23:48:21 volumio volumio[906]: info: Check plugin dependencies Jul 12 23:48:21 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 12 23:48:21 volumio volumio[906]: info: Checking if plugin already exists Jul 12 23:48:21 volumio volumio[906]: info: Rename folder Jul 12 23:48:21 volumio volumio[906]: info: Folder /tmp/downloaded_plugin.zip removed Jul 12 23:48:21 volumio volumio[906]: info: Move to category Jul 12 23:48:23 volumio volumio[906]: info: Checking if install.sh is present Jul 12 23:48:23 volumio volumio[906]: info: Executing install.sh Jul 12 23:48:24 volumio sudo[17048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/ytcr/install.sh Jul 12 23:48:24 volumio sudo[17048]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:24 volumio sudo[17048]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:24 volumio volumio[906]: info: YouTube Cast Receiver installed Jul 12 23:48:24 volumio volumio[906]: Plugin install end detected on script Jul 12 23:48:24 volumio volumio[906]: info: Install script completed Jul 12 23:48:24 volumio volumio[906]: info: Adding reference to registry Jul 12 23:48:24 volumio volumio[906]: info: Done installing plugin. Jul 12 23:48:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 12 23:48:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 12 23:48:24 volumio volumio[906]: info: Folder /tmp/plugins removed Jul 12 23:48:24 volumio volumio[906]: info: Folder /tmp/downloaded_plugin.zip removed Jul 12 23:48:24 volumio volumio[906]: info: Folder /data/temp removed Jul 12 23:48:33 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 23:48:33 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 23:48:33 volumio volumio[906]: info: Discovery: Getting this device information Jul 12 23:48:33 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Jul 12 23:48:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Jul 12 23:48:33 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 23:48:51 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 12 23:48:51 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 12 23:48:53 volumio volumio[906]: info: Enabling plugin ytmusic Jul 12 23:48:53 volumio volumio[906]: info: Loading plugin "ytmusic"... Jul 12 23:48:53 volumio volumio[906]: info: PLUGIN START: ytmusic Jul 12 23:48:53 volumio volumio[906]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 12 23:48:53 volumio volumio[906]: info: [1720802933932] CoreMusicLibrary::Adding element YouTube Music Jul 12 23:48:53 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 12 23:48:53 volumio volumio[906]: Cannot find translation for source Spotify Jul 12 23:48:53 volumio volumio[906]: Cannot find translation for source YouTube Music Jul 12 23:48:53 volumio volumio[906]: info: Done. Jul 12 23:48:54 volumio volumio[906]: info: Enabling plugin ytcr Jul 12 23:48:54 volumio volumio[906]: info: Loading plugin "ytcr"... Jul 12 23:48:54 volumio volumio[906]: error: !!!! WARNING !!!! Jul 12 23:48:54 volumio volumio[906]: error: The plugin music_service/ytcr failed to load, setting it to stopped. Error: Error: Cannot find module '/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/lib/index.js'. Please verify that the package.json has a valid "main" entry Jul 12 23:48:54 volumio volumio[906]: error: Stack trace: Error: Cannot find module '/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/lib/index.js'. Please verify that the package.json has a valid "main" entry Jul 12 23:48:54 volumio volumio[906]: at tryPackage (internal/modules/cjs/loader.js:303:19) Jul 12 23:48:54 volumio volumio[906]: at Function.Module._findPath (internal/modules/cjs/loader.js:516:18) Jul 12 23:48:54 volumio volumio[906]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:867:27) Jul 12 23:48:54 volumio volumio[906]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Jul 12 23:48:54 volumio volumio[906]: at Module.require (internal/modules/cjs/loader.js:952:19) Jul 12 23:48:54 volumio volumio[906]: at require (internal/modules/cjs/helpers.js:88:18) Jul 12 23:48:54 volumio volumio[906]: at Object. (/data/plugins/music_service/ytcr/dist/index.js:40:41) Jul 12 23:48:54 volumio volumio[906]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Jul 12 23:48:54 volumio volumio[906]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Jul 12 23:48:54 volumio volumio[906]: at Module.load (internal/modules/cjs/loader.js:928:32) Jul 12 23:48:54 volumio volumio[906]: error: !!!! WARNING !!!! Jul 12 23:48:54 volumio volumio[906]: info: Done. Jul 12 23:48:54 volumio volumio[906]: info: Enabling plugin youtube2 Jul 12 23:48:54 volumio volumio[906]: info: Loading plugin "youtube2"... Jul 12 23:48:54 volumio volumio[906]: info: PLUGIN START: youtube2 Jul 12 23:48:54 volumio volumio[906]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 12 23:48:54 volumio volumio[906]: info: [1720802934843] CoreMusicLibrary::Adding element YouTube2 Jul 12 23:48:54 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 12 23:48:54 volumio volumio[906]: Cannot find translation for source Spotify Jul 12 23:48:54 volumio volumio[906]: Cannot find translation for source YouTube Music Jul 12 23:48:54 volumio volumio[906]: Cannot find translation for source YouTube2 Jul 12 23:48:54 volumio volumio[906]: info: Done. Jul 12 23:48:55 volumio volumio[906]: info: Enabling plugin squeezelite_mc Jul 12 23:48:55 volumio volumio[906]: info: Loading plugin "squeezelite_mc"... Jul 12 23:48:56 volumio volumio[906]: info: PLUGIN START: squeezelite_mc Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Starting proxy server... Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Proxy server started on port 33909 Jul 12 23:48:56 volumio volumio[906]: info: CoreCommandRouter::volumioRetrievevolume Jul 12 23:48:56 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Jul 12 23:48:56 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Jul 12 23:48:56 volumio volumio[906]: info: CoreStateMachine::pushState Jul 12 23:48:56 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Jul 12 23:48:56 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 12 23:48:56 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Server discovery started Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Player finder started Jul 12 23:48:56 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:48:56 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:48:56 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Card 2 supports the following ALSA formats: ["S16_LE","S24_LE"] Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"volumio","dsdFormat":null,"card":"2","mixerType":"None","mixer":null} Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jul 12 23:48:56 volumio sudo[17056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jul 12 23:48:56 volumio sudo[17056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:56 volumio sudo[17056]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Jul 12 23:48:56 volumio sudo[17060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Jul 12 23:48:56 volumio sudo[17060]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:56 volumio sudo[17060]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Jul 12 23:48:56 volumio sudo[17064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Jul 12 23:48:56 volumio sudo[17064]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:56 volumio sudo[17064]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:56 volumio volumio[906]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Jul 12 23:48:57 volumio sudo[17067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 12 23:48:57 volumio sudo[17067]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:57 volumio systemd[1]: Reloading. Jul 12 23:48:57 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 12 23:48:57 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jul 12 23:48:57 volumio sudo[17067]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:57 volumio volumio[906]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jul 12 23:48:57 volumio systemd[1]: Starting Daily apt download activities... Jul 12 23:48:57 volumio sudo[17084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jul 12 23:48:57 volumio sudo[17084]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:57 volumio sudo[17084]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:57 volumio volumio[906]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Jul 12 23:48:58 volumio sudo[17091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Jul 12 23:48:58 volumio sudo[17091]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:58 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jul 12 23:48:58 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jul 12 23:48:58 volumio kernel: process '/opt/squeezelite/squeezelite' started with executable stack Jul 12 23:48:58 volumio sudo[17091]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:58 volumio volumio[906]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jul 12 23:48:58 volumio sudo[17113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jul 12 23:48:58 volumio sudo[17113]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:58 volumio sudo[17113]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:59 volumio volumio[906]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jul 12 23:48:59 volumio sudo[17116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jul 12 23:48:59 volumio sudo[17116]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:59 volumio sudo[17116]: pam_unix(sudo:session): session closed for user root Jul 12 23:48:59 volumio volumio[906]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jul 12 23:48:59 volumio systemd[1]: apt-daily.service: Succeeded. Jul 12 23:48:59 volumio systemd[1]: Started Daily apt download activities. Jul 12 23:48:59 volumio sudo[17148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jul 12 23:48:59 volumio sudo[17148]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:48:59 volumio sudo[17148]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:00 volumio volumio[906]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jul 12 23:49:00 volumio sudo[17151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jul 12 23:49:00 volumio sudo[17151]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:00 volumio sudo[17151]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:00 volumio volumio[906]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jul 12 23:49:00 volumio sudo[17154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jul 12 23:49:00 volumio sudo[17154]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:00 volumio sudo[17154]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:00 volumio volumio[906]: info: Done. Jul 12 23:49:02 volumio volumio[906]: info: Enabling plugin fusiondsp Jul 12 23:49:02 volumio volumio[906]: info: Loading plugin "fusiondsp"... Jul 12 23:49:02 volumio volumio[906]: info: Applying required configuration parameters for plugin fusiondsp Jul 12 23:49:02 volumio volumio[906]: info: Preparing to generate the ALSA configuration file Jul 12 23:49:02 volumio volumio[906]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 12 23:49:02 volumio volumio[906]: info: Reading ALSA contributions from plugins. Jul 12 23:49:02 volumio volumio[906]: info: Asound.conf file written Jul 12 23:49:02 volumio sudo[17157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 12 23:49:02 volumio sudo[17157]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:02 volumio sudo[17157]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:02 volumio volumio[906]: info: Output device has changed, restarting MPD Jul 12 23:49:02 volumio sudo[17162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 12 23:49:02 volumio sudo[17162]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:02 volumio volumio[906]: [SpotifyConnect] Creating VLS config file Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: PLUGIN START: fusiondsp Jul 12 23:49:02 volumio sudo[17162]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:02 volumio volumio[906]: info: Loading i18n strings for locale vi Jul 12 23:49:02 volumio sudo[17165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 12 23:49:02 volumio sudo[17165]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:02 volumio volumio[906]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: FusionDsp - mixtype--------------------- None Jul 12 23:49:02 volumio volumio[906]: info: Preparing to generate the ALSA configuration file Jul 12 23:49:02 volumio systemd[1]: Stopping Music Player Daemon... Jul 12 23:49:02 volumio volumio[906]: info: Done. Jul 12 23:49:02 volumio volumio[906]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 12 23:49:02 volumio volumio[906]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 12 23:49:02 volumio volumio[906]: info: Reading ALSA contributions from plugins. Jul 12 23:49:02 volumio volumio[906]: info: Enabling plugin fusiondsp Jul 12 23:49:02 volumio volumio[906]: info: Loading plugin "fusiondsp"... Jul 12 23:49:02 volumio systemd[1]: mpd.service: Succeeded. Jul 12 23:49:02 volumio systemd[1]: Stopped Music Player Daemon. Jul 12 23:49:02 volumio volumio[906]: info: Applying required configuration parameters for plugin fusiondsp Jul 12 23:49:02 volumio volumio[906]: info: MPD Permissions set Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:02 volumio sudo[17168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Jul 12 23:49:02 volumio sudo[17168]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio systemd[1]: Starting Music Player Daemon... Jul 12 23:49:03 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jul 12 23:49:03 volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Jul 12 23:49:03 volumio systemd[1]: volspotconnect.service: Succeeded. Jul 12 23:49:03 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Jul 12 23:49:03 volumio systemd[1]: Started Volspotconnect2 Daemon. Jul 12 23:49:03 volumio sudo[17168]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Vollibrespot Daemon service restarted! Jul 12 23:49:03 volumio volumio[906]: info: Asound.conf file unchanged, so no further update is needed Jul 12 23:49:03 volumio volumio[906]: info: Output device has changed, restarting MPD Jul 12 23:49:03 volumio volumio[17173]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jul 12 23:49:03 volumio volumio[17173]: Reading Config from "/tmp/volspotify.toml" Jul 12 23:49:03 volumio volumio[17173]: [Vollibrespot] : Using Alsa backend with device: volumio Jul 12 23:49:03 volumio sudo[17183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 12 23:49:03 volumio sudo[17183]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio sudo[17183]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio volumio[17173]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Creating VLS config file Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: Preparing to generate the ALSA configuration file Jul 12 23:49:03 volumio sudo[17169]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 12 23:49:03 volumio sudo[17169]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio sudo[17169]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio sudo[17196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 12 23:49:03 volumio sudo[17196]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 12 23:49:03 volumio volumio[906]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 12 23:49:03 volumio volumio[906]: info: Reading ALSA contributions from plugins. Jul 12 23:49:03 volumio volumio[906]: info: MPD Permissions set Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 12 23:49:03 volumio systemd[1]: mpd.service: Succeeded. Jul 12 23:49:03 volumio systemd[1]: Stopped Music Player Daemon. Jul 12 23:49:03 volumio systemd[1]: Starting Music Player Daemon... Jul 12 23:49:03 volumio sudo[17216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Jul 12 23:49:03 volumio sudo[17216]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio volumio[17173]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Jul 12 23:49:03 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jul 12 23:49:03 volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Jul 12 23:49:03 volumio systemd[1]: volspotconnect.service: Succeeded. Jul 12 23:49:03 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio systemd[1]: Started Volspotconnect2 Daemon. Jul 12 23:49:03 volumio volumio[906]: info: Asound.conf file unchanged, so no further update is needed Jul 12 23:49:03 volumio sudo[17216]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio volumio[906]: info: Output device has changed, restarting MPD Jul 12 23:49:03 volumio volumio[17238]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jul 12 23:49:03 volumio volumio[17238]: Reading Config from "/tmp/volspotify.toml" Jul 12 23:49:03 volumio volumio[17238]: [Vollibrespot] : Using Alsa backend with device: volumio Jul 12 23:49:03 volumio sudo[17242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 12 23:49:03 volumio sudo[17242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio sudo[17242]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Creating VLS config file Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: PLUGIN START: fusiondsp Jul 12 23:49:03 volumio sudo[17223]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 12 23:49:03 volumio sudo[17223]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio volumio[906]: info: Loading i18n strings for locale vi Jul 12 23:49:03 volumio sudo[17223]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio volumio[17238]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jul 12 23:49:03 volumio volumio[906]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Jul 12 23:49:03 volumio sudo[17245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 12 23:49:03 volumio sudo[17245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: FusionDsp - mixtype--------------------- None Jul 12 23:49:03 volumio volumio[906]: info: Preparing to generate the ALSA configuration file Jul 12 23:49:03 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 12 23:49:03 volumio systemd[1]: mpd.service: Succeeded. Jul 12 23:49:03 volumio systemd[1]: Stopped Music Player Daemon. Jul 12 23:49:03 volumio volumio[906]: info: Done. Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 12 23:49:03 volumio volumio[906]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 12 23:49:03 volumio volumio[906]: info: Reading ALSA contributions from plugins. Jul 12 23:49:03 volumio volumio[906]: info: MPD Permissions set Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Vollibrespot Daemon service restarted! Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio sudo[17255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Jul 12 23:49:03 volumio sudo[17255]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio systemd[1]: Starting Music Player Daemon... Jul 12 23:49:03 volumio volumio[17238]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Jul 12 23:49:03 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jul 12 23:49:03 volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Jul 12 23:49:03 volumio systemd[1]: volspotconnect.service: Succeeded. Jul 12 23:49:03 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Jul 12 23:49:03 volumio systemd[1]: Started Volspotconnect2 Daemon. Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio sudo[17255]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio volumio[17262]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jul 12 23:49:03 volumio volumio[17262]: Reading Config from "/tmp/volspotify.toml" Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Vollibrespot Daemon service restarted! Jul 12 23:49:03 volumio volumio[17262]: [Vollibrespot] : Using Alsa backend with device: volumio Jul 12 23:49:03 volumio volumio[906]: info: Asound.conf file unchanged, so no further update is needed Jul 12 23:49:03 volumio volumio[906]: info: Output device has changed, restarting MPD Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Creating VLS config file Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[17262]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 12 23:49:03 volumio sudo[17265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 12 23:49:03 volumio sudo[17253]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 12 23:49:03 volumio sudo[17265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio sudo[17253]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio sudo[17267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 12 23:49:03 volumio sudo[17253]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio sudo[17265]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio sudo[17267]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio volumio[906]: info: MPD Permissions set Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio sudo[17277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 23:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 12 23:49:03 volumio volumio[17262]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Jul 12 23:49:03 volumio sudo[17277]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jul 12 23:49:03 volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Jul 12 23:49:03 volumio systemd[1]: volspotconnect.service: Succeeded. Jul 12 23:49:03 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Jul 12 23:49:03 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 12 23:49:03 volumio systemd[1]: mpd.service: Succeeded. Jul 12 23:49:03 volumio systemd[1]: Stopped Music Player Daemon. Jul 12 23:49:03 volumio systemd[1]: Starting Music Player Daemon... Jul 12 23:49:03 volumio systemd[1]: Started Volspotconnect2 Daemon. Jul 12 23:49:03 volumio sudo[17277]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:03 volumio volumio[906]: [SpotifyConnect] Vollibrespot Daemon service restarted! Jul 12 23:49:03 volumio volumio[17284]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jul 12 23:49:03 volumio volumio[17284]: Reading Config from "/tmp/volspotify.toml" Jul 12 23:49:03 volumio volumio[17284]: [Vollibrespot] : Using Alsa backend with device: volumio Jul 12 23:49:03 volumio volumio[17284]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jul 12 23:49:03 volumio sudo[17283]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 12 23:49:03 volumio sudo[17283]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 23:49:03 volumio sudo[17283]: pam_unix(sudo:session): session closed for user root Jul 12 23:49:04 volumio volumio[17284]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Jul 12 23:49:04 volumio volumio[906]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 12 23:49:04 volumio volumio[906]: TypeError: Cannot read property 'off' of undefined Jul 12 23:49:04 volumio volumio[906]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:106:15) Jul 12 23:49:04 volumio volumio[906]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jul 12 23:49:04 volumio volumio[906]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Jul 12 23:49:04 volumio volumio[906]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1537:29) Jul 12 23:49:04 volumio volumio[906]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1380:47) Jul 12 23:49:04 volumio volumio[906]: at Socket.emit (events.js:315:20) Jul 12 23:49:04 volumio volumio[906]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 12 23:49:04 volumio volumio[906]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 12 23:49:04 volumio volumio[906]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 12 23:49:04 volumio volumio[17284]: [Vollibrespot] : Authenticated as "31gtrd43emmlrb3adws4groheisi" ! Jul 12 23:49:04 volumio volumio[17284]: [Vollibrespot] : Using alsa sink Jul 12 23:49:04 volumio volumio[17284]: [Vollibrespot] : Metadata pipe established Jul 12 23:49:04 volumio volumio[17284]: [Vollibrespot] : Event: Volume { volume_to_mixer: 65535 } Jul 12 23:49:04 volumio volumio[17284]: [Vollibrespot] : Country: "IN" Jul 12 23:49:04 volumio sudo[17304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-12 23:48 Jul 12 23:49:04 volumio sudo[17304]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"