-- Logs begin at Wed 2025-03-12 11:22:43 CET, end at Wed 2025-03-12 11:31:28 CET. -- Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12664, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12671, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12678, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12685, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12692, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:00 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:00 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:00 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12699, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12706, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12713, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12720, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12727, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12734, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12741, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12748, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12755, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12764, instance 1, run: true Mar 12 11:30:00 volumio volumio[1085]: info: camilladsp spawned new process with pid 12771, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12778, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12785, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12792, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12799, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12806, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12813, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:01 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:01 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:01 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12820, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12827, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12834, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12841, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12848, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12855, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12862, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12869, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12876, instance 1, run: true Mar 12 11:30:01 volumio volumio[1085]: info: camilladsp spawned new process with pid 12885, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12892, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12899, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12906, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12913, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12920, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12927, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:02 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:02 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:02 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12934, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12941, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12948, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12955, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12962, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12969, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12976, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12983, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12990, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 12997, instance 1, run: true Mar 12 11:30:02 volumio volumio[1085]: info: camilladsp spawned new process with pid 13006, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13013, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13020, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13027, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13034, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13041, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:03 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:03 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:03 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13048, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13055, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13062, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13069, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13076, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13083, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13090, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13097, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13104, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13111, instance 1, run: true Mar 12 11:30:03 volumio volumio[1085]: info: camilladsp spawned new process with pid 13120, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13127, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13134, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13141, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13148, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13155, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13162, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:04 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:04 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:04 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13169, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13176, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13183, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13190, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13197, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13204, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13211, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13218, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13225, instance 1, run: true Mar 12 11:30:04 volumio volumio[1085]: info: camilladsp spawned new process with pid 13232, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13241, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13248, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13255, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13262, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13269, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13276, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13283, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:05 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:05 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:05 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13290, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13297, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13304, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13311, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13318, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13325, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13332, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13339, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13346, instance 1, run: true Mar 12 11:30:05 volumio volumio[1085]: info: camilladsp spawned new process with pid 13353, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13362, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13383, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13390, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13397, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13404, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13411, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13418, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:06 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:06 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:06 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13425, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13432, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13439, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13446, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13453, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13460, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13467, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13474, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13481, instance 1, run: true Mar 12 11:30:06 volumio volumio[1085]: info: camilladsp spawned new process with pid 13488, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13497, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13504, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13511, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13518, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13525, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13532, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13539, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:07 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:07 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:07 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13546, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13553, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13560, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13567, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13574, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13581, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13588, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13595, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13602, instance 1, run: true Mar 12 11:30:07 volumio volumio[1085]: info: camilladsp spawned new process with pid 13609, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13618, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13625, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13632, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13639, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13646, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13653, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13660, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:08 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:08 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:08 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13667, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13674, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13681, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13688, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13695, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13715, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13737, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13757, instance 1, run: true Mar 12 11:30:08 volumio volumio[1085]: info: camilladsp spawned new process with pid 13764, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13771, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13780, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13787, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13794, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13801, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13808, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13815, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:09 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:09 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:09 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13822, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13829, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13836, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13843, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13850, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13857, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13864, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13871, instance 1, run: true Mar 12 11:30:09 volumio volumio[1085]: info: camilladsp spawned new process with pid 13878, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13885, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13894, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13901, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13908, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13915, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13922, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13929, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:10 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:10 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:10 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13936, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13943, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13950, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13957, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13964, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13971, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13978, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13985, instance 1, run: true Mar 12 11:30:10 volumio volumio[1085]: info: camilladsp spawned new process with pid 13992, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 13999, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14006, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14015, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14022, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14029, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14036, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14043, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14050, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:11 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:11 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:11 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14057, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14064, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14071, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14078, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14085, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14092, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14099, instance 1, run: true Mar 12 11:30:11 volumio volumio[1085]: info: camilladsp spawned new process with pid 14106, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14113, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14120, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14129, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14136, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14143, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14150, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14157, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14164, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:12 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:12 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:12 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14171, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14178, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14185, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14192, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14199, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14206, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14213, instance 1, run: true Mar 12 11:30:12 volumio volumio[1085]: info: camilladsp spawned new process with pid 14220, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14227, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14237, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14244, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14253, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14260, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14267, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14274, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14281, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14288, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:13 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:13 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:13 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14295, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14302, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14309, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14316, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14323, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14330, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14337, instance 1, run: true Mar 12 11:30:13 volumio volumio[1085]: info: camilladsp spawned new process with pid 14344, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14351, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14358, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14367, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14374, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14381, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14388, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14395, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14402, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:14 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:14 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:14 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14409, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14416, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14423, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14430, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14437, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14444, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14451, instance 1, run: true Mar 12 11:30:14 volumio volumio[1085]: info: camilladsp spawned new process with pid 14458, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14465, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14472, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14479, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14488, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14495, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14502, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14509, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14516, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:15 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:15 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:15 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14523, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14530, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14537, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14544, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14551, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14558, instance 1, run: true Mar 12 11:30:15 volumio volumio[1085]: info: camilladsp spawned new process with pid 14565, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14572, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14579, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14600, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14607, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14616, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14623, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14630, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14637, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14644, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:16 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:16 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:16 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14651, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14658, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14665, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14672, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14679, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14686, instance 1, run: true Mar 12 11:30:16 volumio volumio[1085]: info: camilladsp spawned new process with pid 14693, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14700, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14707, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14714, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14721, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14728, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14737, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14744, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14751, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14758, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14766, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:17 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:17 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:17 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14773, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14780, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14787, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14794, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14801, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14808, instance 1, run: true Mar 12 11:30:17 volumio volumio[1085]: info: camilladsp spawned new process with pid 14815, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14822, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14829, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14836, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14843, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14850, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14859, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14866, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14873, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14880, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14887, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:18 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:18 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:18 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14894, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14901, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14908, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14915, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14922, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14929, instance 1, run: true Mar 12 11:30:18 volumio volumio[1085]: info: camilladsp spawned new process with pid 14936, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 14943, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 14950, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 14957, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 14964, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 14973, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 14980, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 14987, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 14994, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 15001, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:19 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:19 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:19 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 15008, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 15015, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 15022, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 15029, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 15036, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 15043, instance 1, run: true Mar 12 11:30:19 volumio volumio[1085]: info: camilladsp spawned new process with pid 15050, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15057, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15064, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15071, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15078, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15085, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15094, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15101, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15108, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15115, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:20 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:20 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:20 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15122, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15129, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15136, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15143, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15150, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15157, instance 1, run: true Mar 12 11:30:20 volumio volumio[1085]: info: camilladsp spawned new process with pid 15164, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15171, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15178, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15185, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15192, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15199, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15206, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15215, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15222, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15229, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15236, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:21 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:21 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:21 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15243, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15250, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15257, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15264, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15271, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15278, instance 1, run: true Mar 12 11:30:21 volumio volumio[1085]: info: camilladsp spawned new process with pid 15285, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15292, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15299, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15306, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15313, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15320, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15327, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15336, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15343, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15350, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15357, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:22 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:22 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:22 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15364, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15371, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15378, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15385, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15392, instance 1, run: true Mar 12 11:30:22 volumio volumio[1085]: info: camilladsp spawned new process with pid 15399, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15406, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15413, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15420, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15427, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15434, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15441, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15448, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15457, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15464, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15471, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:23 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:23 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:23 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15478, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15485, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15492, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15499, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15506, instance 1, run: true Mar 12 11:30:23 volumio volumio[1085]: info: camilladsp spawned new process with pid 15513, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15520, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15527, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15534, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15541, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15548, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15555, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15562, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15571, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15578, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15585, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15592, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:24 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:24 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15599, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15606, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15613, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15620, instance 1, run: true Mar 12 11:30:24 volumio volumio[1085]: info: camilladsp spawned new process with pid 15627, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15634, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15641, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15648, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15655, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15662, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15669, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15676, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15683, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15692, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15699, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15706, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:25 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:25 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:25 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15713, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15720, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15727, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15734, instance 1, run: true Mar 12 11:30:25 volumio volumio[1085]: info: camilladsp spawned new process with pid 15741, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15748, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15755, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15770, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15783, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15790, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15797, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15804, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15811, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15818, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15827, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15834, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:26 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:26 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:26 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15841, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15848, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15855, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15862, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15869, instance 1, run: true Mar 12 11:30:26 volumio volumio[1085]: info: camilladsp spawned new process with pid 15876, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15883, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15890, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15897, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15904, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15911, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15918, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15925, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15932, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15939, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15948, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15955, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:27 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:27 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:27 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15962, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15969, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15976, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15983, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15990, instance 1, run: true Mar 12 11:30:27 volumio volumio[1085]: info: camilladsp spawned new process with pid 15997, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16004, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16011, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16018, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16025, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16032, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16039, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16046, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16054, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16061, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: CALLMETHOD: system_controller backup_restore restore [object Object] Mar 12 11:30:28 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: backup_restore , restore Mar 12 11:30:28 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:28 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:28 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:28 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16074, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16081, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16088, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16095, instance 1, run: true Mar 12 11:30:28 volumio volumio[1085]: info: camilladsp spawned new process with pid 16102, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16109, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16116, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16123, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16130, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16137, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16144, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16151, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16158, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16165, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16174, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:29 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:29 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:29 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16181, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16188, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16195, instance 1, run: true Mar 12 11:30:29 volumio volumio[1085]: info: camilladsp spawned new process with pid 16202, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16209, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16216, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16223, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16230, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16237, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16244, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16251, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16258, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16265, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16274, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:30 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:30 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:30 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16281, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16288, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16295, instance 1, run: true Mar 12 11:30:30 volumio volumio[1085]: info: camilladsp spawned new process with pid 16302, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16309, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16316, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16323, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16330, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16337, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16344, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16351, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16358, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16366, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16373, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16382, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:31 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:31 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:31 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16389, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16396, instance 1, run: true Mar 12 11:30:31 volumio volumio[1085]: info: camilladsp spawned new process with pid 16403, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16410, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16417, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16424, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16431, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16438, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16445, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16452, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16459, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16466, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16473, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16480, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:32 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:32 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:32 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16489, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16496, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16503, instance 1, run: true Mar 12 11:30:32 volumio volumio[1085]: info: camilladsp spawned new process with pid 16510, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16519, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16527, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16534, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16541, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16548, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16555, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16562, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16569, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16576, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16583, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:33 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:33 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:33 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16590, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16599, instance 1, run: true Mar 12 11:30:33 volumio volumio[1085]: info: camilladsp spawned new process with pid 16606, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16613, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16620, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16627, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16634, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16641, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16648, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16655, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16662, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16669, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16676, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16683, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16690, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16697, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:34 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:34 volumio volumio[1085]: info: CoreStateMachine::getQueue Mar 12 11:30:34 volumio volumio[1085]: info: CorePlayQueue::getQueue Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16704, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16711, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: CALLMETHOD: system_controller backup_restore relaunch [object Object] Mar 12 11:30:34 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: backup_restore , relaunch Mar 12 11:30:34 volumio sudo[16721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio Mar 12 11:30:34 volumio sudo[16721]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16723, instance 1, run: true Mar 12 11:30:34 volumio volumio[1085]: info: camilladsp spawned new process with pid 16736, instance 1, run: true Mar 12 11:30:34 volumio systemd[1]: Started dynamicswap service. Mar 12 11:30:34 volumio systemd[1]: Stopping Volumio Backend Module... Mar 12 11:30:34 volumio sudo[16721]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:35 volumio volumio-remote-updater[596]: [2025-03-12 11:30:35] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 12 11:30:35 volumio volumio-remote-updater[596]: [2025-03-12 11:30:35] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 12 11:30:35 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=15/TERM Mar 12 11:30:35 volumio systemd[1]: volumio.service: Succeeded. Mar 12 11:30:35 volumio systemd[1]: Stopped Volumio Backend Module. Mar 12 11:30:35 volumio systemd[1]: Started Volumio Backend Module. Mar 12 11:30:35 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 12 11:30:37 volumio volumio[16748]: info: ------------------------------------------- Mar 12 11:30:37 volumio volumio[16748]: info: ----- Volumio3 ---- Mar 12 11:30:37 volumio volumio[16748]: info: ------------------------------------------- Mar 12 11:30:37 volumio volumio[16748]: info: ----- System startup ---- Mar 12 11:30:37 volumio volumio[16748]: info: ------------------------------------------- Mar 12 11:30:38 volumio volumio[16748]: info: MYVOLUMIO Environment detected Mar 12 11:30:39 volumio volumio[16748]: info: Plugin folders cleanup Mar 12 11:30:39 volumio volumio[16748]: info: Scanning into folder /volumio/app/plugins/ Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category audio_interface Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category miscellanea Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category music_service Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category plugins.json Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category system_controller Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category user_interface Mar 12 11:30:39 volumio volumio[16748]: info: Scanning into folder /data/plugins/ Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category audio_interface Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category system_controller Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category system_hardware Mar 12 11:30:39 volumio volumio[16748]: info: Scanning category user_interface Mar 12 11:30:39 volumio volumio[16748]: info: Plugin folders cleanup completed Mar 12 11:30:39 volumio volumio[16748]: info: ------------------------------------------- Mar 12 11:30:39 volumio volumio[16748]: info: ----- Core plugins startup ---- Mar 12 11:30:39 volumio volumio[16748]: info: ------------------------------------------- Mar 12 11:30:39 volumio volumio[16748]: info: Loading plugins from folder /volumio/app/plugins/ Mar 12 11:30:39 volumio volumio[16748]: info: Adding plugin upnp to MyMusic Plugins Mar 12 11:30:39 volumio volumio[16748]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 12 11:30:39 volumio volumio[16748]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 12 11:30:39 volumio volumio[16748]: info: Loading plugins from folder /data/plugins/ Mar 12 11:30:39 volumio volumio[16748]: info: Loading plugin "system"... Mar 12 11:30:39 volumio volumio[16748]: info: Loading plugin "ampswitch"... Mar 12 11:30:39 volumio volumio[16748]: info: Applying required configuration parameters for plugin ampswitch Mar 12 11:30:39 volumio volumio[16748]: info: Loading plugin "appearance"... Mar 12 11:30:40 volumio volumio-remote-updater[596]: [2025-03-12 11:30:40] [connect] Successful connection Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "network"... Mar 12 11:30:41 volumio volumio[16748]: info: Refreshing Cached IP Addresses Mar 12 11:30:41 volumio sudo[16771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 12 11:30:41 volumio sudo[16771]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:41 volumio sudo[16771]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:41 volumio sudo[16773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 12 11:30:41 volumio sudo[16773]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:41 volumio sudo[16773]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "services"... Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "alsa_controller"... Mar 12 11:30:41 volumio sudo[16786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 12 11:30:41 volumio sudo[16786]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:41 volumio volumio[16748]: warn: Unable to locate the audio output device HiFiBerry Digi. Please configure a valid output device. Mar 12 11:30:41 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "wizard"... Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "networkfs"... Mar 12 11:30:41 volumio volumio[16748]: info: Starting Udev Watcher for removable devices Mar 12 11:30:41 volumio volumio[16748]: info: Ignoring mount for partition: boot Mar 12 11:30:41 volumio volumio[16748]: info: Ignoring mount for partition: volumio Mar 12 11:30:41 volumio volumio[16748]: info: Ignoring mount for partition: volumio_data Mar 12 11:30:41 volumio volumio[16748]: info: Mounting Device 16GB Mar 12 11:30:41 volumio sudo[16800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/16GB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 12 11:30:41 volumio sudo[16800]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:41 volumio sudo[16800]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:41 volumio volumio[16748]: mount: /media/16GB: /dev/sda1 already mounted on /media/16GB. Mar 12 11:30:41 volumio volumio[16748]: error: Failed to mount 16GB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/16GB" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 12 11:30:41 volumio volumio[16748]: mount: /media/16GB: /dev/sda1 already mounted on /media/16GB. Mar 12 11:30:41 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "volumio_command_line_client"... Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "upnp"... Mar 12 11:30:41 volumio volumio[16748]: info: [1741775441442] Starting Upmpd Daemon Mar 12 11:30:41 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "my_music"... Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "mpd"... Mar 12 11:30:41 volumio volumio[16748]: info: Loading plugin "upnp_browser"... Mar 12 11:30:42 volumio volumio[16748]: info: Loading plugin "alarm-clock"... Mar 12 11:30:42 volumio volumio[16748]: info: Loading plugin "airplay_emulation"... Mar 12 11:30:42 volumio volumio[16748]: info: Starting Shairport Sync Mar 12 11:30:42 volumio volumio[16748]: info: Loading plugin "last_100"... Mar 12 11:30:42 volumio volumio[16748]: info: Loading plugin "webradio"... Mar 12 11:30:42 volumio volumio[16748]: info: Loading plugin "i2s_dacs"... Mar 12 11:30:42 volumio volumio[16748]: info: Loading plugin "volumiodiscovery"... Mar 12 11:30:42 volumio volumio[16748]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 12 11:30:42 volumio volumio[16748]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 12 11:30:42 volumio volumio[16748]: *** WARNING *** For more information see Mar 12 11:30:42 volumio volumio[16748]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 12 11:30:42 volumio node[16748]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 12 11:30:42 volumio volumio[16748]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 12 11:30:42 volumio volumio[16748]: *** WARNING *** For more information see Mar 12 11:30:42 volumio node[16748]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 12 11:30:42 volumio node[16748]: *** WARNING *** For more information see Mar 12 11:30:42 volumio node[16748]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 12 11:30:42 volumio node[16748]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 12 11:30:42 volumio node[16748]: *** WARNING *** For more information see Mar 12 11:30:42 volumio volumio[16748]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 12 11:30:42 volumio volumio[16748]: info: Discovery: Started advertising with name: Volumio Mar 12 11:30:42 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 12 11:30:42 volumio volumio[16748]: info: Loading plugin "autostart"... Mar 12 11:30:43 volumio volumio[16748]: info: Applying required configuration parameters for plugin autostart Mar 12 11:30:43 volumio volumio[16748]: info: AutoStart - onVolumioStart - read config.json Mar 12 11:30:43 volumio volumio[16748]: info: Loading plugin "gpio-buttons"... Mar 12 11:30:43 volumio volumio[16748]: info: GPIO-Buttons initialized Mar 12 11:30:43 volumio volumio[16748]: info: Loading plugin "outputs"... Mar 12 11:30:43 volumio volumio[16748]: info: Loading plugin "albumart"... Mar 12 11:30:43 volumio volumio[16748]: info: Plugin example_plugin is not enabled Mar 12 11:30:43 volumio volumio[16748]: info: Loading plugin "inputs"... Mar 12 11:30:43 volumio volumio[16748]: info: Loading plugin "updater_comm"... Mar 12 11:30:44 volumio volumio[16748]: info: Plugin mpdemulation is not enabled Mar 12 11:30:44 volumio volumio[16748]: info: Loading plugin "rest_api"... Mar 12 11:30:44 volumio volumio[16748]: info: Loading plugin "websocket"... Mar 12 11:30:44 volumio volumio[16748]: info: Starting Socket.io Server version 2.3.0 Mar 12 11:30:44 volumio volumio[16748]: info: Loading plugin "fusiondsp"... Mar 12 11:30:44 volumio volumio[16748]: Forking 3 albumart workers Mar 12 11:30:44 volumio volumio[16748]: info: Applying required configuration parameters for plugin fusiondsp Mar 12 11:30:44 volumio sudo[16786]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:45 volumio volumio[16748]: info: Loading plugin "backup_restore"... Mar 12 11:30:45 volumio volumio[16748]: Starting albumart workers Mar 12 11:30:45 volumio volumio[16748]: info: Applying required configuration parameters for plugin backup_restore Mar 12 11:30:45 volumio volumio[16748]: info: Loading plugin "audiophonics_evo_sabre"... Mar 12 11:30:45 volumio volumio[16748]: info: Applying required configuration parameters for plugin audiophonics_evo_sabre Mar 12 11:30:45 volumio volumio[16748]: Starting albumart workers Mar 12 11:30:45 volumio volumio[16748]: Starting albumart workers Mar 12 11:30:45 volumio volumio[16748]: info: Loading plugin "audiophonicsonoff"... Mar 12 11:30:46 volumio volumio[16748]: info: Applying required configuration parameters for plugin audiophonicsonoff Mar 12 11:30:46 volumio volumio[16748]: info: Audiophonics on/off initiated Mar 12 11:30:46 volumio volumio[16748]: info: Loading plugin "gpio_control"... Mar 12 11:30:46 volumio volumio[16748]: gpiox_arm32 V2.1.0 Mar 12 11:30:46 volumio volumio[16748]: info: Applying required configuration parameters for plugin gpio_control Mar 12 11:30:46 volumio volumio[16748]: info: Loading plugin "remotepi"... Mar 12 11:30:47 volumio volumio[16748]: info: Applying required configuration parameters for plugin remotepi Mar 12 11:30:47 volumio volumio[16748]: info: Loading plugin "touch_display"... Mar 12 11:30:47 volumio volumio[16748]: info: Applying required configuration parameters for plugin touch_display Mar 12 11:30:47 volumio volumio[16748]: info: Loading i18n strings for locale pl Mar 12 11:30:47 volumio volumio[16748]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Mar 12 11:30:47 volumio volumio[16748]: error: remotepi: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:47 volumio volumio[16748]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:47 volumio volumio[16748]: Updating browse sources language Mar 12 11:30:47 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::initPlayerControls Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: Express server listening on port 3000 Mar 12 11:30:48 volumio volumio[16748]: [Metrics] WebUI: 11s 217.45ms Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::resetVolumioState Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::getcurrentVolume Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioRetrievevolume Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::pushState Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioPushState Mar 12 11:30:48 volumio volumio[16748]: info: Volumio Network Manager: Network status updated: 3 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 8 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 12 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 13 Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 14 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 15 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 16 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 17 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:48 volumio volumio[16748]: info: Reloading queue from file Mar 12 11:30:48 volumio volumio[16748]: verbose: New Socket.io Connection to 192.168.55.114 from 192.168.55.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Edg/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 22 Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Mar 12 11:30:48 volumio volumio[16748]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Mar 12 11:30:48 volumio volumio[16748]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Mar 12 11:30:48 volumio volumio[16748]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:48 volumio volumio[16748]: info: Setting Device type: Raspberry PI Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::setRepeat true single undefined Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::pushState Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioPushState Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::setRandom null Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::pushState Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioPushState Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:48 volumio volumio[16748]: info: Completed loading Core Plugins Mar 12 11:30:48 volumio volumio[16748]: info: Preparing to generate the ALSA configuration file Mar 12 11:30:48 volumio volumio[16748]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 12 11:30:48 volumio volumio[16748]: info: Reading ALSA contributions from plugins. Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioGetVisibleSources Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 11:30:48 volumio volumio[16748]: info: Listing playlists Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:30:48 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:30:48 volumio volumio[16748]: info: Discovery: adding e6895fe1-00aa-4b98-8887-b0ec54940ceb Mar 12 11:30:48 volumio volumio[16748]: info: Discovery: Found device Volumio Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:48 volumio volumio[16748]: info: Discovery: this is already registered, e6895fe1-00aa-4b98-8887-b0ec54940ceb Mar 12 11:30:48 volumio volumio[16748]: info: Discovery: Found device Volumio Mar 12 11:30:48 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:48 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:49 volumio volumio[16748]: info: Asound.conf file unchanged, so no further update is needed Mar 12 11:30:49 volumio volumio[16748]: info: Output device has changed, restarting MPD Mar 12 11:30:49 volumio sudo[16869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 12 11:30:49 volumio volumio[16748]: info: Output device has changed, restarting Shairport Sync Mar 12 11:30:49 volumio sudo[16869]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:49 volumio sudo[16869]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:49 volumio sudo[16871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 12 11:30:49 volumio sudo[16871]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:49 volumio systemd[1]: Stopping Music Player Daemon... Mar 12 11:30:49 volumio volumio[16748]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 12 11:30:49 volumio volumio[16748]: info: ___________ START PLUGINS ___________ Mar 12 11:30:49 volumio volumio[16748]: info: ControllerMpd::onStart: Initializing MPD Mar 12 11:30:49 volumio volumio[16748]: info: Creating MPD Configuration file Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 12 11:30:49 volumio sudo[16891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 12 11:30:49 volumio volumio[16748]: info: [1741775449399] CoreMusicLibrary::Adding element Serwery Mediów Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 11:30:49 volumio sudo[16891]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:49 volumio sudo[16891]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:49 volumio sudo[16893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 12 11:30:49 volumio sudo[16893]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:49 volumio volumio[16748]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:49 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:49 volumio volumio[16748]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 12 11:30:49 volumio volumio[16748]: info: [1741775449570] CoreMusicLibrary::Adding element Last_100 Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 12 11:30:49 volumio volumio[16748]: info: [1741775449574] CoreMusicLibrary::Adding element Webradio Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 12 11:30:49 volumio volumio[16748]: info: Initializing BBC Radios Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:49 volumio volumio[16748]: info: AutoStart - onStart Mar 12 11:30:49 volumio volumio[16748]: info: GPIO-Buttons: Reading config and creating triggers... Mar 12 11:30:49 volumio volumio[16748]: info: Loading i18n strings for locale pl Mar 12 11:30:49 volumio volumio[16748]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Mar 12 11:30:49 volumio volumio[16748]: error: remotepi: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:49 volumio volumio[16748]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:49 volumio volumio[16748]: info: FusionDsp - mixtype--------------------- None Mar 12 11:30:49 volumio volumio[16748]: info: EVO SABRE : Starting Plugin Mar 12 11:30:49 volumio volumio[16748]: info: Loading i18n strings for locale pl Mar 12 11:30:49 volumio volumio[16748]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Mar 12 11:30:49 volumio volumio[16748]: error: remotepi: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:49 volumio volumio[16748]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:49 volumio volumio[16748]: info: Configuring GPIO pins Mar 12 11:30:49 volumio volumio[16748]: error: Plugin audiophonicsonoff failed to start! Error: EBUSY: resource busy or locked, write Mar 12 11:30:49 volumio volumio[16748]: info: [GPIO_Control] Reading config and creating GPIOs Mar 12 11:30:49 volumio volumio[16748]: info: Loading i18n strings for locale pl Mar 12 11:30:49 volumio volumio[16748]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Mar 12 11:30:49 volumio volumio[16748]: error: remotepi: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:49 volumio volumio[16748]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:49 volumio volumio[16748]: info: Loading i18n strings for locale pl Mar 12 11:30:49 volumio volumio[16748]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Mar 12 11:30:49 volumio volumio[16748]: error: remotepi: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:49 volumio volumio[16748]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 12 11:30:49 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 12 11:30:49 volumio volumio[16748]: info: Volumio Calling Home Mar 12 11:30:49 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:49 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:49 volumio systemd[1]: mpd.service: Succeeded. Mar 12 11:30:49 volumio systemd[1]: Stopped Music Player Daemon. Mar 12 11:30:50 volumio volumio[16748]: info: GPIO-Buttons started Mar 12 11:30:50 volumio volumio[16748]: info: Preparing to generate the ALSA configuration file Mar 12 11:30:50 volumio systemd[1]: Starting Music Player Daemon... Mar 12 11:30:50 volumio volumio[16748]: info: [GPIO_Control] GPIOs created Mar 12 11:30:50 volumio volumio[16748]: info: [GPIO_Control] Handling event: systemStartup Mar 12 11:30:50 volumio sudo[16930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Mar 12 11:30:50 volumio sudo[16930]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio sudo[16928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Mar 12 11:30:50 volumio sudo[16928]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio sudo[16926]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 12 11:30:50 volumio sudo[16933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 12 11:30:50 volumio sudo[16926]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio sudo[16933]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio sudo[16926]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:50 volumio volumio[16748]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 12 11:30:50 volumio volumio[16748]: info: Reading ALSA contributions from plugins. Mar 12 11:30:50 volumio volumio[16748]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:50 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:50 volumio volumio[16748]: info: [ASDebug] CurState: stop PrevState: na Mar 12 11:30:50 volumio volumio[16748]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Mar 12 11:30:50 volumio volumio[16748]: info: [ASDebug] CurState: stop PrevState: na Mar 12 11:30:50 volumio volumio[16748]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:50 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:50 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:50 volumio volumio[16748]: info: MPD Permissions set Mar 12 11:30:50 volumio systemd[1]: Reloading. Mar 12 11:30:50 volumio volumio[16748]: info: [GPIO_Control] Status changed: stop Mar 12 11:30:50 volumio volumio[16748]: info: [GPIO_Control] Handling event: musicStop Mar 12 11:30:50 volumio volumio[16748]: info: [GPIO_Control] Handling event: repeatOn Mar 12 11:30:50 volumio volumio[16748]: info: [GPIO_Control] Handling event: repeatAllOn Mar 12 11:30:50 volumio volumio[16748]: info: [GPIO_Control] Status changed: stop Mar 12 11:30:50 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 23 Mar 12 11:30:50 volumio volumio[16748]: info: Volumio called home Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:50 volumio sudo[16940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 12 11:30:50 volumio sudo[16940]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:50 volumio volumio[16748]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Mar 12 11:30:50 volumio sudo[16965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod o+rx /sys/kernel/debug Mar 12 11:30:50 volumio sudo[16967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Mar 12 11:30:50 volumio sudo[16967]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio sudo[16965]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio sudo[16965]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:50 volumio sudo[16967]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:50 volumio volumio[16748]: info: Starting Shairport Sync Mar 12 11:30:50 volumio volumio[16748]: info: Starting Shairport Sync Mar 12 11:30:50 volumio sudo[16971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 12 11:30:50 volumio sudo[16971]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio volumio[16748]: info: Starting Shairport Sync Mar 12 11:30:50 volumio sudo[16974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 12 11:30:50 volumio sudo[16974]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:50 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:50 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:50 volumio sudo[16976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 12 11:30:50 volumio sudo[16976]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:51 volumio volumio[16748]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Mar 12 11:30:51 volumio volumio[16748]: info: [ASDebug] Togle GPIO: OFF Mar 12 11:30:51 volumio volumio[16748]: info: Asound.conf file unchanged, so no further update is needed Mar 12 11:30:51 volumio volumio[16748]: info: Output device has changed, restarting MPD Mar 12 11:30:51 volumio sudo[16981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 12 11:30:51 volumio volumio[16748]: info: Output device has changed, restarting Shairport Sync Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:51 volumio sudo[16981]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:51 volumio sudo[16981]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:51 volumio sudo[16983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 12 11:30:51 volumio sudo[16983]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:51 volumio volumio[16748]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 12 11:30:51 volumio volumio[16748]: info: MPD Permissions set Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: info: Starting Shairport Sync Mar 12 11:30:51 volumio sudo[17008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 12 11:30:51 volumio sudo[17008]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:51 volumio sudo[17011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 12 11:30:51 volumio sudo[17011]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:51 volumio sudo[17011]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:51 volumio sudo[17014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 12 11:30:51 volumio sudo[17014]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:51 volumio sudo[17014]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:51 volumio sudo[17017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 12 11:30:51 volumio sudo[17017]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:51 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 12 11:30:51 volumio volumio[16748]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 12 11:30:51 volumio volumio[16748]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Mar 12 11:30:51 volumio volumio[16748]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 12 11:30:51 volumio volumio[16748]: info: camilladsp spawned new process with pid 17025, instance 1, run: true Mar 12 11:30:51 volumio volumio[16748]: info: camilladsp service started and running in background, instance 1 Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 11:30:51 volumio volumio[16748]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Mar 12 11:30:51 volumio volumio[16748]: cannot open device 'volumioHw': No such device Mar 12 11:30:51 volumio volumio[16748]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 12 11:30:51 volumio volumio[16748]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Mar 12 11:30:51 volumio volumio[16748]: cannot open device 'volumioHw': No such device Mar 12 11:30:51 volumio volumio[16748]: info: FusionDsp loaded Mar 12 11:30:51 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 12 11:30:51 volumio sudo[17035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 12 11:30:51 volumio sudo[17035]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:52 volumio volumio[16748]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 12 11:30:52 volumio volumio[16748]: info: Adding Signal Path Element [object Object] Mar 12 11:30:52 volumio volumio[16748]: info: Adding fusiondspeq DSP Signal Path Element Mar 12 11:30:52 volumio volumio[16748]: info: FusionDsp - ---- installed callbackRead Mar 12 11:30:52 volumio volumio[16748]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 12 11:30:52 volumio volumio[16748]: info: FusionDsp - Nulleq applied Mar 12 11:30:52 volumio volumio[16748]: error: FusionDsp - WebSocket error: [object Object] Mar 12 11:30:52 volumio volumio[16748]: info: camilladsp spawned new process with pid 17037, instance 1, run: true Mar 12 11:30:52 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24 Mar 12 11:30:52 volumio volumio[16748]: info: camilladsp spawned new process with pid 17044, instance 1, run: true Mar 12 11:30:52 volumio volumio[16748]: info: camilladsp spawned new process with pid 17052, instance 1, run: true Mar 12 11:30:52 volumio volumio[16748]: info: camilladsp spawned new process with pid 17059, instance 1, run: true Mar 12 11:30:52 volumio kernel: brcmfmac: brcmf_sdio_bus_rxctl: resumed on timeout Mar 12 11:30:52 volumio kernel: brcmfmac: brcmf_sdiod_ramrw: membytes transfer failed Mar 12 11:30:52 volumio kernel: brcmfmac: brcmf_sdio_readshared: unable to obtain sdpcm_shared info: rv=-84 (addr=0x0) Mar 12 11:30:52 volumio kernel: ieee80211 phy0: _brcmf_set_multicast_list: Setting mcast_list failed, -110 Mar 12 11:30:52 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:52 volumio systemd[1]: Reloading. Mar 12 11:30:52 volumio sudo[16933]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:52 volumio volumio-remote-updater[596]: [2025-03-12 11:30:52] [connect] Successful connection Mar 12 11:30:52 volumio volumio[16748]: info: camilladsp spawned new process with pid 17066, instance 1, run: true Mar 12 11:30:52 volumio volumio[16748]: info: touch_display: systemctl daemon-reload succeeded. Mar 12 11:30:52 volumio volumio[16748]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 25 Mar 12 11:30:52 volumio volumio-remote-updater[596]: [2025-03-12 11:30:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741775452 101 Mar 12 11:30:52 volumio volumio[16748]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 26 Mar 12 11:30:52 volumio sudo[17082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Mar 12 11:30:52 volumio sudo[17082]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:52 volumio volumio[16748]: info: camilladsp spawned new process with pid 17089, instance 1, run: true Mar 12 11:30:52 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:52 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:53 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 12 11:30:53 volumio volumio[16748]: info: Listing playlists Mar 12 11:30:53 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 12 11:30:53 volumio volumio[16748]: info: camilladsp spawned new process with pid 17100, instance 1, run: true Mar 12 11:30:53 volumio volumio[16748]: info: camilladsp spawned new process with pid 17107, instance 1, run: true Mar 12 11:30:53 volumio volumio[16748]: info: camilladsp spawned new process with pid 17114, instance 1, run: true Mar 12 11:30:53 volumio volumio[16748]: info: camilladsp spawned new process with pid 17121, instance 1, run: true Mar 12 11:30:53 volumio volumio[16748]: info: camilladsp spawned new process with pid 17128, instance 1, run: true Mar 12 11:30:53 volumio mpd[16938]: Mar 12 11:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17138, instance 1, run: true Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17145, instance 1, run: true Mar 12 11:30:54 volumio systemd[1]: Started Music Player Daemon. Mar 12 11:30:54 volumio sudo[16930]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:54 volumio volumio[16748]: info: touch_display: systemctl disable getty@tty1.service succeeded. Mar 12 11:30:54 volumio sudo[16893]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:54 volumio sudo[16871]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:54 volumio systemd[1]: Reloading. Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17154, instance 1, run: true Mar 12 11:30:54 volumio volumio[16748]: error: MPD error: The expression evaluated to a falsy value: Mar 12 11:30:54 volumio volumio[16748]: assert.ok(self.idling) Mar 12 11:30:54 volumio volumio[16748]: error: The expression evaluated to a falsy value: Mar 12 11:30:54 volumio volumio[16748]: assert.ok(self.idling) Mar 12 11:30:54 volumio volumio[16748]: info: MPD running with PID16938 Mar 12 11:30:54 volumio volumio[16748]: ,establishing connection Mar 12 11:30:54 volumio volumio[16748]: error: MPD error: The expression evaluated to a falsy value: Mar 12 11:30:54 volumio volumio[16748]: assert.ok(self.idling) Mar 12 11:30:54 volumio volumio[16748]: error: The expression evaluated to a falsy value: Mar 12 11:30:54 volumio volumio[16748]: assert.ok(self.idling) Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17174, instance 1, run: true Mar 12 11:30:54 volumio volumio[16748]: error: updateQueue error: null Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17181, instance 1, run: true Mar 12 11:30:54 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17188, instance 1, run: true Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17195, instance 1, run: true Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17202, instance 1, run: true Mar 12 11:30:54 volumio volumio[16748]: info: camilladsp spawned new process with pid 17209, instance 1, run: true Mar 12 11:30:55 volumio kernel: brcmfmac: brcmf_sdio_bus_rxctl: resumed on timeout Mar 12 11:30:55 volumio kernel: brcmfmac: brcmf_sdiod_ramrw: membytes transfer failed Mar 12 11:30:55 volumio kernel: brcmfmac: brcmf_sdio_readshared: unable to obtain sdpcm_shared info: rv=-84 (addr=0x0) Mar 12 11:30:55 volumio kernel: ieee80211 phy0: _brcmf_set_multicast_list: Setting allmulti failed, -110 Mar 12 11:30:55 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17216, instance 1, run: true Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17223, instance 1, run: true Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17230, instance 1, run: true Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17237, instance 1, run: true Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17244, instance 1, run: true Mar 12 11:30:55 volumio sudo[16940]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio volumio[16748]: info: EVO SABRE : systemd cmd daemon-reload : success Mar 12 11:30:55 volumio sudo[17252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart evo_oled2.service Mar 12 11:30:55 volumio sudo[17252]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17253, instance 1, run: true Mar 12 11:30:55 volumio systemd[1]: Stopping Music Player Daemon... Mar 12 11:30:55 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 12 11:30:55 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:55 volumio sudo[17017]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio volumio[16748]: info: Upmpdcli Daemon Started Mar 12 11:30:55 volumio sudo[17082]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio sudo[17035]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17261, instance 1, run: true Mar 12 11:30:55 volumio sudo[16928]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 12 11:30:55 volumio volumio[16748]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Mar 12 11:30:55 volumio volumio[16748]: info: touch_display: Volumio Kiosk started. Mar 12 11:30:55 volumio systemd[1]: mpd.service: Succeeded. Mar 12 11:30:55 volumio systemd[1]: Stopped Music Player Daemon. Mar 12 11:30:55 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:55 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:55 volumio systemd[1]: Stopping OLED Display Service for EVO SABRE... Mar 12 11:30:55 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:30:55 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:30:55 volumio volumio[16748]: info: touch_display: systemctl stop getty@tty1.service succeeded. Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17272, instance 1, run: true Mar 12 11:30:55 volumio sudo[1557]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio systemd[1]: Starting Music Player Daemon... Mar 12 11:30:55 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 12 11:30:55 volumio sudo[16974]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio sudo[16976]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio volumio[16748]: info: Shairport-Sync Started Mar 12 11:30:55 volumio systemd[1]: evo_oled2.service: Succeeded. Mar 12 11:30:55 volumio sudo[17008]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio systemd[1]: Stopped OLED Display Service for EVO SABRE. Mar 12 11:30:55 volumio sudo[16971]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio volumio[16748]: Error adding Membership: Error: addMembership EINVAL Mar 12 11:30:55 volumio volumio[16748]: info: Shairport-Sync Started Mar 12 11:30:55 volumio volumio[16748]: info: Shairport-Sync Started Mar 12 11:30:55 volumio volumio[16748]: info: Shairport-Sync Started Mar 12 11:30:55 volumio systemd[1]: Started OLED Display Service for EVO SABRE. Mar 12 11:30:55 volumio volumio[16748]: info: camilladsp spawned new process with pid 17286, instance 1, run: true Mar 12 11:30:55 volumio sudo[17252]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:55 volumio sudo[17270]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 12 11:30:55 volumio sudo[17270]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:55 volumio sudo[17282]: root : TTY=unknown ; PWD=/data/plugins/system_hardware/audiophonics_evo_sabre/apps/evo_oled ; USER=root ; COMMAND=/usr/bin/node /data/plugins/system_hardware/audiophonics_evo_sabre/apps/evo_oled/index.js volumio Mar 12 11:30:55 volumio sudo[17282]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:55 volumio volumio[16748]: info: EVO SABRE : systemd cmd restart evo_oled2.service : success Mar 12 11:30:56 volumio sudo[17270]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:56 volumio volumio[16748]: info: touch_display: X display number found: 0 Mar 12 11:30:56 volumio sudo[17302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart evo_remote.service Mar 12 11:30:56 volumio sudo[17302]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:56 volumio volumio[16748]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 12 11:30:56 volumio volumio[16748]: info: touch_display: X display number found: 0 Mar 12 11:30:56 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:56 volumio lircd[1656]: lircd-0.10.1[1656]: Notice: caught signal Mar 12 11:30:56 volumio lircd-0.10.1[1656]: Notice: caught signal Mar 12 11:30:56 volumio volumio[16748]: info: camilladsp spawned new process with pid 17306, instance 1, run: true Mar 12 11:30:56 volumio systemd[1]: Stopping evo_remote.service... Mar 12 11:30:56 volumio systemd[1]: evo_remote.service: Main process exited, code=killed, status=15/TERM Mar 12 11:30:56 volumio systemd[1]: evo_remote.service: Succeeded. Mar 12 11:30:56 volumio systemd[1]: Stopped evo_remote.service. Mar 12 11:30:56 volumio systemd[1]: evo_irexec.service: Succeeded. Mar 12 11:30:56 volumio volumio[16748]: info: touch_display: X display number found: 0 Mar 12 11:30:56 volumio systemd[1]: Starting lircd(8) initialization helper tool... Mar 12 11:30:56 volumio volumio[16748]: info: camilladsp spawned new process with pid 17321, instance 1, run: true Mar 12 11:30:56 volumio volumio[16748]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 12 11:30:56 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:56 volumio volumio[16748]: info: camilladsp spawned new process with pid 17328, instance 1, run: true Mar 12 11:30:56 volumio volumio[16748]: info: camilladsp spawned new process with pid 17335, instance 1, run: true Mar 12 11:30:56 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:56 volumio volumio[16748]: info: camilladsp spawned new process with pid 17342, instance 1, run: true Mar 12 11:30:56 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:56 volumio volumio[16748]: info: camilladsp spawned new process with pid 17349, instance 1, run: true Mar 12 11:30:56 volumio lircd-setup[17315]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Mar 12 11:30:56 volumio lircd-setup[17315]: parser = configparser.SafeConfigParser() Mar 12 11:30:57 volumio systemd[1]: lircd-setup.service: Succeeded. Mar 12 11:30:57 volumio systemd[1]: Started lircd(8) initialization helper tool. Mar 12 11:30:57 volumio volumio[16748]: info: camilladsp spawned new process with pid 17356, instance 1, run: true Mar 12 11:30:57 volumio systemd[1]: Started evo_remote.service. Mar 12 11:30:57 volumio sudo[17302]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Info: lircd: Opening log, level: Info Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Version: lircd 0.10.1 Mar 12 11:30:57 volumio volumio[16748]: info: EVO SABRE : systemd cmd restart evo_remote.service : success Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: System info: Linux volumio 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l GNU/Linux Mar 12 11:30:57 volumio volumio[16748]: info: camilladsp spawned new process with pid 17368, instance 1, run: true Mar 12 11:30:57 volumio sudo[17367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart evo_irexec.service Mar 12 11:30:57 volumio sudo[17367]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Info: Initial device: /dev/lirc0 Mar 12 11:30:57 volumio lircd[17357]: lircd-0.10.1[17357]: Info: lircd: Opening log, level: Info Mar 12 11:30:57 volumio lircd[17357]: lircd-0.10.1[17357]: Warning: Running as root Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Info: [lirc] protocol is enabled Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Info: Initial device: /dev/lirc0 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Info: [lirc] protocol is enabled Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: driver: default Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: output: /var/run/lirc/lircd Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: nodaemon: 1 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: logfile: syslog Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: immediate-init: 0 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: permission: 666 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: driver-options: Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: listen: 0 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: connect: (null) Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: userelease: 0 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: effective_user: (null) Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: release_suffix: _EVUP Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: allow_simulate: 0 Mar 12 11:30:57 volumio lircd[17357]: lircd-0.10.1[17357]: Info: Using remote: ApEvo. Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: repeat_max: 600 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: configfile: /data/plugins/system_hardware/audiophonics_evo_sabre/apps/lirc/lircd.conf Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Options: dynamic_codes: (null) Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Current driver: default Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Driver API version: 3 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Driver version: 0.10.0 Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Info: lircd: Opening log, level: Info Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Warning: Running as root Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Info: Using remote: ApEvo. Mar 12 11:30:57 volumio lircd[17357]: lircd-0.10.1[17357]: Notice: lircd(default) ready, using /var/run/lirc/lircd Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: lircd(default) ready, using /var/run/lirc/lircd Mar 12 11:30:57 volumio volumio[16748]: info: camilladsp spawned new process with pid 17377, instance 1, run: true Mar 12 11:30:57 volumio systemd[1]: Starting lircd(8) initialization helper tool... Mar 12 11:30:57 volumio volumio[16748]: info: camilladsp spawned new process with pid 17384, instance 1, run: true Mar 12 11:30:57 volumio kernel: brcmfmac: brcmf_sdio_bus_rxctl: resumed on timeout Mar 12 11:30:57 volumio kernel: brcmfmac: brcmf_sdiod_ramrw: membytes transfer failed Mar 12 11:30:57 volumio kernel: brcmfmac: brcmf_sdio_readshared: unable to obtain sdpcm_shared info: rv=-84 (addr=0x0) Mar 12 11:30:57 volumio kernel: ieee80211 phy0: _brcmf_set_multicast_list: Setting BRCMF_C_SET_PROMISC failed, err=-110 Mar 12 11:30:57 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:57 volumio volumio[16748]: info: camilladsp spawned new process with pid 17392, instance 1, run: true Mar 12 11:30:57 volumio lircd-setup[17376]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Mar 12 11:30:57 volumio lircd-setup[17376]: parser = configparser.SafeConfigParser() Mar 12 11:30:57 volumio systemd[1]: lircd-setup.service: Succeeded. Mar 12 11:30:57 volumio systemd[1]: Started lircd(8) initialization helper tool. Mar 12 11:30:57 volumio volumio[16748]: info: camilladsp spawned new process with pid 17402, instance 1, run: true Mar 12 11:30:57 volumio systemd[1]: Started evo_irexec.service. Mar 12 11:30:57 volumio lircd[17357]: lircd-0.10.1[17357]: Notice: accepted new client on /var/run/lirc/lircd Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Notice: accepted new client on /var/run/lirc/lircd Mar 12 11:30:57 volumio lircd[17357]: lircd-0.10.1[17357]: Info: [lirc] protocol is enabled Mar 12 11:30:57 volumio lircd-0.10.1[17357]: Info: [lirc] protocol is enabled Mar 12 11:30:57 volumio sudo[17367]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:57 volumio volumio[16748]: info: EVO SABRE : systemd cmd restart evo_irexec.service : success Mar 12 11:30:57 volumio volumio[16748]: info: Completed starting Core Plugins Mar 12 11:30:57 volumio volumio[16748]: info: ------------------------------------------- Mar 12 11:30:57 volumio volumio[16748]: info: ----- MyVolumio plugins startup ---- Mar 12 11:30:57 volumio volumio[16748]: info: ------------------------------------------- Mar 12 11:30:57 volumio volumio[16748]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 12 11:30:57 volumio volumio[16748]: info: camilladsp spawned new process with pid 17411, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17418, instance 1, run: true Mar 12 11:30:58 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17425, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17432, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17439, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17446, instance 1, run: true Mar 12 11:30:58 volumio mpd[17295]: Mar 12 11:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 12 11:30:58 volumio systemd[1]: Started Music Player Daemon. Mar 12 11:30:58 volumio sudo[16983]: pam_unix(sudo:session): session closed for user root Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17455, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: error: updateQueue error: null Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17462, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17469, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17476, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17483, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17490, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17497, instance 1, run: true Mar 12 11:30:58 volumio volumio[16748]: info: camilladsp spawned new process with pid 17504, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17511, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17518, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17525, instance 1, run: true Mar 12 11:30:59 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17532, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: Cannot compose Albumart path Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17539, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17546, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17553, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17560, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17567, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17574, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17581, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17588, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17595, instance 1, run: true Mar 12 11:30:59 volumio volumio[16748]: info: camilladsp spawned new process with pid 17602, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17609, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17616, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17623, instance 1, run: true Mar 12 11:31:00 volumio kernel: brcmfmac: brcmf_sdio_bus_rxctl: resumed on timeout Mar 12 11:31:00 volumio kernel: brcmfmac: brcmf_sdiod_ramrw: membytes transfer failed Mar 12 11:31:00 volumio kernel: brcmfmac: brcmf_sdio_readshared: unable to obtain sdpcm_shared info: rv=-84 (addr=0x0) Mar 12 11:31:00 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:31:00 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17630, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17637, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17644, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17651, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17658, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17665, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17672, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17679, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:00 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17686, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:00 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:00 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:00 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:00 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17693, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17700, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17707, instance 1, run: true Mar 12 11:31:00 volumio volumio[16748]: info: camilladsp spawned new process with pid 17714, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17721, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17728, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17735, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17742, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17753, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17769, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17777, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17784, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17791, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17798, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17805, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17812, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17819, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17826, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17833, instance 1, run: true Mar 12 11:31:01 volumio volumio[16748]: info: camilladsp spawned new process with pid 17840, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17847, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17854, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17861, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17868, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17875, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17882, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17889, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17896, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17903, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17910, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17917, instance 1, run: true Mar 12 11:31:02 volumio kernel: brcmfmac: brcmf_sdio_bus_rxctl: resumed on timeout Mar 12 11:31:02 volumio kernel: brcmfmac: brcmf_sdiod_ramrw: membytes transfer failed Mar 12 11:31:02 volumio kernel: brcmfmac: brcmf_sdio_readshared: unable to obtain sdpcm_shared info: rv=-84 (addr=0x0) Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17924, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17931, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17938, instance 1, run: true Mar 12 11:31:02 volumio volumio[16748]: info: camilladsp spawned new process with pid 17945, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 17952, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 17959, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 17966, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 17973, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 17980, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 17987, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 17994, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18001, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18008, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18015, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18022, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18029, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18036, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18043, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18050, instance 1, run: true Mar 12 11:31:03 volumio volumio[16748]: info: camilladsp spawned new process with pid 18057, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18064, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18071, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18078, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18085, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18092, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18099, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18106, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18113, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18120, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18127, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18134, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18141, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18148, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18155, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18162, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18169, instance 1, run: true Mar 12 11:31:04 volumio volumio[16748]: info: camilladsp spawned new process with pid 18176, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18183, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18190, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18197, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18204, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18211, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18218, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18225, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18232, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18239, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18246, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18253, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18260, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18267, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18274, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18281, instance 1, run: true Mar 12 11:31:05 volumio volumio[16748]: info: camilladsp spawned new process with pid 18288, instance 1, run: true Mar 12 11:31:06 volumio volumio[16748]: info: camilladsp spawned new process with pid 18295, instance 1, run: true Mar 12 11:31:06 volumio volumio[16748]: info: camilladsp spawned new process with pid 18302, instance 1, run: true Mar 12 11:31:06 volumio volumio[16748]: info: camilladsp spawned new process with pid 18309, instance 1, run: true Mar 12 11:31:06 volumio volumio[16748]: info: camilladsp spawned new process with pid 18316, instance 1, run: true Mar 12 11:31:06 volumio volumio[16748]: info: camilladsp spawned new process with pid 18323, instance 1, run: true Mar 12 11:31:06 volumio volumio[16748]: info: camilladsp spawned new process with pid 18330, instance 1, run: true Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 12 11:31:06 volumio volumio[16748]: info: Adding plugin bluetooth to MyMusic Plugins Mar 12 11:31:06 volumio volumio[16748]: info: Adding plugin multiroom to MyMusic Plugins Mar 12 11:31:06 volumio volumio[16748]: info: Adding plugin metavolumio to MyMusic Plugins Mar 12 11:31:06 volumio volumio[16748]: info: Adding plugin cd_controller to MyMusic Plugins Mar 12 11:31:06 volumio volumio[16748]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 12 11:31:06 volumio volumio[16748]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 12 11:31:06 volumio volumio[16748]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 12 11:31:07 volumio volumio[16748]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 12 11:31:07 volumio volumio[16748]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 12 11:31:07 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:07 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:07 volumio volumio[16748]: info: Starting MyVolumio Remote Streaming Endpoints Mar 12 11:31:07 volumio volumio[16748]: info: MyVolumio login type: Token Mar 12 11:31:07 volumio volumio[16748]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 12 11:31:07 volumio volumio[16748]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 12 11:31:09 volumio volumio[16748]: info: Starting Streaming Service Transparent Proxy Mar 12 11:31:09 volumio volumio[16748]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 12 11:31:09 volumio volumio[16748]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 12 11:31:09 volumio volumio[16748]: info: Streaming services startup Mar 12 11:31:09 volumio volumio[16748]: info: Starting Streaming Daemon Mar 12 11:31:09 volumio sudo[18385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 12 11:31:09 volumio sudo[18385]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:31:09 volumio volumio[16748]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 12 11:31:09 volumio sudo[18385]: pam_unix(sudo:session): session closed for user root Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 12 11:31:09 volumio volumio[16748]: error: Cannot start Volumio Streaming Daemon Mar 12 11:31:09 volumio volumio[16748]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 12 11:31:09 volumio volumio[16748]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 12 11:31:09 volumio volumio[16748]: info: camilladsp spawned new process with pid 18392, instance 1, run: true Mar 12 11:31:09 volumio volumio[16748]: info: camilladsp spawned new process with pid 18413, instance 1, run: true Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Mar 12 11:31:09 volumio volumio[16748]: info: camilladsp spawned new process with pid 18420, instance 1, run: true Mar 12 11:31:09 volumio volumio[16748]: info: AutoStart - Plugin is starting Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:09 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:09 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:09 volumio volumio[16748]: info: AutoStart - start playing Mar 12 11:31:09 volumio volumio[16748]: info: AutoStart - start playing with no specific position Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::volumioPlay Mar 12 11:31:09 volumio volumio[16748]: info: CoreStateMachine::play index 0 Mar 12 11:31:09 volumio volumio[16748]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 12 11:31:09 volumio volumio[16748]: info: CoreStateMachine::stop Mar 12 11:31:09 volumio volumio[16748]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 12 11:31:09 volumio volumio[16748]: info: CoreStateMachine::play index undefined Mar 12 11:31:09 volumio volumio[16748]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 12 11:31:09 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:09 volumio volumio[16748]: info: CoreStateMachine::startPlaybackTimer Mar 12 11:31:09 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:09 volumio volumio[16748]: info: [1741775469724] ControllerWebradio::clearAddPlayTrack Mar 12 11:31:09 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand stop Mar 12 11:31:09 volumio volumio[16748]: info: sendMpdCommand stop took 4 milliseconds Mar 12 11:31:09 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand clear Mar 12 11:31:09 volumio volumio[16748]: info: camilladsp spawned new process with pid 18427, instance 1, run: true Mar 12 11:31:09 volumio volumio[16748]: info: Mar 12 11:31:09 volumio volumio[16748]: ---------------------------- MPD announces system playlist update Mar 12 11:31:09 volumio volumio[16748]: info: Ignoring MPD Status Update Mar 12 11:31:09 volumio volumio[16748]: info: sendMpdCommand clear took 25 milliseconds Mar 12 11:31:09 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand load "http://www.rmfon.pl/tunein/tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0" Mar 12 11:31:09 volumio volumio[16748]: info: Received Get System Version Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 12 11:31:09 volumio volumio[16748]: error: updateQueue error: null Mar 12 11:31:09 volumio volumio[16748]: info: ------------------------------ 13ms Mar 12 11:31:09 volumio volumio[16748]: info: camilladsp spawned new process with pid 18435, instance 1, run: true Mar 12 11:31:09 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Mar 12 11:31:09 volumio volumio[16748]: info: camilladsp spawned new process with pid 18442, instance 1, run: true Mar 12 11:31:09 volumio volumio[16748]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 12 11:31:09 volumio volumio[16748]: info: camilladsp spawned new process with pid 18449, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18456, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18463, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18471, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18478, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: STREAMING PROXY: Starting server on port 3245 Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18485, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: Node JS runtime: 14 Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18494, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: info: MyVolumio token set successfully Mar 12 11:31:10 volumio volumio[16748]: info: MYVOLUMIO: Adding device Mar 12 11:31:10 volumio volumio[16748]: info: MYVOLUMIO: Evaluating Server Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18501, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18508, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: info: camilladsp spawned new process with pid 18515, instance 1, run: true Mar 12 11:31:10 volumio volumio[16748]: info: MyVolumio status changed Mar 12 11:31:10 volumio volumio[16748]: info: Streaming services startup Mar 12 11:31:10 volumio volumio[16748]: info: Starting Streaming Daemon Mar 12 11:31:11 volumio volumio[16748]: info: Removing browser output: myVolumio user plan is not superstar Mar 12 11:31:11 volumio volumio[16748]: info: Removing audio output: Mar 12 11:31:11 volumio volumio[16748]: info: Stoppping Tunnel 1 Mar 12 11:31:11 volumio sudo[18538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 12 11:31:11 volumio sudo[18538]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:31:11 volumio sudo[18541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 12 11:31:11 volumio sudo[18541]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 11:31:11 volumio sudo[18538]: pam_unix(sudo:session): session closed for user root Mar 12 11:31:11 volumio sudo[18541]: pam_unix(sudo:session): session closed for user root Mar 12 11:31:11 volumio volumio[16748]: error: Cannot start Volumio Streaming Daemon Mar 12 11:31:11 volumio volumio[16748]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 12 11:31:11 volumio volumio[16748]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18543, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: Remote SSH Stopped Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18550, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18557, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18564, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: Setting Geolocation for MyVolumio to eu7 Mar 12 11:31:11 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:11 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:11 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18584, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18592, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18599, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18606, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18613, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18620, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18627, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18635, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18642, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18649, instance 1, run: true Mar 12 11:31:11 volumio volumio[16748]: info: camilladsp spawned new process with pid 18656, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18663, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18670, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18677, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18684, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18691, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18698, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: Updating MyVolumio device info Mar 12 11:31:12 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:12 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:12 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18705, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18712, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18719, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18727, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18734, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18741, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18748, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18755, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18762, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18769, instance 1, run: true Mar 12 11:31:12 volumio volumio[16748]: info: camilladsp spawned new process with pid 18776, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18783, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18790, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18797, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18804, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18811, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18818, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18825, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18832, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18839, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18846, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18853, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18860, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18867, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18874, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18881, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18888, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18895, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18902, instance 1, run: true Mar 12 11:31:13 volumio volumio[16748]: info: camilladsp spawned new process with pid 18909, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18918, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18925, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18932, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18939, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18946, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18953, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18960, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18967, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18974, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18981, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand add "http://www.rmfon.pl/tunein/tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0" Mar 12 11:31:14 volumio volumio[16748]: info: Mar 12 11:31:14 volumio volumio[16748]: ---------------------------- MPD announces system playlist update Mar 12 11:31:14 volumio volumio[16748]: info: Ignoring MPD Status Update Mar 12 11:31:14 volumio volumio[16748]: info: sendMpdCommand add "http://www.rmfon.pl/tunein/tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0" took 14 milliseconds Mar 12 11:31:14 volumio volumio[16748]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 12 11:31:14 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand play Mar 12 11:31:14 volumio volumio[16748]: info: ------------------------------ 6ms Mar 12 11:31:14 volumio volumio[16748]: info: sendMpdCommand play took 4 milliseconds Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18991, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 18998, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 19005, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 19012, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 19019, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 19026, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 19033, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 19040, instance 1, run: true Mar 12 11:31:14 volumio volumio[16748]: info: camilladsp spawned new process with pid 19047, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19054, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19061, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19068, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19075, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19082, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19089, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19096, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: Mar 12 11:31:15 volumio volumio[16748]: ---------------------------- MPD announces state update: player Mar 12 11:31:15 volumio volumio[16748]: info: ControllerMpd::getState Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand status Mar 12 11:31:15 volumio volumio[16748]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 12 11:31:15 volumio volumio[16748]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp stopping service pid 19096... Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp service terminated, instance 1 Mar 12 11:31:15 volumio volumio[16748]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 12 11:31:15 volumio volumio[16748]: info: FusionDsp - Nulleq applied Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp service started and running in background, instance 1 Mar 12 11:31:15 volumio volumio[16748]: info: Mar 12 11:31:15 volumio volumio[16748]: ---------------------------- MPD announces state update: player Mar 12 11:31:15 volumio volumio[16748]: info: sendMpdCommand status took 66 milliseconds Mar 12 11:31:15 volumio volumio[16748]: info: ControllerMpd::getState Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand status Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::parseState Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 12 11:31:15 volumio volumio[16748]: info: Mar 12 11:31:15 volumio volumio[16748]: ---------------------------- MPD announces system playlist update Mar 12 11:31:15 volumio volumio[16748]: info: Ignoring MPD Status Update Mar 12 11:31:15 volumio volumio[16748]: info: Mar 12 11:31:15 volumio volumio[16748]: ---------------------------- MPD announces state update: player Mar 12 11:31:15 volumio volumio[16748]: info: ControllerMpd::getState Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand status Mar 12 11:31:15 volumio volumio[16748]: info: sendMpdCommand status took 8 milliseconds Mar 12 11:31:15 volumio volumio[16748]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::parseState Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::parseTrackInfo Mar 12 11:31:15 volumio volumio[16748]: info: ControllerMpd::pushState Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::servicePushState Mar 12 11:31:15 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:15 volumio volumio[16748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0","artist":"RMF CHILLOUT","album":null,"uri":"http://www.rmfon.pl/tunein/tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0","trackType":""} Mar 12 11:31:15 volumio volumio[16748]: verbose: CURRENT POSITION 0 Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::syncState stateService play Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::syncState currentStatus stop Mar 12 11:31:15 volumio volumio[16748]: info: ------------------------------ 88ms Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19107, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: ------------------------------ 33ms Mar 12 11:31:15 volumio volumio[16748]: info: sendMpdCommand status took 32 milliseconds Mar 12 11:31:15 volumio volumio[16748]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::parseState Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::parseTrackInfo Mar 12 11:31:15 volumio volumio[16748]: info: ControllerMpd::pushState Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::servicePushState Mar 12 11:31:15 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:15 volumio volumio[16748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0","artist":"RMF CHILLOUT","album":null,"uri":"http://www.rmfon.pl/tunein/tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0","trackType":""} Mar 12 11:31:15 volumio volumio[16748]: verbose: CURRENT POSITION 0 Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::syncState stateService play Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::syncState currentStatus play Mar 12 11:31:15 volumio volumio[16748]: info: Received an update from plugin. extracting info from payload Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::pushState Mar 12 11:31:15 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::volumioPushState Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::pushState Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::volumioPushState Mar 12 11:31:15 volumio volumio[16748]: info: ------------------------------ 113ms Mar 12 11:31:15 volumio volumio[16748]: info: sendMpdCommand playlistinfo took 71 milliseconds Mar 12 11:31:15 volumio volumio[16748]: verbose: ControllerMpd::parseTrackInfo Mar 12 11:31:15 volumio volumio[16748]: info: ControllerMpd::pushState Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::servicePushState Mar 12 11:31:15 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:15 volumio volumio[16748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0","artist":"RMF CHILLOUT","album":null,"uri":"http://www.rmfon.pl/tunein/tunein.php?host=rs202-krk-cyfronet.rmfstream.pl&mount=rmf_chillout&secure=0","trackType":""} Mar 12 11:31:15 volumio volumio[16748]: verbose: CURRENT POSITION 0 Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::syncState stateService play Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::syncState currentStatus play Mar 12 11:31:15 volumio volumio[16748]: info: Received an update from plugin. extracting info from payload Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::pushState Mar 12 11:31:15 volumio volumio[16748]: info: CorePlayQueue::getTrack 0 Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::volumioPushState Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::pushState Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::volumioPushState Mar 12 11:31:15 volumio volumio[16748]: info: ------------------------------ 223ms Mar 12 11:31:15 volumio volumio[16748]: info: [ASDebug] CurState: play PrevState: stop Mar 12 11:31:15 volumio volumio[16748]: info: [ASDebug] Togle GPIO: ON Mar 12 11:31:15 volumio volumio[16748]: info: [ASDebug] CurState: play PrevState: play Mar 12 11:31:15 volumio volumio[16748]: info: [ASDebug] CurState: play PrevState: play Mar 12 11:31:15 volumio volumio[16748]: info: [ASDebug] CurState: play PrevState: play Mar 12 11:31:15 volumio volumio[16748]: info: [GPIO_Control] Status changed: play Mar 12 11:31:15 volumio volumio[16748]: info: [GPIO_Control] Handling event: musicPlay Mar 12 11:31:15 volumio volumio[16748]: info: [GPIO_Control] Status changed: play Mar 12 11:31:15 volumio volumio[16748]: info: [GPIO_Control] Status changed: play Mar 12 11:31:15 volumio volumio[16748]: info: [GPIO_Control] Status changed: play Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19114, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:15 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:15 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:15 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19121, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19128, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19135, instance 1, run: true Mar 12 11:31:15 volumio volumio[16748]: info: camilladsp spawned new process with pid 19142, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19149, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19156, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19163, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: MYVOLUMIO: Adding device Mar 12 11:31:16 volumio volumio[16748]: info: MYVOLUMIO: Evaluating Server Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19170, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19177, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:16 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:16 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:16 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19199, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19206, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19213, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19220, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: camilladsp spawned new process with pid 19227, instance 1, run: true Mar 12 11:31:16 volumio volumio[16748]: info: Setting Geolocation for MyVolumio to eu7 Mar 12 11:31:16 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:16 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:16 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19234, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19241, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19248, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19255, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19262, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19269, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19276, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19283, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19290, instance 1, run: true Mar 12 11:31:17 volumio kernel: brcmfmac: brcmf_sdio_txfail: sdio error, abort command and terminate frame Mar 12 11:31:17 volumio kernel: brcmfmac: brcmf_sdio_isr: failed backplane access Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19298, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:17 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:17 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:17 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19305, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19312, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19319, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19326, instance 1, run: true Mar 12 11:31:17 volumio volumio[16748]: info: camilladsp spawned new process with pid 19333, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19340, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: Updating MyVolumio device info Mar 12 11:31:18 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:18 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:18 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19347, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19354, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19361, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19368, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19375, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19382, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19389, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19396, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19403, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19410, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:18 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:18 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:18 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19417, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19424, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19431, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19438, instance 1, run: true Mar 12 11:31:18 volumio volumio[16748]: info: camilladsp spawned new process with pid 19445, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19452, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19459, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19466, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19473, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19480, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19487, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19494, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19501, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19508, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19515, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19522, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:19 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:19 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:19 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19529, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 12 11:31:19 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 11:31:19 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19538, instance 1, run: true Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19545, instance 1, run: true Mar 12 11:31:19 volumio volumio-remote-updater[596]: No test mode Mar 12 11:31:19 volumio volumio-remote-updater[596]: No alpha test mode Mar 12 11:31:19 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 12 11:31:19 volumio volumio[16748]: info: camilladsp spawned new process with pid 19553, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19560, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 12 11:31:20 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19567, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19574, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19581, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19588, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19595, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19602, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19609, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19616, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19623, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19630, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:20 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:20 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:20 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19637, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19644, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19651, instance 1, run: true Mar 12 11:31:20 volumio volumio[16748]: info: camilladsp spawned new process with pid 19658, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19665, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19672, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19679, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19686, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19693, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19700, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19707, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19727, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19735, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19742, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19749, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:21 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:21 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:21 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19756, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19763, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19770, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19777, instance 1, run: true Mar 12 11:31:21 volumio volumio[16748]: info: camilladsp spawned new process with pid 19784, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19791, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19798, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19805, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19812, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19819, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19826, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19833, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19840, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19847, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19854, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19861, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:22 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:22 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:22 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:22 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19868, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Mar 12 11:31:22 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19875, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19882, instance 1, run: true Mar 12 11:31:22 volumio volumio[16748]: info: camilladsp spawned new process with pid 19889, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19896, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19903, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19910, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19917, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19924, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19931, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19938, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19945, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19952, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19959, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19966, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19973, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:23 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:23 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:23 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19980, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19987, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 19994, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 20001, instance 1, run: true Mar 12 11:31:23 volumio volumio[16748]: info: camilladsp spawned new process with pid 20008, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20015, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20022, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20029, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20036, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20043, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20050, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20057, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20064, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20071, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20078, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20085, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:24 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:24 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:24 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20092, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20099, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20106, instance 1, run: true Mar 12 11:31:24 volumio volumio[16748]: info: camilladsp spawned new process with pid 20113, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20120, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20127, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20134, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20141, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20148, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20155, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20162, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20169, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20176, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20183, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20190, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20197, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:25 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:25 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:25 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20204, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20211, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20218, instance 1, run: true Mar 12 11:31:25 volumio volumio[16748]: info: camilladsp spawned new process with pid 20225, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20232, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20239, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20246, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20253, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20260, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20267, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20274, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20281, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20288, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20295, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20302, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20309, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: CoreCommandRouter::volumioGetState Mar 12 11:31:26 volumio volumio[16748]: info: CoreCommandRouter::volumioGetQueue Mar 12 11:31:26 volumio volumio[16748]: info: CoreStateMachine::getQueue Mar 12 11:31:26 volumio volumio[16748]: info: CorePlayQueue::getQueue Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20316, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: Command Delete User Data Received Mar 12 11:31:26 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: inputs , setMCUFactoryReset Mar 12 11:31:26 volumio volumio[16748]: info: Error : CoreCommandRouter::executeOnPlugin: No method [setMCUFactoryReset] in plugin inputs Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20323, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20330, instance 1, run: true Mar 12 11:31:26 volumio volumio[16748]: info: camilladsp spawned new process with pid 20337, instance 1, run: true Mar 12 11:31:27 volumio volumio[16748]: info: camilladsp spawned new process with pid 20344, instance 1, run: true Mar 12 11:31:27 volumio volumio[16748]: info: camilladsp spawned new process with pid 20351, instance 1, run: true Mar 12 11:31:27 volumio volumio[16748]: info: camilladsp spawned new process with pid 20358, instance 1, run: true Mar 12 11:31:27 volumio volumio[16748]: info: camilladsp spawned new process with pid 20365, instance 1, run: true Mar 12 11:31:27 volumio volumio[16748]: info: camilladsp spawned new process with pid 20372, instance 1, run: true Mar 12 11:31:27 volumio volumio[16748]: info: camilladsp spawned new process with pid 20379, instance 1, run: true Mar 12 11:31:27 volumio volumio[16748]: info: CoreCommandRouter::executeOnPlugin: system , deleteUserData Mar 12 11:31:27 volumio volumio[16748]: info: Created User Data delete file, rebooting Mar 12 11:31:27 volumio volumio[16748]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Mar 12 11:31:27 volumio volumio[16748]: info: PLUGIN onReboot : networkfs Mar 12 11:31:27 volumio volumio[16748]: info: PLUGIN onReboot : audiophonicsonoff Mar 12 11:31:27 volumio volumio[16748]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 12 11:31:27 volumio volumio[16748]: TypeError: Cannot read property 'writeSync' of undefined Mar 12 11:31:27 volumio volumio[16748]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_hardware/audiophonicsonoff/index.js:40:25) Mar 12 11:31:27 volumio volumio[16748]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Mar 12 11:31:27 volumio volumio[16748]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Mar 12 11:31:27 volumio volumio[16748]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Mar 12 11:31:27 volumio volumio[16748]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Mar 12 11:31:27 volumio volumio[16748]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Mar 12 11:31:27 volumio volumio[16748]: at CoreCommandRouter.reboot (/volumio/app/index.js:1350:22) Mar 12 11:31:27 volumio volumio[16748]: at /volumio/app/plugins/system_controller/system/index.js:719:26 Mar 12 11:31:27 volumio volumio[16748]: at /volumio/node_modules/graceful-fs/graceful-fs.js:144:16 Mar 12 11:31:27 volumio volumio[16748]: at /data/plugins/system_hardware/gpio-buttons/node_modules/graceful-fs/graceful-fs.js:43:10 Mar 12 11:31:27 volumio volumio[16748]: at /data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:43:10 Mar 12 11:31:27 volumio volumio[16748]: at /volumio/node_modules/graceful-fs/graceful-fs.js:61:14 Mar 12 11:31:27 volumio volumio[16748]: at FSReqCallback.oncomplete (fs.js:171:23) Mar 12 11:31:27 volumio volumio[16748]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 12 11:31:28 volumio sudo[20395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-12 11:30 Mar 12 11:31:28 volumio sudo[20395]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"