-- Logs begin at Sat 2025-01-18 03:14:59 PST, end at Sat 2025-01-18 13:15:36 PST. -- Jan 18 13:14:00 volumio volumio[879]: info: camilladsp spawned new process with pid 11504, instance 2, run: true Jan 18 13:14:00 volumio volumio[879]: info: Selecting previously unselected package python3.7-dev. Jan 18 13:14:00 volumio volumio[879]: info: Selecting previously unselected package python3.7-dev. Jan 18 13:14:00 volumio volumio[879]: info: camilladsp spawned new process with pid 11517, instance 2, run: true Jan 18 13:14:00 volumio volumio[879]: info: Preparing to unpack .../40-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Jan 18 13:14:00 volumio volumio[879]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Jan 18 13:14:00 volumio volumio[879]: info: Preparing to unpack .../40-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Jan 18 13:14:00 volumio volumio[879]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Jan 18 13:14:00 volumio mpd[11427]: Jan 18 13:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 13:14:00 volumio volumio[879]: info: camilladsp spawned new process with pid 11533, instance 2, run: true Jan 18 13:14:00 volumio volumio[879]: info: Selecting previously unselected package python3-dev. Jan 18 13:14:00 volumio volumio[879]: info: Preparing to unpack .../41-python3-dev_3.7.3-1_armhf.deb ... Jan 18 13:14:00 volumio volumio[879]: info: Unpacking python3-dev (3.7.3-1) ... Jan 18 13:14:00 volumio volumio[879]: info: Selecting previously unselected package python3-dev. Jan 18 13:14:00 volumio volumio[879]: info: Preparing to unpack .../41-python3-dev_3.7.3-1_armhf.deb ... Jan 18 13:14:00 volumio volumio[879]: info: Unpacking python3-dev (3.7.3-1) ... Jan 18 13:14:00 volumio volumio[879]: info: camilladsp spawned new process with pid 11549, instance 2, run: true Jan 18 13:14:00 volumio volumio[879]: info: Selecting previously unselected package python3-entrypoints. Jan 18 13:14:00 volumio volumio[879]: info: Preparing to unpack .../42-python3-entrypoints_0.3-1_all.deb ... Jan 18 13:14:00 volumio volumio[879]: info: Unpacking python3-entrypoints (0.3-1) ... Jan 18 13:14:01 volumio volumio[879]: info: Selecting previously unselected package python3-entrypoints. Jan 18 13:14:01 volumio volumio[879]: info: Preparing to unpack .../42-python3-entrypoints_0.3-1_all.deb ... Jan 18 13:14:01 volumio volumio[879]: info: Unpacking python3-entrypoints (0.3-1) ... Jan 18 13:14:01 volumio volumio[11392]: Traceback (most recent call last): Jan 18 13:14:01 volumio volumio[11392]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:01 volumio volumio[11392]: from camilladsp import CamillaConnection Jan 18 13:14:01 volumio volumio[11392]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:01 volumio volumio[879]: info: camilladsp spawned new process with pid 11565, instance 2, run: true Jan 18 13:14:01 volumio volumio[879]: info: Selecting previously unselected package python3-gi. Jan 18 13:14:01 volumio volumio[879]: info: Preparing to unpack .../43-python3-gi_3.30.4-1_armhf.deb ... Jan 18 13:14:01 volumio volumio[879]: info: Unpacking python3-gi (3.30.4-1) ... Jan 18 13:14:01 volumio volumio[879]: info: Selecting previously unselected package python3-gi. Jan 18 13:14:01 volumio volumio[879]: info: Preparing to unpack .../43-python3-gi_3.30.4-1_armhf.deb ... Jan 18 13:14:01 volumio volumio[879]: info: Unpacking python3-gi (3.30.4-1) ... Jan 18 13:14:01 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:01 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:01 volumio systemd[1]: Started Music Player Daemon. Jan 18 13:14:01 volumio sudo[11405]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:01 volumio sudo[11297]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:01 volumio sudo[11370]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:01 volumio sudo[11323]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:01 volumio volumio[879]: info: camilladsp spawned new process with pid 11574, instance 2, run: true Jan 18 13:14:01 volumio volumio[879]: error: MPD error: The expression evaluated to a falsy value: Jan 18 13:14:01 volumio volumio[879]: assert.ok(self.idling) Jan 18 13:14:01 volumio volumio[879]: error: The expression evaluated to a falsy value: Jan 18 13:14:01 volumio volumio[879]: assert.ok(self.idling) Jan 18 13:14:01 volumio volumio[879]: error: MPD error: The expression evaluated to a falsy value: Jan 18 13:14:01 volumio volumio[879]: assert.ok(self.idling) Jan 18 13:14:01 volumio volumio[879]: error: The expression evaluated to a falsy value: Jan 18 13:14:01 volumio volumio[879]: assert.ok(self.idling) Jan 18 13:14:01 volumio volumio[879]: error: MPD error: The expression evaluated to a falsy value: Jan 18 13:14:01 volumio volumio[879]: assert.ok(self.idling) Jan 18 13:14:01 volumio volumio[879]: error: The expression evaluated to a falsy value: Jan 18 13:14:01 volumio volumio[879]: assert.ok(self.idling) Jan 18 13:14:01 volumio volumio[879]: error: updateQueue error: null Jan 18 13:14:01 volumio volumio[879]: info: camilladsp spawned new process with pid 11581, instance 2, run: true Jan 18 13:14:01 volumio volumio[879]: info: camilladsp spawned new process with pid 11594, instance 2, run: true Jan 18 13:14:01 volumio volumio[879]: info: Selecting previously unselected package python3-secretstorage. Jan 18 13:14:01 volumio volumio[879]: info: Selecting previously unselected package python3-secretstorage. Jan 18 13:14:01 volumio volumio[879]: info: Preparing to unpack .../44-python3-secretstorage_2.3.1-2_all.deb ... Jan 18 13:14:01 volumio volumio[879]: info: Preparing to unpack .../44-python3-secretstorage_2.3.1-2_all.deb ... Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11606, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: Unpacking python3-secretstorage (2.3.1-2) ... Jan 18 13:14:02 volumio volumio[879]: info: Unpacking python3-secretstorage (2.3.1-2) ... Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11620, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: Selecting previously unselected package python3-keyring. Jan 18 13:14:02 volumio volumio[879]: info: Preparing to unpack .../45-python3-keyring_17.1.1-1_all.deb ... Jan 18 13:14:02 volumio volumio[879]: info: Selecting previously unselected package python3-keyring. Jan 18 13:14:02 volumio volumio[879]: info: Preparing to unpack .../45-python3-keyring_17.1.1-1_all.deb ... Jan 18 13:14:02 volumio volumio[879]: info: Unpacking python3-keyring (17.1.1-1) ... Jan 18 13:14:02 volumio volumio[879]: info: Unpacking python3-keyring (17.1.1-1) ... Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11627, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11634, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11641, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11648, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11655, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11662, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11675, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11682, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: Selecting previously unselected package python3-keyrings.alt. Jan 18 13:14:02 volumio volumio[879]: info: Selecting previously unselected package python3-keyrings.alt. Jan 18 13:14:02 volumio volumio[879]: info: Preparing to unpack .../46-python3-keyrings.alt_3.1.1-1_all.deb ... Jan 18 13:14:02 volumio volumio[879]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Jan 18 13:14:02 volumio volumio[879]: info: Preparing to unpack .../46-python3-keyrings.alt_3.1.1-1_all.deb ... Jan 18 13:14:02 volumio volumio[879]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11707, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: Selecting previously unselected package python3-pip. Jan 18 13:14:02 volumio volumio[879]: info: Selecting previously unselected package python3-pip. Jan 18 13:14:02 volumio volumio[879]: info: camilladsp spawned new process with pid 11722, instance 2, run: true Jan 18 13:14:02 volumio volumio[879]: info: Preparing to unpack .../47-python3-pip_18.1-5+rpt1_all.deb ... Jan 18 13:14:03 volumio volumio[879]: info: Unpacking python3-pip (18.1-5+rpt1) ... Jan 18 13:14:03 volumio volumio[879]: info: Preparing to unpack .../47-python3-pip_18.1-5+rpt1_all.deb ... Jan 18 13:14:03 volumio volumio[879]: info: Unpacking python3-pip (18.1-5+rpt1) ... Jan 18 13:14:03 volumio volumio[879]: info: camilladsp spawned new process with pid 11729, instance 2, run: true Jan 18 13:14:03 volumio volumio[879]: info: camilladsp spawned new process with pid 11736, instance 2, run: true Jan 18 13:14:03 volumio volumio[879]: info: camilladsp spawned new process with pid 11743, instance 2, run: true Jan 18 13:14:03 volumio volumio[879]: info: camilladsp spawned new process with pid 11750, instance 2, run: true Jan 18 13:14:03 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:03 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1. Jan 18 13:14:03 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:03 volumio volumio[879]: info: camilladsp spawned new process with pid 11757, instance 2, run: true Jan 18 13:14:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:03 volumio volumio[879]: info: CorePlayQueue::getTrack 1 Jan 18 13:14:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:03 volumio volumio[879]: info: CorePlayQueue::getTrack 1 Jan 18 13:14:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:03 volumio volumio[879]: info: CorePlayQueue::getTrack 1 Jan 18 13:14:03 volumio volumio[879]: info: Listing playlists Jan 18 13:14:03 volumio volumio[879]: info: Listing playlists Jan 18 13:14:03 volumio volumio[879]: info: Listing playlists Jan 18 13:14:03 volumio volumio[879]: info: Listing playlists Jan 18 13:14:03 volumio volumio[879]: info: Listing playlists Jan 18 13:14:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:03 volumio volumio[879]: info: CorePlayQueue::getTrack 1 Jan 18 13:14:03 volumio volumio[879]: info: Listing playlists Jan 18 13:14:03 volumio volumio[879]: info: Listing playlists Jan 18 13:14:03 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:03 volumio volumio[879]: info: camilladsp spawned new process with pid 11765, instance 2, run: true Jan 18 13:14:03 volumio volumio[879]: info: camilladsp spawned new process with pid 11772, instance 2, run: true Jan 18 13:14:03 volumio volumio[879]: info: camilladsp spawned new process with pid 11782, instance 2, run: true Jan 18 13:14:03 volumio volumio[879]: info: Selecting previously unselected package python3-setuptools. Jan 18 13:14:03 volumio volumio[879]: info: Selecting previously unselected package python3-setuptools. Jan 18 13:14:04 volumio volumio[879]: info: camilladsp spawned new process with pid 11795, instance 2, run: true Jan 18 13:14:04 volumio volumio[879]: info: Preparing to unpack .../48-python3-setuptools_40.8.0-1_all.deb ... Jan 18 13:14:04 volumio volumio[879]: info: Unpacking python3-setuptools (40.8.0-1) ... Jan 18 13:14:04 volumio volumio[879]: info: Preparing to unpack .../48-python3-setuptools_40.8.0-1_all.deb ... Jan 18 13:14:04 volumio volumio[879]: info: Unpacking python3-setuptools (40.8.0-1) ... Jan 18 13:14:04 volumio volumio[879]: info: CoreCommandRouter::volumioNext Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::next Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::stop Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::stPlaybackTimer Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::updateTrackBlock Jan 18 13:14:04 volumio volumio[879]: info: CorePlayQueue::getTrackBlock Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:04 volumio volumio[879]: info: CorePlayQueue::getTrack 1 Jan 18 13:14:04 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:14:04 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::serviceStop Jan 18 13:14:04 volumio volumio[879]: info: CorePlayQueue::getTrack 1 Jan 18 13:14:04 volumio volumio[879]: info: CoreCommandRouter::serviceStop Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::stop Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 13:14:04 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand stop took 15 milliseconds Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::play index undefined Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 13:14:04 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::startPlaybackTimer Jan 18 13:14:04 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::clearAddPlayTracks NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 13:14:04 volumio volumio[879]: info: CoreStateMachine::updateTrackBlock Jan 18 13:14:04 volumio volumio[879]: info: CorePlayQueue::getTrackBlock Jan 18 13:14:04 volumio volumio[879]: info: camilladsp spawned new process with pid 11802, instance 2, run: true Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand stop took 39 milliseconds Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand clear Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces system playlist update Jan 18 13:14:04 volumio volumio[879]: info: Ignoring MPD Status Update Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand clear took 3 milliseconds Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand add "NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac" Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces system playlist update Jan 18 13:14:04 volumio volumio[879]: info: Ignoring MPD Status Update Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces system playlist update Jan 18 13:14:04 volumio volumio[879]: info: Ignoring MPD Status Update Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces system playlist update Jan 18 13:14:04 volumio volumio[879]: info: Ignoring MPD Status Update Jan 18 13:14:04 volumio volumio[879]: error: updateQueue error: null Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces system playlist update Jan 18 13:14:04 volumio volumio[879]: info: Ignoring MPD Status Update Jan 18 13:14:04 volumio volumio[879]: info: ------------------------------ 9ms Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand add "NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac" took 7 milliseconds Jan 18 13:14:04 volumio volumio[879]: info: ------------------------------ 7ms Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand play Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces system playlist update Jan 18 13:14:04 volumio volumio[879]: info: Ignoring MPD Status Update Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces system playlist update Jan 18 13:14:04 volumio volumio[879]: info: Ignoring MPD Status Update Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces system playlist update Jan 18 13:14:04 volumio volumio[879]: info: Ignoring MPD Status Update Jan 18 13:14:04 volumio volumio[879]: info: ------------------------------ 14ms Jan 18 13:14:04 volumio volumio[879]: info: ------------------------------ 12ms Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand play took 10 milliseconds Jan 18 13:14:04 volumio volumio[879]: info: ------------------------------ 9ms Jan 18 13:14:04 volumio volumio[879]: info: ------------------------------ 4ms Jan 18 13:14:04 volumio volumio[879]: info: camilladsp spawned new process with pid 11823, instance 2, run: true Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:14:04 volumio volumio[879]: info: FusionDsp - ---- read samplerate, raw: 96000,S32_LE,2,32 Jan 18 13:14:04 volumio volumio[879]: info: FusionDsp - ---- read samplerate from file: 96000 Jan 18 13:14:04 volumio volumio[879]: info: camilladsp stopping service pid 11425... Jan 18 13:14:04 volumio volumio[879]: info: camilladsp service terminated, instance 1 Jan 18 13:14:04 volumio volumio[879]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 13:14:04 volumio volumio[879]: info: camilladsp service started and running in background, instance 1 Jan 18 13:14:04 volumio volumio[879]: info: FusionDsp - ---- read samplerate, raw: 96000,S32_LE,2,32 Jan 18 13:14:04 volumio volumio[879]: info: FusionDsp - ---- read samplerate from file: 96000 Jan 18 13:14:04 volumio volumio[879]: info: camilladsp stopping service pid 11823... Jan 18 13:14:04 volumio volumio[879]: info: camilladsp service terminated, instance 2 Jan 18 13:14:04 volumio volumio[879]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 13:14:04 volumio volumio[879]: info: camilladsp service started and running in background, instance 2 Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand status took 305 milliseconds Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand status took 309 milliseconds Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand status took 308 milliseconds Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand status took 308 milliseconds Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:14:04 volumio volumio[879]: info: Jan 18 13:14:04 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:14:04 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:14:04 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:14:04 volumio volumio[879]: info: camilladsp spawned new process with pid 11839, instance 2, run: true Jan 18 13:14:04 volumio volumio[879]: info: camilladsp spawned new process with pid 11846, instance 1, run: true Jan 18 13:14:04 volumio volumio[879]: info: sendMpdCommand status took 152 milliseconds Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand playlistinfo took 145 milliseconds Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand playlistinfo took 146 milliseconds Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand status took 144 milliseconds Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand status took 137 milliseconds Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand status took 136 milliseconds Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::parseTrackInfo Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:14:05 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:14:05 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState stateService play Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus stop Jan 18 13:14:05 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:14:05 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState stateService play Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus play Jan 18 13:14:05 volumio volumio[879]: info: Received an update from plugin. extracting info from payload Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:14:05 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState stateService play Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus play Jan 18 13:14:05 volumio volumio[879]: info: Received an update from plugin. extracting info from payload Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:14:05 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState stateService play Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus play Jan 18 13:14:05 volumio volumio[879]: info: Received an update from plugin. extracting info from payload Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: ------------------------------ 646ms Jan 18 13:14:05 volumio volumio[879]: info: ------------------------------ 688ms Jan 18 13:14:05 volumio volumio[879]: info: ------------------------------ 677ms Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand playlistinfo took 223 milliseconds Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand playlistinfo took 221 milliseconds Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand playlistinfo took 222 milliseconds Jan 18 13:14:05 volumio volumio[879]: info: sendMpdCommand playlistinfo took 221 milliseconds Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::parseTrackInfo Jan 18 13:14:05 volumio volumio[879]: verbose: ControllerMpd::parseTrackInfo Jan 18 13:14:05 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1490,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2494 Kbps","isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:14:05 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState stateService play Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus play Jan 18 13:14:05 volumio volumio[879]: info: Received an update from plugin. extracting info from payload Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1490,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2494 Kbps","isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:14:05 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState stateService play Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus play Jan 18 13:14:05 volumio volumio[879]: info: Received an update from plugin. extracting info from payload Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1490,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2494 Kbps","isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:14:05 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState stateService play Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus play Jan 18 13:14:05 volumio volumio[879]: info: Received an update from plugin. extracting info from payload Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1490,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2494 Kbps","isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:14:05 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState stateService play Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus play Jan 18 13:14:05 volumio volumio[879]: info: Received an update from plugin. extracting info from payload Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:14:05 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:05 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:14:05 volumio volumio[879]: info: ------------------------------ 464ms Jan 18 13:14:05 volumio volumio[879]: info: ------------------------------ 436ms Jan 18 13:14:05 volumio volumio[879]: info: ------------------------------ 431ms Jan 18 13:14:05 volumio volumio[879]: info: ------------------------------ 429ms Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:14:05 volumio volumio[879]: info: camilladsp spawned new process with pid 11862, instance 1, run: true Jan 18 13:14:05 volumio volumio[879]: info: Selecting previously unselected package python3-wheel. Jan 18 13:14:05 volumio volumio[879]: info: Preparing to unpack .../49-python3-wheel_0.32.3-2_all.deb ... Jan 18 13:14:05 volumio volumio[879]: info: Unpacking python3-wheel (0.32.3-2) ... Jan 18 13:14:05 volumio volumio[879]: info: Selecting previously unselected package python3-wheel. Jan 18 13:14:05 volumio volumio[879]: info: Preparing to unpack .../49-python3-wheel_0.32.3-2_all.deb ... Jan 18 13:14:05 volumio volumio[879]: info: Unpacking python3-wheel (0.32.3-2) ... Jan 18 13:14:05 volumio volumio[879]: info: camilladsp spawned new process with pid 11875, instance 1, run: true Jan 18 13:14:05 volumio volumio[879]: info: Selecting previously unselected package python3-xdg. Jan 18 13:14:05 volumio volumio[879]: info: Selecting previously unselected package python3-xdg. Jan 18 13:14:05 volumio volumio[879]: info: Preparing to unpack .../50-python3-xdg_0.25-5_all.deb ... Jan 18 13:14:05 volumio volumio[879]: info: Unpacking python3-xdg (0.25-5) ... Jan 18 13:14:05 volumio volumio[879]: info: Preparing to unpack .../50-python3-xdg_0.25-5_all.deb ... Jan 18 13:14:05 volumio volumio[879]: info: Unpacking python3-xdg (0.25-5) ... Jan 18 13:14:05 volumio volumio[879]: info: camilladsp spawned new process with pid 11885, instance 1, run: true Jan 18 13:14:06 volumio volumio[11758]: Traceback (most recent call last): Jan 18 13:14:06 volumio volumio[11758]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:06 volumio volumio[11758]: from camilladsp import CamillaConnection Jan 18 13:14:06 volumio volumio[11758]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11893, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11900, instance 1, run: true Jan 18 13:14:06 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:06 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11909, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: Setting up python3-entrypoints (0.3-1) ... Jan 18 13:14:06 volumio volumio[879]: info: Setting up python3-entrypoints (0.3-1) ... Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11919, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11926, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11933, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11940, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11951, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11960, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11967, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11974, instance 1, run: true Jan 18 13:14:06 volumio volumio[879]: info: camilladsp spawned new process with pid 11983, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 11990, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 11997, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 12005, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: Setting up dh-python (3.20190308) ... Jan 18 13:14:07 volumio volumio[879]: info: Setting up dh-python (3.20190308) ... Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 12015, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 12022, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 12029, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 12038, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 12049, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 12056, instance 1, run: true Jan 18 13:14:07 volumio volumio[879]: info: camilladsp spawned new process with pid 12065, instance 1, run: true Jan 18 13:14:08 volumio volumio[879]: info: camilladsp spawned new process with pid 12072, instance 1, run: true Jan 18 13:14:08 volumio volumio[879]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:14:08 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:08 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2. Jan 18 13:14:08 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:08 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:08 volumio volumio[879]: info: camilladsp spawned new process with pid 12081, instance 1, run: true Jan 18 13:14:08 volumio volumio[879]: info: Setting up python3-attr (18.2.0-1) ... Jan 18 13:14:08 volumio volumio[879]: info: Setting up python3-attr (18.2.0-1) ... Jan 18 13:14:08 volumio volumio[879]: info: camilladsp spawned new process with pid 12091, instance 1, run: true Jan 18 13:14:08 volumio volumio[879]: info: camilladsp spawned new process with pid 12098, instance 1, run: true Jan 18 13:14:08 volumio volumio[879]: info: camilladsp spawned new process with pid 12105, instance 1, run: true Jan 18 13:14:08 volumio volumio[879]: info: camilladsp spawned new process with pid 12116, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12125, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12132, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12141, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12148, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12155, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12162, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: Setting up python3-dbus (1.2.8-3) ... Jan 18 13:14:09 volumio volumio[879]: info: Setting up python3-dbus (1.2.8-3) ... Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12173, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12180, instance 1, run: true Jan 18 13:14:09 volumio volumio[879]: info: camilladsp spawned new process with pid 12187, instance 1, run: true Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12195, instance 1, run: true Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12208, instance 1, run: true Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12215, instance 1, run: true Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12224, instance 1, run: true Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12231, instance 1, run: true Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12238, instance 1, run: true Jan 18 13:14:10 volumio volumio[12079]: Traceback (most recent call last): Jan 18 13:14:10 volumio volumio[12079]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:10 volumio volumio[12079]: from camilladsp import CamillaConnection Jan 18 13:14:10 volumio volumio[12079]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12245, instance 1, run: true Jan 18 13:14:10 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:10 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12252, instance 1, run: true Jan 18 13:14:10 volumio volumio[879]: info: camilladsp spawned new process with pid 12260, instance 1, run: true Jan 18 13:14:10 volumio volumio[879]: info: Setting up python3-setuptools (40.8.0-1) ... Jan 18 13:14:10 volumio volumio[879]: info: Setting up python3-setuptools (40.8.0-1) ... Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12270, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12277, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12284, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12295, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12304, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12311, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12319, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12327, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12334, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12341, instance 1, run: true Jan 18 13:14:11 volumio volumio[879]: info: camilladsp spawned new process with pid 12348, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12355, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12362, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12369, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12376, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12383, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12390, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12397, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12418, instance 1, run: true Jan 18 13:14:12 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:12 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 3. Jan 18 13:14:12 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12425, instance 1, run: true Jan 18 13:14:12 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:12 volumio volumio[879]: info: camilladsp spawned new process with pid 12434, instance 1, run: true Jan 18 13:14:12 volumio volumio[879]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ... Jan 18 13:14:12 volumio volumio[879]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ... Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12441, instance 1, run: true Jan 18 13:14:13 volumio volumio[879]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Jan 18 13:14:13 volumio volumio[879]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Jan 18 13:14:13 volumio volumio[879]: info: Setting up python3-xdg (0.25-5) ... Jan 18 13:14:13 volumio volumio[879]: info: Setting up python3-xdg (0.25-5) ... Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12451, instance 1, run: true Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12458, instance 1, run: true Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12465, instance 1, run: true Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12476, instance 1, run: true Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12485, instance 1, run: true Jan 18 13:14:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12492, instance 1, run: true Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12499, instance 1, run: true Jan 18 13:14:13 volumio volumio[879]: info: camilladsp spawned new process with pid 12508, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12515, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12522, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12529, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12536, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12548, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ... Jan 18 13:14:14 volumio volumio[879]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ... Jan 18 13:14:14 volumio volumio[879]: info: Setting up python3-wheel (0.32.3-2) ... Jan 18 13:14:14 volumio volumio[879]: info: Setting up python3-wheel (0.32.3-2) ... Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12565, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12575, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12582, instance 1, run: true Jan 18 13:14:14 volumio volumio[879]: info: camilladsp spawned new process with pid 12593, instance 1, run: true Jan 18 13:14:15 volumio volumio[12426]: Traceback (most recent call last): Jan 18 13:14:15 volumio volumio[12426]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:15 volumio volumio[12426]: from camilladsp import CamillaConnection Jan 18 13:14:15 volumio volumio[12426]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12602, instance 1, run: true Jan 18 13:14:15 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:15 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12609, instance 1, run: true Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12618, instance 1, run: true Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12625, instance 1, run: true Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12632, instance 1, run: true Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12640, instance 1, run: true Jan 18 13:14:15 volumio volumio[879]: info: Setting up python3-multidict (4.5.2-1) ... Jan 18 13:14:15 volumio volumio[879]: info: Setting up python3-multidict (4.5.2-1) ... Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12650, instance 1, run: true Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12657, instance 1, run: true Jan 18 13:14:15 volumio volumio[879]: info: camilladsp spawned new process with pid 12664, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12671, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12682, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12691, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12698, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12705, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12714, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12721, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12728, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12736, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12743, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: Setting up libfakeroot:armhf (1.23-1) ... Jan 18 13:14:16 volumio volumio[879]: info: Setting up libfakeroot:armhf (1.23-1) ... Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12750, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12757, instance 1, run: true Jan 18 13:14:16 volumio volumio[879]: info: Setting up python3-async-timeout (3.0.1-1) ... Jan 18 13:14:16 volumio volumio[879]: info: Setting up python3-async-timeout (3.0.1-1) ... Jan 18 13:14:16 volumio volumio[879]: info: camilladsp spawned new process with pid 12767, instance 1, run: true Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12774, instance 1, run: true Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12781, instance 1, run: true Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12788, instance 1, run: true Jan 18 13:14:17 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:17 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 4. Jan 18 13:14:17 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12799, instance 1, run: true Jan 18 13:14:17 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12809, instance 1, run: true Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12816, instance 1, run: true Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12825, instance 1, run: true Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12832, instance 1, run: true Jan 18 13:14:17 volumio volumio[879]: info: camilladsp spawned new process with pid 12839, instance 1, run: true Jan 18 13:14:17 volumio volumio[879]: info: Setting up fakeroot (1.23-1) ... Jan 18 13:14:17 volumio volumio[879]: info: Setting up fakeroot (1.23-1) ... Jan 18 13:14:18 volumio volumio[879]: info: camilladsp spawned new process with pid 12849, instance 1, run: true Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/fakeroot.1.gz because associated file /usr/share/man/es/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/faked.1.gz because associated file /usr/share/man/es/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/fakeroot.1.gz because associated file /usr/share/man/fr/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/faked.1.gz because associated file /usr/share/man/fr/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/fakeroot.1.gz because associated file /usr/share/man/sv/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/fakeroot.1.gz because associated file /usr/share/man/es/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/faked.1.gz because associated file /usr/share/man/es/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/fakeroot.1.gz because associated file /usr/share/man/fr/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/faked.1.gz because associated file /usr/share/man/fr/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/fakeroot.1.gz because associated file /usr/share/man/sv/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/faked.1.gz because associated file /usr/share/man/sv/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: camilladsp spawned new process with pid 12857, instance 1, run: true Jan 18 13:14:18 volumio volumio[879]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/faked.1.gz because associated file /usr/share/man/sv/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jan 18 13:14:18 volumio volumio[879]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:18 volumio volumio[879]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Jan 18 13:14:18 volumio volumio[879]: info: Setting up make (4.2.1-1.2) ... Jan 18 13:14:18 volumio volumio[879]: info: Setting up libmpfr6:armhf (4.0.2-1) ... Jan 18 13:14:18 volumio volumio[879]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:18 volumio volumio[879]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Jan 18 13:14:18 volumio volumio[879]: info: Setting up make (4.2.1-1.2) ... Jan 18 13:14:18 volumio volumio[879]: info: Setting up libmpfr6:armhf (4.0.2-1) ... Jan 18 13:14:18 volumio volumio[879]: info: camilladsp spawned new process with pid 12867, instance 1, run: true Jan 18 13:14:19 volumio volumio[879]: info: Setting up python3-gi (3.30.4-1) ... Jan 18 13:14:19 volumio volumio[879]: info: Setting up python3-gi (3.30.4-1) ... Jan 18 13:14:19 volumio volumio[879]: info: camilladsp spawned new process with pid 12878, instance 1, run: true Jan 18 13:14:19 volumio volumio[879]: info: camilladsp spawned new process with pid 12887, instance 1, run: true Jan 18 13:14:19 volumio volumio[879]: info: camilladsp spawned new process with pid 12894, instance 1, run: true Jan 18 13:14:19 volumio volumio[879]: info: camilladsp spawned new process with pid 12903, instance 1, run: true Jan 18 13:14:19 volumio volumio[879]: info: camilladsp spawned new process with pid 12910, instance 1, run: true Jan 18 13:14:19 volumio volumio[12800]: Traceback (most recent call last): Jan 18 13:14:19 volumio volumio[12800]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:19 volumio volumio[12800]: from camilladsp import CamillaConnection Jan 18 13:14:19 volumio volumio[12800]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:19 volumio volumio[879]: info: camilladsp spawned new process with pid 12917, instance 1, run: true Jan 18 13:14:19 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:19 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:19 volumio volumio[879]: info: camilladsp spawned new process with pid 12924, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12931, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12938, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12946, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12953, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: Setting up libmpc3:armhf (1.1.0-1) ... Jan 18 13:14:20 volumio volumio[879]: info: Setting up libmpc3:armhf (1.1.0-1) ... Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12960, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: Setting up patch (2.7.6-3+deb10u1) ... Jan 18 13:14:20 volumio volumio[879]: info: Setting up patch (2.7.6-3+deb10u1) ... Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12967, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:20 volumio volumio[879]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12974, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: Setting up libisl19:armhf (0.20-2) ... Jan 18 13:14:20 volumio volumio[879]: info: Setting up libisl19:armhf (0.20-2) ... Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12984, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: Setting up python3-crypto (2.6.1-9+b1) ... Jan 18 13:14:20 volumio volumio[879]: info: Setting up python3-crypto (2.6.1-9+b1) ... Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12991, instance 1, run: true Jan 18 13:14:20 volumio volumio[879]: info: camilladsp spawned new process with pid 12998, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13005, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13016, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13025, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13032, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13041, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13048, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13055, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13062, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13069, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13076, instance 1, run: true Jan 18 13:14:21 volumio volumio[879]: info: camilladsp spawned new process with pid 13083, instance 1, run: true Jan 18 13:14:22 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:22 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 5. Jan 18 13:14:22 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:22 volumio volumio[879]: info: camilladsp spawned new process with pid 13090, instance 1, run: true Jan 18 13:14:22 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:22 volumio volumio[879]: info: camilladsp spawned new process with pid 13098, instance 1, run: true Jan 18 13:14:22 volumio volumio[879]: info: camilladsp spawned new process with pid 13105, instance 1, run: true Jan 18 13:14:22 volumio volumio[879]: info: camilladsp spawned new process with pid 13112, instance 1, run: true Jan 18 13:14:22 volumio volumio[879]: info: camilladsp spawned new process with pid 13119, instance 1, run: true Jan 18 13:14:22 volumio volumio[879]: info: camilladsp spawned new process with pid 13126, instance 1, run: true Jan 18 13:14:22 volumio volumio[879]: info: camilladsp spawned new process with pid 13134, instance 1, run: true Jan 18 13:14:22 volumio volumio[879]: info: Setting up python-pip-whl (18.1-5+rpt1) ... Jan 18 13:14:22 volumio volumio[879]: info: Setting up python-pip-whl (18.1-5+rpt1) ... Jan 18 13:14:22 volumio volumio[879]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... Jan 18 13:14:22 volumio volumio[879]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... Jan 18 13:14:22 volumio volumio[879]: info: camilladsp spawned new process with pid 13158, instance 1, run: true Jan 18 13:14:22 volumio volumio[879]: info: Setting up python3-yarl (1.3.0-1) ... Jan 18 13:14:22 volumio volumio[879]: info: Setting up python3-yarl (1.3.0-1) ... Jan 18 13:14:23 volumio volumio[879]: info: camilladsp spawned new process with pid 13165, instance 1, run: true Jan 18 13:14:23 volumio volumio[879]: info: camilladsp spawned new process with pid 13172, instance 1, run: true Jan 18 13:14:23 volumio volumio[879]: info: camilladsp spawned new process with pid 13183, instance 1, run: true Jan 18 13:14:23 volumio volumio[879]: info: camilladsp spawned new process with pid 13192, instance 1, run: true Jan 18 13:14:23 volumio volumio[879]: info: camilladsp spawned new process with pid 13199, instance 1, run: true Jan 18 13:14:23 volumio volumio[879]: info: camilladsp spawned new process with pid 13208, instance 1, run: true Jan 18 13:14:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:23 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:23 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:23 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:23 volumio volumio[879]: info: Listing playlists Jan 18 13:14:23 volumio volumio[879]: info: Listing playlists Jan 18 13:14:23 volumio volumio[879]: info: Listing playlists Jan 18 13:14:23 volumio volumio[879]: info: Listing playlists Jan 18 13:14:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:23 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:23 volumio volumio[879]: info: Listing playlists Jan 18 13:14:23 volumio volumio[879]: info: Listing playlists Jan 18 13:14:23 volumio volumio[879]: info: camilladsp spawned new process with pid 13215, instance 1, run: true Jan 18 13:14:23 volumio volumio[879]: info: Listing playlists Jan 18 13:14:23 volumio volumio[879]: info: Listing playlists Jan 18 13:14:23 volumio volumio[879]: info: camilladsp spawned new process with pid 13222, instance 1, run: true Jan 18 13:14:23 volumio volumio[879]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Jan 18 13:14:23 volumio volumio[879]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13233, instance 1, run: true Jan 18 13:14:24 volumio volumio[879]: info: Setting up python3-asn1crypto (0.24.0-1) ... Jan 18 13:14:24 volumio volumio[879]: info: Setting up python3-asn1crypto (0.24.0-1) ... Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13240, instance 1, run: true Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13247, instance 1, run: true Jan 18 13:14:24 volumio volumio[13091]: Traceback (most recent call last): Jan 18 13:14:24 volumio volumio[13091]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:24 volumio volumio[13091]: from camilladsp import CamillaConnection Jan 18 13:14:24 volumio volumio[13091]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13254, instance 1, run: true Jan 18 13:14:24 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:24 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13276, instance 1, run: true Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13285, instance 1, run: true Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13292, instance 1, run: true Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13304, instance 1, run: true Jan 18 13:14:24 volumio volumio[879]: info: camilladsp spawned new process with pid 13311, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13318, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13325, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13332, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13339, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13346, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13353, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13360, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:25 volumio volumio[879]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:25 volumio volumio[879]: info: Setting up python3-cffi-backend (1.12.2-1) ... Jan 18 13:14:25 volumio volumio[879]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Jan 18 13:14:25 volumio volumio[879]: info: Setting up python3-cffi-backend (1.12.2-1) ... Jan 18 13:14:25 volumio volumio[879]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13367, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: camilladsp spawned new process with pid 13377, instance 1, run: true Jan 18 13:14:25 volumio volumio[879]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Jan 18 13:14:25 volumio volumio[879]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Jan 18 13:14:25 volumio volumio[879]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Jan 18 13:14:25 volumio volumio[879]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Jan 18 13:14:26 volumio volumio[879]: info: CALLMETHOD: audio_interface fusiondsp choosedsp [object Object] Jan 18 13:14:26 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , choosedsp Jan 18 13:14:26 volumio volumio[879]: info: camilladsp spawned new process with pid 13384, instance 1, run: true Jan 18 13:14:26 volumio volumio[879]: info: camilladsp spawned new process with pid 13395, instance 1, run: true Jan 18 13:14:26 volumio volumio[879]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 13:14:26 volumio volumio[879]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:14:26 volumio volumio[879]: info: CoreCommandRouter::Close All Modals sent Jan 18 13:14:26 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:26 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 6. Jan 18 13:14:26 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:26 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:26 volumio volumio[879]: info: camilladsp spawned new process with pid 13408, instance 1, run: true Jan 18 13:14:26 volumio volumio[879]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 18 13:14:27 volumio volumio[879]: info: camilladsp spawned new process with pid 13415, instance 1, run: true Jan 18 13:14:27 volumio volumio[879]: info: camilladsp spawned new process with pid 13422, instance 1, run: true Jan 18 13:14:27 volumio volumio[879]: info: camilladsp spawned new process with pid 13429, instance 1, run: true Jan 18 13:14:27 volumio volumio[879]: info: camilladsp spawned new process with pid 13436, instance 1, run: true Jan 18 13:14:27 volumio volumio[879]: info: camilladsp spawned new process with pid 13443, instance 1, run: true Jan 18 13:14:27 volumio volumio[879]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... Jan 18 13:14:27 volumio volumio[879]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... Jan 18 13:14:27 volumio volumio[879]: info: camilladsp spawned new process with pid 13452, instance 1, run: true Jan 18 13:14:27 volumio volumio[879]: info: Setting up dpkg-dev (1.19.8) ... Jan 18 13:14:27 volumio volumio[879]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... Jan 18 13:14:27 volumio volumio[879]: info: Setting up dpkg-dev (1.19.8) ... Jan 18 13:14:27 volumio volumio[879]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... Jan 18 13:14:27 volumio volumio[879]: info: camilladsp spawned new process with pid 13462, instance 1, run: true Jan 18 13:14:28 volumio volumio[13407]: Traceback (most recent call last): Jan 18 13:14:28 volumio volumio[13407]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:28 volumio volumio[13407]: from camilladsp import CamillaConnection Jan 18 13:14:28 volumio volumio[13407]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:28 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:28 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:28 volumio volumio[879]: info: camilladsp spawned new process with pid 13473, instance 1, run: true Jan 18 13:14:28 volumio volumio[879]: info: camilladsp spawned new process with pid 13482, instance 1, run: true Jan 18 13:14:28 volumio volumio[879]: info: camilladsp spawned new process with pid 13489, instance 1, run: true Jan 18 13:14:28 volumio volumio[879]: info: camilladsp spawned new process with pid 13498, instance 1, run: true Jan 18 13:14:28 volumio volumio[879]: info: camilladsp spawned new process with pid 13505, instance 1, run: true Jan 18 13:14:28 volumio volumio[879]: info: camilladsp spawned new process with pid 13512, instance 1, run: true Jan 18 13:14:28 volumio volumio[879]: info: camilladsp spawned new process with pid 13519, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13526, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13533, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13540, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13547, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13554, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13561, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13568, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13576, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: Setting up python3-pip (18.1-5+rpt1) ... Jan 18 13:14:29 volumio volumio[879]: info: Setting up python3-pip (18.1-5+rpt1) ... Jan 18 13:14:29 volumio volumio[879]: info: camilladsp spawned new process with pid 13586, instance 1, run: true Jan 18 13:14:29 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:14:29 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:14:29 volumio volumio[879]: info: Discovery: Getting this device information Jan 18 13:14:29 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:29 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:29 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:14:30 volumio volumio[879]: info: camilladsp spawned new process with pid 13593, instance 1, run: true Jan 18 13:14:30 volumio volumio[879]: info: camilladsp spawned new process with pid 13600, instance 1, run: true Jan 18 13:14:30 volumio volumio[879]: info: camilladsp spawned new process with pid 13612, instance 1, run: true Jan 18 13:14:30 volumio volumio[879]: info: CALLMETHOD: audio_interface fusiondsp moresettings Jan 18 13:14:30 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , moresettings Jan 18 13:14:30 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:30 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 7. Jan 18 13:14:30 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:30 volumio volumio[879]: info: camilladsp spawned new process with pid 13621, instance 1, run: true Jan 18 13:14:30 volumio volumio[879]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 13:14:30 volumio volumio[879]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:14:30 volumio volumio[879]: info: CoreCommandRouter::Close All Modals sent Jan 18 13:14:30 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:30 volumio volumio[879]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 18 13:14:30 volumio volumio[879]: info: camilladsp spawned new process with pid 13632, instance 1, run: true Jan 18 13:14:31 volumio volumio[879]: info: camilladsp spawned new process with pid 13639, instance 1, run: true Jan 18 13:14:31 volumio volumio[879]: info: camilladsp spawned new process with pid 13646, instance 1, run: true Jan 18 13:14:31 volumio volumio[879]: info: camilladsp spawned new process with pid 13653, instance 1, run: true Jan 18 13:14:31 volumio volumio[879]: info: camilladsp spawned new process with pid 13660, instance 1, run: true Jan 18 13:14:31 volumio volumio[879]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:31 volumio volumio[879]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:31 volumio volumio[879]: info: camilladsp spawned new process with pid 13670, instance 1, run: true Jan 18 13:14:31 volumio volumio[879]: info: Setting up cpp (4:8.3.0-1+rpi2) ... Jan 18 13:14:31 volumio volumio[879]: info: Setting up cpp (4:8.3.0-1+rpi2) ... Jan 18 13:14:31 volumio volumio[879]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Jan 18 13:14:31 volumio volumio[879]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Jan 18 13:14:31 volumio volumio[13622]: Traceback (most recent call last): Jan 18 13:14:31 volumio volumio[13622]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:31 volumio volumio[13622]: from camilladsp import CamillaConnection Jan 18 13:14:31 volumio volumio[13622]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:31 volumio volumio[879]: info: camilladsp spawned new process with pid 13680, instance 1, run: true Jan 18 13:14:31 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:31 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:31 volumio volumio[879]: info: camilladsp spawned new process with pid 13687, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: camilladsp spawned new process with pid 13695, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: camilladsp spawned new process with pid 13705, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: camilladsp spawned new process with pid 13714, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: camilladsp spawned new process with pid 13722, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: camilladsp spawned new process with pid 13730, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: camilladsp spawned new process with pid 13737, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: camilladsp spawned new process with pid 13744, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: camilladsp spawned new process with pid 13752, instance 1, run: true Jan 18 13:14:32 volumio volumio[879]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:32 volumio volumio[879]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Jan 18 13:14:32 volumio volumio[879]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... Jan 18 13:14:32 volumio volumio[879]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Jan 18 13:14:32 volumio volumio[879]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... Jan 18 13:14:32 volumio volumio[879]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13775, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: Setting up gcc (4:8.3.0-1+rpi2) ... Jan 18 13:14:33 volumio volumio[879]: info: Setting up python3-secretstorage (2.3.1-2) ... Jan 18 13:14:33 volumio volumio[879]: info: Setting up gcc (4:8.3.0-1+rpi2) ... Jan 18 13:14:33 volumio volumio[879]: info: Setting up python3-secretstorage (2.3.1-2) ... Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13787, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13794, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13801, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13812, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:33 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:33 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:33 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:33 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13821, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13828, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13837, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13844, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13851, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: camilladsp spawned new process with pid 13858, instance 1, run: true Jan 18 13:14:33 volumio volumio[879]: info: Setting up python3-dev (3.7.3-1) ... Jan 18 13:14:33 volumio volumio[879]: info: Setting up python3-dev (3.7.3-1) ... Jan 18 13:14:34 volumio volumio[879]: info: Setting up g++-8 (8.3.0-6+rpi1) ... Jan 18 13:14:34 volumio volumio[879]: info: Setting up g++-8 (8.3.0-6+rpi1) ... Jan 18 13:14:34 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:34 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 8. Jan 18 13:14:34 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:34 volumio volumio[879]: info: camilladsp spawned new process with pid 13865, instance 1, run: true Jan 18 13:14:34 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:34 volumio volumio[879]: info: Setting up python3-keyring (17.1.1-1) ... Jan 18 13:14:34 volumio volumio[879]: info: Setting up python3-keyring (17.1.1-1) ... Jan 18 13:14:34 volumio volumio[879]: info: camilladsp spawned new process with pid 13876, instance 1, run: true Jan 18 13:14:34 volumio volumio[879]: info: camilladsp spawned new process with pid 13883, instance 1, run: true Jan 18 13:14:34 volumio volumio[879]: info: camilladsp spawned new process with pid 13899, instance 1, run: true Jan 18 13:14:34 volumio volumio[879]: info: camilladsp spawned new process with pid 13912, instance 1, run: true Jan 18 13:14:34 volumio volumio[879]: info: camilladsp spawned new process with pid 13921, instance 1, run: true Jan 18 13:14:34 volumio volumio[879]: info: camilladsp spawned new process with pid 13931, instance 1, run: true Jan 18 13:14:34 volumio volumio[879]: info: camilladsp spawned new process with pid 13940, instance 1, run: true Jan 18 13:14:35 volumio volumio[879]: info: camilladsp spawned new process with pid 13947, instance 1, run: true Jan 18 13:14:35 volumio volumio[879]: info: camilladsp spawned new process with pid 13954, instance 1, run: true Jan 18 13:14:35 volumio volumio[879]: info: camilladsp spawned new process with pid 13961, instance 1, run: true Jan 18 13:14:35 volumio volumio[879]: info: camilladsp spawned new process with pid 13969, instance 1, run: true Jan 18 13:14:35 volumio volumio[879]: info: Setting up g++ (4:8.3.0-1+rpi2) ... Jan 18 13:14:35 volumio volumio[879]: info: Setting up g++ (4:8.3.0-1+rpi2) ... Jan 18 13:14:35 volumio volumio[879]: info: camilladsp spawned new process with pid 13979, instance 1, run: true Jan 18 13:14:35 volumio volumio[879]: info: camilladsp spawned new process with pid 13987, instance 1, run: true Jan 18 13:14:35 volumio volumio[879]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Jan 18 13:14:35 volumio volumio[879]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Jan 18 13:14:35 volumio volumio[13866]: Traceback (most recent call last): Jan 18 13:14:35 volumio volumio[13866]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:35 volumio volumio[13866]: from camilladsp import CamillaConnection Jan 18 13:14:35 volumio volumio[13866]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:35 volumio volumio[879]: info: camilladsp spawned new process with pid 13997, instance 1, run: true Jan 18 13:14:35 volumio volumio[879]: info: Setting up build-essential (12.6) ... Jan 18 13:14:35 volumio volumio[879]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Jan 18 13:14:35 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:35 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:35 volumio volumio[879]: info: Setting up build-essential (12.6) ... Jan 18 13:14:35 volumio volumio[879]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14004, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14011, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14018, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14025, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14032, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14039, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14046, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14053, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14060, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14067, instance 1, run: true Jan 18 13:14:36 volumio volumio[879]: info: camilladsp spawned new process with pid 14074, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14081, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14088, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14095, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14102, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14109, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14116, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14123, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14130, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14138, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14146, instance 1, run: true Jan 18 13:14:37 volumio volumio[879]: info: camilladsp spawned new process with pid 14153, instance 1, run: true Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14160, instance 1, run: true Jan 18 13:14:38 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:38 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9. Jan 18 13:14:38 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:38 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14169, instance 1, run: true Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14176, instance 1, run: true Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14183, instance 1, run: true Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14190, instance 1, run: true Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14197, instance 1, run: true Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14205, instance 1, run: true Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14217, instance 1, run: true Jan 18 13:14:38 volumio volumio[879]: info: camilladsp spawned new process with pid 14226, instance 1, run: true Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14233, instance 1, run: true Jan 18 13:14:39 volumio sudo[10394]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:39 volumio sudo[14236]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Jan 18 13:14:39 volumio sudo[14236]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:14:39 volumio sudo[14236]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14243, instance 1, run: true Jan 18 13:14:39 volumio volumio[879]: info: lib/systemd/system/fusiondsp.service Jan 18 13:14:39 volumio volumio[879]: info: lib/systemd/system/fusiondsp.service Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14250, instance 1, run: true Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14257, instance 1, run: true Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14264, instance 1, run: true Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14271, instance 1, run: true Jan 18 13:14:39 volumio volumio[14167]: Traceback (most recent call last): Jan 18 13:14:39 volumio volumio[14167]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:39 volumio volumio[14167]: from camilladsp import CamillaConnection Jan 18 13:14:39 volumio volumio[14167]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14278, instance 1, run: true Jan 18 13:14:39 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:39 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14285, instance 1, run: true Jan 18 13:14:39 volumio volumio[879]: info: camilladsp spawned new process with pid 14292, instance 1, run: true Jan 18 13:14:40 volumio volumio[879]: info: camilladsp spawned new process with pid 14299, instance 1, run: true Jan 18 13:14:40 volumio volumio[879]: info: camilladsp spawned new process with pid 14306, instance 1, run: true Jan 18 13:14:40 volumio volumio[879]: info: camilladsp spawned new process with pid 14313, instance 1, run: true Jan 18 13:14:40 volumio volumio[879]: info: camilladsp spawned new process with pid 14320, instance 1, run: true Jan 18 13:14:40 volumio volumio[879]: info: camilladsp spawned new process with pid 14327, instance 1, run: true Jan 18 13:14:40 volumio volumio[879]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Jan 18 13:14:40 volumio sudo[14335]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Jan 18 13:14:40 volumio sudo[14335]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:14:40 volumio volumio[879]: info: more info at http://www.winimage.com/zLibDll/unzip.html Jan 18 13:14:40 volumio volumio[879]: info: Jan 18 13:14:40 volumio volumio[879]: info: cgui-1.0.0.zip opened Jan 18 13:14:40 volumio sudo[14335]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:40 volumio volumio[879]: info: creating directory: cgui/ Jan 18 13:14:40 volumio sudo[14337]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Jan 18 13:14:40 volumio sudo[14337]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:14:40 volumio sudo[14337]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:40 volumio volumio[879]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Jan 18 13:14:40 volumio sudo[14339]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Jan 18 13:14:40 volumio sudo[14339]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:14:40 volumio volumio[879]: info: more info at http://www.winimage.com/zLibDll/unzip.html Jan 18 13:14:40 volumio volumio[879]: info: Jan 18 13:14:40 volumio volumio[879]: info: cgui-1.0.0.zip opened Jan 18 13:14:40 volumio volumio[879]: info: creating directory: cgui/ Jan 18 13:14:40 volumio sudo[14339]: pam_unix(sudo:session): session closed for user root Jan 18 13:14:40 volumio volumio[879]: info: camilladsp spawned new process with pid 14343, instance 1, run: true Jan 18 13:14:40 volumio volumio[879]: info: camilladsp spawned new process with pid 14350, instance 1, run: true Jan 18 13:14:40 volumio volumio[879]: info: camilladsp spawned new process with pid 14357, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14364, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14371, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14378, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14385, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14392, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14399, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14406, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14413, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14420, instance 1, run: true Jan 18 13:14:41 volumio volumio[879]: info: camilladsp spawned new process with pid 14427, instance 1, run: true Jan 18 13:14:42 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:42 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 10. Jan 18 13:14:42 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14434, instance 1, run: true Jan 18 13:14:42 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14442, instance 1, run: true Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14449, instance 1, run: true Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14456, instance 1, run: true Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14463, instance 1, run: true Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14470, instance 1, run: true Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14477, instance 1, run: true Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14484, instance 1, run: true Jan 18 13:14:42 volumio volumio[879]: info: camilladsp spawned new process with pid 14495, instance 1, run: true Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14512, instance 1, run: true Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14519, instance 1, run: true Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14526, instance 1, run: true Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14533, instance 1, run: true Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14540, instance 1, run: true Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14547, instance 1, run: true Jan 18 13:14:43 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:43 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:43 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:43 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:43 volumio volumio[879]: info: Listing playlists Jan 18 13:14:43 volumio volumio[879]: info: Listing playlists Jan 18 13:14:43 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:43 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:43 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:43 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:43 volumio volumio[879]: info: Listing playlists Jan 18 13:14:43 volumio volumio[879]: info: Listing playlists Jan 18 13:14:43 volumio volumio[879]: info: Listing playlists Jan 18 13:14:43 volumio volumio[879]: info: Listing playlists Jan 18 13:14:43 volumio volumio[879]: info: Listing playlists Jan 18 13:14:43 volumio volumio[879]: info: Listing playlists Jan 18 13:14:43 volumio volumio[14435]: Traceback (most recent call last): Jan 18 13:14:43 volumio volumio[14435]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:43 volumio volumio[14435]: from camilladsp import CamillaConnection Jan 18 13:14:43 volumio volumio[14435]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14554, instance 1, run: true Jan 18 13:14:43 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:43 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14561, instance 1, run: true Jan 18 13:14:43 volumio volumio[879]: info: camilladsp spawned new process with pid 14568, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14575, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14582, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14589, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14596, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14603, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14621, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14628, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14635, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14642, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14652, instance 1, run: true Jan 18 13:14:44 volumio volumio[879]: info: camilladsp spawned new process with pid 14659, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14666, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14673, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14680, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14687, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14694, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14701, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14708, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14715, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14722, instance 1, run: true Jan 18 13:14:45 volumio volumio[879]: info: camilladsp spawned new process with pid 14729, instance 1, run: true Jan 18 13:14:46 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:46 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 11. Jan 18 13:14:46 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:46 volumio volumio[879]: info: camilladsp spawned new process with pid 14736, instance 1, run: true Jan 18 13:14:46 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:46 volumio volumio[879]: info: camilladsp spawned new process with pid 14744, instance 1, run: true Jan 18 13:14:46 volumio volumio[879]: info: camilladsp spawned new process with pid 14751, instance 1, run: true Jan 18 13:14:46 volumio volumio[879]: info: camilladsp spawned new process with pid 14758, instance 1, run: true Jan 18 13:14:46 volumio volumio[879]: info: camilladsp spawned new process with pid 14765, instance 1, run: true Jan 18 13:14:46 volumio volumio[879]: info: camilladsp spawned new process with pid 14772, instance 1, run: true Jan 18 13:14:46 volumio volumio[879]: info: camilladsp spawned new process with pid 14779, instance 1, run: true Jan 18 13:14:46 volumio volumio[879]: info: camilladsp spawned new process with pid 14786, instance 1, run: true Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14793, instance 1, run: true Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14800, instance 1, run: true Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14807, instance 1, run: true Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14814, instance 1, run: true Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14821, instance 1, run: true Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14828, instance 1, run: true Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14835, instance 1, run: true Jan 18 13:14:47 volumio volumio[14737]: Traceback (most recent call last): Jan 18 13:14:47 volumio volumio[14737]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:47 volumio volumio[14737]: from camilladsp import CamillaConnection Jan 18 13:14:47 volumio volumio[14737]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14842, instance 1, run: true Jan 18 13:14:47 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:47 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:47 volumio volumio[879]: info: camilladsp spawned new process with pid 14849, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14856, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14863, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14870, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14877, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14884, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14891, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14898, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14905, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14912, instance 1, run: true Jan 18 13:14:48 volumio volumio[879]: info: camilladsp spawned new process with pid 14919, instance 1, run: true Jan 18 13:14:49 volumio volumio[879]: info: camilladsp spawned new process with pid 14926, instance 1, run: true Jan 18 13:14:49 volumio volumio[879]: info: camilladsp spawned new process with pid 14934, instance 1, run: true Jan 18 13:14:49 volumio volumio[879]: info: camilladsp spawned new process with pid 14941, instance 1, run: true Jan 18 13:14:49 volumio volumio[879]: info: camilladsp spawned new process with pid 14948, instance 1, run: true Jan 18 13:14:49 volumio volumio[879]: info: camilladsp spawned new process with pid 14956, instance 1, run: true Jan 18 13:14:49 volumio volumio[879]: info: camilladsp spawned new process with pid 14965, instance 1, run: true Jan 18 13:14:49 volumio volumio[879]: info: The file cgui/LICENSE.txt exists. Overwrite ? [y]es, [n]o, [A]ll: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Jan 18 13:14:49 volumio volumio[879]: info: The file cgui/LICENSE.txt exists. Overwrite ? [y]es, [n]o, [A]ll: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Jan 18 13:14:49 volumio volumio[879]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Jan 18 13:14:49 volumio volumio[879]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-rtghaz8j Jan 18 13:14:49 volumio volumio[879]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Jan 18 13:14:49 volumio volumio[879]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-rtghaz8j Jan 18 13:14:49 volumio volumio[879]: info: camilladsp spawned new process with pid 15011, instance 1, run: true Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15035, instance 1, run: true Jan 18 13:14:50 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:50 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 12. Jan 18 13:14:50 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15043, instance 1, run: true Jan 18 13:14:50 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15051, instance 1, run: true Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15058, instance 1, run: true Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15065, instance 1, run: true Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15072, instance 1, run: true Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15079, instance 1, run: true Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15086, instance 1, run: true Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15093, instance 1, run: true Jan 18 13:14:50 volumio volumio[879]: info: camilladsp spawned new process with pid 15100, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15108, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15115, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15122, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15129, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15138, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15145, instance 1, run: true Jan 18 13:14:51 volumio volumio[15042]: Traceback (most recent call last): Jan 18 13:14:51 volumio volumio[15042]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:51 volumio volumio[15042]: from camilladsp import CamillaConnection Jan 18 13:14:51 volumio volumio[15042]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15152, instance 1, run: true Jan 18 13:14:51 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:51 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15159, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15166, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15173, instance 1, run: true Jan 18 13:14:51 volumio volumio[879]: info: camilladsp spawned new process with pid 15183, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15191, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15201, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15209, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15216, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15223, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15230, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15237, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15244, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15251, instance 1, run: true Jan 18 13:14:52 volumio volumio[879]: info: camilladsp spawned new process with pid 15258, instance 1, run: true Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15279, instance 1, run: true Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15286, instance 1, run: true Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15293, instance 1, run: true Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15300, instance 1, run: true Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15309, instance 1, run: true Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15316, instance 1, run: true Jan 18 13:14:53 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:53 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:53 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:53 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:53 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:53 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:53 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:53 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15323, instance 1, run: true Jan 18 13:14:53 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:53 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 13. Jan 18 13:14:53 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15331, instance 1, run: true Jan 18 13:14:53 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:53 volumio volumio[879]: info: camilladsp spawned new process with pid 15338, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15345, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15352, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15359, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15367, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: Collecting PyYAML (from camilladsp==1.0.0) Jan 18 13:14:54 volumio volumio[879]: info: Collecting PyYAML (from camilladsp==1.0.0) Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15384, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15391, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15398, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15405, instance 1, run: true Jan 18 13:14:54 volumio volumio[879]: info: camilladsp spawned new process with pid 15415, instance 1, run: true Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15422, instance 1, run: true Jan 18 13:14:55 volumio volumio[879]: info: CALLMETHOD: audio_interface fusiondsp saveparameq [object Object] Jan 18 13:14:55 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , saveparameq Jan 18 13:14:55 volumio volumio[879]: info: FusionDsp - value distance L------- 0 R 0 Jan 18 13:14:55 volumio volumio[879]: info: FusionDsp - no delay needed Jan 18 13:14:55 volumio volumio[879]: error: FusionDsp - wrong value in level -25 or -25 Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15429, instance 1, run: true Jan 18 13:14:55 volumio volumio[15330]: Traceback (most recent call last): Jan 18 13:14:55 volumio volumio[15330]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:55 volumio volumio[15330]: from camilladsp import CamillaConnection Jan 18 13:14:55 volumio volumio[15330]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15436, instance 1, run: true Jan 18 13:14:55 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:55 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15443, instance 1, run: true Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15450, instance 1, run: true Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15457, instance 1, run: true Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15464, instance 1, run: true Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15471, instance 1, run: true Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15478, instance 1, run: true Jan 18 13:14:55 volumio volumio[879]: info: camilladsp spawned new process with pid 15485, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15492, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15499, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15506, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15513, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15520, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15527, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15534, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15541, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15548, instance 1, run: true Jan 18 13:14:56 volumio volumio[879]: info: camilladsp spawned new process with pid 15555, instance 1, run: true Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15562, instance 1, run: true Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15569, instance 1, run: true Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15576, instance 1, run: true Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15583, instance 1, run: true Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15590, instance 1, run: true Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15597, instance 1, run: true Jan 18 13:14:57 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:14:57 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 14. Jan 18 13:14:57 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15605, instance 1, run: true Jan 18 13:14:57 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15612, instance 1, run: true Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15619, instance 1, run: true Jan 18 13:14:57 volumio volumio[879]: info: camilladsp spawned new process with pid 15626, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15633, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15640, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15647, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15654, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Jan 18 13:14:58 volumio volumio[879]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15661, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15668, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15675, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15682, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: camilladsp spawned new process with pid 15689, instance 1, run: true Jan 18 13:14:58 volumio volumio[879]: info: Collecting websocket_client (from camilladsp==1.0.0) Jan 18 13:14:58 volumio volumio[879]: info: Collecting websocket_client (from camilladsp==1.0.0) Jan 18 13:14:58 volumio volumio[15604]: Traceback (most recent call last): Jan 18 13:14:58 volumio volumio[15604]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:14:58 volumio volumio[15604]: from camilladsp import CamillaConnection Jan 18 13:14:58 volumio volumio[15604]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15696, instance 1, run: true Jan 18 13:14:59 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:14:59 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15703, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15710, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15717, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15724, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15731, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15738, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15745, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15752, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:14:59 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:14:59 volumio volumio[879]: info: Discovery: Getting this device information Jan 18 13:14:59 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:14:59 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:14:59 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:14:59 volumio volumio[879]: info: camilladsp spawned new process with pid 15759, instance 1, run: true Jan 18 13:14:59 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Jan 18 13:14:59 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Jan 18 13:15:00 volumio volumio[879]: info: camilladsp spawned new process with pid 15766, instance 1, run: true Jan 18 13:15:00 volumio volumio[879]: info: camilladsp spawned new process with pid 15773, instance 1, run: true Jan 18 13:15:00 volumio volumio[879]: info: Building wheels for collected packages: camilladsp Jan 18 13:15:00 volumio volumio[879]: info: Running setup.py bdist_wheel for camilladsp: started Jan 18 13:15:00 volumio volumio[879]: info: Building wheels for collected packages: camilladsp Jan 18 13:15:00 volumio volumio[879]: info: Running setup.py bdist_wheel for camilladsp: started Jan 18 13:15:00 volumio volumio[879]: info: camilladsp spawned new process with pid 15781, instance 1, run: true Jan 18 13:15:00 volumio volumio[879]: info: camilladsp spawned new process with pid 15788, instance 1, run: true Jan 18 13:15:00 volumio volumio[879]: info: camilladsp spawned new process with pid 15795, instance 1, run: true Jan 18 13:15:00 volumio volumio[879]: info: camilladsp spawned new process with pid 15802, instance 1, run: true Jan 18 13:15:00 volumio volumio[879]: info: camilladsp spawned new process with pid 15809, instance 1, run: true Jan 18 13:15:00 volumio volumio[879]: info: camilladsp spawned new process with pid 15816, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15823, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15830, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15837, instance 1, run: true Jan 18 13:15:01 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:01 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 15. Jan 18 13:15:01 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15844, instance 1, run: true Jan 18 13:15:01 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15854, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15861, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15868, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15875, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15882, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15889, instance 1, run: true Jan 18 13:15:01 volumio volumio[879]: info: camilladsp spawned new process with pid 15896, instance 1, run: true Jan 18 13:15:02 volumio volumio[879]: info: camilladsp spawned new process with pid 15903, instance 1, run: true Jan 18 13:15:02 volumio volumio[879]: info: camilladsp spawned new process with pid 15910, instance 1, run: true Jan 18 13:15:02 volumio volumio[879]: info: camilladsp spawned new process with pid 15917, instance 1, run: true Jan 18 13:15:02 volumio volumio[879]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Jan 18 13:15:02 volumio volumio[879]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-dlyhg7kh/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Jan 18 13:15:02 volumio volumio[879]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Jan 18 13:15:02 volumio volumio[879]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-dlyhg7kh/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Jan 18 13:15:02 volumio volumio[879]: info: camilladsp spawned new process with pid 15924, instance 1, run: true Jan 18 13:15:02 volumio volumio[879]: info: Successfully built camilladsp Jan 18 13:15:02 volumio volumio[879]: info: Successfully built camilladsp Jan 18 13:15:02 volumio volumio[879]: info: camilladsp spawned new process with pid 15931, instance 1, run: true Jan 18 13:15:02 volumio volumio[879]: info: camilladsp spawned new process with pid 15938, instance 1, run: true Jan 18 13:15:02 volumio volumio[879]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Jan 18 13:15:02 volumio volumio[15845]: Traceback (most recent call last): Jan 18 13:15:02 volumio volumio[15845]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jan 18 13:15:02 volumio volumio[15845]: from camilladsp import CamillaConnection Jan 18 13:15:02 volumio volumio[15845]: ModuleNotFoundError: No module named 'camilladsp' Jan 18 13:15:02 volumio volumio[879]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 15945, instance 1, run: true Jan 18 13:15:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:15:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 15952, instance 1, run: true Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 15973, instance 1, run: true Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 15980, instance 1, run: true Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 15987, instance 1, run: true Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 15994, instance 1, run: true Jan 18 13:15:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:03 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:03 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:03 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:03 volumio volumio[879]: info: Listing playlists Jan 18 13:15:03 volumio volumio[879]: info: Listing playlists Jan 18 13:15:03 volumio volumio[879]: info: Listing playlists Jan 18 13:15:03 volumio volumio[879]: info: Listing playlists Jan 18 13:15:03 volumio volumio[879]: info: Listing playlists Jan 18 13:15:03 volumio volumio[879]: info: Listing playlists Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 16001, instance 1, run: true Jan 18 13:15:03 volumio volumio[879]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Jan 18 13:15:03 volumio volumio[879]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Jan 18 13:15:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:03 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:03 volumio volumio[879]: info: Listing playlists Jan 18 13:15:03 volumio volumio[879]: info: Listing playlists Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 16008, instance 1, run: true Jan 18 13:15:03 volumio volumio[879]: info: camilladsp spawned new process with pid 16016, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16023, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16030, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16037, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16044, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16062, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16069, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16076, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16083, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16090, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16100, instance 1, run: true Jan 18 13:15:04 volumio volumio[879]: info: camilladsp spawned new process with pid 16107, instance 1, run: true Jan 18 13:15:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 16. Jan 18 13:15:05 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16115, instance 1, run: true Jan 18 13:15:05 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16122, instance 1, run: true Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16129, instance 1, run: true Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16136, instance 1, run: true Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16143, instance 1, run: true Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16150, instance 1, run: true Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16157, instance 1, run: true Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16164, instance 1, run: true Jan 18 13:15:05 volumio volumio[879]: info: camilladsp spawned new process with pid 16171, instance 1, run: true Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16178, instance 1, run: true Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16185, instance 1, run: true Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16192, instance 1, run: true Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16199, instance 1, run: true Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16206, instance 1, run: true Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16213, instance 1, run: true Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16220, instance 1, run: true Jan 18 13:15:06 volumio volumio[16114]: Traceback (most recent call last): Jan 18 13:15:06 volumio volumio[16114]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jan 18 13:15:06 volumio volumio[16114]: from camilladsp_plot.validate_config import CamillaValidator Jan 18 13:15:06 volumio volumio[16114]: ModuleNotFoundError: No module named 'camilladsp_plot' Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16227, instance 1, run: true Jan 18 13:15:06 volumio volumio[879]: info: camilladsp spawned new process with pid 16234, instance 1, run: true Jan 18 13:15:06 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:15:06 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16241, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16248, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16255, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16262, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16269, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16276, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16283, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16290, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16297, instance 1, run: true Jan 18 13:15:07 volumio volumio[879]: info: camilladsp spawned new process with pid 16304, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16311, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16318, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16325, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16332, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16339, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16346, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16353, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16360, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16367, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16374, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16381, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16388, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: CALLMETHOD: audio_interface fusiondsp saveparameq [object Object] Jan 18 13:15:08 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , saveparameq Jan 18 13:15:08 volumio volumio[879]: info: FusionDsp - value distance L------- 0 R 0 Jan 18 13:15:08 volumio volumio[879]: info: FusionDsp - no delay needed Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16395, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16402, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16409, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16416, instance 1, run: true Jan 18 13:15:08 volumio volumio[879]: info: camilladsp spawned new process with pid 16423, instance 1, run: true Jan 18 13:15:09 volumio volumio[879]: info: camilladsp spawned new process with pid 16430, instance 1, run: true Jan 18 13:15:09 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:09 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 17. Jan 18 13:15:09 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:09 volumio volumio[879]: info: camilladsp spawned new process with pid 16438, instance 1, run: true Jan 18 13:15:09 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:09 volumio volumio[879]: info: camilladsp spawned new process with pid 16445, instance 1, run: true Jan 18 13:15:09 volumio volumio[879]: info: camilladsp spawned new process with pid 16452, instance 1, run: true Jan 18 13:15:09 volumio volumio[879]: info: camilladsp spawned new process with pid 16459, instance 1, run: true Jan 18 13:15:09 volumio volumio[879]: info: camilladsp spawned new process with pid 16466, instance 1, run: true Jan 18 13:15:09 volumio volumio[879]: info: camilladsp spawned new process with pid 16473, instance 1, run: true Jan 18 13:15:09 volumio volumio[879]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 13:15:09 volumio volumio[879]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 18 13:15:09 volumio volumio[879]: info: camilladsp spawned new process with pid 16481, instance 1, run: true Jan 18 13:15:09 volumio volumio[879]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:15:09 volumio volumio[879]: info: CoreCommandRouter::Close All Modals sent Jan 18 13:15:10 volumio volumio[879]: info: camilladsp spawned new process with pid 16489, instance 1, run: true Jan 18 13:15:10 volumio volumio[879]: info: camilladsp spawned new process with pid 16496, instance 1, run: true Jan 18 13:15:10 volumio volumio[16437]: Traceback (most recent call last): Jan 18 13:15:10 volumio volumio[16437]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jan 18 13:15:10 volumio volumio[16437]: from camilladsp_plot.validate_config import CamillaValidator Jan 18 13:15:10 volumio volumio[16437]: ModuleNotFoundError: No module named 'camilladsp_plot' Jan 18 13:15:10 volumio volumio[879]: info: camilladsp spawned new process with pid 16503, instance 1, run: true Jan 18 13:15:10 volumio volumio[879]: info: camilladsp spawned new process with pid 16510, instance 1, run: true Jan 18 13:15:10 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:15:10 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:15:10 volumio volumio[879]: info: camilladsp spawned new process with pid 16517, instance 1, run: true Jan 18 13:15:11 volumio volumio[879]: info: camilladsp spawned new process with pid 16525, instance 1, run: true Jan 18 13:15:11 volumio volumio[879]: info: camilladsp spawned new process with pid 16532, instance 1, run: true Jan 18 13:15:11 volumio volumio[879]: info: camilladsp spawned new process with pid 16539, instance 1, run: true Jan 18 13:15:11 volumio volumio[879]: info: camilladsp spawned new process with pid 16549, instance 1, run: true Jan 18 13:15:11 volumio volumio[879]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Jan 18 13:15:11 volumio volumio[879]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Jan 18 13:15:11 volumio volumio[879]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Jan 18 13:15:11 volumio volumio[879]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Jan 18 13:15:11 volumio volumio[879]: info: camilladsp spawned new process with pid 16559, instance 1, run: true Jan 18 13:15:11 volumio volumio[879]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-7fwu6asd Jan 18 13:15:11 volumio volumio[879]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-7fwu6asd Jan 18 13:15:11 volumio volumio[879]: info: camilladsp spawned new process with pid 16566, instance 1, run: true Jan 18 13:15:11 volumio volumio[879]: info: camilladsp spawned new process with pid 16573, instance 1, run: true Jan 18 13:15:11 volumio volumio[879]: info: camilladsp spawned new process with pid 16580, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16587, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16594, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16601, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16608, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16615, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16622, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16630, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16637, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16644, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16651, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16659, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16666, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16674, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16681, instance 1, run: true Jan 18 13:15:12 volumio volumio[879]: info: camilladsp spawned new process with pid 16688, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16695, instance 1, run: true Jan 18 13:15:13 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:13 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 18. Jan 18 13:15:13 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16703, instance 1, run: true Jan 18 13:15:13 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16710, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16717, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16738, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16745, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16752, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16759, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16766, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16773, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16780, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: info: VolumeController::SetAlsaVolume42 Jan 18 13:15:13 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:15:13 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:13 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:15:13 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:15:13 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 42 Jan 18 13:15:13 volumio volumio[879]: SPOTIFY: SPOTIFY VOLUME 100 Jan 18 13:15:13 volumio volumio[879]: SPOTIFY: VOLUMIO VOLUME 42 Jan 18 13:15:13 volumio volumio[879]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 18 13:15:13 volumio volumio[879]: info: Setting Spotify Volume from Volumio: 42 Jan 18 13:15:13 volumio volumio[879]: info: camilladsp spawned new process with pid 16788, instance 1, run: true Jan 18 13:15:13 volumio volumio[879]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16795, instance 1, run: true Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16802, instance 1, run: true Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16809, instance 1, run: true Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16816, instance 1, run: true Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16829, instance 1, run: true Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16841, instance 1, run: true Jan 18 13:15:14 volumio volumio[16702]: Traceback (most recent call last): Jan 18 13:15:14 volumio volumio[16702]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jan 18 13:15:14 volumio volumio[16702]: from camilladsp_plot.validate_config import CamillaValidator Jan 18 13:15:14 volumio volumio[16702]: ModuleNotFoundError: No module named 'camilladsp_plot' Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16848, instance 1, run: true Jan 18 13:15:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:15:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16855, instance 1, run: true Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16866, instance 1, run: true Jan 18 13:15:14 volumio volumio[879]: info: camilladsp spawned new process with pid 16878, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: info: VolumeController::SetAlsaVolume100 Jan 18 13:15:15 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:15:15 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:15 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:15:15 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:15:15 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:15:15 volumio volumio[879]: SPOTIFY: SPOTIFY VOLUME 42 Jan 18 13:15:15 volumio volumio[879]: SPOTIFY: VOLUMIO VOLUME 100 Jan 18 13:15:15 volumio volumio[879]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 18 13:15:15 volumio volumio[879]: info: Setting Spotify Volume from Volumio: 100 Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16888, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16895, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16902, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16909, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16917, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16924, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16931, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16938, instance 1, run: true Jan 18 13:15:15 volumio volumio[879]: info: camilladsp spawned new process with pid 16945, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 16952, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 16959, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 16966, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 16975, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 16982, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 16989, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 16996, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Jan 18 13:15:16 volumio volumio[879]: info: Sending Spotify command with payload to local API: /player/volume Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 17003, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 17010, instance 1, run: true Jan 18 13:15:16 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:16 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 19. Jan 18 13:15:16 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 17017, instance 1, run: true Jan 18 13:15:16 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:16 volumio volumio[879]: info: camilladsp spawned new process with pid 17025, instance 1, run: true Jan 18 13:15:16 volumio volumio[879]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Jan 18 13:15:17 volumio volumio[879]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Jan 18 13:15:17 volumio volumio[879]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Jan 18 13:15:17 volumio volumio[879]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Jan 18 13:15:17 volumio volumio[879]: info: camilladsp spawned new process with pid 17032, instance 1, run: true Jan 18 13:15:17 volumio volumio[879]: info: camilladsp spawned new process with pid 17039, instance 1, run: true Jan 18 13:15:17 volumio volumio[879]: info: camilladsp spawned new process with pid 17046, instance 1, run: true Jan 18 13:15:17 volumio volumio[879]: info: camilladsp spawned new process with pid 17053, instance 1, run: true Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::volumioPause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::stPlaybackTimer Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::servicePause Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::servicePause Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::pause Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand pause Jan 18 13:15:17 volumio volumio[879]: info: Jan 18 13:15:17 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand pause took 7 milliseconds Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:15:17 volumio volumio[879]: info: Jan 18 13:15:17 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:15:17 volumio volumio[879]: info: Jan 18 13:15:17 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:15:17 volumio volumio[879]: info: Jan 18 13:15:17 volumio volumio[879]: ---------------------------- MPD announces state update: player Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::getState Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand status Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand status took 11 milliseconds Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand status took 10 milliseconds Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand status took 9 milliseconds Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand status took 9 milliseconds Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::parseState Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand playlistinfo took 11 milliseconds Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 18 13:15:17 volumio volumio[879]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::parseTrackInfo Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::parseTrackInfo Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::parseTrackInfo Jan 18 13:15:17 volumio volumio[879]: verbose: ControllerMpd::parseTrackInfo Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":74240,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3117 Kbps","isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:15:17 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::syncState stateService pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::stPlaybackTimer Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":74240,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3117 Kbps","isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:15:17 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::syncState stateService pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::stPlaybackTimer Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":74240,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3117 Kbps","isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:15:17 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::syncState stateService pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::stPlaybackTimer Jan 18 13:15:17 volumio volumio[879]: info: ControllerMpd::pushState Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::servicePushState Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":74240,"duration":201,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3117 Kbps","isStreaming":false,"title":"Lips","artist":"The xx","album":"I See You","uri":"NAS/Flac_etc/1. Main FLAC/The xx - I See You (2017) [24.96 FLAC]/03-Lips.flac","trackType":"flac"} Jan 18 13:15:17 volumio volumio[879]: verbose: CURRENT POSITION 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::syncState stateService pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::syncState currentStatus pause Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::pushState Jan 18 13:15:17 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:17 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Jan 18 13:15:17 volumio volumio[879]: info: CoreStateMachine::stPlaybackTimer Jan 18 13:15:17 volumio volumio[879]: info: ------------------------------ 65ms Jan 18 13:15:17 volumio volumio[879]: info: ------------------------------ 64ms Jan 18 13:15:17 volumio volumio[879]: info: ------------------------------ 64ms Jan 18 13:15:17 volumio volumio[879]: info: ------------------------------ 62ms Jan 18 13:15:17 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:15:17 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:15:17 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:15:17 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 18 13:15:17 volumio volumio[879]: info: camilladsp spawned new process with pid 17060, instance 1, run: true Jan 18 13:15:17 volumio volumio[879]: info: camilladsp spawned new process with pid 17067, instance 1, run: true Jan 18 13:15:17 volumio volumio[879]: info: camilladsp spawned new process with pid 17074, instance 1, run: true Jan 18 13:15:17 volumio volumio[879]: info: camilladsp spawned new process with pid 17081, instance 2, run: true Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17088, instance 2, run: true Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17095, instance 2, run: true Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17102, instance 2, run: true Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17109, instance 2, run: true Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17116, instance 2, run: true Jan 18 13:15:18 volumio volumio[17018]: Traceback (most recent call last): Jan 18 13:15:18 volumio volumio[17018]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jan 18 13:15:18 volumio volumio[17018]: from camilladsp_plot.validate_config import CamillaValidator Jan 18 13:15:18 volumio volumio[17018]: ModuleNotFoundError: No module named 'camilladsp_plot' Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17123, instance 2, run: true Jan 18 13:15:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:15:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17130, instance 2, run: true Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17137, instance 2, run: true Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17144, instance 2, run: true Jan 18 13:15:18 volumio volumio[879]: info: camilladsp spawned new process with pid 17151, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17158, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Jan 18 13:15:19 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17165, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17172, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17179, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17186, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17193, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17200, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:19 volumio volumio[879]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17207, instance 2, run: true Jan 18 13:15:19 volumio volumio[879]: info: camilladsp spawned new process with pid 17214, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17221, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17228, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17235, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17242, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17249, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17256, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17263, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17270, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17277, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17284, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17291, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Jan 18 13:15:20 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17298, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17305, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17312, instance 2, run: true Jan 18 13:15:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 20. Jan 18 13:15:20 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:20 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:20 volumio volumio[879]: info: camilladsp spawned new process with pid 17320, instance 2, run: true Jan 18 13:15:20 volumio volumio[879]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:20 volumio volumio[879]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17327, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17334, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17341, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17348, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17355, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17362, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17369, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17376, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17383, instance 2, run: true Jan 18 13:15:21 volumio volumio[879]: info: camilladsp spawned new process with pid 17390, instance 2, run: true Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17397, instance 2, run: true Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17404, instance 2, run: true Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17411, instance 2, run: true Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17418, instance 2, run: true Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17425, instance 2, run: true Jan 18 13:15:22 volumio volumio[17319]: Traceback (most recent call last): Jan 18 13:15:22 volumio volumio[17319]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jan 18 13:15:22 volumio volumio[17319]: from camilladsp_plot.validate_config import CamillaValidator Jan 18 13:15:22 volumio volumio[17319]: ModuleNotFoundError: No module named 'camilladsp_plot' Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17432, instance 2, run: true Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17439, instance 2, run: true Jan 18 13:15:22 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:15:22 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17446, instance 2, run: true Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17453, instance 2, run: true Jan 18 13:15:22 volumio volumio[879]: info: camilladsp spawned new process with pid 17460, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17467, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17474, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17481, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17496, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17509, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17516, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: Downloading https://www.piwheels.org/simple/pyrsistent/pyrsistent-0.19.3-cp37-cp37m-linux_armv7l.whl (83kB) Jan 18 13:15:23 volumio volumio[879]: info: Downloading https://www.piwheels.org/simple/pyrsistent/pyrsistent-0.19.3-cp37-cp37m-linux_armv7l.whl (83kB) Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17523, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:23 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:23 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:23 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:23 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:23 volumio volumio[879]: info: Listing playlists Jan 18 13:15:23 volumio volumio[879]: info: Listing playlists Jan 18 13:15:23 volumio volumio[879]: info: Listing playlists Jan 18 13:15:23 volumio volumio[879]: info: Listing playlists Jan 18 13:15:23 volumio volumio[879]: info: Listing playlists Jan 18 13:15:23 volumio volumio[879]: info: Listing playlists Jan 18 13:15:23 volumio volumio[879]: info: Listing playlists Jan 18 13:15:23 volumio volumio[879]: info: Listing playlists Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17530, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17537, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17544, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17551, instance 2, run: true Jan 18 13:15:23 volumio volumio[879]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:23 volumio volumio[879]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:23 volumio volumio[879]: info: camilladsp spawned new process with pid 17558, instance 2, run: true Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17565, instance 2, run: true Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17573, instance 2, run: true Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17580, instance 2, run: true Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17587, instance 2, run: true Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17602, instance 2, run: true Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17612, instance 2, run: true Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17619, instance 2, run: true Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17626, instance 2, run: true Jan 18 13:15:24 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:24 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 21. Jan 18 13:15:24 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17634, instance 2, run: true Jan 18 13:15:24 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:24 volumio volumio[879]: info: camilladsp spawned new process with pid 17642, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17651, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17658, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17665, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17672, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17679, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17686, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Jan 18 13:15:25 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17693, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17700, instance 2, run: true Jan 18 13:15:25 volumio volumio[879]: info: camilladsp spawned new process with pid 17707, instance 2, run: true Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17714, instance 2, run: true Jan 18 13:15:26 volumio volumio[879]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Jan 18 13:15:26 volumio volumio[879]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17721, instance 2, run: true Jan 18 13:15:26 volumio volumio[879]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:26 volumio volumio[879]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17728, instance 2, run: true Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17735, instance 2, run: true Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17742, instance 2, run: true Jan 18 13:15:26 volumio volumio[17633]: Traceback (most recent call last): Jan 18 13:15:26 volumio volumio[17633]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jan 18 13:15:26 volumio volumio[17633]: from camilladsp_plot.validate_config import CamillaValidator Jan 18 13:15:26 volumio volumio[17633]: ModuleNotFoundError: No module named 'camilladsp_plot' Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17749, instance 2, run: true Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17756, instance 2, run: true Jan 18 13:15:26 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:15:26 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17763, instance 2, run: true Jan 18 13:15:26 volumio volumio[879]: info: camilladsp spawned new process with pid 17770, instance 2, run: true Jan 18 13:15:26 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Jan 18 13:15:26 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17777, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17784, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:27 volumio volumio[879]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17791, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17798, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17805, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Jan 18 13:15:27 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17812, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: Collecting zipp>=3.1.0; python_version < "3.10" (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:27 volumio volumio[879]: info: Collecting zipp>=3.1.0; python_version < "3.10" (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17819, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17826, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17833, instance 2, run: true Jan 18 13:15:27 volumio volumio[879]: info: camilladsp spawned new process with pid 17840, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17847, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17854, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17861, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17868, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17875, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Jan 18 13:15:28 volumio volumio[879]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17882, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17889, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17897, instance 2, run: true Jan 18 13:15:28 volumio volumio[879]: info: Building wheels for collected packages: camilladsp-plot Jan 18 13:15:28 volumio volumio[879]: info: Running setup.py bdist_wheel for camilladsp-plot: started Jan 18 13:15:28 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:28 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 22. Jan 18 13:15:28 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:28 volumio volumio[879]: info: Building wheels for collected packages: camilladsp-plot Jan 18 13:15:28 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:28 volumio volumio[879]: info: Running setup.py bdist_wheel for camilladsp-plot: started Jan 18 13:15:28 volumio volumio[879]: info: camilladsp spawned new process with pid 17905, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17912, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17919, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17926, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17933, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17940, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17947, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17954, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17961, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:15:29 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:15:29 volumio volumio[879]: info: Discovery: Getting this device information Jan 18 13:15:29 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:29 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:29 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17968, instance 2, run: true Jan 18 13:15:29 volumio volumio[879]: info: camilladsp spawned new process with pid 17975, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 17985, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 17992, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 17999, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 18006, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 18013, instance 2, run: true Jan 18 13:15:30 volumio volumio[17904]: Traceback (most recent call last): Jan 18 13:15:30 volumio volumio[17904]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jan 18 13:15:30 volumio volumio[17904]: from camilladsp_plot.validate_config import CamillaValidator Jan 18 13:15:30 volumio volumio[17904]: ModuleNotFoundError: No module named 'camilladsp_plot' Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 18020, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 18027, instance 2, run: true Jan 18 13:15:30 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:15:30 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 18034, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 18041, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 18048, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: camilladsp spawned new process with pid 18055, instance 2, run: true Jan 18 13:15:30 volumio volumio[879]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Jan 18 13:15:30 volumio volumio[879]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18062, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-gd9skzuf/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Jan 18 13:15:31 volumio volumio[879]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-gd9skzuf/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Jan 18 13:15:31 volumio volumio[879]: info: Successfully built camilladsp-plot Jan 18 13:15:31 volumio volumio[879]: info: Successfully built camilladsp-plot Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18069, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18076, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18083, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18090, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18097, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18104, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18111, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18118, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18125, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: Installing collected packages: zipp, importlib-resources, pyrsistent, typing-extensions, importlib-metadata, pkgutil-resolve-name, jsonschema, camilladsp-plot Jan 18 13:15:31 volumio volumio[879]: info: Installing collected packages: zipp, importlib-resources, pyrsistent, typing-extensions, importlib-metadata, pkgutil-resolve-name, jsonschema, camilladsp-plot Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18132, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18139, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18146, instance 2, run: true Jan 18 13:15:31 volumio volumio[879]: info: camilladsp spawned new process with pid 18153, instance 2, run: true Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18160, instance 2, run: true Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18167, instance 2, run: true Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18174, instance 2, run: true Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18181, instance 2, run: true Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18188, instance 2, run: true Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18195, instance 2, run: true Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18202, instance 2, run: true Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18209, instance 2, run: true Jan 18 13:15:32 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jan 18 13:15:32 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 23. Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18216, instance 2, run: true Jan 18 13:15:32 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 18 13:15:32 volumio volumio[879]: info: camilladsp spawned new process with pid 18224, instance 2, run: true Jan 18 13:15:32 volumio systemd[1]: Started FusionDsp Daemon. Jan 18 13:15:33 volumio volumio[879]: info: camilladsp spawned new process with pid 18231, instance 2, run: true Jan 18 13:15:33 volumio volumio[879]: info: camilladsp spawned new process with pid 18238, instance 2, run: true Jan 18 13:15:33 volumio volumio[879]: info: camilladsp spawned new process with pid 18245, instance 2, run: true Jan 18 13:15:33 volumio volumio[879]: info: Successfully installed camilladsp-plot-1.0.2 importlib-metadata-6.7.0 importlib-resources-5.12.0 jsonschema-4.17.3 pkgutil-resolve-name-1.3.10 pyrsistent-0.19.3 typing-extensions-4.7.1 zipp-3.15.0 Jan 18 13:15:33 volumio volumio[879]: info: Successfully installed camilladsp-plot-1.0.2 importlib-metadata-6.7.0 importlib-resources-5.12.0 jsonschema-4.17.3 pkgutil-resolve-name-1.3.10 pyrsistent-0.19.3 typing-extensions-4.7.1 zipp-3.15.0 Jan 18 13:15:33 volumio volumio[879]: info: camilladsp spawned new process with pid 18256, instance 2, run: true Jan 18 13:15:33 volumio volumio[879]: info: camilladsp spawned new process with pid 18273, instance 2, run: true Jan 18 13:15:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:33 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:33 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:33 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:33 volumio volumio[879]: info: copying hw detection script Jan 18 13:15:33 volumio volumio[879]: info: copying hw detection script Jan 18 13:15:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Jan 18 13:15:33 volumio volumio[879]: info: CorePlayQueue::getTrack 2 Jan 18 13:15:33 volumio volumio[879]: info: camilladsp spawned new process with pid 18284, instance 2, run: true Jan 18 13:15:33 volumio volumio[879]: info: Detected cpu architecture as armv7l Jan 18 13:15:33 volumio volumio[879]: info: Detected cpu architecture as armv7l Jan 18 13:15:33 volumio volumio[879]: info: camilladsp spawned new process with pid 18291, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18298, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18305, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18312, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18319, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18335, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18344, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18351, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp Jan 18 13:15:34 volumio volumio[879]: info: camilladsp Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18360, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18367, instance 2, run: true Jan 18 13:15:34 volumio volumio[879]: info: camilladsp spawned new process with pid 18377, instance 2, run: true Jan 18 13:15:35 volumio volumio[879]: info: camilladsp spawned new process with pid undefined, instance 2, run: true Jan 18 13:15:35 volumio volumio[879]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 13:15:35 volumio volumio[879]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES Jan 18 13:15:35 volumio volumio[879]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jan 18 13:15:35 volumio volumio[879]: at onErrorNT (internal/child_process.js:465:16) Jan 18 13:15:35 volumio volumio[879]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jan 18 13:15:35 volumio volumio[879]: errno: -13, Jan 18 13:15:35 volumio volumio[879]: code: 'EACCES', Jan 18 13:15:35 volumio volumio[879]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 18 13:15:35 volumio volumio[879]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 18 13:15:35 volumio volumio[879]: spawnargs: [ Jan 18 13:15:35 volumio volumio[879]: '-p', Jan 18 13:15:35 volumio volumio[879]: 9876, Jan 18 13:15:35 volumio volumio[879]: '-o', Jan 18 13:15:35 volumio volumio[879]: '/tmp/camilladsp.log', Jan 18 13:15:35 volumio volumio[879]: '-l', Jan 18 13:15:35 volumio volumio[879]: 'warn', Jan 18 13:15:35 volumio volumio[879]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 18 13:15:35 volumio volumio[879]: ] Jan 18 13:15:35 volumio volumio[879]: } Jan 18 13:15:35 volumio volumio[879]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 13:15:35 volumio sudo[18392]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params Jan 18 13:15:35 volumio sudo[18392]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:15:35 volumio sudo[18392]: pam_unix(sudo:session): session closed for user root Jan 18 13:15:35 volumio sudo[18399]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Jan 18 13:15:35 volumio sudo[18399]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:15:35 volumio sudo[18399]: pam_unix(sudo:session): session closed for user root Jan 18 13:15:35 volumio sudo[18401]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Jan 18 13:15:35 volumio sudo[18401]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:15:36 volumio sudo[18407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 13:14 Jan 18 13:15:36 volumio sudo[18407]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"