-- Logs begin at Tue 2024-10-01 19:04:35 MSK, end at Tue 2024-10-01 19:16:24 MSK. -- Oct 01 19:15:00 volumio volumio[869]: 0+0 records in Oct 01 19:15:00 volumio volumio[869]: 0+0 records out Oct 01 19:15:00 volumio volumio[869]: 0 bytes copied, 0.000679071 s, 0.0 kB/s Oct 01 19:15:00 volumio volumio[869]: info: camilladsp spawned new process with pid 4700, instance 1, run: true Oct 01 19:15:01 volumio volumio[869]: 0+0 records in Oct 01 19:15:01 volumio volumio[869]: 0+0 records out Oct 01 19:15:01 volumio volumio[869]: 0 bytes copied, 0.000657989 s, 0.0 kB/s Oct 01 19:15:01 volumio volumio[869]: info: camilladsp spawned new process with pid 4705, instance 1, run: true Oct 01 19:15:02 volumio volumio[869]: 0+0 records in Oct 01 19:15:02 volumio volumio[869]: 0+0 records out Oct 01 19:15:02 volumio volumio[869]: 0 bytes copied, 0.000196163 s, 0.0 kB/s Oct 01 19:15:02 volumio volumio[869]: info: camilladsp spawned new process with pid 4710, instance 1, run: true Oct 01 19:15:03 volumio volumio[869]: 0+0 records in Oct 01 19:15:03 volumio volumio[869]: 0+0 records out Oct 01 19:15:03 volumio volumio[869]: 0 bytes copied, 0.0002016 s, 0.0 kB/s Oct 01 19:15:03 volumio volumio[869]: info: camilladsp spawned new process with pid 4716, instance 1, run: true Oct 01 19:15:04 volumio volumio[869]: 0+0 records in Oct 01 19:15:04 volumio volumio[869]: 0+0 records out Oct 01 19:15:04 volumio volumio[869]: 0 bytes copied, 0.000205342 s, 0.0 kB/s Oct 01 19:15:04 volumio volumio[869]: info: camilladsp spawned new process with pid 4721, instance 1, run: true Oct 01 19:15:05 volumio volumio[869]: 0+0 records in Oct 01 19:15:05 volumio volumio[869]: 0+0 records out Oct 01 19:15:05 volumio volumio[869]: 0 bytes copied, 0.000208215 s, 0.0 kB/s Oct 01 19:15:05 volumio volumio[869]: info: camilladsp spawned new process with pid 4726, instance 1, run: true Oct 01 19:15:06 volumio volumio[869]: 0+0 records in Oct 01 19:15:06 volumio volumio[869]: 0+0 records out Oct 01 19:15:06 volumio volumio[869]: 0 bytes copied, 0.000874206 s, 0.0 kB/s Oct 01 19:15:06 volumio volumio[869]: info: camilladsp spawned new process with pid 4731, instance 1, run: true Oct 01 19:15:07 volumio volumio[869]: 0+0 records in Oct 01 19:15:07 volumio volumio[869]: 0+0 records out Oct 01 19:15:07 volumio volumio[869]: 0 bytes copied, 0.000204247 s, 0.0 kB/s Oct 01 19:15:07 volumio volumio[869]: info: camilladsp spawned new process with pid 4736, instance 1, run: true Oct 01 19:15:08 volumio volumio[869]: 0+0 records in Oct 01 19:15:08 volumio volumio[869]: 0+0 records out Oct 01 19:15:08 volumio volumio[869]: 0 bytes copied, 0.000205147 s, 0.0 kB/s Oct 01 19:15:08 volumio volumio[869]: info: camilladsp spawned new process with pid 4741, instance 1, run: true Oct 01 19:15:09 volumio volumio[869]: 0+0 records in Oct 01 19:15:09 volumio volumio[869]: 0+0 records out Oct 01 19:15:09 volumio volumio[869]: 0 bytes copied, 0.000200422 s, 0.0 kB/s Oct 01 19:15:09 volumio volumio[869]: info: camilladsp spawned new process with pid 4746, instance 1, run: true Oct 01 19:15:10 volumio volumio[869]: 0+0 records in Oct 01 19:15:10 volumio volumio[869]: 0+0 records out Oct 01 19:15:10 volumio volumio[869]: 0 bytes copied, 0.00059676 s, 0.0 kB/s Oct 01 19:15:10 volumio volumio[869]: info: camilladsp spawned new process with pid 4751, instance 1, run: true Oct 01 19:15:11 volumio volumio[869]: 0+0 records in Oct 01 19:15:11 volumio volumio[869]: 0+0 records out Oct 01 19:15:11 volumio volumio[869]: 0 bytes copied, 0.000203654 s, 0.0 kB/s Oct 01 19:15:11 volumio volumio[869]: info: camilladsp spawned new process with pid 4756, instance 1, run: true Oct 01 19:15:12 volumio volumio[869]: 0+0 records in Oct 01 19:15:12 volumio volumio[869]: 0+0 records out Oct 01 19:15:12 volumio volumio[869]: 0 bytes copied, 0.000198338 s, 0.0 kB/s Oct 01 19:15:12 volumio volumio[869]: info: camilladsp spawned new process with pid 4761, instance 1, run: true Oct 01 19:15:13 volumio volumio[869]: 0+0 records in Oct 01 19:15:13 volumio volumio[869]: 0+0 records out Oct 01 19:15:13 volumio volumio[869]: 0 bytes copied, 0.000294893 s, 0.0 kB/s Oct 01 19:15:13 volumio volumio[869]: info: camilladsp spawned new process with pid 4766, instance 1, run: true Oct 01 19:15:14 volumio volumio[869]: 0+0 records in Oct 01 19:15:14 volumio volumio[869]: 0+0 records out Oct 01 19:15:14 volumio volumio[869]: 0 bytes copied, 0.00558229 s, 0.0 kB/s Oct 01 19:15:14 volumio volumio[869]: info: camilladsp spawned new process with pid 4771, instance 1, run: true Oct 01 19:15:15 volumio volumio[869]: 0+0 records in Oct 01 19:15:15 volumio volumio[869]: 0+0 records out Oct 01 19:15:15 volumio volumio[869]: 0 bytes copied, 0.000205035 s, 0.0 kB/s Oct 01 19:15:15 volumio volumio[869]: info: camilladsp spawned new process with pid 4776, instance 1, run: true Oct 01 19:15:16 volumio volumio[869]: 0+0 records in Oct 01 19:15:16 volumio volumio[869]: 0+0 records out Oct 01 19:15:16 volumio volumio[869]: 0 bytes copied, 0.00020178 s, 0.0 kB/s Oct 01 19:15:16 volumio volumio[869]: info: camilladsp spawned new process with pid 4781, instance 1, run: true Oct 01 19:15:17 volumio volumio[869]: 0+0 records in Oct 01 19:15:17 volumio volumio[869]: 0+0 records out Oct 01 19:15:17 volumio volumio[869]: 0 bytes copied, 0.000206107 s, 0.0 kB/s Oct 01 19:15:17 volumio volumio[869]: info: camilladsp spawned new process with pid 4786, instance 1, run: true Oct 01 19:15:18 volumio volumio[869]: 0+0 records in Oct 01 19:15:18 volumio volumio[869]: 0+0 records out Oct 01 19:15:18 volumio volumio[869]: 0 bytes copied, 0.000200489 s, 0.0 kB/s Oct 01 19:15:19 volumio volumio[869]: info: camilladsp spawned new process with pid 4791, instance 1, run: true Oct 01 19:15:20 volumio volumio[869]: 0+0 records in Oct 01 19:15:20 volumio volumio[869]: 0+0 records out Oct 01 19:15:20 volumio volumio[869]: 0 bytes copied, 0.000193777 s, 0.0 kB/s Oct 01 19:15:20 volumio volumio[869]: info: camilladsp spawned new process with pid 4796, instance 1, run: true Oct 01 19:15:21 volumio volumio[869]: 0+0 records in Oct 01 19:15:21 volumio volumio[869]: 0+0 records out Oct 01 19:15:21 volumio volumio[869]: 0 bytes copied, 0.000204277 s, 0.0 kB/s Oct 01 19:15:21 volumio volumio[869]: info: camilladsp spawned new process with pid 4801, instance 1, run: true Oct 01 19:15:22 volumio volumio[869]: 0+0 records in Oct 01 19:15:22 volumio volumio[869]: 0+0 records out Oct 01 19:15:22 volumio volumio[869]: 0 bytes copied, 0.000208568 s, 0.0 kB/s Oct 01 19:15:22 volumio volumio[869]: info: camilladsp spawned new process with pid 4806, instance 1, run: true Oct 01 19:15:23 volumio volumio[869]: 0+0 records in Oct 01 19:15:23 volumio volumio[869]: 0+0 records out Oct 01 19:15:23 volumio volumio[869]: 0 bytes copied, 0.000208673 s, 0.0 kB/s Oct 01 19:15:23 volumio volumio[869]: info: camilladsp spawned new process with pid 4811, instance 1, run: true Oct 01 19:15:24 volumio volumio[869]: 0+0 records in Oct 01 19:15:24 volumio volumio[869]: 0+0 records out Oct 01 19:15:24 volumio volumio[869]: 0 bytes copied, 0.000202784 s, 0.0 kB/s Oct 01 19:15:24 volumio volumio[869]: info: camilladsp spawned new process with pid 4816, instance 1, run: true Oct 01 19:15:25 volumio volumio[869]: 0+0 records in Oct 01 19:15:25 volumio volumio[869]: 0+0 records out Oct 01 19:15:25 volumio volumio[869]: 0 bytes copied, 0.000203827 s, 0.0 kB/s Oct 01 19:15:25 volumio volumio[869]: info: camilladsp spawned new process with pid 4821, instance 1, run: true Oct 01 19:15:26 volumio volumio[869]: 0+0 records in Oct 01 19:15:26 volumio volumio[869]: 0+0 records out Oct 01 19:15:26 volumio volumio[869]: 0 bytes copied, 0.00474412 s, 0.0 kB/s Oct 01 19:15:26 volumio volumio[869]: info: camilladsp spawned new process with pid 4826, instance 1, run: true Oct 01 19:15:27 volumio volumio[869]: 0+0 records in Oct 01 19:15:27 volumio volumio[869]: 0+0 records out Oct 01 19:15:27 volumio volumio[869]: 0 bytes copied, 0.000201922 s, 0.0 kB/s Oct 01 19:15:27 volumio volumio[869]: info: camilladsp spawned new process with pid 4832, instance 1, run: true Oct 01 19:15:28 volumio volumio[869]: 0+0 records in Oct 01 19:15:28 volumio volumio[869]: 0+0 records out Oct 01 19:15:28 volumio volumio[869]: 0 bytes copied, 0.000222397 s, 0.0 kB/s Oct 01 19:15:28 volumio volumio[869]: info: camilladsp spawned new process with pid 4837, instance 1, run: true Oct 01 19:15:29 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 01 19:15:29 volumio volumio[869]: 0+0 records in Oct 01 19:15:29 volumio volumio[869]: 0+0 records out Oct 01 19:15:29 volumio volumio[869]: 0 bytes copied, 0.000196305 s, 0.0 kB/s Oct 01 19:15:29 volumio volumio[869]: info: camilladsp spawned new process with pid 4842, instance 1, run: true Oct 01 19:15:30 volumio volumio[869]: 0+0 records in Oct 01 19:15:30 volumio volumio[869]: 0+0 records out Oct 01 19:15:30 volumio volumio[869]: 0 bytes copied, 0.000197625 s, 0.0 kB/s Oct 01 19:15:30 volumio volumio[869]: info: camilladsp spawned new process with pid 4847, instance 1, run: true Oct 01 19:15:31 volumio volumio[869]: 0+0 records in Oct 01 19:15:31 volumio volumio[869]: 0+0 records out Oct 01 19:15:31 volumio volumio[869]: 0 bytes copied, 0.000202732 s, 0.0 kB/s Oct 01 19:15:31 volumio volumio[869]: info: camilladsp spawned new process with pid 4852, instance 1, run: true Oct 01 19:15:32 volumio volumio[869]: 0+0 records in Oct 01 19:15:32 volumio volumio[869]: 0+0 records out Oct 01 19:15:32 volumio volumio[869]: 0 bytes copied, 0.000193987 s, 0.0 kB/s Oct 01 19:15:32 volumio volumio[869]: info: camilladsp spawned new process with pid 4857, instance 1, run: true Oct 01 19:15:33 volumio volumio[869]: 0+0 records in Oct 01 19:15:33 volumio volumio[869]: 0+0 records out Oct 01 19:15:33 volumio volumio[869]: 0 bytes copied, 0.00020019 s, 0.0 kB/s Oct 01 19:15:33 volumio volumio[869]: info: camilladsp spawned new process with pid 4862, instance 1, run: true Oct 01 19:15:34 volumio volumio[869]: 0+0 records in Oct 01 19:15:34 volumio volumio[869]: 0+0 records out Oct 01 19:15:34 volumio volumio[869]: 0 bytes copied, 0.000198307 s, 0.0 kB/s Oct 01 19:15:34 volumio volumio[869]: info: camilladsp spawned new process with pid 4867, instance 1, run: true Oct 01 19:15:35 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/fusiondsp/1.0.51/volumio/buster/amd64 Oct 01 19:15:35 volumio volumio[869]: 0+0 records in Oct 01 19:15:35 volumio volumio[869]: 0+0 records out Oct 01 19:15:35 volumio volumio[869]: 0 bytes copied, 0.000195914 s, 0.0 kB/s Oct 01 19:15:35 volumio volumio[869]: info: camilladsp spawned new process with pid 4874, instance 1, run: true Oct 01 19:15:37 volumio volumio[869]: 0+0 records in Oct 01 19:15:37 volumio volumio[869]: 0+0 records out Oct 01 19:15:37 volumio volumio[869]: 0 bytes copied, 0.000199394 s, 0.0 kB/s Oct 01 19:15:37 volumio volumio[869]: info: camilladsp spawned new process with pid 4879, instance 1, run: true Oct 01 19:15:38 volumio volumio[869]: 0+0 records in Oct 01 19:15:38 volumio volumio[869]: 0+0 records out Oct 01 19:15:38 volumio volumio[869]: 0 bytes copied, 0.000192359 s, 0.0 kB/s Oct 01 19:15:38 volumio volumio[869]: info: camilladsp spawned new process with pid 4884, instance 1, run: true Oct 01 19:15:39 volumio volumio[869]: 0+0 records in Oct 01 19:15:39 volumio volumio[869]: 0+0 records out Oct 01 19:15:39 volumio volumio[869]: 0 bytes copied, 0.00183214 s, 0.0 kB/s Oct 01 19:15:39 volumio volumio[869]: info: camilladsp spawned new process with pid 4889, instance 1, run: true Oct 01 19:15:40 volumio volumio[869]: 0+0 records in Oct 01 19:15:40 volumio volumio[869]: 0+0 records out Oct 01 19:15:40 volumio volumio[869]: 0 bytes copied, 0.00017964 s, 0.0 kB/s Oct 01 19:15:40 volumio volumio[869]: info: camilladsp spawned new process with pid 4894, instance 1, run: true Oct 01 19:15:40 volumio volumio[869]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/fusiondsp/1.0.51/volumio/buster/amd64 Oct 01 19:15:40 volumio volumio[869]: info: Folder /tmp/plugins removed Oct 01 19:15:41 volumio volumio[869]: info: Check plugin dependencies Oct 01 19:15:41 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 01 19:15:41 volumio volumio[869]: info: Checking if plugin already exists Oct 01 19:15:41 volumio volumio[869]: info: An error occurred installing the plugin. Rolling back config Oct 01 19:15:41 volumio volumio[869]: info: Plugin folders cleanup Oct 01 19:15:41 volumio volumio[869]: info: Scanning into folder /volumio/app/plugins/ Oct 01 19:15:41 volumio volumio[869]: info: Scanning category audio_interface Oct 01 19:15:41 volumio volumio[869]: info: Scanning category miscellanea Oct 01 19:15:41 volumio volumio[869]: info: Scanning category music_service Oct 01 19:15:41 volumio volumio[869]: info: Scanning category plugins.json Oct 01 19:15:41 volumio volumio[869]: info: Scanning category system_controller Oct 01 19:15:41 volumio volumio[869]: info: Scanning category user_interface Oct 01 19:15:41 volumio volumio[869]: info: Scanning into folder /data/plugins/ Oct 01 19:15:41 volumio volumio[869]: info: Scanning category audio_interface Oct 01 19:15:41 volumio volumio[869]: info: Scanning category system_hardware Oct 01 19:15:41 volumio volumio[869]: info: Plugin folders cleanup completed Oct 01 19:15:41 volumio volumio[869]: info: Error: Error Oct 01 19:15:41 volumio volumio[869]: info: Folder /tmp/plugins removed Oct 01 19:15:41 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Oct 01 19:15:41 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Oct 01 19:15:41 volumio volumio[869]: 0+0 records in Oct 01 19:15:41 volumio volumio[869]: 0+0 records out Oct 01 19:15:41 volumio volumio[869]: 0 bytes copied, 0.0071801 s, 0.0 kB/s Oct 01 19:15:41 volumio volumio[869]: info: camilladsp spawned new process with pid 4901, instance 1, run: true Oct 01 19:15:41 volumio volumio[869]: info: Folder /data/temp removed Oct 01 19:15:42 volumio volumio[869]: 0+0 records in Oct 01 19:15:42 volumio volumio[869]: 0+0 records out Oct 01 19:15:42 volumio volumio[869]: 0 bytes copied, 0.000652364 s, 0.0 kB/s Oct 01 19:15:42 volumio volumio[869]: info: camilladsp spawned new process with pid 4906, instance 1, run: true Oct 01 19:15:43 volumio volumio[869]: 0+0 records in Oct 01 19:15:43 volumio volumio[869]: 0+0 records out Oct 01 19:15:43 volumio volumio[869]: 0 bytes copied, 0.00344864 s, 0.0 kB/s Oct 01 19:15:43 volumio volumio[869]: info: camilladsp spawned new process with pid 4911, instance 1, run: true Oct 01 19:15:44 volumio volumio[869]: 0+0 records in Oct 01 19:15:44 volumio volumio[869]: 0+0 records out Oct 01 19:15:44 volumio volumio[869]: 0 bytes copied, 0.000195637 s, 0.0 kB/s Oct 01 19:15:44 volumio volumio[869]: info: camilladsp spawned new process with pid 4916, instance 1, run: true Oct 01 19:15:45 volumio volumio[869]: 0+0 records in Oct 01 19:15:45 volumio volumio[869]: 0+0 records out Oct 01 19:15:45 volumio volumio[869]: 0 bytes copied, 0.00019164 s, 0.0 kB/s Oct 01 19:15:45 volumio volumio[869]: info: camilladsp spawned new process with pid 4921, instance 1, run: true Oct 01 19:15:46 volumio volumio[869]: 0+0 records in Oct 01 19:15:46 volumio volumio[869]: 0+0 records out Oct 01 19:15:46 volumio volumio[869]: 0 bytes copied, 0.00106709 s, 0.0 kB/s Oct 01 19:15:46 volumio volumio[869]: info: camilladsp spawned new process with pid 4927, instance 1, run: true Oct 01 19:15:47 volumio volumio[869]: 0+0 records in Oct 01 19:15:47 volumio volumio[869]: 0+0 records out Oct 01 19:15:47 volumio volumio[869]: 0 bytes copied, 0.000195487 s, 0.0 kB/s Oct 01 19:15:47 volumio volumio[869]: info: camilladsp spawned new process with pid 4932, instance 1, run: true Oct 01 19:15:49 volumio volumio[869]: 0+0 records in Oct 01 19:15:49 volumio volumio[869]: 0+0 records out Oct 01 19:15:49 volumio volumio[869]: 0 bytes copied, 0.00114994 s, 0.0 kB/s Oct 01 19:15:49 volumio volumio[869]: info: camilladsp spawned new process with pid 4937, instance 1, run: true Oct 01 19:15:50 volumio volumio[869]: 0+0 records in Oct 01 19:15:50 volumio volumio[869]: 0+0 records out Oct 01 19:15:50 volumio volumio[869]: 0 bytes copied, 0.000189562 s, 0.0 kB/s Oct 01 19:15:50 volumio volumio[869]: info: camilladsp spawned new process with pid 4942, instance 1, run: true Oct 01 19:15:51 volumio volumio[869]: 0+0 records in Oct 01 19:15:51 volumio volumio[869]: 0+0 records out Oct 01 19:15:51 volumio volumio[869]: 0 bytes copied, 0.000192022 s, 0.0 kB/s Oct 01 19:15:51 volumio volumio[869]: info: camilladsp spawned new process with pid 4947, instance 1, run: true Oct 01 19:15:52 volumio volumio[869]: 0+0 records in Oct 01 19:15:52 volumio volumio[869]: 0+0 records out Oct 01 19:15:52 volumio volumio[869]: 0 bytes copied, 0.000199769 s, 0.0 kB/s Oct 01 19:15:52 volumio volumio[869]: info: camilladsp spawned new process with pid 4952, instance 1, run: true Oct 01 19:15:53 volumio volumio[869]: 0+0 records in Oct 01 19:15:53 volumio volumio[869]: 0+0 records out Oct 01 19:15:53 volumio volumio[869]: 0 bytes copied, 0.000204562 s, 0.0 kB/s Oct 01 19:15:53 volumio volumio[869]: info: camilladsp spawned new process with pid 4957, instance 1, run: true Oct 01 19:15:54 volumio volumio[869]: 0+0 records in Oct 01 19:15:54 volumio volumio[869]: 0+0 records out Oct 01 19:15:54 volumio volumio[869]: 0 bytes copied, 0.000192337 s, 0.0 kB/s Oct 01 19:15:54 volumio volumio[869]: info: camilladsp spawned new process with pid 4962, instance 1, run: true Oct 01 19:15:55 volumio volumio[869]: 0+0 records in Oct 01 19:15:55 volumio volumio[869]: 0+0 records out Oct 01 19:15:55 volumio volumio[869]: 0 bytes copied, 0.000824008 s, 0.0 kB/s Oct 01 19:15:55 volumio volumio[869]: info: camilladsp spawned new process with pid 4967, instance 1, run: true Oct 01 19:15:56 volumio volumio[869]: 0+0 records in Oct 01 19:15:56 volumio volumio[869]: 0+0 records out Oct 01 19:15:56 volumio volumio[869]: 0 bytes copied, 0.000696973 s, 0.0 kB/s Oct 01 19:15:56 volumio volumio[869]: info: camilladsp spawned new process with pid 4972, instance 1, run: true Oct 01 19:15:57 volumio volumio[869]: 0+0 records in Oct 01 19:15:57 volumio volumio[869]: 0+0 records out Oct 01 19:15:57 volumio volumio[869]: 0 bytes copied, 0.000189937 s, 0.0 kB/s Oct 01 19:15:57 volumio volumio[869]: info: camilladsp spawned new process with pid 4977, instance 1, run: true Oct 01 19:15:58 volumio volumio[869]: 0+0 records in Oct 01 19:15:58 volumio volumio[869]: 0+0 records out Oct 01 19:15:58 volumio volumio[869]: 0 bytes copied, 0.000188234 s, 0.0 kB/s Oct 01 19:15:58 volumio volumio[869]: info: camilladsp spawned new process with pid 4982, instance 1, run: true Oct 01 19:15:59 volumio volumio[869]: 0+0 records in Oct 01 19:15:59 volumio volumio[869]: 0+0 records out Oct 01 19:15:59 volumio volumio[869]: 0 bytes copied, 0.000192195 s, 0.0 kB/s Oct 01 19:15:59 volumio volumio[869]: info: camilladsp spawned new process with pid 4987, instance 1, run: true Oct 01 19:16:00 volumio volumio[869]: 0+0 records in Oct 01 19:16:00 volumio volumio[869]: 0+0 records out Oct 01 19:16:00 volumio volumio[869]: 0 bytes copied, 0.000194159 s, 0.0 kB/s Oct 01 19:16:00 volumio volumio[869]: info: camilladsp spawned new process with pid 4992, instance 1, run: true Oct 01 19:16:01 volumio volumio[869]: 0+0 records in Oct 01 19:16:01 volumio volumio[869]: 0+0 records out Oct 01 19:16:01 volumio volumio[869]: 0 bytes copied, 0.00019422 s, 0.0 kB/s Oct 01 19:16:01 volumio volumio[869]: info: camilladsp spawned new process with pid 4997, instance 1, run: true Oct 01 19:16:02 volumio volumio[869]: 0+0 records in Oct 01 19:16:02 volumio volumio[869]: 0+0 records out Oct 01 19:16:02 volumio volumio[869]: 0 bytes copied, 0.000197002 s, 0.0 kB/s Oct 01 19:16:02 volumio volumio[869]: info: camilladsp spawned new process with pid 5002, instance 1, run: true Oct 01 19:16:03 volumio volumio[869]: 0+0 records in Oct 01 19:16:03 volumio volumio[869]: 0+0 records out Oct 01 19:16:03 volumio volumio[869]: 0 bytes copied, 0.000197909 s, 0.0 kB/s Oct 01 19:16:03 volumio volumio[869]: info: camilladsp spawned new process with pid 5007, instance 1, run: true Oct 01 19:16:04 volumio volumio[869]: 0+0 records in Oct 01 19:16:04 volumio volumio[869]: 0+0 records out Oct 01 19:16:04 volumio volumio[869]: 0 bytes copied, 0.000196815 s, 0.0 kB/s Oct 01 19:16:04 volumio volumio[869]: info: camilladsp spawned new process with pid 5012, instance 1, run: true Oct 01 19:16:05 volumio volumio[869]: 0+0 records in Oct 01 19:16:05 volumio volumio[869]: 0+0 records out Oct 01 19:16:05 volumio volumio[869]: 0 bytes copied, 0.000194122 s, 0.0 kB/s Oct 01 19:16:05 volumio volumio[869]: info: camilladsp spawned new process with pid 5017, instance 1, run: true Oct 01 19:16:06 volumio volumio[869]: 0+0 records in Oct 01 19:16:06 volumio volumio[869]: 0+0 records out Oct 01 19:16:06 volumio volumio[869]: 0 bytes copied, 0.00021018 s, 0.0 kB/s Oct 01 19:16:07 volumio volumio[869]: info: camilladsp spawned new process with pid 5023, instance 1, run: true Oct 01 19:16:08 volumio volumio[869]: 0+0 records in Oct 01 19:16:08 volumio volumio[869]: 0+0 records out Oct 01 19:16:08 volumio volumio[869]: 0 bytes copied, 0.00102927 s, 0.0 kB/s Oct 01 19:16:08 volumio volumio[869]: info: camilladsp spawned new process with pid 5028, instance 1, run: true Oct 01 19:16:09 volumio volumio[869]: 0+0 records in Oct 01 19:16:09 volumio volumio[869]: 0+0 records out Oct 01 19:16:09 volumio volumio[869]: 0 bytes copied, 0.000197317 s, 0.0 kB/s Oct 01 19:16:09 volumio volumio[869]: info: camilladsp spawned new process with pid 5033, instance 1, run: true Oct 01 19:16:10 volumio volumio[869]: 0+0 records in Oct 01 19:16:10 volumio volumio[869]: 0+0 records out Oct 01 19:16:10 volumio volumio[869]: 0 bytes copied, 0.000186135 s, 0.0 kB/s Oct 01 19:16:10 volumio volumio[869]: info: camilladsp spawned new process with pid 5038, instance 1, run: true Oct 01 19:16:11 volumio volumio[869]: 0+0 records in Oct 01 19:16:11 volumio volumio[869]: 0+0 records out Oct 01 19:16:11 volumio volumio[869]: 0 bytes copied, 0.000194579 s, 0.0 kB/s Oct 01 19:16:11 volumio volumio[869]: info: camilladsp spawned new process with pid 5043, instance 1, run: true Oct 01 19:16:12 volumio volumio[869]: 0+0 records in Oct 01 19:16:12 volumio volumio[869]: 0+0 records out Oct 01 19:16:12 volumio volumio[869]: 0 bytes copied, 0.000196957 s, 0.0 kB/s Oct 01 19:16:12 volumio volumio[869]: info: camilladsp spawned new process with pid 5048, instance 1, run: true Oct 01 19:16:13 volumio volumio[869]: 0+0 records in Oct 01 19:16:13 volumio volumio[869]: 0+0 records out Oct 01 19:16:13 volumio volumio[869]: 0 bytes copied, 0.000193207 s, 0.0 kB/s Oct 01 19:16:13 volumio volumio[869]: info: camilladsp spawned new process with pid 5053, instance 1, run: true Oct 01 19:16:14 volumio volumio[869]: 0+0 records in Oct 01 19:16:14 volumio volumio[869]: 0+0 records out Oct 01 19:16:14 volumio volumio[869]: 0 bytes copied, 0.000705599 s, 0.0 kB/s Oct 01 19:16:14 volumio volumio[869]: info: camilladsp spawned new process with pid 5058, instance 1, run: true Oct 01 19:16:15 volumio volumio[869]: 0+0 records in Oct 01 19:16:15 volumio volumio[869]: 0+0 records out Oct 01 19:16:15 volumio volumio[869]: 0 bytes copied, 0.000193027 s, 0.0 kB/s Oct 01 19:16:15 volumio volumio[869]: info: camilladsp spawned new process with pid 5063, instance 1, run: true Oct 01 19:16:16 volumio volumio[869]: 0+0 records in Oct 01 19:16:16 volumio volumio[869]: 0+0 records out Oct 01 19:16:16 volumio volumio[869]: 0 bytes copied, 0.000199057 s, 0.0 kB/s Oct 01 19:16:16 volumio volumio[869]: info: camilladsp spawned new process with pid 5068, instance 1, run: true Oct 01 19:16:16 volumio volumio[869]: info: FusionDsp - Stopping FusionDsp service Oct 01 19:16:16 volumio volumio[869]: info: camilladsp service terminated, instance 1 Oct 01 19:16:17 volumio volumio[869]: info: Disabling plugin fusiondsp Oct 01 19:16:17 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:17 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:17 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:17 volumio volumio[869]: info: Asound.conf file written Oct 01 19:16:17 volumio sudo[5072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Oct 01 19:16:17 volumio sudo[5072]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:17 volumio volumio[1388]: Backend configuration: Oct 01 19:16:17 volumio volumio[1388]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Oct 01 19:16:17 volumio volumio[1388]: active_config_txt: null Oct 01 19:16:17 volumio volumio[1388]: camilla_host: 127.0.0.1 Oct 01 19:16:17 volumio volumio[1388]: camilla_port: 9876 Oct 01 19:16:17 volumio volumio[1388]: coeff_dir: /data/INTERNAL/FusionDsp/filters Oct 01 19:16:17 volumio volumio[1388]: config_dir: /data/configuration/audio_interface/fusiondsp Oct 01 19:16:17 volumio volumio[1388]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Oct 01 19:16:17 volumio volumio[1388]: log_file: /tmp/camilladsp.log Oct 01 19:16:17 volumio volumio[1388]: on_get_active_config: null Oct 01 19:16:17 volumio volumio[1388]: on_set_active_config: null Oct 01 19:16:17 volumio volumio[1388]: port: 5011 Oct 01 19:16:17 volumio volumio[1388]: supported_capture_types: null Oct 01 19:16:17 volumio volumio[1388]: supported_playback_types: null Oct 01 19:16:17 volumio volumio[1388]: update_config_symlink: false Oct 01 19:16:17 volumio volumio[1388]: update_config_txt: false Oct 01 19:16:17 volumio volumio[1388]: ======== Running on http://0.0.0.0:5011 ======== Oct 01 19:16:17 volumio volumio[1388]: (Press CTRL+C to quit) Oct 01 19:16:17 volumio systemd[1]: Stopping FusionDsp Daemon... Oct 01 19:16:17 volumio sudo[5075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 01 19:16:17 volumio sudo[5075]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:17 volumio sudo[5075]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:17 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:17 volumio systemd[1]: fusiondsp.service: Succeeded. Oct 01 19:16:17 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 01 19:16:17 volumio sudo[5072]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:17 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:17 volumio sudo[5082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:17 volumio sudo[5082]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:17 volumio sudo[5082]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:17 volumio sudo[5085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:17 volumio sudo[5085]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:17 volumio systemd[1]: musicservicesshield.service: Succeeded. Oct 01 19:16:17 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Oct 01 19:16:17 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Oct 01 19:16:17 volumio systemd[1]: Stopping Music Player Daemon... Oct 01 19:16:17 volumio systemd[1]: mpd.service: Succeeded. Oct 01 19:16:17 volumio systemd[1]: Stopped Music Player Daemon. Oct 01 19:16:17 volumio systemd[1]: Starting Music Player Daemon... Oct 01 19:16:17 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:17 volumio volumio[869]: info: Done. Oct 01 19:16:17 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:17 volumio volumio[869]: info: FusionDsp - Reporting Fusion DSP Disabled Oct 01 19:16:17 volumio volumio[869]: info: Removing fusiondspeq DSP Signal Path Element Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:17 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:17 volumio volumio[869]: info: Disabling plugin fusiondsp Oct 01 19:16:17 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:17 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:17 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:17 volumio volumio[869]: info: Starting Shairport Sync Oct 01 19:16:18 volumio volumio[869]: info: Disabling plugin fusiondsp Oct 01 19:16:18 volumio volumio[869]: info: Disabling plugin fusiondsp Oct 01 19:16:18 volumio sudo[5100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 01 19:16:18 volumio sudo[5100]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:18 volumio volumio[869]: info: Disabling plugin fusiondsp Oct 01 19:16:18 volumio volumio[869]: info: Asound.conf file unchanged, so no further update is needed Oct 01 19:16:18 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 01 19:16:18 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 01 19:16:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:18 volumio sudo[5100]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:18 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:18 volumio sudo[5105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:18 volumio sudo[5105]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:18 volumio sudo[5105]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:18 volumio sudo[5109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:18 volumio sudo[5109]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:18 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 01 19:16:18 volumio systemd[1]: mpd.service: Succeeded. Oct 01 19:16:18 volumio systemd[1]: Stopped Music Player Daemon. Oct 01 19:16:18 volumio systemd[1]: Starting Music Player Daemon... Oct 01 19:16:18 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:18 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:18 volumio volumio[869]: info: Done. Oct 01 19:16:18 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:18 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:18 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:18 volumio volumio[869]: info: Shairport-Sync Started Oct 01 19:16:18 volumio volumio[869]: info: Enabling plugin fusiondsp Oct 01 19:16:18 volumio volumio[869]: info: Loading plugin "fusiondsp"... Oct 01 19:16:18 volumio volumio[869]: info: Applying required configuration parameters for plugin fusiondsp Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: Enabling plugin fusiondsp Oct 01 19:16:19 volumio volumio[869]: info: Loading plugin "fusiondsp"... Oct 01 19:16:19 volumio volumio[869]: info: Applying required configuration parameters for plugin fusiondsp Oct 01 19:16:19 volumio volumio[869]: info: Starting Shairport Sync Oct 01 19:16:19 volumio volumio[869]: info: Asound.conf file unchanged, so no further update is needed Oct 01 19:16:19 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:19 volumio sudo[5124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 01 19:16:19 volumio sudo[5124]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:19 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 01 19:16:19 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 01 19:16:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:19 volumio sudo[5127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:19 volumio sudo[5127]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:19 volumio sudo[5124]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:19 volumio sudo[5127]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:19 volumio sudo[5130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:19 volumio sudo[5130]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:19 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 01 19:16:19 volumio systemd[1]: mpd.service: Succeeded. Oct 01 19:16:19 volumio systemd[1]: Stopped Music Player Daemon. Oct 01 19:16:19 volumio systemd[1]: Starting Music Player Daemon... Oct 01 19:16:19 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:19 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:19 volumio volumio[869]: info: Done. Oct 01 19:16:19 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:19 volumio volumio[869]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 01 19:16:19 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:19 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:19 volumio volumio[869]: info: Shairport-Sync Started Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:19 volumio volumio[869]: info: Starting Shairport Sync Oct 01 19:16:19 volumio volumio[869]: info: Asound.conf file written Oct 01 19:16:19 volumio sudo[5147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 01 19:16:19 volumio sudo[5147]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 01 19:16:19 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 01 19:16:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:20 volumio sudo[5150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 01 19:16:20 volumio sudo[5150]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:20 volumio sudo[5150]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:20 volumio sudo[5147]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:20 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:20 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:20 volumio sudo[5159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:20 volumio sudo[5159]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:20 volumio sudo[5159]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:20 volumio sudo[5161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:20 volumio sudo[5161]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:20 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 01 19:16:20 volumio systemd[1]: mpd.service: Succeeded. Oct 01 19:16:20 volumio systemd[1]: Stopped Music Player Daemon. Oct 01 19:16:20 volumio systemd[1]: Starting Music Player Daemon... Oct 01 19:16:20 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:20 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:20 volumio volumio[869]: info: Done. Oct 01 19:16:20 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:20 volumio volumio[869]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 01 19:16:20 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:20 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:20 volumio volumio[869]: info: Shairport-Sync Started Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: Starting Shairport Sync Oct 01 19:16:20 volumio volumio[869]: info: Asound.conf file unchanged, so no further update is needed Oct 01 19:16:20 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:20 volumio sudo[5176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 01 19:16:20 volumio sudo[5176]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:20 volumio ntpd[859]: 193.192.36.3 local addr 192.168.0.102 -> Oct 01 19:16:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 01 19:16:20 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 01 19:16:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:20 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:20 volumio sudo[5176]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:20 volumio sudo[5179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:21 volumio sudo[5179]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:21 volumio sudo[5184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:21 volumio sudo[5179]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio sudo[5184]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:21 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 01 19:16:21 volumio systemd[1]: mpd.service: Succeeded. Oct 01 19:16:21 volumio systemd[1]: Stopped Music Player Daemon. Oct 01 19:16:21 volumio systemd[1]: Starting Music Player Daemon... Oct 01 19:16:21 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:21 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:21 volumio volumio[869]: info: Done. Oct 01 19:16:21 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:21 volumio volumio[869]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 01 19:16:21 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:21 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:21 volumio volumio[869]: info: Shairport-Sync Started Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: Starting Shairport Sync Oct 01 19:16:21 volumio volumio[869]: info: Asound.conf file unchanged, so no further update is needed Oct 01 19:16:21 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:21 volumio sudo[5201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 01 19:16:21 volumio sudo[5201]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:21 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 01 19:16:21 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 01 19:16:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:21 volumio sudo[5203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:21 volumio sudo[5203]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:21 volumio sudo[5201]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio sudo[5203]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio sudo[5207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:21 volumio sudo[5207]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:21 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 01 19:16:21 volumio systemd[1]: mpd.service: Succeeded. Oct 01 19:16:21 volumio systemd[1]: Stopped Music Player Daemon. Oct 01 19:16:21 volumio systemd[1]: mpd.service: Start request repeated too quickly. Oct 01 19:16:21 volumio systemd[1]: mpd.service: Failed with result 'start-limit-hit'. Oct 01 19:16:21 volumio systemd[1]: Failed to start Music Player Daemon. Oct 01 19:16:21 volumio systemd[1]: mpd.socket: Failed with result 'service-start-limit-hit'. Oct 01 19:16:21 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:21 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:21 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Oct 01 19:16:21 volumio sudo[5109]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio sudo[5085]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio sudo[5130]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio sudo[5184]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio sudo[5161]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio sudo[5207]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:21 volumio volumio[869]: info: Done. Oct 01 19:16:22 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:22 volumio volumio[869]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 01 19:16:22 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:22 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:22 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:22 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:22 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:22 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:22 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:22 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:22 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:22 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:22 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:22 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:22 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:22 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:22 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:22 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:22 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:22 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:22 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:22 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:22 volumio volumio[869]: info: Shairport-Sync Started Oct 01 19:16:22 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:22 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:22 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:22 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:22 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:22 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: Starting Shairport Sync Oct 01 19:16:22 volumio volumio[869]: info: Asound.conf file unchanged, so no further update is needed Oct 01 19:16:22 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:22 volumio sudo[5233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 01 19:16:22 volumio sudo[5233]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:22 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:22 volumio sudo[5238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 01 19:16:22 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 01 19:16:22 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:22 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Oct 01 19:16:22 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Oct 01 19:16:22 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:22 volumio sudo[5233]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:22 volumio sudo[5238]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:22 volumio volumio[5215]: cset: --> shielding system active with Oct 01 19:16:22 volumio sudo[5238]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:22 volumio volumio[5215]: cset: "system" cpuset of CPUSPEC(1) with 164 tasks running Oct 01 19:16:22 volumio volumio[5215]: cset: "user" cpuset of CPUSPEC(0) with 0 tasks running Oct 01 19:16:22 volumio sudo[5242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:22 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Oct 01 19:16:22 volumio sudo[5242]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:22 volumio systemd[1]: musicservicesshield.service: Succeeded. Oct 01 19:16:22 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Oct 01 19:16:22 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Oct 01 19:16:22 volumio systemd[1]: mpd.service: Start request repeated too quickly. Oct 01 19:16:22 volumio systemd[1]: mpd.service: Failed with result 'start-limit-hit'. Oct 01 19:16:22 volumio systemd[1]: Failed to start Music Player Daemon. Oct 01 19:16:22 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Oct 01 19:16:22 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:22 volumio sudo[5242]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:22 volumio volumio[869]: info: Done. Oct 01 19:16:22 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:22 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:22 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:22 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:22 volumio volumio[869]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Oct 01 19:16:22 volumio volumio[869]: Job for shairport-sync.service failed. Oct 01 19:16:22 volumio volumio[869]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Oct 01 19:16:22 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:22 volumio volumio[869]: info: Enabling plugin fusiondsp Oct 01 19:16:22 volumio volumio[869]: info: Loading plugin "fusiondsp"... Oct 01 19:16:22 volumio volumio[869]: info: Applying required configuration parameters for plugin fusiondsp Oct 01 19:16:22 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:22 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:22 volumio volumio[869]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 01 19:16:22 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:22 volumio volumio[869]: info: Starting Shairport Sync Oct 01 19:16:22 volumio volumio[869]: info: Asound.conf file unchanged, so no further update is needed Oct 01 19:16:22 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:23 volumio sudo[5267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 01 19:16:23 volumio sudo[5267]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:23 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:23 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Oct 01 19:16:23 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Oct 01 19:16:23 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:23 volumio sudo[5267]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:23 volumio sudo[5272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:23 volumio sudo[5272]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:23 volumio volumio[5247]: cset: --> shielding system active with Oct 01 19:16:23 volumio volumio[5247]: cset: "system" cpuset of CPUSPEC(1) with 165 tasks running Oct 01 19:16:23 volumio volumio[5247]: cset: "user" cpuset of CPUSPEC(0) with 0 tasks running Oct 01 19:16:23 volumio sudo[5274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:23 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Oct 01 19:16:23 volumio sudo[5272]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:23 volumio sudo[5274]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:23 volumio systemd[1]: musicservicesshield.service: Succeeded. Oct 01 19:16:23 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Oct 01 19:16:23 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Oct 01 19:16:23 volumio systemd[1]: mpd.service: Start request repeated too quickly. Oct 01 19:16:23 volumio systemd[1]: mpd.service: Failed with result 'start-limit-hit'. Oct 01 19:16:23 volumio systemd[1]: Failed to start Music Player Daemon. Oct 01 19:16:23 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Oct 01 19:16:23 volumio sudo[5274]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:23 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:23 volumio volumio[869]: info: PLUGIN START: fusiondsp Oct 01 19:16:23 volumio volumio[869]: info: Loading i18n strings for locale ru Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: FusionDsp - mixtype--------------------- Software Oct 01 19:16:23 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:23 volumio volumio[869]: info: Done. Oct 01 19:16:23 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:23 volumio volumio[869]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 01 19:16:23 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:23 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:23 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:23 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:23 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:23 volumio volumio[869]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Oct 01 19:16:23 volumio volumio[869]: Job for shairport-sync.service failed. Oct 01 19:16:23 volumio volumio[869]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Oct 01 19:16:23 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: Enabling plugin fusiondsp Oct 01 19:16:23 volumio volumio[869]: info: Loading plugin "fusiondsp"... Oct 01 19:16:23 volumio volumio[869]: info: Applying required configuration parameters for plugin fusiondsp Oct 01 19:16:23 volumio volumio[869]: info: Starting Shairport Sync Oct 01 19:16:23 volumio volumio[869]: info: Enabling plugin fusiondsp Oct 01 19:16:23 volumio volumio[869]: info: Loading plugin "fusiondsp"... Oct 01 19:16:23 volumio volumio[869]: info: Applying required configuration parameters for plugin fusiondsp Oct 01 19:16:23 volumio volumio[869]: info: Asound.conf file unchanged, so no further update is needed Oct 01 19:16:23 volumio volumio[869]: info: Output device has changed, restarting MPD Oct 01 19:16:23 volumio sudo[5297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 01 19:16:23 volumio sudo[5297]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:23 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Oct 01 19:16:23 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Oct 01 19:16:23 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Oct 01 19:16:23 volumio sudo[5297]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:23 volumio volumio[869]: info: Output device has changed, restarting Shairport Sync Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:23 volumio sudo[5303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 19:16:23 volumio sudo[5303]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:23 volumio volumio[5279]: cset: --> shielding system active with Oct 01 19:16:23 volumio volumio[5279]: cset: "system" cpuset of CPUSPEC(1) with 164 tasks running Oct 01 19:16:23 volumio volumio[5279]: cset: "user" cpuset of CPUSPEC(0) with 0 tasks running Oct 01 19:16:23 volumio sudo[5303]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:23 volumio sudo[5305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 19:16:23 volumio sudo[5305]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 19:16:23 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Oct 01 19:16:24 volumio systemd[1]: musicservicesshield.service: Succeeded. Oct 01 19:16:24 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Oct 01 19:16:24 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Oct 01 19:16:24 volumio systemd[1]: mpd.service: Start request repeated too quickly. Oct 01 19:16:24 volumio systemd[1]: mpd.service: Failed with result 'start-limit-hit'. Oct 01 19:16:24 volumio systemd[1]: Failed to start Music Player Daemon. Oct 01 19:16:24 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Oct 01 19:16:24 volumio sudo[5305]: pam_unix(sudo:session): session closed for user root Oct 01 19:16:24 volumio volumio[869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 01 19:16:24 volumio volumio[869]: info: Preparing to generate the ALSA configuration file Oct 01 19:16:24 volumio volumio[869]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 01 19:16:24 volumio volumio[869]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 01 19:16:24 volumio volumio[869]: info: Reading ALSA contributions from plugins. Oct 01 19:16:24 volumio volumio[869]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 01 19:16:24 volumio volumio[869]: Job for mpd.service failed. Oct 01 19:16:24 volumio volumio[869]: See "systemctl status mpd.service" and "journalctl -xe" for details. Oct 01 19:16:24 volumio volumio[869]: info: MPD Permissions set Oct 01 19:16:24 volumio volumio[869]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Oct 01 19:16:24 volumio volumio[869]: Job for shairport-sync.service failed. Oct 01 19:16:24 volumio volumio[869]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Oct 01 19:16:24 volumio volumio[869]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 19:16:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 19:16:24 volumio volumio[869]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 19:16:24 volumio volumio[869]: TypeError: Cannot read property 'off' of undefined Oct 01 19:16:24 volumio volumio[869]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Oct 01 19:16:24 volumio volumio[869]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Oct 01 19:16:24 volumio volumio[869]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1869:8) Oct 01 19:16:24 volumio volumio[869]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1517:29) Oct 01 19:16:24 volumio volumio[869]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1344:47) Oct 01 19:16:24 volumio volumio[869]: at Socket.emit (events.js:400:28) Oct 01 19:16:24 volumio volumio[869]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 01 19:16:24 volumio volumio[869]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 01 19:16:24 volumio volumio[869]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 19:16:24 volumio volumio[5311]: cset: --> shielding system active with Oct 01 19:16:24 volumio volumio[5311]: cset: "system" cpuset of CPUSPEC(1) with 167 tasks running Oct 01 19:16:24 volumio volumio[5311]: cset: "user" cpuset of CPUSPEC(0) with 0 tasks running Oct 01 19:16:24 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Oct 01 19:16:24 volumio sudo[5340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 19:15 Oct 01 19:16:24 volumio sudo[5340]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="68644ecc3d95554759c26a672c9f9845659ebf49" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="d1eed292e757ec0ddcc4830aa293d402cdfd9c92" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 06 Mar 2023 11:11:21 AM CET" VOLUMIO_VERSION="3.435" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="63811e135313e2a5bdc1840ef571bb94"