-- Logs begin at Fri 2024-07-19 20:38:24 CEST, end at Sat 2024-07-20 09:49:33 CEST. --
Jul 20 09:48:00 volumio volumio[17210]: info: Fetched 469 kB in 5s (91.6 kB/s)
Jul 20 09:48:05 volumio volumio[17210]: info: Reading package lists...
Jul 20 09:48:14 volumio volumio[1080]: [Vollibrespot] : couldn't parse packet from V4(192.168.88.1:5353): type 47 is invalid
Jul 20 09:48:15 volumio volumio[17210]: info: Building dependency tree...
Jul 20 09:48:22 volumio sudo[7264]: pam_unix(sudo:session): session closed for user root
Jul 20 09:48:22 volumio volumio[17210]: info: Enabling plugin fusiondsp
Jul 20 09:48:22 volumio volumio[17210]: info: Loading plugin "fusiondsp"...
Jul 20 09:48:22 volumio sudo[7513]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip
Jul 20 09:48:22 volumio sudo[7513]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:27 volumio volumio[1080]: [Vollibrespot] : couldn't parse packet from V4(192.168.88.1:5353): type 47 is invalid
Jul 20 09:48:29 volumio volumio-remote-updater[566]: [2024-07-20 09:48:29] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
Jul 20 09:48:34 volumio volumio-remote-updater[566]: [2024-07-20 09:48:34] [connect] Successful connection
Jul 20 09:48:41 volumio volumio[1080]: [Vollibrespot] : couldn't parse packet from V4(192.168.88.1:26166): type 47 is invalid
Jul 20 09:48:44 volumio volumio[17210]: info: Preparing to generate the ALSA configuration file
Jul 20 09:48:44 volumio volumio[17210]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 20 09:48:44 volumio volumio[17210]: info: CoreCommandRouter::volumioGetState
Jul 20 09:48:44 volumio volumio[17210]: info: Reading state information...
Jul 20 09:48:44 volumio volumio[17210]: info: 5 packages can be upgraded. Run 'apt list --upgradable' to see them.
Jul 20 09:48:44 volumio volumio[17210]: info: Reading package lists...
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 2
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.86 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 5
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.86 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 8
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.86 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 11
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.86 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13
Jul 20 09:48:44 volumio volumio[17210]: info: Asound.conf file unchanged, so no further update is needed
Jul 20 09:48:44 volumio volumio[17210]: info: Output device has changed, restarting MPD
Jul 20 09:48:44 volumio sudo[7520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 20 09:48:44 volumio sudo[7520]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:44 volumio volumio[17210]: info: Output device has changed, restarting Shairport Sync
Jul 20 09:48:44 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:44 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 20 09:48:44 volumio sudo[7523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 20 09:48:44 volumio sudo[7523]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:44 volumio systemd[1]: Stopping Music Player Daemon...
Jul 20 09:48:45 volumio sudo[7520]: pam_unix(sudo:session): session closed for user root
Jul 20 09:48:45 volumio volumio[17210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Relinquishing Volumio State
Jul 20 09:48:45 volumio volumio[17210]: verbose: UNSET VOLATILE: Service: volspotconnect2
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] unSetVolatile called
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Relinquishing Volumio State to another service
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Received stop
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Creating VLS config file
Jul 20 09:48:45 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] /tmp/volume: 81
Jul 20 09:48:45 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:45 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:45 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Volumio alsa_controller configuration:
Jul 20 09:48:45 volumio volumio[17210]: outdev:volumio
Jul 20 09:48:45 volumio volumio[17210]: outputdevicemixer:1
Jul 20 09:48:45 volumio volumio[17210]: volcurve:logarithmic
Jul 20 09:48:45 volumio volumio[17210]: mixtype:Hardware
Jul 20 09:48:45 volumio volumio[17210]: mixname:Digital
Jul 20 09:48:45 volumio volumio[17210]:
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] MODULAR_ALSA_PIPELINE: true
Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect]
Jul 20 09:48:45 volumio volumio[17210]: outdev:volumio
Jul 20 09:48:45 volumio volumio[17210]: mixer:alsa
Jul 20 09:48:45 volumio volumio[17210]: mixname:Digital
Jul 20 09:48:45 volumio volumio[17210]: mixdev:hw:1
Jul 20 09:48:45 volumio volumio[17210]: mixidx:0
Jul 20 09:48:45 volumio volumio[17210]:
Jul 20 09:48:45 volumio volumio[17210]: info: CoreStateMachine::resetVolumioState
Jul 20 09:48:45 volumio volumio[17210]: info: CoreStateMachine::getcurrentVolume
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::volumioRetrievevolume
Jul 20 09:48:46 volumio volumio[17210]: info: PLUGIN START: fusiondsp
Jul 20 09:48:46 volumio volumio[17210]: info: Loading i18n strings for locale pl
Jul 20 09:48:46 volumio volumio[17210]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found.
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: FusionDsp - mixtype--------------------- Hardware
Jul 20 09:48:46 volumio volumio[17210]: info: Preparing to generate the ALSA configuration file
Jul 20 09:48:46 volumio volumio[17210]: info: Done.
Jul 20 09:48:46 volumio systemd[1]: mpd.service: Succeeded.
Jul 20 09:48:46 volumio systemd[1]: Stopped Music Player Daemon.
Jul 20 09:48:46 volumio volumio[17210]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jul 20 09:48:46 volumio volumio[17210]: info: Reading ALSA contributions from plugins.
Jul 20 09:48:46 volumio systemd[1]: Starting Music Player Daemon...
Jul 20 09:48:46 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 14
Jul 20 09:48:46 volumio volumio[17210]: info: MPD Permissions set
Jul 20 09:48:46 volumio sudo[7531]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 20 09:48:46 volumio sudo[7531]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:46 volumio sudo[7531]: pam_unix(sudo:session): session closed for user root
Jul 20 09:48:46 volumio volumio[1080]: [Vollibrespot] : Pause
Jul 20 09:48:46 volumio volumio[1080]: [Vollibrespot] : Event: Pause { track_id: SpotifyId { id: 289340812561000672718230927290262821257, audio_type: Track }, position_ms: 160697 }
Jul 20 09:48:46 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 15
Jul 20 09:48:46 volumio volumio[17210]: info: Building dependency tree...
Jul 20 09:48:46 volumio volumio[17210]: info: Reading state information...
Jul 20 09:48:46 volumio volumio[17210]: info: The following additional packages will be installed:
Jul 20 09:48:46 volumio volumio[17210]: info: build-essential bzip2 dh-python dpkg-dev fakeroot g++ g++-8 gcc gcc-8
Jul 20 09:48:46 volumio volumio[17210]: info: libalgorithm-diff-perl libalgorithm-diff-xs-perl libalgorithm-merge-perl
Jul 20 09:48:46 volumio volumio[17210]: info: libasan5 libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libpython3-dev
Jul 20 09:48:46 volumio volumio[17210]: info: libpython3.7 libpython3.7-dev libstdc++-8-dev libubsan1 make patch
Jul 20 09:48:46 volumio volumio[17210]: info: python-pip-whl python3-asn1crypto python3-async-timeout python3-attr
Jul 20 09:48:46 volumio volumio[17210]: info: python3-cffi-backend python3-crypto python3-cryptography python3-dbus
Jul 20 09:48:46 volumio volumio[17210]: info: python3-dev python3-entrypoints python3-gi python3-keyring
Jul 20 09:48:46 volumio volumio[17210]: info: python3-keyrings.alt python3-multidict python3-secretstorage
Jul 20 09:48:46 volumio volumio[17210]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev
Jul 20 09:48:46 volumio volumio[17210]: info: Suggested packages:
Jul 20 09:48:46 volumio volumio[17210]: info: bzip2-doc debian-keyring gcc-8-doc libstdc++6-8-dbg gcc-multilib autoconf
Jul 20 09:48:46 volumio volumio[17210]: info: automake libtool flex bison gdb gcc-doc gcc-8-locales libgcc1-dbg
Jul 20 09:48:46 volumio volumio[17210]: info: libgomp1-dbg libitm1-dbg libatomic1-dbg libasan5-dbg liblsan0-dbg
Jul 20 09:48:46 volumio volumio[17210]: info: libtsan0-dbg libubsan1-dbg libmpx2-dbg libquadmath0-dbg libstdc++-8-doc
Jul 20 09:48:46 volumio volumio[17210]: info: make-doc ed diffutils-doc python-attr-doc python-crypto-doc
Jul 20 09:48:46 volumio volumio[17210]: info: python-cryptography-doc python3-cryptography-vectors python-dbus-doc
Jul 20 09:48:46 volumio volumio[17210]: info: python3-dbus-dbg gnome-keyring libkf5wallet-bin gir1.2-gnomekeyring-1.0
Jul 20 09:48:46 volumio volumio[17210]: info: python-secretstorage-doc python-setuptools-doc
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Pause
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] pause
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Shape Of My Heart
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Not pushing metadata: { active: false, isStopping: true }
Jul 20 09:48:46 volumio volumio[17210]: info: VolumeController:: Volume=81 Mute =false
Jul 20 09:48:46 volumio volumio[17210]: info: CoreStateMachine::pushState
Jul 20 09:48:46 volumio volumio[17210]: info: CorePlayQueue::getTrack 0
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::volumioPushState
Jul 20 09:48:46 volumio volumio[17210]: info: CoreStateMachine::updateTrackBlock
Jul 20 09:48:46 volumio volumio[17210]: info: CorePlayQueue::getTrackBlock
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::volumioRetrievevolume
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:46 volumio volumio[17210]: info: The following NEW packages will be installed:
Jul 20 09:48:46 volumio volumio[17210]: info: build-essential bzip2 dh-python dpkg-dev fakeroot g++ g++-8 gcc gcc-8
Jul 20 09:48:46 volumio volumio[17210]: info: libalgorithm-diff-perl libalgorithm-diff-xs-perl libalgorithm-merge-perl
Jul 20 09:48:46 volumio volumio[17210]: info: libasan5 libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libpython3-dev
Jul 20 09:48:46 volumio volumio[17210]: info: libpython3.7 libpython3.7-dev libstdc++-8-dev libubsan1 make patch
Jul 20 09:48:46 volumio volumio[17210]: info: python-pip-whl python3-aiohttp python3-asn1crypto python3-async-timeout
Jul 20 09:48:46 volumio volumio[17210]: info: python3-attr python3-cffi-backend python3-crypto python3-cryptography
Jul 20 09:48:46 volumio volumio[17210]: info: python3-dbus python3-dev python3-entrypoints python3-gi python3-keyring
Jul 20 09:48:46 volumio volumio[17210]: info: python3-keyrings.alt python3-multidict python3-pip python3-secretstorage
Jul 20 09:48:46 volumio volumio[17210]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev
Jul 20 09:48:46 volumio volumio[17210]: info: Starting Shairport Sync
Jul 20 09:48:46 volumio volumio[17210]: info: 0 upgraded, 46 newly installed, 0 to remove and 7 not upgraded.
Jul 20 09:48:46 volumio volumio[17210]: info: Need to get 72.4 MB of archives.
Jul 20 09:48:46 volumio volumio[17210]: info: After this operation, 160 MB of additional disk space will be used.
Jul 20 09:48:46 volumio volumio[17210]: info: Get:1 http://archive.raspberrypi.org/debian buster/main armhf python-pip-whl all 18.1-5+rpt1 [1591 kB]
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Restarting Vollibrespot Daemon
Jul 20 09:48:46 volumio volumio[17210]: info: VolumeController:: Volume=81 Mute =false
Jul 20 09:48:46 volumio volumio[17210]: info: CoreStateMachine::pushState
Jul 20 09:48:46 volumio volumio[17210]: info: CorePlayQueue::getTrack 0
Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::volumioPushState
Jul 20 09:48:46 volumio volumio[17210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Jul 20 09:48:46 volumio volumio[17210]: info: Get:4 http://archive.raspberrypi.org/debian buster/main armhf python3-pip all 18.1-5+rpt1 [171 kB]
Jul 20 09:48:46 volumio volumio[17210]: info: Get:2 http://ftp.icm.edu.pl/pub/Linux/distributions/raspbian/raspbian buster/main armhf bzip2 armhf 1.0.6-9.2~deb10u2 [46.3 kB]
Jul 20 09:48:46 volumio volumio[1080]: [Vollibrespot] : Event: SinkInactive
Jul 20 09:48:46 volumio volumio[1080]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 289340812561000672718230927290262821257, audio_type: Track } }
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Sink released
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Not pushing Pause { active: false, isStopping: true}
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] ResolvedStop in 909s 328.79ms
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] ResolvedStop in 0s 963.64ms
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Device palyback is inactive
Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Device is paused
Jul 20 09:48:46 volumio volumio[17210]: info: Asound.conf file written
Jul 20 09:48:47 volumio sudo[7546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 20 09:48:47 volumio sudo[7546]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:47 volumio sudo[7548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service
Jul 20 09:48:47 volumio sudo[7548]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:47 volumio sudo[7550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jul 20 09:48:47 volumio sudo[7550]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:47 volumio systemd[1]: Stopping Volspotconnect2 Daemon...
Jul 20 09:48:47 volumio systemd[1]: volspotconnect2.service: Main process exited, code=killed, status=15/TERM
Jul 20 09:48:47 volumio systemd[1]: volspotconnect2.service: Succeeded.
Jul 20 09:48:47 volumio systemd[1]: Stopped Volspotconnect2 Daemon.
Jul 20 09:48:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 20 09:48:47 volumio systemd[1]: Started Volspotconnect2 Daemon.
Jul 20 09:48:47 volumio sudo[7548]: pam_unix(sudo:session): session closed for user root
Jul 20 09:48:47 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 20 09:48:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 20 09:48:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 20 09:48:47 volumio sudo[7546]: pam_unix(sudo:session): session closed for user root
Jul 20 09:48:47 volumio volumio-remote-updater[566]: [2024-07-20 09:48:47] [connect] Successful connection
Jul 20 09:48:47 volumio sudo[7550]: pam_unix(sudo:session): session closed for user root
Jul 20 09:48:49 volumio volumio[17210]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy
Jul 20 09:48:49 volumio volumio[17210]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy
Jul 20 09:48:49 volumio volumio[17210]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy
Jul 20 09:48:49 volumio volumio[17210]: info: Output device has changed, restarting MPD
Jul 20 09:48:49 volumio sudo[7563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 20 09:48:49 volumio sudo[7563]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:49 volumio sudo[7563]: pam_unix(sudo:session): session closed for user root
Jul 20 09:48:49 volumio volumio[17210]: info: Output device has changed, restarting Shairport Sync
Jul 20 09:48:49 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:49 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 20 09:48:49 volumio sudo[7566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 20 09:48:49 volumio sudo[7566]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:50 volumio volumio[17210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] Creating VLS config file
Jul 20 09:48:50 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] /tmp/volume: 81
Jul 20 09:48:50 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:50 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:50 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] Volumio alsa_controller configuration:
Jul 20 09:48:50 volumio volumio[17210]: outdev:volumio
Jul 20 09:48:50 volumio volumio[17210]: outputdevicemixer:1
Jul 20 09:48:50 volumio volumio[17210]: volcurve:logarithmic
Jul 20 09:48:50 volumio volumio[17210]: mixtype:Hardware
Jul 20 09:48:50 volumio volumio[17210]: mixname:Digital
Jul 20 09:48:50 volumio volumio[17210]:
Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] MODULAR_ALSA_PIPELINE: true
Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect]
Jul 20 09:48:50 volumio volumio[17210]: outdev:volumio
Jul 20 09:48:50 volumio volumio[17210]: mixer:alsa
Jul 20 09:48:50 volumio volumio[17210]: mixname:Digital
Jul 20 09:48:50 volumio volumio[17210]: mixdev:hw:1
Jul 20 09:48:50 volumio volumio[17210]: mixidx:0
Jul 20 09:48:50 volumio volumio[17210]:
Jul 20 09:48:55 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jul 20 09:48:55 volumio systemd[1]: mpd.service: Succeeded.
Jul 20 09:48:55 volumio systemd[1]: Stopped Music Player Daemon.
Jul 20 09:48:55 volumio systemd[1]: Starting Music Player Daemon...
Jul 20 09:48:55 volumio sudo[7574]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 20 09:48:55 volumio sudo[7574]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:48:55 volumio sudo[7574]: pam_unix(sudo:session): session closed for user root
Jul 20 09:49:02 volumio volumio-remote-updater[566]: [2024-07-20 09:49:02] [connect] Successful connection
Jul 20 09:49:09 volumio volumio[7554]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07
Jul 20 09:49:09 volumio volumio[7554]: Reading Config from "volspotify.toml"
Jul 20 09:49:12 volumio mpd[7579]: Jul 20 09:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 20 09:49:15 volumio volumio[7554]: [Vollibrespot] : Using Alsa backend with device: volumio
Jul 20 09:49:17 volumio volumio-remote-updater[566]: [2024-07-20 09:49:17] [connect] Successful connection
Jul 20 09:49:21 volumio systemd[1]: Started Music Player Daemon.
Jul 20 09:49:21 volumio sudo[7523]: pam_unix(sudo:session): session closed for user root
Jul 20 09:49:21 volumio sudo[7566]: pam_unix(sudo:session): session closed for user root
Jul 20 09:49:28 volumio volumio[7554]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" }
Jul 20 09:49:28 volumio volumio[17210]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Jul 20 09:49:28 volumio volumio[17210]: info: camilladsp service started and running in background, instance 1
Jul 20 09:49:28 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 09:49:29 volumio volumio[17210]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jul 20 09:49:29 volumio volumio[17210]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Jul 20 09:49:29 volumio volumio[17210]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jul 20 09:49:29 volumio volumio[17210]: info: FusionDsp loaded
Jul 20 09:49:29 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 09:49:29 volumio sudo[7632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Jul 20 09:49:29 volumio sudo[7632]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 09:49:29 volumio volumio[17210]: info: FusionDsp - Reporting Fusion DSP Enabled
Jul 20 09:49:29 volumio volumio[17210]: info: Adding Signal Path Element [object Object]
Jul 20 09:49:29 volumio volumio[17210]: info: Adding fusiondspeq DSP Signal Path Element
Jul 20 09:49:29 volumio volumio[17210]: info: FusionDsp - ---- installed callbackRead
Jul 20 09:49:29 volumio volumio[17210]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 20 09:49:29 volumio volumio[17210]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Jul 20 09:49:29 volumio volumio[17210]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Jul 20 09:49:29 volumio volumio[17210]: at onErrorNT (internal/child_process.js:465:16)
Jul 20 09:49:29 volumio volumio[17210]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Jul 20 09:49:29 volumio volumio[17210]: at runNextTicks (internal/process/task_queues.js:62:3)
Jul 20 09:49:29 volumio volumio[17210]: at listOnTimeout (internal/timers.js:523:9)
Jul 20 09:49:29 volumio volumio[17210]: at processTimers (internal/timers.js:497:7) {
Jul 20 09:49:29 volumio volumio[17210]: errno: -2,
Jul 20 09:49:29 volumio volumio[17210]: code: 'ENOENT',
Jul 20 09:49:29 volumio volumio[17210]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Jul 20 09:49:29 volumio volumio[17210]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Jul 20 09:49:29 volumio volumio[17210]: spawnargs: [
Jul 20 09:49:29 volumio volumio[17210]: '-p',
Jul 20 09:49:29 volumio volumio[17210]: 9876,
Jul 20 09:49:29 volumio volumio[17210]: '-o',
Jul 20 09:49:29 volumio volumio[17210]: '/tmp/camilladsp.log',
Jul 20 09:49:29 volumio volumio[17210]: '-l',
Jul 20 09:49:29 volumio volumio[17210]: 'warn',
Jul 20 09:49:29 volumio volumio[17210]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Jul 20 09:49:29 volumio volumio[17210]: ]
Jul 20 09:49:29 volumio volumio[17210]: }
Jul 20 09:49:29 volumio volumio[17210]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 20 09:49:32 volumio volumio-remote-updater[566]: [2024-07-20 09:49:32] [connect] Successful connection
Jul 20 09:49:32 volumio sudo[7632]: pam_unix(sudo:session): session closed for user root
Jul 20 09:49:33 volumio sudo[7646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-20 09:48
Jul 20 09:49:33 volumio sudo[7646]: 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="905ee02fb5387537cfa16b84ebd7f14b7640848e"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 18 Jul 2024 07:14:40 PM CEST"
VOLUMIO_VERSION="3.741"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="a68099d1a5f4301106a28f85f8548ae3"