-- Logs begin at Mon 2025-06-23 22:39:17 EEST, end at Mon 2025-06-23 23:23:12 EEST. -- Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4092, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4103, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4110, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4117, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4126, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4137, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4147, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4154, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4168, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4176, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4183, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4191, instance 1, run: true Jun 23 23:22:00 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4198, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4205, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4213, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4220, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4227, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4234, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4241, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4248, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4265, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4289, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4296, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4304, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4311, instance 1, run: true Jun 23 23:22:01 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4318, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4325, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4332, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4339, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4346, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4353, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4360, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4367, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4374, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4381, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4388, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4395, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4402, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4409, instance 1, run: true Jun 23 23:22:02 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4416, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4423, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4430, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4437, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4444, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4451, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4458, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4465, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4472, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4479, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4486, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4493, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4500, instance 1, run: true Jun 23 23:22:03 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4507, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4514, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4521, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4528, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4535, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4542, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4549, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4556, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4563, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4570, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4577, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4584, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4591, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4598, instance 1, run: true Jun 23 23:22:04 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4605, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4612, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4619, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4626, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4633, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4640, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4647, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4654, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4661, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4669, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4685, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4692, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4699, instance 1, run: true Jun 23 23:22:05 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4706, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4713, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4720, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4727, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4734, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 23:22:06 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 23:22:06 rivoplus volumio[3451]: info: Discovery: Getting this device information Jun 23 23:22:06 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:06 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:06 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4741, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4748, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4755, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4762, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4769, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4776, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4783, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4790, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4797, instance 1, run: true Jun 23 23:22:06 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4804, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4811, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4818, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4825, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4832, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4839, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4846, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4853, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4860, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4867, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4874, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4881, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4888, instance 1, run: true Jun 23 23:22:07 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4895, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4902, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4909, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4916, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4923, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4930, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4937, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4944, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4951, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4958, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4965, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4972, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4979, instance 1, run: true Jun 23 23:22:08 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4986, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 4993, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5000, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5007, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5014, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5021, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5028, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:09 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5035, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5042, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5050, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5057, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5064, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5071, instance 1, run: true Jun 23 23:22:09 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5078, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5085, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5092, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5099, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5106, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5113, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5120, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5127, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5134, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5141, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5148, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5155, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5162, instance 1, run: true Jun 23 23:22:10 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5169, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5176, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5183, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5190, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5197, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5204, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5211, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5219, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: Executing endpoint metavolumio Jun 23 23:22:11 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 23 23:22:11 rivoplus volumio[3451]: info: Executing endpoint metavolumio Jun 23 23:22:11 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 23 23:22:11 rivoplus volumio[3451]: info: Executing endpoint metavolumio Jun 23 23:22:11 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5226, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5233, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5256, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5264, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5271, instance 1, run: true Jun 23 23:22:11 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5278, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5285, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5292, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5299, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5306, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5313, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5320, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5327, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5334, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5341, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5348, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5355, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5362, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5369, instance 1, run: true Jun 23 23:22:12 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5376, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5383, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5390, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5397, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5404, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5411, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5418, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5425, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5432, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5439, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5446, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5453, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5460, instance 1, run: true Jun 23 23:22:13 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5467, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5474, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5481, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5488, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5495, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5502, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5509, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5516, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5523, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5530, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5537, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5544, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5551, instance 1, run: true Jun 23 23:22:14 rivoplus volumio[3451]: error: Failed request for metavolumio API Jun 23 23:22:14 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5558, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5565, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5572, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5579, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5586, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5593, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5600, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5607, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5614, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5621, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5628, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5635, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5642, instance 1, run: true Jun 23 23:22:15 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5649, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5656, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5663, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5670, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5677, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5684, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5691, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5698, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5705, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5712, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5719, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5726, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5733, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5740, instance 1, run: true Jun 23 23:22:16 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5747, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5754, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5761, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5768, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5775, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5782, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5789, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5796, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5803, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5810, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5817, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5824, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5831, instance 1, run: true Jun 23 23:22:17 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5838, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5846, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5853, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5860, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5867, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5874, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5881, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5888, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5895, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5902, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5909, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5916, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5923, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5930, instance 1, run: true Jun 23 23:22:18 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5937, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5944, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5951, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5958, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5965, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5972, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5979, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5986, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 5993, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6000, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6007, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6014, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6021, instance 1, run: true Jun 23 23:22:19 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6028, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6035, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6042, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6049, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6056, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6063, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6073, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6080, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6087, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6094, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6101, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6108, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6115, instance 1, run: true Jun 23 23:22:20 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6122, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6129, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6136, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6143, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6150, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6157, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6165, instance 1, run: true Jun 23 23:22:21 rivoplus kernel: usb 1-1.4.2: new high-speed USB device number 10 using xhci-hcd Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6172, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6179, instance 1, run: true Jun 23 23:22:21 rivoplus kernel: usb 1-1.4.2: New USB device found, idVendor=152a, idProduct=86ef Jun 23 23:22:21 rivoplus kernel: usb 1-1.4.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jun 23 23:22:21 rivoplus kernel: usb 1-1.4.2: Product: DENAFRIPS USB v3.12 | A12.1.8 Jun 23 23:22:21 rivoplus kernel: usb 1-1.4.2: Manufacturer: DENAFRIPS Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6187, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6194, instance 1, run: true Jun 23 23:22:21 rivoplus kernel: usb 1-1.4.2: Warning! Unlikely big volume range (=512), cval->res is probably wrong. Jun 23 23:22:21 rivoplus kernel: usb 1-1.4.2: [10] FU [PCM Playback Volume] ch = 2, val = -16384/0/32 Jun 23 23:22:21 rivoplus volumio[3451]: info: camilladsp spawned new process with pid 6222, instance 1, run: true Jun 23 23:22:21 rivoplus volumio[3451]: info: Jun 23 23:22:21 rivoplus volumio[3451]: ---------------------------- USB Audio Device Attached Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jun 23 23:22:21 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:21 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreCommandRouter::Close All Modals sent Jun 23 23:22:21 rivoplus volumio[3451]: info: Preparing to save Alsa Options, stopping services first Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:21 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreCommandRouter::volumioPause Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreStateMachine::pause Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreStateMachine::stPlaybackTimer Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreStateMachine::servicePause Jun 23 23:22:21 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreCommandRouter::servicePause Jun 23 23:22:21 rivoplus volumio[3451]: info: [1750710141964] ControllerUPNPBrowser::pause Jun 23 23:22:21 rivoplus volumio[3451]: verbose: ControllerMpd::sendMpdCommand pause Jun 23 23:22:21 rivoplus volumio[3451]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"DENAFRIPS USB v3.12 | A12.1.8","alsacard":"A1218"},"i2s":false} Jun 23 23:22:21 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 23 23:22:22 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:22 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:22 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:22 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 23 23:22:22 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:22 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:22 rivoplus volumio[3451]: info: Setting mixer PCM for card DENAFRIPS USB v3.12 | A12.1.8 Jun 23 23:22:22 rivoplus volumio[3451]: info: QobuzConnect: setDeactiveState invoked Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:22 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:22 rivoplus volumio[3451]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 23 23:22:22 rivoplus vtcs[18646]: [2025-06-23 23:22:22.208] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jun 23 23:22:22 rivoplus vtcs[18646]: [2025-06-23 23:22:22.214] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jun 23 23:22:22 rivoplus sudo[6242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 23 23:22:22 rivoplus sudo[6242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:22 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Jun 23 23:22:22 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 23 23:22:22 rivoplus systemd[1]: vtcs.service: Succeeded. Jun 23 23:22:22 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Jun 23 23:22:22 rivoplus sudo[6242]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:22 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:22 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 23 23:22:22 rivoplus volumio[3451]: info: Updating Volume Controller Parameters: Device: 5 Name: DENAFRIPS USB v3.12 | A12.1.8 Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 23 23:22:22 rivoplus volumio[3451]: info: Disabling external Volume Control Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 23 23:22:22 rivoplus volumio[3451]: info: Preparing to generate the ALSA configuration file Jun 23 23:22:22 rivoplus sudo[6251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 23 23:22:22 rivoplus sudo[6251]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:22 rivoplus sudo[6251]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:22 rivoplus volumio[3451]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 23 23:22:22 rivoplus volumio[3451]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 23 23:22:22 rivoplus volumio[3451]: info: Reading ALSA contributions from plugins. Jun 23 23:22:22 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 23 23:22:22 rivoplus sudo[6258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 23 23:22:22 rivoplus sudo[6258]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:22 rivoplus volumio[3451]: info: sendMpdCommand pause took 655 milliseconds Jun 23 23:22:22 rivoplus volumio[3451]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jun 23 23:22:22 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:22 rivoplus sudo[6258]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:22 rivoplus sudo[6260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 23 23:22:22 rivoplus sudo[6260]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:22 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 23 23:22:22 rivoplus qobuz-connect[18607]: 20250623 23:22:22.726 [18607.18607] INFO SampleApp: Stopping Local configuration server Jun 23 23:22:22 rivoplus qobuz-connect[18607]: 20250623 23:22:22.736 [18607.18607] INFO SampleApp: shat down connection on UNIX socket Jun 23 23:22:22 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:22 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 23 23:22:22 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 23 23:22:22 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 23 23:22:22 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 23 23:22:22 rivoplus sudo[6260]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:22 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:22 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: Not Reporting Auto name since its the default one Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:22 rivoplus volumio[3451]: info: Not Reporting Auto name since its the default one Jun 23 23:22:23 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 23 23:22:23 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 23 23:22:23 rivoplus volumio[3451]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 23 23:22:23 rivoplus volumio[3451]: info: QobuzConnect: setDeactiveState invoked Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:23 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:23 rivoplus volumio[3451]: info: VolumeController:: Volume=undefined Mute =false Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreStateMachine::pushState Jun 23 23:22:23 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::volumioPushState Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:23 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:23 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output update for this device Jun 23 23:22:23 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetQueue Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreStateMachine::getQueue Jun 23 23:22:23 rivoplus volumio[3451]: info: CorePlayQueue::getQueue Jun 23 23:22:23 rivoplus volumio[3451]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Jun 23 23:22:23 rivoplus volumio[3451]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 23 23:22:23 rivoplus volumio[3451]: info: Updating RAAT Signal Path Jun 23 23:22:23 rivoplus volumio[3451]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 23 23:22:23 rivoplus volumio[3451]: info: Executing endpoint qc_getconfig Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.116 [6267.6267] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.139 [6267.6267] INFO VolumeManager: [0xaccb17f0]: Setting new playback volume: 75 Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.139 [6267.6267] INFO VolumeManager: [0xaccb17f0]: Setting new mute state: 0 Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.139 [6267.6267] INFO QobuzConnect: [0xaccb21c0]: Client initialized! Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.139 [6267.6267] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.156 [6267.6267] INFO LocalConfigManager: [0xaccb10d0]: Starting Local Configuration server Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.156 [6267.6267] INFO SampleApp: Starting Local configuration server Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.157 [6267.6267] INFO SampleApp: Connected to UNIX socket client 0xacca6ed8 Jun 23 23:22:23 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:23 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.266 [6267.6267] INFO SampleApp: Playback volume changed: 75 Jun 23 23:22:23 rivoplus sudo[6285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 23 23:22:23 rivoplus sudo[6285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus sudo[6285]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:23 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:23 rivoplus sudo[6289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 23 23:22:23 rivoplus sudo[6289]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus volumio[3451]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 23 23:22:23 rivoplus volumio[3451]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 23 23:22:23 rivoplus volumio[3451]: info: Asound.conf file unchanged, so no further update is needed Jun 23 23:22:23 rivoplus volumio[3451]: info: Output device has changed, restarting MPD Jun 23 23:22:23 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:23 rivoplus sudo[6289]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus sudo[6292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 23 23:22:23 rivoplus sudo[6292]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus sudo[6292]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus sudo[6301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 23:22:23 rivoplus sudo[6301]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus sudo[6301]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus sudo[6305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 23 23:22:23 rivoplus sudo[6305]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 23 23:22:23 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 23 23:22:23 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 23 23:22:23 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:23 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:23 rivoplus sudo[6305]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus volumio[3451]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: QobuzConnect: setDeactiveState invoked Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:23 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:23 rivoplus volumio[3451]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus sudo[6313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 23:22:23 rivoplus sudo[6313]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus sudo[6328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 23 23:22:23 rivoplus sudo[6328]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus systemd[1]: Stopping Music Player Daemon... Jun 23 23:22:23 rivoplus sudo[6328]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus sudo[6332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 23 23:22:23 rivoplus sudo[6332]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus systemd[1]: mpd.service: Succeeded. Jun 23 23:22:23 rivoplus sudo[6332]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 23 23:22:23 rivoplus systemd[1]: Starting Music Player Daemon... Jun 23 23:22:23 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 23 23:22:23 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 23 23:22:23 rivoplus sudo[6340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 23 23:22:23 rivoplus sudo[6340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 23 23:22:23 rivoplus sudo[6340]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:23 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:23 rivoplus volumio[3451]: info: MCU Signalled Playback Inactive Jun 23 23:22:23 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 23 23:22:23 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 23 23:22:23 rivoplus volumio[3451]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 23 23:22:23 rivoplus sudo[6344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 23 23:22:23 rivoplus volumio[3451]: info: MPD Permissions set Jun 23 23:22:23 rivoplus volumio[3451]: info: Raat Daemon started successfully Jun 23 23:22:23 rivoplus sudo[6344]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus volumio[3451]: info: Raat Daemon started successfully Jun 23 23:22:23 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:23 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:23 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.941 [6267.6267] INFO SampleApp: Stopping Local configuration server Jun 23 23:22:23 rivoplus qobuz-connect[6267]: 20250623 23:22:23.951 [6267.6267] INFO SampleApp: shat down connection on UNIX socket Jun 23 23:22:23 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 23 23:22:23 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 23 23:22:23 rivoplus sudo[6341]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 23 23:22:23 rivoplus sudo[6341]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:23 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 23 23:22:23 rivoplus sudo[6344]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:23 rivoplus sudo[6341]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 23 23:22:24 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:24 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:24 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 23:22:24 rivoplus volumio[3451]: info: Not Reporting Auto name since its the default one Jun 23 23:22:24 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 23 23:22:24 rivoplus volumio[3451]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 23 23:22:24 rivoplus volumio[3451]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 23 23:22:24 rivoplus volumio[3451]: info: QobuzConnect: setDeactiveState invoked Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:24 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:24 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 23 23:22:24 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 23 23:22:24 rivoplus volumio[3451]: info: Executing endpoint qc_getconfig Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.192 [6349.6349] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.201 [6349.6349] INFO VolumeManager: [0xaafbb7f0]: Setting new playback volume: 75 Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.201 [6349.6349] INFO VolumeManager: [0xaafbb7f0]: Setting new mute state: 0 Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.201 [6349.6349] INFO QobuzConnect: [0xaafbc1c0]: Client initialized! Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.201 [6349.6349] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.218 [6349.6349] INFO LocalConfigManager: [0xaafbb0d0]: Starting Local Configuration server Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.218 [6349.6349] INFO SampleApp: Starting Local configuration server Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.219 [6349.6349] INFO SampleApp: Connected to UNIX socket client 0xaafb0ed8 Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 23 23:22:24 rivoplus volumio[3451]: No protocol specified Jun 23 23:22:24 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:24 rivoplus volumio[3451]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 23 23:22:24 rivoplus volumio[3451]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 23 23:22:24 rivoplus qobuz-connect[6349]: 20250623 23:22:24.342 [6349.6349] INFO SampleApp: Playback volume changed: 75 Jun 23 23:22:24 rivoplus sudo[6365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 23 23:22:24 rivoplus sudo[6365]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:24 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:24 rivoplus sudo[6365]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:24 rivoplus sudo[6367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 23 23:22:24 rivoplus sudo[6367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:24 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:24 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:24 rivoplus sudo[6367]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:24 rivoplus volumio[3451]: info: Raat Daemon started successfully Jun 23 23:22:24 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:24 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:24 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:24 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 23 23:22:25 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:25 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:25 rivoplus volumio[3451]: info: TidalConnect service stoped! Jun 23 23:22:25 rivoplus volumio[3451]: info: TidalConnect service stoped! Jun 23 23:22:25 rivoplus volumio[3451]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 23 23:22:25 rivoplus volumio[3451]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 23 23:22:25 rivoplus sudo[6389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 23 23:22:25 rivoplus sudo[6389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:25 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Jun 23 23:22:25 rivoplus sudo[6389]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:25 rivoplus mpd[6354]: Jun 23 23:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 23 23:22:26 rivoplus systemd[1]: Started Music Player Daemon. Jun 23 23:22:26 rivoplus sudo[6313]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:26 rivoplus volumio[3451]: error: updateQueue error: null Jun 23 23:22:26 rivoplus volumio[3451]: info: Executing endpoint tc_getconfig Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 23 23:22:26 rivoplus vtcs[6391]: STARTING TidalConnect services, version: 1.5.1-beta1 Jun 23 23:22:26 rivoplus vtcs[6391]: STARTED TidalConnect services. Jun 23 23:22:26 rivoplus volumio[3451]: info: Executing endpoint tc_connect Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 23 23:22:26 rivoplus volumio[3451]: info: Connecting to TidalConnect Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::servicePushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::pushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioPushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output update for this device Jun 23 23:22:26 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::servicePushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::pushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioPushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output update for this device Jun 23 23:22:26 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::getQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::getQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getQueue Jun 23 23:22:26 rivoplus volumio[3451]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Jun 23 23:22:26 rivoplus volumio[3451]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Jun 23 23:22:26 rivoplus volumio[3451]: info: Updating RAAT Signal Path Jun 23 23:22:26 rivoplus volumio[3451]: info: Updating RAAT Signal Path Jun 23 23:22:26 rivoplus volumio[3451]: info: RAAT: Requesting Headphone Status Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 23 23:22:26 rivoplus volumio[3451]: info: MCU Signalled Headphone Mode Disabled Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 23 23:22:26 rivoplus volumio[3451]: info: Reporting Headphone State: false Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:26 rivoplus volumio[3451]: info: Updating RAAT Signal Path Jun 23 23:22:26 rivoplus volumio[3451]: info: RAAT: Requesting Headphone Status Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::getcurrentVolume Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioRetrievevolume Jun 23 23:22:26 rivoplus volumio[3451]: info: MCU Signalled Headphone Mode Disabled Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 23 23:22:26 rivoplus volumio[3451]: info: Reporting Headphone State: false Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:26 rivoplus volumio[3451]: info: Updating RAAT Signal Path Jun 23 23:22:26 rivoplus volumio[3451]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jun 23 23:22:26 rivoplus volumio[3451]: xcb_connection_has_error() returned true Jun 23 23:22:26 rivoplus volumio[3451]: info: VolumeController:: Volume=undefined Mute =false Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::pushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioPushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output update for this device Jun 23 23:22:26 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::updateTrackBlock Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrackBlock Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioRetrievevolume Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::getQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getQueue Jun 23 23:22:26 rivoplus volumio[3451]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Jun 23 23:22:26 rivoplus volumio[3451]: info: Updating RAAT Signal Path Jun 23 23:22:26 rivoplus volumio[3451]: info: VolumeController:: Volume=5 Mute =false Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::pushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioPushState Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:26 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output update for this device Jun 23 23:22:26 rivoplus volumio[3451]: info: MRS: Pushing multiroomSync output Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CoreStateMachine::getQueue Jun 23 23:22:26 rivoplus volumio[3451]: info: CorePlayQueue::getQueue Jun 23 23:22:26 rivoplus volumio[3451]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Jun 23 23:22:26 rivoplus volumio[3451]: info: Updating RAAT Signal Path Jun 23 23:22:26 rivoplus volumio[3451]: info: TidalConnect service stoped! Jun 23 23:22:26 rivoplus volumio[3451]: info: TidalConnect service stoped! Jun 23 23:22:26 rivoplus volumio[3451]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 23 23:22:26 rivoplus volumio[3451]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 23 23:22:26 rivoplus sudo[6425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 23 23:22:26 rivoplus sudo[6425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 23:22:26 rivoplus sudo[6425]: pam_unix(sudo:session): session closed for user root Jun 23 23:22:27 rivoplus volumio[3451]: info: RAAT: Requesting Headphone Status Jun 23 23:22:27 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 23 23:22:27 rivoplus volumio[3451]: info: MCU Signalled Headphone Mode Disabled Jun 23 23:22:27 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 23 23:22:27 rivoplus volumio[3451]: info: Reporting Headphone State: false Jun 23 23:22:27 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 23:22:27 rivoplus volumio[3451]: info: Updating RAAT Signal Path Jun 23 23:22:28 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:22:28 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 1. Jun 23 23:22:28 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:28 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:28 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:28 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:28 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:28 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 23 23:22:28 rivoplus volumio[3451]: info: TidalConnect service started! Jun 23 23:22:29 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:29 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:29 rivoplus volumio[3451]: info: TidalConnect service started! Jun 23 23:22:33 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:22:33 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 2. Jun 23 23:22:33 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:33 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:33 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:33 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:33 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:33 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 23 23:22:34 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:34 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:36 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 23:22:36 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 23:22:36 rivoplus volumio[3451]: info: Discovery: Getting this device information Jun 23 23:22:36 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:22:36 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:36 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 23:22:36 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 23 23:22:36 rivoplus volumio[3451]: info: Preload queue cleared Jun 23 23:22:37 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:22:37 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 3. Jun 23 23:22:37 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:37 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:37 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:37 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:37 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:37 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 23 23:22:38 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 23 23:22:38 rivoplus volumio[3451]: info: Preload queue cleared Jun 23 23:22:38 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:38 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:40 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 23 23:22:40 rivoplus volumio[3451]: info: Preload queue cleared Jun 23 23:22:40 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 23 23:22:40 rivoplus volumio-remote-updater[2860]: No test mode Jun 23 23:22:40 rivoplus volumio-remote-updater[2860]: No alpha test mode Jun 23 23:22:40 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 23 23:22:40 rivoplus volumio[3451]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 23 23:22:40 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 23 23:22:41 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:22:41 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 4. Jun 23 23:22:41 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:41 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:41 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:41 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:41 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:41 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 23 23:22:42 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:42 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:44 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 23 23:22:45 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:22:45 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 5. Jun 23 23:22:45 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:45 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:46 rivoplus volumio[3451]: Cannot compose Albumart path Jun 23 23:22:46 rivoplus volumio[3451]: Cannot compose Albumart path Jun 23 23:22:46 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 23 23:22:46 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:46 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:46 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:46 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:46 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:46 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preload queue cleared Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4662 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4642 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4641 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4663 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4640 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4639 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4638 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4666 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4636 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4671 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3339 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3370 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3395 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3404 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3414 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@2783 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@2827 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1811 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1809 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1818 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1814 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1816 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1815 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1817 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1813 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1810 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1808 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1807 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1812 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1738 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1739 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1740 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1741 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1742 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1743 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1744 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1745 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1746 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1747 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1748 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1749 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4558 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4090 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4084 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4083 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4082 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4081 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4080 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4089 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4088 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4085 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4086 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4087 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4079 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4091 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4078 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@443 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@444 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@445 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@446 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@447 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@448 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@449 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@450 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@451 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@452 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@453 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@454 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@455 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@456 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@457 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@458 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@459 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@460 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@461 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@462 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@463 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@464 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@465 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@466 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@467 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@468 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@469 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@470 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@471 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@472 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@473 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@474 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@475 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@476 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@477 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@478 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@479 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@480 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@481 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@482 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@483 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@484 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@485 Jun 23 23:22:46 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@486 Jun 23 23:22:46 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4662 in service upnp_browser Jun 23 23:22:46 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4642 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: Cannot compose Albumart path Jun 23 23:22:47 rivoplus volumio[3451]: Cannot compose Albumart path Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4641 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4663 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4640 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4639 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4638 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4666 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4636 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4671 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3339 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3370 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3395 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3404 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@3414 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@2783 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@2827 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1811 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1809 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1818 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1814 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1816 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1815 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1817 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1813 in service upnp_browser Jun 23 23:22:47 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1810 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1808 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Preload queue cleared Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1807 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1812 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1738 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1739 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1740 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1741 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1742 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1743 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1744 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1745 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1746 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1747 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1748 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1749 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4558 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4090 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4084 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4083 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4082 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4081 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4080 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4089 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4088 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4085 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4086 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4087 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4079 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4091 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4078 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@443 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@444 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@445 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@446 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@447 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@448 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@449 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@450 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@451 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@452 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@453 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@454 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@455 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@456 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@457 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@458 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@459 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@460 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@461 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@462 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@463 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@464 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@465 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@466 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@467 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@468 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@469 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@470 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@471 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@472 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@473 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@474 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@475 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@476 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@477 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@478 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@479 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@480 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@481 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@482 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@483 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@484 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@485 Jun 23 23:22:48 rivoplus volumio[3451]: info: Preloading song: upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@486 Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1807 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1812 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1738 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1739 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1740 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1741 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1742 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1743 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1744 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1745 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1746 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1747 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1748 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@1749 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4558 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4090 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4084 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4083 in service upnp_browser Jun 23 23:22:48 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4082 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4081 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4080 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4089 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4088 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4085 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4086 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4087 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4079 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4091 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@4078 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@443 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@444 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@445 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@446 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@447 in service upnp_browser Jun 23 23:22:49 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:22:49 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 6. Jun 23 23:22:49 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:49 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@448 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@449 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@450 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:49 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:49 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:49 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@451 in service upnp_browser Jun 23 23:22:49 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@452 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@453 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@454 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@455 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@456 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@457 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@458 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@459 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@460 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@461 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@462 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@463 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@464 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@465 in service upnp_browser Jun 23 23:22:50 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:50 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@466 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@467 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@468 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@469 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@470 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@471 in service upnp_browser Jun 23 23:22:50 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@472 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@473 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@474 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@475 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@476 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@477 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@478 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@479 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@480 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@481 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@482 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@483 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@484 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@485 in service upnp_browser Jun 23 23:22:51 rivoplus volumio[3451]: info: Exploding uri upnp/http://192.168.1.11:50001/ContentDirectory/control@23$@486 in service upnp_browser Jun 23 23:22:53 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:22:53 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 7. Jun 23 23:22:53 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:53 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:53 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:53 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:53 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:53 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 23 23:22:54 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:54 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:22:57 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:22:57 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 8. Jun 23 23:22:57 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:22:57 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:22:57 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:22:57 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:22:57 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:22:57 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 23 23:22:58 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:22:58 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:23:02 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:23:02 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 9. Jun 23 23:23:02 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:23:02 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:23:02 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:23:02 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:23:02 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:23:02 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 23 23:23:02 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:23:02 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:23:06 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:23:06 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 10. Jun 23 23:23:06 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:23:06 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:23:06 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:23:06 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:23:06 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:23:06 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 23 23:23:06 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 23 23:23:06 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 23:23:06 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 23:23:06 rivoplus volumio[3451]: info: Discovery: Getting this device information Jun 23 23:23:06 rivoplus volumio[3451]: info: CoreCommandRouter::volumioGetState Jun 23 23:23:06 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:23:06 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 23:23:06 rivoplus volumio[3451]: info: Preload queue cleared Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:23:06 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:06 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:07 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:07 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:07 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:07 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:07 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:07 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:07 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:07 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:09 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:09 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:09 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:09 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:09 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:09 rivoplus volumio[3451]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Jun 23 23:23:10 rivoplus systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 23:23:10 rivoplus systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 11. Jun 23 23:23:10 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 23 23:23:10 rivoplus systemd[1]: Started RAAT DAEMON. Jun 23 23:23:10 rivoplus volumio[3451]: info: Executing endpoint restartRAATSocket Jun 23 23:23:10 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 23 23:23:10 rivoplus volumio[3451]: info: CorePlayQueue::getTrack 9 Jun 23 23:23:10 rivoplus volumio[3451]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 23 23:23:11 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Jun 23 23:23:11 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Jun 23 23:23:11 rivoplus volumio[3451]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 23 23:23:11 rivoplus volumio[3451]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 23 23:23:11 rivoplus volumio[3451]: TypeError: Cannot read property 'length' of undefined Jun 23 23:23:11 rivoplus volumio[3451]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jun 23 23:23:11 rivoplus volumio[3451]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jun 23 23:23:11 rivoplus volumio[3451]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jun 23 23:23:11 rivoplus volumio[3451]: at Parser.emit (events.js:400:28) Jun 23 23:23:11 rivoplus volumio[3451]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jun 23 23:23:11 rivoplus volumio[3451]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jun 23 23:23:11 rivoplus volumio[3451]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jun 23 23:23:11 rivoplus volumio[3451]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jun 23 23:23:11 rivoplus volumio[3451]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jun 23 23:23:11 rivoplus volumio[3451]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jun 23 23:23:11 rivoplus volumio[3451]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jun 23 23:23:11 rivoplus volumio[3451]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jun 23 23:23:11 rivoplus volumio[3451]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jun 23 23:23:11 rivoplus volumio[3451]: at IncomingMessage.emit (events.js:412:35) Jun 23 23:23:11 rivoplus volumio[3451]: at endReadableNT (internal/streams/readable.js:1333:12) Jun 23 23:23:11 rivoplus volumio[3451]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jun 23 23:23:11 rivoplus volumio[3451]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 23 23:23:12 rivoplus sudo[6776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-23 23:22 Jun 23 23:23:12 rivoplus sudo[6776]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:41:30 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="e2256d79dd6d0ae59eb47f10e57a5e95"