-- Logs begin at Thu 2019-02-14 05:11:58 EST, end at Thu 2024-11-28 14:57:17 EST. -- Nov 28 14:56:00 volumio volumio[3276]: 0+0 records in Nov 28 14:56:00 volumio volumio[3276]: 0+0 records out Nov 28 14:56:00 volumio volumio[3276]: 0 bytes copied, 5.1815e-05 s, 0.0 kB/s Nov 28 14:56:00 volumio volumio[3276]: info: camilladsp spawned new process with pid 21179, instance 2, run: true Nov 28 14:56:01 volumio volumio[3276]: 0+0 records in Nov 28 14:56:01 volumio volumio[3276]: 0+0 records out Nov 28 14:56:01 volumio volumio[3276]: 0 bytes copied, 5.113e-05 s, 0.0 kB/s Nov 28 14:56:01 volumio volumio[3276]: info: camilladsp spawned new process with pid 21184, instance 2, run: true Nov 28 14:56:02 volumio volumio[3276]: 0+0 records in Nov 28 14:56:02 volumio volumio[3276]: 0+0 records out Nov 28 14:56:02 volumio volumio[3276]: 0 bytes copied, 5.3055e-05 s, 0.0 kB/s Nov 28 14:56:02 volumio volumio[3276]: info: camilladsp spawned new process with pid 21189, instance 2, run: true Nov 28 14:56:03 volumio volumio[3276]: 0+0 records in Nov 28 14:56:03 volumio volumio[3276]: 0+0 records out Nov 28 14:56:03 volumio volumio[3276]: 0 bytes copied, 5.1518e-05 s, 0.0 kB/s Nov 28 14:56:03 volumio volumio[3276]: info: camilladsp spawned new process with pid 21195, instance 2, run: true Nov 28 14:56:04 volumio volumio[3276]: 0+0 records in Nov 28 14:56:04 volumio volumio[3276]: 0+0 records out Nov 28 14:56:04 volumio volumio[3276]: 0 bytes copied, 5.2185e-05 s, 0.0 kB/s Nov 28 14:56:04 volumio volumio[3276]: info: camilladsp spawned new process with pid 21200, instance 2, run: true Nov 28 14:56:05 volumio volumio[3276]: 0+0 records in Nov 28 14:56:05 volumio volumio[3276]: 0+0 records out Nov 28 14:56:05 volumio volumio[3276]: 0 bytes copied, 5.0351e-05 s, 0.0 kB/s Nov 28 14:56:05 volumio volumio[3276]: info: camilladsp spawned new process with pid 21205, instance 2, run: true Nov 28 14:56:06 volumio volumio[3276]: 0+0 records in Nov 28 14:56:06 volumio volumio[3276]: 0+0 records out Nov 28 14:56:06 volumio volumio[3276]: 0 bytes copied, 5.1389e-05 s, 0.0 kB/s Nov 28 14:56:06 volumio volumio[3276]: info: camilladsp spawned new process with pid 21224, instance 2, run: true Nov 28 14:56:07 volumio volumio[3276]: 0+0 records in Nov 28 14:56:07 volumio volumio[3276]: 0+0 records out Nov 28 14:56:07 volumio volumio[3276]: 0 bytes copied, 5.5425e-05 s, 0.0 kB/s Nov 28 14:56:07 volumio volumio[3276]: info: camilladsp spawned new process with pid 21232, instance 2, run: true Nov 28 14:56:09 volumio volumio[3276]: 0+0 records in Nov 28 14:56:09 volumio volumio[3276]: 0+0 records out Nov 28 14:56:09 volumio volumio[3276]: 0 bytes copied, 5.0555e-05 s, 0.0 kB/s Nov 28 14:56:09 volumio volumio[3276]: info: camilladsp spawned new process with pid 21237, instance 2, run: true Nov 28 14:56:10 volumio volumio[3276]: 0+0 records in Nov 28 14:56:10 volumio volumio[3276]: 0+0 records out Nov 28 14:56:10 volumio volumio[3276]: 0 bytes copied, 5.1203e-05 s, 0.0 kB/s Nov 28 14:56:10 volumio volumio[3276]: info: camilladsp spawned new process with pid 21242, instance 2, run: true Nov 28 14:56:10 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:10 volumio volumio[3276]: info: CorePlayQueue::getTrack 0 Nov 28 14:56:10 volumio volumio[3276]: info: [1732823770769] ControllerPandora::ExpireOldTracks::reaper Nov 28 14:56:10 volumio volumio[3276]: info: [1732823770769] [Pandora] ExpireOldTracks::reaper: No victims found: Expiring zero tracks. Don't worry -- Jason will return. Nov 28 14:56:11 volumio volumio[3276]: 0+0 records in Nov 28 14:56:11 volumio volumio[3276]: 0+0 records out Nov 28 14:56:11 volumio volumio[3276]: 0 bytes copied, 5.0704e-05 s, 0.0 kB/s Nov 28 14:56:11 volumio volumio[3276]: info: camilladsp spawned new process with pid 21247, instance 2, run: true Nov 28 14:56:12 volumio volumio[3276]: 0+0 records in Nov 28 14:56:12 volumio volumio[3276]: 0+0 records out Nov 28 14:56:12 volumio volumio[3276]: 0 bytes copied, 5.0685e-05 s, 0.0 kB/s Nov 28 14:56:12 volumio volumio[3276]: info: camilladsp spawned new process with pid 21252, instance 2, run: true Nov 28 14:56:13 volumio volumio[3276]: 0+0 records in Nov 28 14:56:13 volumio volumio[3276]: 0+0 records out Nov 28 14:56:13 volumio volumio[3276]: 0 bytes copied, 5.6593e-05 s, 0.0 kB/s Nov 28 14:56:13 volumio volumio[3276]: info: camilladsp spawned new process with pid 21257, instance 2, run: true Nov 28 14:56:14 volumio volumio[3276]: 0+0 records in Nov 28 14:56:14 volumio volumio[3276]: 0+0 records out Nov 28 14:56:14 volumio volumio[3276]: 0 bytes copied, 5.1889e-05 s, 0.0 kB/s Nov 28 14:56:14 volumio volumio[3276]: info: camilladsp spawned new process with pid 21262, instance 2, run: true Nov 28 14:56:15 volumio volumio[3276]: 0+0 records in Nov 28 14:56:15 volumio volumio[3276]: 0+0 records out Nov 28 14:56:15 volumio volumio[3276]: 0 bytes copied, 5.2593e-05 s, 0.0 kB/s Nov 28 14:56:15 volumio volumio[3276]: info: camilladsp spawned new process with pid 21267, instance 2, run: true Nov 28 14:56:16 volumio volumio[3276]: 0+0 records in Nov 28 14:56:16 volumio volumio[3276]: 0+0 records out Nov 28 14:56:16 volumio volumio[3276]: 0 bytes copied, 5.5425e-05 s, 0.0 kB/s Nov 28 14:56:16 volumio volumio[3276]: info: camilladsp spawned new process with pid 21272, instance 2, run: true Nov 28 14:56:17 volumio volumio[3276]: 0+0 records in Nov 28 14:56:17 volumio volumio[3276]: 0+0 records out Nov 28 14:56:17 volumio volumio[3276]: 0 bytes copied, 4.7759e-05 s, 0.0 kB/s Nov 28 14:56:17 volumio volumio[3276]: info: camilladsp spawned new process with pid 21291, instance 2, run: true Nov 28 14:56:18 volumio volumio[3276]: 0+0 records in Nov 28 14:56:18 volumio volumio[3276]: 0+0 records out Nov 28 14:56:18 volumio volumio[3276]: 0 bytes copied, 4.9667e-05 s, 0.0 kB/s Nov 28 14:56:18 volumio volumio[3276]: info: camilladsp spawned new process with pid 21299, instance 2, run: true Nov 28 14:56:19 volumio volumio[3276]: 0+0 records in Nov 28 14:56:19 volumio volumio[3276]: 0+0 records out Nov 28 14:56:19 volumio volumio[3276]: 0 bytes copied, 5.1018e-05 s, 0.0 kB/s Nov 28 14:56:19 volumio volumio[3276]: info: camilladsp spawned new process with pid 21304, instance 2, run: true Nov 28 14:56:20 volumio volumio[3276]: 0+0 records in Nov 28 14:56:20 volumio volumio[3276]: 0+0 records out Nov 28 14:56:20 volumio volumio[3276]: 0 bytes copied, 5.3352e-05 s, 0.0 kB/s Nov 28 14:56:20 volumio volumio[3276]: info: camilladsp spawned new process with pid 21309, instance 2, run: true Nov 28 14:56:21 volumio volumio[3276]: 0+0 records in Nov 28 14:56:21 volumio volumio[3276]: 0+0 records out Nov 28 14:56:21 volumio volumio[3276]: 0 bytes copied, 4.9703e-05 s, 0.0 kB/s Nov 28 14:56:21 volumio volumio[3276]: info: camilladsp spawned new process with pid 21314, instance 2, run: true Nov 28 14:56:22 volumio volumio[3276]: 0+0 records in Nov 28 14:56:22 volumio volumio[3276]: 0+0 records out Nov 28 14:56:22 volumio volumio[3276]: 0 bytes copied, 5.55e-05 s, 0.0 kB/s Nov 28 14:56:22 volumio volumio[3276]: info: camilladsp spawned new process with pid 21319, instance 2, run: true Nov 28 14:56:23 volumio volumio[3276]: 0+0 records in Nov 28 14:56:23 volumio volumio[3276]: 0+0 records out Nov 28 14:56:23 volumio volumio[3276]: 0 bytes copied, 4.9963e-05 s, 0.0 kB/s Nov 28 14:56:23 volumio volumio[3276]: info: camilladsp spawned new process with pid 21325, instance 2, run: true Nov 28 14:56:24 volumio volumio[3276]: 0+0 records in Nov 28 14:56:24 volumio volumio[3276]: 0+0 records out Nov 28 14:56:24 volumio volumio[3276]: 0 bytes copied, 4.0519e-05 s, 0.0 kB/s Nov 28 14:56:24 volumio volumio[3276]: info: camilladsp spawned new process with pid 21330, instance 2, run: true Nov 28 14:56:24 volumio dnsmasq-dhcp[1052]: no address range available for DHCP request via wlan0 Nov 28 14:56:25 volumio volumio[3276]: 0+0 records in Nov 28 14:56:25 volumio volumio[3276]: 0+0 records out Nov 28 14:56:25 volumio volumio[3276]: 0 bytes copied, 4.9148e-05 s, 0.0 kB/s Nov 28 14:56:25 volumio volumio[3276]: info: camilladsp spawned new process with pid 21335, instance 2, run: true Nov 28 14:56:26 volumio volumio[3276]: 0+0 records in Nov 28 14:56:26 volumio volumio[3276]: 0+0 records out Nov 28 14:56:26 volumio volumio[3276]: 0 bytes copied, 4.9389e-05 s, 0.0 kB/s Nov 28 14:56:26 volumio volumio[3276]: info: camilladsp spawned new process with pid 21340, instance 2, run: true Nov 28 14:56:27 volumio volumio[3276]: 0+0 records in Nov 28 14:56:27 volumio volumio[3276]: 0+0 records out Nov 28 14:56:27 volumio volumio[3276]: 0 bytes copied, 5.0333e-05 s, 0.0 kB/s Nov 28 14:56:27 volumio volumio[3276]: info: camilladsp spawned new process with pid 21359, instance 2, run: true Nov 28 14:56:28 volumio volumio[3276]: 0+0 records in Nov 28 14:56:28 volumio volumio[3276]: 0+0 records out Nov 28 14:56:28 volumio volumio[3276]: 0 bytes copied, 5.0111e-05 s, 0.0 kB/s Nov 28 14:56:28 volumio volumio[3276]: info: camilladsp spawned new process with pid 21367, instance 2, run: true Nov 28 14:56:29 volumio volumio[3276]: 0+0 records in Nov 28 14:56:29 volumio volumio[3276]: 0+0 records out Nov 28 14:56:29 volumio volumio[3276]: 0 bytes copied, 5.4722e-05 s, 0.0 kB/s Nov 28 14:56:29 volumio volumio[3276]: info: camilladsp spawned new process with pid 21372, instance 2, run: true Nov 28 14:56:30 volumio volumio[3276]: 0+0 records in Nov 28 14:56:30 volumio volumio[3276]: 0+0 records out Nov 28 14:56:30 volumio volumio[3276]: 0 bytes copied, 5.0296e-05 s, 0.0 kB/s Nov 28 14:56:30 volumio volumio[3276]: info: camilladsp spawned new process with pid 21377, instance 2, run: true Nov 28 14:56:31 volumio volumio[3276]: 0+0 records in Nov 28 14:56:31 volumio volumio[3276]: 0+0 records out Nov 28 14:56:31 volumio volumio[3276]: 0 bytes copied, 5.2796e-05 s, 0.0 kB/s Nov 28 14:56:31 volumio volumio[3276]: info: camilladsp spawned new process with pid 21382, instance 2, run: true Nov 28 14:56:32 volumio volumio[3276]: 0+0 records in Nov 28 14:56:32 volumio volumio[3276]: 0+0 records out Nov 28 14:56:32 volumio volumio[3276]: 0 bytes copied, 5.0167e-05 s, 0.0 kB/s Nov 28 14:56:32 volumio volumio[3276]: info: camilladsp spawned new process with pid 21387, instance 2, run: true Nov 28 14:56:33 volumio volumio[3276]: 0+0 records in Nov 28 14:56:33 volumio volumio[3276]: 0+0 records out Nov 28 14:56:33 volumio volumio[3276]: 0 bytes copied, 4.9222e-05 s, 0.0 kB/s Nov 28 14:56:33 volumio volumio[3276]: info: camilladsp spawned new process with pid 21392, instance 2, run: true Nov 28 14:56:34 volumio volumio[3276]: 0+0 records in Nov 28 14:56:34 volumio volumio[3276]: 0+0 records out Nov 28 14:56:34 volumio volumio[3276]: 0 bytes copied, 5.6778e-05 s, 0.0 kB/s Nov 28 14:56:34 volumio volumio[3276]: info: camilladsp spawned new process with pid 21397, instance 2, run: true Nov 28 14:56:35 volumio volumio[3276]: 0+0 records in Nov 28 14:56:35 volumio volumio[3276]: 0+0 records out Nov 28 14:56:35 volumio volumio[3276]: 0 bytes copied, 5.3092e-05 s, 0.0 kB/s Nov 28 14:56:35 volumio volumio[3276]: info: camilladsp spawned new process with pid 21402, instance 2, run: true Nov 28 14:56:36 volumio volumio[3276]: 0+0 records in Nov 28 14:56:36 volumio volumio[3276]: 0+0 records out Nov 28 14:56:36 volumio volumio[3276]: 0 bytes copied, 0.000107444 s, 0.0 kB/s Nov 28 14:56:36 volumio volumio[3276]: info: camilladsp spawned new process with pid 21415, instance 2, run: true Nov 28 14:56:37 volumio volumio[3276]: 0+0 records in Nov 28 14:56:37 volumio volumio[3276]: 0+0 records out Nov 28 14:56:37 volumio volumio[3276]: 0 bytes copied, 5.2759e-05 s, 0.0 kB/s Nov 28 14:56:37 volumio volumio[3276]: info: camilladsp spawned new process with pid 21426, instance 2, run: true Nov 28 14:56:38 volumio volumio[3276]: 0+0 records in Nov 28 14:56:38 volumio volumio[3276]: 0+0 records out Nov 28 14:56:38 volumio volumio[3276]: 0 bytes copied, 4.9907e-05 s, 0.0 kB/s Nov 28 14:56:38 volumio volumio[3276]: info: camilladsp spawned new process with pid 21434, instance 2, run: true Nov 28 14:56:39 volumio volumio[3276]: 0+0 records in Nov 28 14:56:39 volumio volumio[3276]: 0+0 records out Nov 28 14:56:39 volumio volumio[3276]: 0 bytes copied, 5.0185e-05 s, 0.0 kB/s Nov 28 14:56:39 volumio volumio[3276]: info: camilladsp spawned new process with pid 21439, instance 2, run: true Nov 28 14:56:40 volumio volumio[3276]: 0+0 records in Nov 28 14:56:40 volumio volumio[3276]: 0+0 records out Nov 28 14:56:40 volumio volumio[3276]: 0 bytes copied, 4.8111e-05 s, 0.0 kB/s Nov 28 14:56:40 volumio volumio[3276]: info: camilladsp spawned new process with pid 21444, instance 2, run: true Nov 28 14:56:41 volumio volumio[3276]: 0+0 records in Nov 28 14:56:41 volumio volumio[3276]: 0+0 records out Nov 28 14:56:41 volumio volumio[3276]: 0 bytes copied, 5.0593e-05 s, 0.0 kB/s Nov 28 14:56:41 volumio volumio[3276]: info: camilladsp spawned new process with pid 21449, instance 2, run: true Nov 28 14:56:42 volumio volumio[3276]: 0+0 records in Nov 28 14:56:42 volumio volumio[3276]: 0+0 records out Nov 28 14:56:42 volumio volumio[3276]: 0 bytes copied, 4.8815e-05 s, 0.0 kB/s Nov 28 14:56:42 volumio volumio[3276]: info: camilladsp spawned new process with pid 21454, instance 2, run: true Nov 28 14:56:43 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: pandora , handleBrowseUri Nov 28 14:56:43 volumio volumio[3276]: info: [1732823803746] ControllerPandora::handleBrowseUri Nov 28 14:56:43 volumio volumio[3276]: info: [1732823803746] ControllerPandora::checkForExpiredStations Nov 28 14:56:43 volumio volumio[3276]: 0+0 records in Nov 28 14:56:43 volumio volumio[3276]: 0+0 records out Nov 28 14:56:43 volumio volumio[3276]: 0 bytes copied, 4.9277e-05 s, 0.0 kB/s Nov 28 14:56:43 volumio volumio[3276]: info: camilladsp spawned new process with pid 21460, instance 2, run: true Nov 28 14:56:43 volumio volumio[3276]: info: Preload queue cleared Nov 28 14:56:44 volumio volumio[3276]: 0+0 records in Nov 28 14:56:44 volumio volumio[3276]: 0+0 records out Nov 28 14:56:44 volumio volumio[3276]: 0 bytes copied, 5.3093e-05 s, 0.0 kB/s Nov 28 14:56:44 volumio volumio[3276]: info: camilladsp spawned new process with pid 21465, instance 2, run: true Nov 28 14:56:45 volumio volumio[3276]: 0+0 records in Nov 28 14:56:45 volumio volumio[3276]: 0+0 records out Nov 28 14:56:45 volumio volumio[3276]: 0 bytes copied, 4.9629e-05 s, 0.0 kB/s Nov 28 14:56:45 volumio volumio[3276]: info: camilladsp spawned new process with pid 21470, instance 2, run: true Nov 28 14:56:46 volumio volumio[3276]: 0+0 records in Nov 28 14:56:46 volumio volumio[3276]: 0+0 records out Nov 28 14:56:46 volumio volumio[3276]: 0 bytes copied, 4.8407e-05 s, 0.0 kB/s Nov 28 14:56:46 volumio volumio[3276]: info: camilladsp spawned new process with pid 21489, instance 2, run: true Nov 28 14:56:47 volumio volumio[3276]: 0+0 records in Nov 28 14:56:47 volumio volumio[3276]: 0+0 records out Nov 28 14:56:47 volumio volumio[3276]: 0 bytes copied, 5.05e-05 s, 0.0 kB/s Nov 28 14:56:47 volumio volumio[3276]: info: camilladsp spawned new process with pid 21497, instance 2, run: true Nov 28 14:56:47 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: pandora , handleBrowseUri Nov 28 14:56:47 volumio volumio[3276]: info: [1732823807875] ControllerPandora::handleBrowseUri Nov 28 14:56:47 volumio volumio[3276]: info: [1732823807875] ControllerPandora::checkForExpiredStations Nov 28 14:56:47 volumio volumio[3276]: info: [1732823807876] ControllerPandora::PandoraHandler::fillStationData Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808101] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808624] [Pandora] PandoraHandler::fetchTracks::fetchStationPlaylist: Retrieved Allison Krausse Radio playlist Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808625] ControllerPandora::PandoraHandler::fetchTracks::fillNewTracks Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808625] [Pandora] PandoraHandler::fetchTracks::fillNewTracks: Fetched 4 track(s) Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::addQueueItems Nov 28 14:56:48 volumio volumio[3276]: info: Preload queue cleared Nov 28 14:56:48 volumio volumio[3276]: info: Adding Item to queue: /pandora/stationToken=2116725652096567751trackId=4147597147436990977 Nov 28 14:56:48 volumio volumio[3276]: info: Exploding uri /pandora/stationToken=2116725652096567751trackId=4147597147436990977 in service pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808626] ControllerPandora::explodeUri Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: Adding Item to queue: /pandora/stationToken=2116725652096567751trackId=5980043642109074285 Nov 28 14:56:48 volumio volumio[3276]: info: Exploding uri /pandora/stationToken=2116725652096567751trackId=5980043642109074285 in service pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808627] ControllerPandora::explodeUri Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: Adding Item to queue: /pandora/stationToken=2116725652096567751trackId=5920064181904221079 Nov 28 14:56:48 volumio volumio[3276]: info: Exploding uri /pandora/stationToken=2116725652096567751trackId=5920064181904221079 in service pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808627] ControllerPandora::explodeUri Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: Adding Item to queue: /pandora/stationToken=2116725652096567751trackId=6834970440787630614 Nov 28 14:56:48 volumio volumio[3276]: info: Exploding uri /pandora/stationToken=2116725652096567751trackId=6834970440787630614 in service pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808627] ControllerPandora::explodeUri Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CoreCommandRouter::volumioPushQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::saveQueue Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::updateTrackBlock Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getTrackBlock Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::play index 1 Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::stop Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::play index undefined Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::startPlaybackTimer Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808633] ControllerPandora::clearAddPlayTrack Nov 28 14:56:48 volumio volumio[3276]: info: ControllerMpd::clear Nov 28 14:56:48 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand clear Nov 28 14:56:48 volumio volumio[3276]: info: Nov 28 14:56:48 volumio volumio[3276]: ---------------------------- MPD announces system playlist update Nov 28 14:56:48 volumio volumio[3276]: info: Ignoring MPD Status Update Nov 28 14:56:48 volumio volumio[3276]: info: sendMpdCommand clear took 3 milliseconds Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808636] ControllerPandora::checkForExpiredStations Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808637] ControllerPandora::removeTrack Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808637] [Pandora] removeTrack: Not removing track with uri: null at queue index: -1 Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808637] ControllerPandora::appendTracksToMpd Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808637] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd Nov 28 14:56:48 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand addid Nov 28 14:56:48 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand play Nov 28 14:56:48 volumio volumio[3276]: info: Nov 28 14:56:48 volumio volumio[3276]: ---------------------------- MPD announces system playlist update Nov 28 14:56:48 volumio volumio[3276]: info: Ignoring MPD Status Update Nov 28 14:56:48 volumio volumio[3276]: error: updateQueue error: null Nov 28 14:56:48 volumio volumio[3276]: info: Nov 28 14:56:48 volumio volumio[3276]: ---------------------------- MPD announces system playlist update Nov 28 14:56:48 volumio volumio[3276]: info: Ignoring MPD Status Update Nov 28 14:56:48 volumio volumio[3276]: info: ------------------------------ 3ms Nov 28 14:56:48 volumio volumio[3276]: info: sendMpdCommand addid took 2 milliseconds Nov 28 14:56:48 volumio volumio[3276]: info: sendMpdCommand play took 2 milliseconds Nov 28 14:56:48 volumio volumio[3276]: info: ------------------------------ 2ms Nov 28 14:56:48 volumio volumio[3276]: verbose: MPD COMMAND [object Object] Nov 28 14:56:48 volumio volumio[3276]: verbose: MPD COMMAND [object Object] Nov 28 14:56:48 volumio volumio[3276]: verbose: MPD COMMAND [object Object] Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808641] ControllerPandora::pushState Nov 28 14:56:48 volumio volumio[3276]: info: CoreCommandRouter::servicePushState Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:48 volumio volumio[3276]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Restless (Remastered)","name":"Restless (Remastered)","artist":"Alison Krauss & Union Station","album":"Lonely Runs Both Ways","albumart":"http://mediaserver-cont-sv5-2-v4v6.pandora.com/images/6a/06/b4/4c/6c5a4a0d82a654ece81ca940/1080W_1080H.jpg","realUri":"http://t1-2.p-cdn.us/access/4147597147436990977.mp3?version=5&lid=70011335&token=AiE28%2FZsUBKVS8lB3vCyr43gom%2FdgM4vxYGr7BxXzOaSb120N3epzyED9jkArekAlSsfFGWtGW2BPb2tqKCFs2r8ha7CtQFtcsn2gA%2FwdvnfHSMEeN6VRHLW%2Fn6U5dm3CgkwIvcDSuSYnm3UKVlLFBp5rAIt0QfGf7hhhkXAvAWD4E%2FSnmChlJqDuU5QUvJr1OCrdZ0AqKWhlkN0Mru2lACjVSv19YRFt9ULYjym3zaxBGoGltBAprtFnq%2FLpY%2BqwoJja60SRtvZjgmvfFn65pX0luuu7xbxXsYELOQorRanJxTs3kBbV%2Bg3kB%2BMgtpirbEZ%2BlHadO9aF22DIc7aBA%3D%3D","isStreaming":true,"duration":171,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-2.p-cdn.us/access/4147597147436990977.mp3?version=5&lid=70011335&token=AiE28%2FZsUBKVS8lB3vCyr43gom%2FdgM4vxYGr7BxXzOaSb120N3epzyED9jkArekAlSsfFGWtGW2BPb2tqKCFs2r8ha7CtQFtcsn2gA%2FwdvnfHSMEeN6VRHLW%2Fn6U5dm3CgkwIvcDSuSYnm3UKVlLFBp5rAIt0QfGf7hhhkXAvAWD4E%2FSnmChlJqDuU5QUvJr1OCrdZ0AqKWhlkN0Mru2lACjVSv19YRFt9ULYjym3zaxBGoGltBAprtFnq%2FLpY%2BqwoJja60SRtvZjgmvfFn65pX0luuu7xbxXsYELOQorRanJxTs3kBbV%2Bg3kB%2BMgtpirbEZ%2BlHadO9aF22DIc7aBA%3D%3D","seek":0,"status":"play"} Nov 28 14:56:48 volumio volumio[3276]: verbose: CURRENT POSITION 1 Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::syncState stateService play Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::syncState currentStatus stop Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::setConsumeUpdateService pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808641] ControllerPandora::fetchAndAddTracks Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808641] ControllerPandora::getStationTracks Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808642] [Pandora] PandoraHandler::getSongMaxDiff: -12 Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808642] ControllerPandora::fetchAndAddTracks::getSqInfo Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808642] ControllerPandora::getStationTracks Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808642] [Pandora] fetchAndAddTracks: diff1: -12 sQPos1: 0 Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808642] [Pandora] fetchAndAddTracks: Fetching tracks Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808642] ControllerPandora::PandoraHandler::fillStationData Nov 28 14:56:48 volumio volumio[3276]: info: Nov 28 14:56:48 volumio volumio[3276]: ---------------------------- MPD announces system playlist update Nov 28 14:56:48 volumio volumio[3276]: info: Ignoring MPD Status Update Nov 28 14:56:48 volumio volumio[3276]: info: Nov 28 14:56:48 volumio volumio[3276]: ---------------------------- MPD announces system playlist update Nov 28 14:56:48 volumio volumio[3276]: info: Ignoring MPD Status Update Nov 28 14:56:48 volumio volumio[3276]: info: ------------------------------ 5ms Nov 28 14:56:48 volumio volumio[3276]: info: ------------------------------ 1ms Nov 28 14:56:48 volumio volumio[3276]: info: Nov 28 14:56:48 volumio volumio[3276]: ---------------------------- MPD announces system playlist update Nov 28 14:56:48 volumio volumio[3276]: info: Ignoring MPD Status Update Nov 28 14:56:48 volumio volumio[3276]: info: ------------------------------ 1ms Nov 28 14:56:48 volumio volumio[3276]: info: ------------------------------ 1ms Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808780] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist Nov 28 14:56:48 volumio volumio[3276]: 0+0 records in Nov 28 14:56:48 volumio volumio[3276]: 0+0 records out Nov 28 14:56:48 volumio volumio[3276]: 0 bytes copied, 5.0037e-05 s, 0.0 kB/s Nov 28 14:56:48 volumio volumio[3276]: info: camilladsp spawned new process with pid 21505, instance 2, run: true Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808958] [Pandora] PandoraHandler::fetchTracks::fetchStationPlaylist: Retrieved Allison Krausse Radio playlist Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808958] ControllerPandora::PandoraHandler::fetchTracks::fillNewTracks Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808958] [Pandora] PandoraHandler::fetchTracks::fillNewTracks: Fetched 4 track(s) Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::addQueueItems Nov 28 14:56:48 volumio volumio[3276]: info: Preload queue cleared Nov 28 14:56:48 volumio volumio[3276]: info: Adding Item to queue: /pandora/stationToken=2116725652096567751trackId=6178861439351009848 Nov 28 14:56:48 volumio volumio[3276]: info: Exploding uri /pandora/stationToken=2116725652096567751trackId=6178861439351009848 in service pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808959] ControllerPandora::explodeUri Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: Adding Item to queue: /pandora/stationToken=2116725652096567751trackId=8216002421070132837 Nov 28 14:56:48 volumio volumio[3276]: info: Exploding uri /pandora/stationToken=2116725652096567751trackId=8216002421070132837 in service pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808959] ControllerPandora::explodeUri Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: Adding Item to queue: /pandora/stationToken=2116725652096567751trackId=3060629143103964903 Nov 28 14:56:48 volumio volumio[3276]: info: Exploding uri /pandora/stationToken=2116725652096567751trackId=3060629143103964903 in service pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808959] ControllerPandora::explodeUri Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: Adding Item to queue: /pandora/stationToken=2116725652096567751trackId=1677892303452019262 Nov 28 14:56:48 volumio volumio[3276]: info: Exploding uri /pandora/stationToken=2116725652096567751trackId=1677892303452019262 in service pandora Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808959] ControllerPandora::explodeUri Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: CoreCommandRouter::volumioPushQueue Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::saveQueue Nov 28 14:56:48 volumio volumio[3276]: info: CoreStateMachine::updateTrackBlock Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getTrackBlock Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808962] ControllerPandora::getStationTracks Nov 28 14:56:48 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:48 volumio volumio[3276]: info: [1732823808962] [Pandora] PandoraHandler::getSongMaxDiff: -8 Nov 28 14:56:49 volumio volumio[3276]: info: [1732823809142] ControllerPandora::pandoraListener Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::getState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand status Nov 28 14:56:49 volumio volumio[3276]: info: Nov 28 14:56:49 volumio volumio[3276]: ---------------------------- MPD announces state update: player Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::getState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand status Nov 28 14:56:49 volumio volumio[3276]: info: Nov 28 14:56:49 volumio volumio[3276]: ---------------------------- MPD announces state update: player Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::getState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand status Nov 28 14:56:49 volumio volumio[3276]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 28 14:56:49 volumio volumio[3276]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 28 14:56:49 volumio volumio[3276]: info: camilladsp stopping service pid 27604... Nov 28 14:56:49 volumio volumio[3276]: info: camilladsp service terminated, instance 1 Nov 28 14:56:49 volumio volumio[3276]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 28 14:56:49 volumio volumio[3276]: info: camilladsp service started and running in background, instance 1 Nov 28 14:56:49 volumio volumio[3276]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 28 14:56:49 volumio volumio[3276]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 28 14:56:49 volumio volumio[3276]: info: camilladsp service terminated, instance 2 Nov 28 14:56:49 volumio volumio[3276]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 28 14:56:49 volumio volumio[3276]: info: camilladsp spawned new process with pid 21512, instance 2, run: true Nov 28 14:56:49 volumio volumio[3276]: info: camilladsp service started and running in background, instance 2 Nov 28 14:56:49 volumio volumio[3276]: info: Nov 28 14:56:49 volumio volumio[3276]: ---------------------------- MPD announces state update: player Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand status took 33 milliseconds Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::getState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand status Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand status took 33 milliseconds Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand status took 33 milliseconds Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 28 14:56:49 volumio volumio[3276]: info: Nov 28 14:56:49 volumio volumio[3276]: ---------------------------- MPD announces state update: player Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::getState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand status Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand status took 5 milliseconds Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand status took 3 milliseconds Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseTrackInfo Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseTrackInfo Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseTrackInfo Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseState Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 28 14:56:49 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:49 volumio volumio[3276]: info: [1732823809182] ControllerPandora::pushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::servicePushState Nov 28 14:56:49 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:49 volumio volumio[3276]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Restless (Remastered)","artist":"Alison Krauss & Union Station","album":"Lonely Runs Both Ways","uri":"http://t1-2.p-cdn.us/access/4147597147436990977.mp3?version=5&lid=70011335&token=AiE28%2FZsUBKVS8lB3vCyr43gom%2FdgM4vxYGr7BxXzOaSb120N3epzyED9jkArekAlSsfFGWtGW2BPb2tqKCFs2r8ha7CtQFtcsn2gA%2FwdvnfHSMEeN6VRHLW%2Fn6U5dm3CgkwIvcDSuSYnm3UKVlLFBp5rAIt0QfGf7hhhkXAvAWD4E%2FSnmChlJqDuU5QUvJr1OCrdZ0AqKWhlkN0Mru2lACjVSv19YRFt9ULYjym3zaxBGoGltBAprtFnq%2FLpY%2BqwoJja60SRtvZjgmvfFn65pX0luuu7xbxXsYELOQorRanJxTs3kBbV%2Bg3kB%2BMgtpirbEZ%2BlHadO9aF22DIc7aBA%3D%3D","trackType":"mp3"} Nov 28 14:56:49 volumio volumio[3276]: verbose: CURRENT POSITION 1 Nov 28 14:56:49 volumio volumio[3276]: info: CoreStateMachine::syncState stateService play Nov 28 14:56:49 volumio volumio[3276]: info: CoreStateMachine::syncState currentStatus play Nov 28 14:56:49 volumio volumio[3276]: info: Received an update from plugin. extracting info from payload Nov 28 14:56:49 volumio volumio[3276]: info: CoreStateMachine::pushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::volumioPushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreStateMachine::pushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::volumioPushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreStateMachine::setConsumeUpdateService pandora Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::pushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::servicePushState Nov 28 14:56:49 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:49 volumio volumio[3276]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::pushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::servicePushState Nov 28 14:56:49 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:49 volumio volumio[3276]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 28 14:56:49 volumio volumio[3276]: info: ------------------------------ 43ms Nov 28 14:56:49 volumio volumio[3276]: info: ------------------------------ 42ms Nov 28 14:56:49 volumio volumio[3276]: info: camilladsp spawned new process with pid 21515, instance 1, run: true Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 28 14:56:49 volumio volumio[3276]: info: sendMpdCommand playlistinfo took 16 milliseconds Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseTrackInfo Nov 28 14:56:49 volumio volumio[3276]: verbose: ControllerMpd::parseTrackInfo Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::pushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::servicePushState Nov 28 14:56:49 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:49 volumio volumio[3276]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 28 14:56:49 volumio volumio[3276]: info: ControllerMpd::pushState Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::servicePushState Nov 28 14:56:49 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:56:49 volumio volumio[3276]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 28 14:56:49 volumio volumio[3276]: info: ------------------------------ 22ms Nov 28 14:56:49 volumio volumio[3276]: info: ------------------------------ 22ms Nov 28 14:56:49 volumio volumio[3276]: info: CoreCommandRouter::volumioGetQueue Nov 28 14:56:49 volumio volumio[3276]: info: CoreStateMachine::getQueue Nov 28 14:56:49 volumio volumio[3276]: info: CorePlayQueue::getQueue Nov 28 14:56:49 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:49 volumio volumio[3276]: 2+0 records in Nov 28 14:56:49 volumio volumio[3276]: 2+0 records out Nov 28 14:56:49 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.00023511 s, 279 MB/s Nov 28 14:56:49 volumio volumio[3276]: info: camilladsp spawned new process with pid 21521, instance 2, run: true Nov 28 14:56:50 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:50 volumio volumio[3276]: 2+0 records in Nov 28 14:56:50 volumio volumio[3276]: 2+0 records out Nov 28 14:56:50 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000249888 s, 262 MB/s Nov 28 14:56:50 volumio volumio[3276]: info: camilladsp spawned new process with pid 21526, instance 2, run: true Nov 28 14:56:50 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:50 volumio volumio[3276]: 1+1 records in Nov 28 14:56:50 volumio volumio[3276]: 1+1 records out Nov 28 14:56:50 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000144907 s, 426 MB/s Nov 28 14:56:50 volumio volumio[3276]: info: camilladsp spawned new process with pid 21531, instance 1, run: true Nov 28 14:56:50 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:50 volumio volumio[3276]: 2+0 records in Nov 28 14:56:50 volumio volumio[3276]: 2+0 records out Nov 28 14:56:50 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000304721 s, 215 MB/s Nov 28 14:56:50 volumio volumio[3276]: info: camilladsp spawned new process with pid 21536, instance 2, run: true Nov 28 14:56:51 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:51 volumio volumio[3276]: 1+1 records in Nov 28 14:56:51 volumio volumio[3276]: 1+1 records out Nov 28 14:56:51 volumio volumio[3276]: 62640 bytes (63 kB, 61 KiB) copied, 0.000160721 s, 390 MB/s Nov 28 14:56:51 volumio volumio[3276]: info: camilladsp spawned new process with pid 21541, instance 2, run: true Nov 28 14:56:51 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:51 volumio volumio[3276]: 1+1 records in Nov 28 14:56:51 volumio volumio[3276]: 1+1 records out Nov 28 14:56:51 volumio volumio[3276]: 64608 bytes (65 kB, 63 KiB) copied, 0.000283758 s, 228 MB/s Nov 28 14:56:51 volumio volumio[3276]: info: camilladsp spawned new process with pid 21546, instance 1, run: true Nov 28 14:56:51 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:51 volumio volumio[3276]: 1+1 records in Nov 28 14:56:51 volumio volumio[3276]: 1+1 records out Nov 28 14:56:51 volumio volumio[3276]: 63584 bytes (64 kB, 62 KiB) copied, 0.000151962 s, 418 MB/s Nov 28 14:56:51 volumio volumio[3276]: info: camilladsp spawned new process with pid 21551, instance 2, run: true Nov 28 14:56:52 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:52 volumio volumio[3276]: 2+0 records in Nov 28 14:56:52 volumio volumio[3276]: 2+0 records out Nov 28 14:56:52 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000278795 s, 235 MB/s Nov 28 14:56:52 volumio volumio[3276]: info: camilladsp spawned new process with pid 21556, instance 2, run: true Nov 28 14:56:52 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:52 volumio volumio[3276]: 1+1 records in Nov 28 14:56:52 volumio volumio[3276]: 1+1 records out Nov 28 14:56:52 volumio volumio[3276]: 62656 bytes (63 kB, 61 KiB) copied, 0.000202925 s, 309 MB/s Nov 28 14:56:52 volumio volumio[3276]: info: camilladsp spawned new process with pid 21561, instance 1, run: true Nov 28 14:56:52 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:52 volumio volumio[3276]: 2+0 records in Nov 28 14:56:52 volumio volumio[3276]: 2+0 records out Nov 28 14:56:52 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000145574 s, 450 MB/s Nov 28 14:56:52 volumio volumio[3276]: info: camilladsp spawned new process with pid 21566, instance 2, run: true Nov 28 14:56:53 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:53 volumio volumio[3276]: 1+1 records in Nov 28 14:56:53 volumio volumio[3276]: 1+1 records out Nov 28 14:56:53 volumio volumio[3276]: 62720 bytes (63 kB, 61 KiB) copied, 0.000224332 s, 280 MB/s Nov 28 14:56:53 volumio volumio[3276]: info: camilladsp spawned new process with pid 21571, instance 2, run: true Nov 28 14:56:53 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:53 volumio volumio[3276]: 1+1 records in Nov 28 14:56:53 volumio volumio[3276]: 1+1 records out Nov 28 14:56:53 volumio volumio[3276]: 64512 bytes (65 kB, 63 KiB) copied, 0.000221184 s, 292 MB/s Nov 28 14:56:53 volumio volumio[3276]: info: camilladsp spawned new process with pid 21576, instance 1, run: true Nov 28 14:56:54 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:54 volumio volumio[3276]: 2+0 records in Nov 28 14:56:54 volumio volumio[3276]: 2+0 records out Nov 28 14:56:54 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000143684 s, 456 MB/s Nov 28 14:56:54 volumio volumio[3276]: info: camilladsp spawned new process with pid 21581, instance 2, run: true Nov 28 14:56:54 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:54 volumio volumio[3276]: 1+1 records in Nov 28 14:56:54 volumio volumio[3276]: 1+1 records out Nov 28 14:56:54 volumio volumio[3276]: 62736 bytes (63 kB, 61 KiB) copied, 0.000150462 s, 417 MB/s Nov 28 14:56:54 volumio volumio[3276]: info: camilladsp spawned new process with pid 21586, instance 2, run: true Nov 28 14:56:54 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:54 volumio volumio[3276]: 2+0 records in Nov 28 14:56:54 volumio volumio[3276]: 2+0 records out Nov 28 14:56:54 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000152685 s, 429 MB/s Nov 28 14:56:54 volumio volumio[3276]: info: camilladsp spawned new process with pid 21591, instance 1, run: true Nov 28 14:56:54 volumio dnsmasq-dhcp[1052]: no address range available for DHCP request via wlan0 Nov 28 14:56:55 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:55 volumio volumio[3276]: 1+1 records in Nov 28 14:56:55 volumio volumio[3276]: 1+1 records out Nov 28 14:56:55 volumio volumio[3276]: 62576 bytes (63 kB, 61 KiB) copied, 0.000138462 s, 452 MB/s Nov 28 14:56:55 volumio volumio[3276]: info: camilladsp spawned new process with pid 21596, instance 2, run: true Nov 28 14:56:55 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:55 volumio volumio[3276]: 1+1 records in Nov 28 14:56:55 volumio volumio[3276]: 1+1 records out Nov 28 14:56:55 volumio volumio[3276]: 64672 bytes (65 kB, 63 KiB) copied, 0.000161685 s, 400 MB/s Nov 28 14:56:55 volumio volumio[3276]: info: camilladsp spawned new process with pid 21601, instance 2, run: true Nov 28 14:56:55 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:55 volumio volumio[3276]: 1+1 records in Nov 28 14:56:55 volumio volumio[3276]: 1+1 records out Nov 28 14:56:55 volumio volumio[3276]: 63520 bytes (64 kB, 62 KiB) copied, 0.000157444 s, 403 MB/s Nov 28 14:56:55 volumio volumio[3276]: info: camilladsp spawned new process with pid 21606, instance 1, run: true Nov 28 14:56:56 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:56 volumio volumio[3276]: 2+0 records in Nov 28 14:56:56 volumio volumio[3276]: 2+0 records out Nov 28 14:56:56 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000158037 s, 415 MB/s Nov 28 14:56:56 volumio volumio[3276]: info: camilladsp spawned new process with pid 21611, instance 2, run: true Nov 28 14:56:56 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:56 volumio volumio[3276]: 1+1 records in Nov 28 14:56:56 volumio volumio[3276]: 1+1 records out Nov 28 14:56:56 volumio volumio[3276]: 62656 bytes (63 kB, 61 KiB) copied, 0.000159148 s, 394 MB/s Nov 28 14:56:56 volumio volumio[3276]: info: camilladsp spawned new process with pid 21616, instance 2, run: true Nov 28 14:56:56 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:56 volumio volumio[3276]: 2+0 records in Nov 28 14:56:56 volumio volumio[3276]: 2+0 records out Nov 28 14:56:56 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000159314 s, 411 MB/s Nov 28 14:56:56 volumio volumio[3276]: info: camilladsp spawned new process with pid 21621, instance 1, run: true Nov 28 14:56:57 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:57 volumio volumio[3276]: 1+1 records in Nov 28 14:56:57 volumio volumio[3276]: 1+1 records out Nov 28 14:56:57 volumio volumio[3276]: 62784 bytes (63 kB, 61 KiB) copied, 0.000203814 s, 308 MB/s Nov 28 14:56:57 volumio volumio[3276]: info: camilladsp spawned new process with pid 21640, instance 2, run: true Nov 28 14:56:57 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:57 volumio volumio[3276]: 1+1 records in Nov 28 14:56:57 volumio volumio[3276]: 1+1 records out Nov 28 14:56:57 volumio volumio[3276]: 64448 bytes (64 kB, 63 KiB) copied, 0.000153332 s, 420 MB/s Nov 28 14:56:57 volumio volumio[3276]: info: camilladsp spawned new process with pid 21645, instance 2, run: true Nov 28 14:56:57 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:57 volumio volumio[3276]: 2+0 records in Nov 28 14:56:57 volumio volumio[3276]: 2+0 records out Nov 28 14:56:57 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000150814 s, 435 MB/s Nov 28 14:56:57 volumio volumio[3276]: info: camilladsp spawned new process with pid 21650, instance 1, run: true Nov 28 14:56:58 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:58 volumio volumio[3276]: 1+1 records in Nov 28 14:56:58 volumio volumio[3276]: 1+1 records out Nov 28 14:56:58 volumio volumio[3276]: 62800 bytes (63 kB, 61 KiB) copied, 0.000151426 s, 415 MB/s Nov 28 14:56:58 volumio volumio[3276]: info: camilladsp spawned new process with pid 21658, instance 2, run: true Nov 28 14:56:58 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:58 volumio volumio[3276]: 51+1 records in Nov 28 14:56:58 volumio volumio[3276]: 51+1 records out Nov 28 14:56:58 volumio volumio[3276]: 1702288 bytes (1.7 MB, 1.6 MiB) copied, 0.00393954 s, 432 MB/s Nov 28 14:56:58 volumio volumio[3276]: info: camilladsp spawned new process with pid 21663, instance 2, run: true Nov 28 14:56:58 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:58 volumio volumio[3276]: 1+1 records in Nov 28 14:56:58 volumio volumio[3276]: 1+1 records out Nov 28 14:56:58 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000154869 s, 398 MB/s Nov 28 14:56:58 volumio volumio[3276]: info: camilladsp spawned new process with pid 21668, instance 1, run: true Nov 28 14:56:59 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:59 volumio volumio[3276]: 2+0 records in Nov 28 14:56:59 volumio volumio[3276]: 2+0 records out Nov 28 14:56:59 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000151795 s, 432 MB/s Nov 28 14:56:59 volumio volumio[3276]: info: camilladsp spawned new process with pid 21673, instance 2, run: true Nov 28 14:56:59 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:59 volumio volumio[3276]: 2+0 records in Nov 28 14:56:59 volumio volumio[3276]: 2+0 records out Nov 28 14:56:59 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000162499 s, 403 MB/s Nov 28 14:56:59 volumio volumio[3276]: info: camilladsp spawned new process with pid 21678, instance 2, run: true Nov 28 14:56:59 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:56:59 volumio volumio[3276]: 1+1 records in Nov 28 14:56:59 volumio volumio[3276]: 1+1 records out Nov 28 14:56:59 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000150574 s, 410 MB/s Nov 28 14:56:59 volumio volumio[3276]: info: camilladsp spawned new process with pid 21683, instance 1, run: true Nov 28 14:57:00 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:00 volumio volumio[3276]: 1+1 records in Nov 28 14:57:00 volumio volumio[3276]: 1+1 records out Nov 28 14:57:00 volumio volumio[3276]: 63296 bytes (63 kB, 62 KiB) copied, 0.000161222 s, 393 MB/s Nov 28 14:57:00 volumio volumio[3276]: info: camilladsp spawned new process with pid 21741, instance 2, run: true Nov 28 14:57:00 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:00 volumio volumio[3276]: 2+0 records in Nov 28 14:57:00 volumio volumio[3276]: 2+0 records out Nov 28 14:57:00 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000154055 s, 425 MB/s Nov 28 14:57:00 volumio volumio[3276]: info: camilladsp spawned new process with pid 21749, instance 2, run: true Nov 28 14:57:00 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:00 volumio volumio[3276]: 412+1 records in Nov 28 14:57:00 volumio volumio[3276]: 412+1 records out Nov 28 14:57:00 volumio volumio[3276]: 13531792 bytes (14 MB, 13 MiB) copied, 0.0273467 s, 495 MB/s Nov 28 14:57:00 volumio volumio[3276]: info: camilladsp spawned new process with pid 21754, instance 1, run: true Nov 28 14:57:01 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:01 volumio volumio[3276]: 2+0 records in Nov 28 14:57:01 volumio volumio[3276]: 2+0 records out Nov 28 14:57:01 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000160851 s, 407 MB/s Nov 28 14:57:01 volumio volumio[3276]: info: camilladsp spawned new process with pid 21760, instance 2, run: true Nov 28 14:57:01 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:01 volumio volumio[3276]: 1+1 records in Nov 28 14:57:01 volumio volumio[3276]: 1+1 records out Nov 28 14:57:01 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000158685 s, 389 MB/s Nov 28 14:57:01 volumio volumio[3276]: info: camilladsp spawned new process with pid 21765, instance 2, run: true Nov 28 14:57:01 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:01 volumio volumio[3276]: 2+0 records in Nov 28 14:57:01 volumio volumio[3276]: 2+0 records out Nov 28 14:57:01 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000297388 s, 220 MB/s Nov 28 14:57:01 volumio volumio[3276]: info: camilladsp spawned new process with pid 21770, instance 1, run: true Nov 28 14:57:02 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:02 volumio volumio[3276]: 1+1 records in Nov 28 14:57:02 volumio volumio[3276]: 1+1 records out Nov 28 14:57:02 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000162907 s, 379 MB/s Nov 28 14:57:02 volumio volumio[3276]: info: camilladsp spawned new process with pid 21775, instance 2, run: true Nov 28 14:57:02 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:02 volumio volumio[3276]: 2+0 records in Nov 28 14:57:02 volumio volumio[3276]: 2+0 records out Nov 28 14:57:02 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.00017224 s, 380 MB/s Nov 28 14:57:02 volumio volumio[3276]: info: camilladsp spawned new process with pid 21780, instance 2, run: true Nov 28 14:57:02 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:02 volumio volumio[3276]: 1+1 records in Nov 28 14:57:02 volumio volumio[3276]: 1+1 records out Nov 28 14:57:02 volumio volumio[3276]: 65168 bytes (65 kB, 64 KiB) copied, 0.000226999 s, 287 MB/s Nov 28 14:57:02 volumio volumio[3276]: info: camilladsp spawned new process with pid 21785, instance 1, run: true Nov 28 14:57:03 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:03 volumio volumio[3276]: 409+1 records in Nov 28 14:57:03 volumio volumio[3276]: 409+1 records out Nov 28 14:57:03 volumio volumio[3276]: 13431344 bytes (13 MB, 13 MiB) copied, 0.0282266 s, 476 MB/s Nov 28 14:57:03 volumio volumio[3276]: info: camilladsp spawned new process with pid 21791, instance 2, run: true Nov 28 14:57:03 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:03 volumio volumio[3276]: 1+1 records in Nov 28 14:57:03 volumio volumio[3276]: 1+1 records out Nov 28 14:57:03 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000134666 s, 458 MB/s Nov 28 14:57:03 volumio volumio[3276]: info: camilladsp spawned new process with pid 21796, instance 2, run: true Nov 28 14:57:03 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:03 volumio volumio[3276]: 2+0 records in Nov 28 14:57:03 volumio volumio[3276]: 2+0 records out Nov 28 14:57:03 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000141759 s, 462 MB/s Nov 28 14:57:03 volumio volumio[3276]: info: camilladsp spawned new process with pid 21801, instance 1, run: true Nov 28 14:57:04 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:04 volumio volumio[3276]: 1+1 records in Nov 28 14:57:04 volumio volumio[3276]: 1+1 records out Nov 28 14:57:04 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000161333 s, 383 MB/s Nov 28 14:57:04 volumio volumio[3276]: info: camilladsp spawned new process with pid 21806, instance 2, run: true Nov 28 14:57:04 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:04 volumio volumio[3276]: 2+0 records in Nov 28 14:57:04 volumio volumio[3276]: 2+0 records out Nov 28 14:57:04 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000158332 s, 414 MB/s Nov 28 14:57:04 volumio volumio[3276]: info: camilladsp spawned new process with pid 21811, instance 2, run: true Nov 28 14:57:04 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:04 volumio volumio[3276]: 1+1 records in Nov 28 14:57:04 volumio volumio[3276]: 1+1 records out Nov 28 14:57:04 volumio volumio[3276]: 63920 bytes (64 kB, 62 KiB) copied, 0.00015387 s, 415 MB/s Nov 28 14:57:04 volumio volumio[3276]: info: camilladsp spawned new process with pid 21816, instance 1, run: true Nov 28 14:57:05 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:05 volumio volumio[3276]: 1+1 records in Nov 28 14:57:05 volumio volumio[3276]: 1+1 records out Nov 28 14:57:05 volumio volumio[3276]: 63328 bytes (63 kB, 62 KiB) copied, 0.00015587 s, 406 MB/s Nov 28 14:57:05 volumio volumio[3276]: info: camilladsp spawned new process with pid 21821, instance 2, run: true Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 28 14:57:05 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 28 14:57:05 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:05 volumio volumio[3276]: 1+1 records in Nov 28 14:57:05 volumio volumio[3276]: 1+1 records out Nov 28 14:57:05 volumio volumio[3276]: 64864 bytes (65 kB, 63 KiB) copied, 0.00016074 s, 404 MB/s Nov 28 14:57:05 volumio volumio[3276]: info: camilladsp spawned new process with pid 21830, instance 2, run: true Nov 28 14:57:05 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:05 volumio volumio[3276]: 1+1 records in Nov 28 14:57:05 volumio volumio[3276]: 1+1 records out Nov 28 14:57:05 volumio volumio[3276]: 64576 bytes (65 kB, 63 KiB) copied, 0.000142333 s, 454 MB/s Nov 28 14:57:05 volumio volumio[3276]: info: camilladsp spawned new process with pid 21835, instance 1, run: true Nov 28 14:57:06 volumio volumio[3276]: info: [1732823826199] [80s80s] Pushing the next song state Aretha Franklin & George Michael - I Knew You Were Waiting (For Me) and getting next track. Nov 28 14:57:06 volumio volumio[3276]: info: CoreCommandRouter::servicePushState Nov 28 14:57:06 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:57:06 volumio volumio[3276]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received 80s80s Nov 28 14:57:06 volumio volumio[3276]: info: [1732823826200] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=1 Nov 28 14:57:06 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:06 volumio volumio[3276]: 1+1 records in Nov 28 14:57:06 volumio volumio[3276]: 1+1 records out Nov 28 14:57:06 volumio volumio[3276]: 63344 bytes (63 kB, 62 KiB) copied, 0.000151074 s, 419 MB/s Nov 28 14:57:06 volumio volumio[3276]: info: camilladsp spawned new process with pid 21840, instance 2, run: true Nov 28 14:57:06 volumio volumio[3276]: info: CorePlayQueue::getTrack 1 Nov 28 14:57:06 volumio volumio[3276]: info: CorePlayQueue::getTrack 2 Nov 28 14:57:06 volumio volumio[3276]: info: Prefetching next song Nov 28 14:57:06 volumio volumio[3276]: info: [1732823826690] [80s80s] received new event containing 1 songs. Nov 28 14:57:06 volumio volumio[3276]: info: [1732823826690] [80s80s] PlayNextTrack API delay: 30 Nov 28 14:57:06 volumio volumio[3276]: info: [1732823826696] [80s80s] Setting timer to: 230000 milliseconds. Nov 28 14:57:06 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:06 volumio volumio[3276]: 1+1 records in Nov 28 14:57:06 volumio volumio[3276]: 1+1 records out Nov 28 14:57:06 volumio volumio[3276]: 64848 bytes (65 kB, 63 KiB) copied, 0.000151426 s, 428 MB/s Nov 28 14:57:06 volumio volumio[3276]: info: camilladsp spawned new process with pid 21859, instance 2, run: true Nov 28 14:57:06 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:06 volumio volumio[3276]: 2+0 records in Nov 28 14:57:06 volumio volumio[3276]: 2+0 records out Nov 28 14:57:06 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000146518 s, 447 MB/s Nov 28 14:57:06 volumio volumio[3276]: info: camilladsp spawned new process with pid 21864, instance 1, run: true Nov 28 14:57:07 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:07 volumio volumio[3276]: 1+1 records in Nov 28 14:57:07 volumio volumio[3276]: 1+1 records out Nov 28 14:57:07 volumio volumio[3276]: 58560 bytes (59 kB, 57 KiB) copied, 0.000155759 s, 376 MB/s Nov 28 14:57:07 volumio volumio[3276]: info: camilladsp spawned new process with pid 21869, instance 2, run: true Nov 28 14:57:07 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:07 volumio volumio[3276]: 2+0 records in Nov 28 14:57:07 volumio volumio[3276]: 2+0 records out Nov 28 14:57:07 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000151 s, 434 MB/s Nov 28 14:57:07 volumio volumio[3276]: info: camilladsp spawned new process with pid 21877, instance 2, run: true Nov 28 14:57:07 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:07 volumio volumio[3276]: 1+1 records in Nov 28 14:57:07 volumio volumio[3276]: 1+1 records out Nov 28 14:57:07 volumio volumio[3276]: 61456 bytes (61 kB, 60 KiB) copied, 0.000155222 s, 396 MB/s Nov 28 14:57:07 volumio volumio[3276]: info: camilladsp spawned new process with pid 21882, instance 1, run: true Nov 28 14:57:08 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:08 volumio volumio[3276]: 1+1 records in Nov 28 14:57:08 volumio volumio[3276]: 1+1 records out Nov 28 14:57:08 volumio volumio[3276]: 61680 bytes (62 kB, 60 KiB) copied, 0.000157481 s, 392 MB/s Nov 28 14:57:08 volumio volumio[3276]: info: camilladsp spawned new process with pid 21887, instance 2, run: true Nov 28 14:57:08 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:08 volumio volumio[3276]: 2+0 records in Nov 28 14:57:08 volumio volumio[3276]: 2+0 records out Nov 28 14:57:08 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000163166 s, 402 MB/s Nov 28 14:57:08 volumio volumio[3276]: info: camilladsp spawned new process with pid 21892, instance 2, run: true Nov 28 14:57:08 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:08 volumio volumio[3276]: 1+1 records in Nov 28 14:57:08 volumio volumio[3276]: 1+1 records out Nov 28 14:57:08 volumio volumio[3276]: 61472 bytes (61 kB, 60 KiB) copied, 0.000157295 s, 391 MB/s Nov 28 14:57:08 volumio volumio[3276]: info: camilladsp spawned new process with pid 21897, instance 1, run: true Nov 28 14:57:09 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:09 volumio volumio[3276]: 2+0 records in Nov 28 14:57:09 volumio volumio[3276]: 2+0 records out Nov 28 14:57:09 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000167703 s, 391 MB/s Nov 28 14:57:09 volumio volumio[3276]: info: camilladsp spawned new process with pid 21902, instance 2, run: true Nov 28 14:57:09 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:09 volumio volumio[3276]: 16+1 records in Nov 28 14:57:09 volumio volumio[3276]: 16+1 records out Nov 28 14:57:09 volumio volumio[3276]: 553776 bytes (554 kB, 541 KiB) copied, 0.00140388 s, 394 MB/s Nov 28 14:57:09 volumio volumio[3276]: info: camilladsp spawned new process with pid 21907, instance 2, run: true Nov 28 14:57:10 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:10 volumio volumio[3276]: 2+0 records in Nov 28 14:57:10 volumio volumio[3276]: 2+0 records out Nov 28 14:57:10 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000150573 s, 435 MB/s Nov 28 14:57:10 volumio volumio[3276]: info: camilladsp spawned new process with pid 21912, instance 1, run: true Nov 28 14:57:10 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 14:57:10 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 28 14:57:10 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:10 volumio volumio[3276]: 1+1 records in Nov 28 14:57:10 volumio volumio[3276]: 1+1 records out Nov 28 14:57:10 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000159462 s, 387 MB/s Nov 28 14:57:10 volumio volumio[3276]: info: camilladsp spawned new process with pid 21917, instance 2, run: true Nov 28 14:57:11 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:11 volumio volumio[3276]: 2+0 records in Nov 28 14:57:11 volumio volumio[3276]: 2+0 records out Nov 28 14:57:11 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000153796 s, 426 MB/s Nov 28 14:57:11 volumio volumio[3276]: info: camilladsp spawned new process with pid 21922, instance 2, run: true Nov 28 14:57:11 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:11 volumio volumio[3276]: 10+1 records in Nov 28 14:57:11 volumio volumio[3276]: 10+1 records out Nov 28 14:57:11 volumio volumio[3276]: 356896 bytes (357 kB, 349 KiB) copied, 0.000980477 s, 364 MB/s Nov 28 14:57:11 volumio volumio[3276]: info: camilladsp spawned new process with pid 21927, instance 1, run: true Nov 28 14:57:11 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:11 volumio volumio[3276]: 1+1 records in Nov 28 14:57:11 volumio volumio[3276]: 1+1 records out Nov 28 14:57:11 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000166166 s, 371 MB/s Nov 28 14:57:11 volumio volumio[3276]: info: camilladsp spawned new process with pid 21932, instance 2, run: true Nov 28 14:57:12 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:12 volumio volumio[3276]: 2+0 records in Nov 28 14:57:12 volumio volumio[3276]: 2+0 records out Nov 28 14:57:12 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000154555 s, 424 MB/s Nov 28 14:57:12 volumio volumio[3276]: info: camilladsp spawned new process with pid 21937, instance 2, run: true Nov 28 14:57:12 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:12 volumio volumio[3276]: 2+0 records in Nov 28 14:57:12 volumio volumio[3276]: 2+0 records out Nov 28 14:57:12 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000152758 s, 429 MB/s Nov 28 14:57:12 volumio volumio[3276]: info: camilladsp spawned new process with pid 21942, instance 1, run: true Nov 28 14:57:12 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:12 volumio volumio[3276]: 1+1 records in Nov 28 14:57:12 volumio volumio[3276]: 1+1 records out Nov 28 14:57:12 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000173592 s, 356 MB/s Nov 28 14:57:12 volumio volumio[3276]: info: camilladsp spawned new process with pid 21947, instance 2, run: true Nov 28 14:57:13 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:13 volumio volumio[3276]: 1+1 records in Nov 28 14:57:13 volumio volumio[3276]: 1+1 records out Nov 28 14:57:13 volumio volumio[3276]: 64672 bytes (65 kB, 63 KiB) copied, 0.000149703 s, 432 MB/s Nov 28 14:57:13 volumio volumio[3276]: info: camilladsp spawned new process with pid 21952, instance 2, run: true Nov 28 14:57:13 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:13 volumio volumio[3276]: 2+0 records in Nov 28 14:57:13 volumio volumio[3276]: 2+0 records out Nov 28 14:57:13 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000142666 s, 459 MB/s Nov 28 14:57:13 volumio volumio[3276]: info: camilladsp spawned new process with pid 21957, instance 1, run: true Nov 28 14:57:13 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:13 volumio volumio[3276]: 1+1 records in Nov 28 14:57:13 volumio volumio[3276]: 1+1 records out Nov 28 14:57:13 volumio volumio[3276]: 62576 bytes (63 kB, 61 KiB) copied, 0.000161777 s, 387 MB/s Nov 28 14:57:13 volumio volumio[3276]: info: camilladsp spawned new process with pid 21962, instance 2, run: true Nov 28 14:57:14 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:14 volumio volumio[3276]: 1+1 records in Nov 28 14:57:14 volumio volumio[3276]: 1+1 records out Nov 28 14:57:14 volumio volumio[3276]: 64656 bytes (65 kB, 63 KiB) copied, 0.000162332 s, 398 MB/s Nov 28 14:57:14 volumio volumio[3276]: info: camilladsp spawned new process with pid 21967, instance 2, run: true Nov 28 14:57:14 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:14 volumio volumio[3276]: 9+1 records in Nov 28 14:57:14 volumio volumio[3276]: 9+1 records out Nov 28 14:57:14 volumio volumio[3276]: 325008 bytes (325 kB, 317 KiB) copied, 0.000929274 s, 350 MB/s Nov 28 14:57:14 volumio volumio[3276]: info: camilladsp spawned new process with pid 21972, instance 1, run: true Nov 28 14:57:14 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:14 volumio volumio[3276]: 2+0 records in Nov 28 14:57:14 volumio volumio[3276]: 2+0 records out Nov 28 14:57:14 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000151407 s, 433 MB/s Nov 28 14:57:14 volumio volumio[3276]: info: camilladsp spawned new process with pid 21977, instance 2, run: true Nov 28 14:57:15 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:15 volumio volumio[3276]: 1+1 records in Nov 28 14:57:15 volumio volumio[3276]: 1+1 records out Nov 28 14:57:15 volumio volumio[3276]: 61712 bytes (62 kB, 60 KiB) copied, 0.000154629 s, 399 MB/s Nov 28 14:57:15 volumio volumio[3276]: info: camilladsp spawned new process with pid 21982, instance 2, run: true Nov 28 14:57:15 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:15 volumio volumio[3276]: 1+1 records in Nov 28 14:57:15 volumio volumio[3276]: 1+1 records out Nov 28 14:57:15 volumio volumio[3276]: 64608 bytes (65 kB, 63 KiB) copied, 0.00022124 s, 292 MB/s Nov 28 14:57:15 volumio volumio[3276]: info: camilladsp spawned new process with pid 21987, instance 1, run: true Nov 28 14:57:15 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:15 volumio volumio[3276]: 2+0 records in Nov 28 14:57:15 volumio volumio[3276]: 2+0 records out Nov 28 14:57:15 volumio volumio[3276]: 65536 bytes (66 kB, 64 KiB) copied, 0.000154296 s, 425 MB/s Nov 28 14:57:15 volumio volumio[3276]: info: camilladsp spawned new process with pid 21992, instance 2, run: true Nov 28 14:57:16 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:16 volumio volumio[3276]: 1+1 records in Nov 28 14:57:16 volumio volumio[3276]: 1+1 records out Nov 28 14:57:16 volumio volumio[3276]: 58560 bytes (59 kB, 57 KiB) copied, 0.000162944 s, 359 MB/s Nov 28 14:57:16 volumio volumio[3276]: info: camilladsp spawned new process with pid 21997, instance 2, run: true Nov 28 14:57:16 volumio volumio[3276]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 28 14:57:16 volumio volumio[3276]: 1+1 records in Nov 28 14:57:16 volumio volumio[3276]: 1+1 records out Nov 28 14:57:16 volumio volumio[3276]: 64576 bytes (65 kB, 63 KiB) copied, 0.00014924 s, 433 MB/s Nov 28 14:57:16 volumio volumio[3276]: info: camilladsp spawned new process with pid 22002, instance 1, run: true Nov 28 14:57:16 volumio volumio[3276]: info: Starting Uninstall of plugin audio_interface - fusiondsp Nov 28 14:57:16 volumio volumio[3276]: info: Uninstalling plugin fusiondsp Nov 28 14:57:16 volumio volumio[3276]: info: FusionDsp - Stopping FusionDsp service Nov 28 14:57:16 volumio volumio[3276]: info: camilladsp service terminated, instance 2 Nov 28 14:57:16 volumio volumio[3276]: info: Disabling plugin fusiondsp Nov 28 14:57:16 volumio volumio[3276]: info: Preparing to generate the ALSA configuration file Nov 28 14:57:16 volumio sudo[22008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Nov 28 14:57:16 volumio sudo[22008]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:57:16 volumio systemd[1]: Stopping FusionDsp Daemon... Nov 28 14:57:16 volumio volumio[5573]: Backend configuration: Nov 28 14:57:16 volumio volumio[5573]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Nov 28 14:57:16 volumio volumio[5573]: active_config_txt: null Nov 28 14:57:16 volumio volumio[5573]: camilla_host: 127.0.0.1 Nov 28 14:57:16 volumio volumio[5573]: camilla_port: 9876 Nov 28 14:57:16 volumio volumio[5573]: coeff_dir: /data/INTERNAL/FusionDsp/filters Nov 28 14:57:16 volumio volumio[5573]: config_dir: /data/configuration/audio_interface/fusiondsp Nov 28 14:57:16 volumio volumio[5573]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Nov 28 14:57:16 volumio volumio[5573]: log_file: /tmp/camilladsp.log Nov 28 14:57:16 volumio volumio[5573]: on_get_active_config: null Nov 28 14:57:16 volumio volumio[5573]: on_set_active_config: null Nov 28 14:57:16 volumio volumio[5573]: port: 5011 Nov 28 14:57:16 volumio volumio[5573]: supported_capture_types: null Nov 28 14:57:16 volumio volumio[5573]: supported_playback_types: null Nov 28 14:57:16 volumio volumio[5573]: update_config_symlink: false Nov 28 14:57:16 volumio volumio[5573]: update_config_txt: false Nov 28 14:57:16 volumio volumio[5573]: ======== Running on http://0.0.0.0:5011 ======== Nov 28 14:57:16 volumio volumio[5573]: (Press CTRL+C to quit) Nov 28 14:57:16 volumio volumio[3276]: info: Asound.conf file written Nov 28 14:57:16 volumio sudo[22011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 28 14:57:16 volumio sudo[22011]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:57:16 volumio sudo[22011]: pam_unix(sudo:session): session closed for user root Nov 28 14:57:16 volumio volumio[3276]: No state is present for card vc4hdmi0 Nov 28 14:57:16 volumio volumio[3276]: Found hardware: "vc4-hdmi" "" "" "" "" Nov 28 14:57:16 volumio volumio[3276]: Hardware is initialized using a generic method Nov 28 14:57:16 volumio volumio[3276]: No state is present for card vc4hdmi0 Nov 28 14:57:16 volumio volumio[3276]: No state is present for card vc4hdmi1 Nov 28 14:57:16 volumio volumio[3276]: Found hardware: "vc4-hdmi" "" "" "" "" Nov 28 14:57:16 volumio volumio[3276]: Hardware is initialized using a generic method Nov 28 14:57:16 volumio volumio[3276]: No state is present for card vc4hdmi1 Nov 28 14:57:16 volumio volumio[3276]: No state is present for card Audio Nov 28 14:57:16 volumio volumio[3276]: Found hardware: "USB-Audio" "USB Mixer" "USB1852:7022" "" "" Nov 28 14:57:16 volumio volumio[3276]: Hardware is initialized using a generic method Nov 28 14:57:16 volumio volumio[3276]: No state is present for card Audio Nov 28 14:57:16 volumio volumio[3276]: info: Output device has changed, restarting MPD Nov 28 14:57:16 volumio systemd[1]: fusiondsp.service: Succeeded. Nov 28 14:57:16 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 28 14:57:16 volumio sudo[22016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 28 14:57:16 volumio sudo[22016]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:57:16 volumio sudo[22016]: pam_unix(sudo:session): session closed for user root Nov 28 14:57:16 volumio volumio[3276]: info: Output device has changed, restarting Shairport Sync Nov 28 14:57:16 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 14:57:16 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 14:57:16 volumio sudo[22019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 28 14:57:16 volumio sudo[22019]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:57:16 volumio sudo[22008]: pam_unix(sudo:session): session closed for user root Nov 28 14:57:16 volumio systemd[1]: Stopping Music Player Daemon... Nov 28 14:57:16 volumio volumio[3276]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 28 14:57:16 volumio systemd[1]: mpd.service: Succeeded. Nov 28 14:57:16 volumio systemd[1]: Stopped Music Player Daemon. Nov 28 14:57:16 volumio volumio[3276]: info: Checking if uninstall.sh is present Nov 28 14:57:16 volumio volumio[3276]: info: MPD Permissions set Nov 28 14:57:16 volumio volumio[3276]: info: FusionDsp - Reporting Fusion DSP Disabled Nov 28 14:57:16 volumio volumio[3276]: info: Removing fusiondspeq DSP Signal Path Element Nov 28 14:57:16 volumio volumio[3276]: info: Executing uninstall.sh Nov 28 14:57:16 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 14:57:16 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 14:57:16 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 14:57:16 volumio volumio[3276]: info: Starting Shairport Sync Nov 28 14:57:16 volumio systemd[1]: Starting Music Player Daemon... Nov 28 14:57:16 volumio sudo[22027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Nov 28 14:57:16 volumio sudo[22027]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:57:16 volumio sudo[22037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 28 14:57:16 volumio sudo[22037]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:57:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 28 14:57:16 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 28 14:57:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 28 14:57:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 28 14:57:16 volumio sudo[22037]: pam_unix(sudo:session): session closed for user root Nov 28 14:57:16 volumio sudo[22024]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 28 14:57:16 volumio sudo[22024]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:57:16 volumio volumio[3276]: info: Shairport-Sync Started Nov 28 14:57:16 volumio sudo[22024]: pam_unix(sudo:session): session closed for user root Nov 28 14:57:16 volumio sudo[22044]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /etc/systemd/system/multi-user.target.wants/fusiondsp.service Nov 28 14:57:16 volumio sudo[22044]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:57:16 volumio sudo[22044]: pam_unix(sudo:session): session closed for user root Nov 28 14:57:16 volumio sudo[22027]: pam_unix(sudo:session): session closed for user root Nov 28 14:57:16 volumio volumio[3276]: info: Uninstall script completed Nov 28 14:57:16 volumio volumio[3276]: info: Removing plugin fusiondsp from configuration Nov 28 14:57:16 volumio volumio[3276]: info: Successfully removed fusiondsp configuration files Nov 28 14:57:16 volumio volumio[3276]: info: Plugin folders cleanup Nov 28 14:57:16 volumio volumio[3276]: info: Scanning into folder /volumio/app/plugins/ Nov 28 14:57:16 volumio volumio[3276]: info: Scanning category audio_interface Nov 28 14:57:16 volumio volumio[3276]: info: Scanning category miscellanea Nov 28 14:57:16 volumio volumio[3276]: info: Scanning category music_service Nov 28 14:57:16 volumio volumio[3276]: info: Scanning category plugins.json Nov 28 14:57:16 volumio volumio[3276]: info: Scanning category system_controller Nov 28 14:57:16 volumio volumio[3276]: info: Scanning category user_interface Nov 28 14:57:16 volumio volumio[3276]: info: Scanning into folder /data/plugins/ Nov 28 14:57:16 volumio volumio[3276]: info: Scanning category audio_interface Nov 28 14:57:16 volumio volumio[3276]: info: Cleaning folder for fusiondsp Nov 28 14:57:16 volumio volumio[3276]: info: Scanning category music_service Nov 28 14:57:16 volumio volumio[3276]: info: Plugin folders cleanup completed Nov 28 14:57:16 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 14:57:16 volumio volumio[3276]: info: [{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"pandora","name":"pandora","category":"music_service","version":"2.12.1","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true}] Nov 28 14:57:16 volumio volumio[3276]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 28 14:57:16 volumio mpd[22045]: Nov 28 14:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 28 14:57:16 volumio systemd[1]: Started Music Player Daemon. Nov 28 14:57:16 volumio sudo[22019]: pam_unix(sudo:session): session closed for user root Nov 28 14:57:16 volumio volumio[3276]: error: updateQueue error: null Nov 28 14:57:17 volumio volumio[3276]: 0+0 records in Nov 28 14:57:17 volumio volumio[3276]: 0+0 records out Nov 28 14:57:17 volumio volumio[3276]: 0 bytes copied, 4.8444e-05 s, 0.0 kB/s Nov 28 14:57:17 volumio volumio[3276]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 28 14:57:17 volumio volumio[3276]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 14:57:17 volumio volumio[3276]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 28 14:57:17 volumio volumio[3276]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 28 14:57:17 volumio volumio[3276]: at onErrorNT (internal/child_process.js:465:16) Nov 28 14:57:17 volumio volumio[3276]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Nov 28 14:57:17 volumio volumio[3276]: errno: -2, Nov 28 14:57:17 volumio volumio[3276]: code: 'ENOENT', Nov 28 14:57:17 volumio volumio[3276]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 28 14:57:17 volumio volumio[3276]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 28 14:57:17 volumio volumio[3276]: spawnargs: [ Nov 28 14:57:17 volumio volumio[3276]: '-p', Nov 28 14:57:17 volumio volumio[3276]: 9876, Nov 28 14:57:17 volumio volumio[3276]: '-o', Nov 28 14:57:17 volumio volumio[3276]: '/tmp/camilladsp.log', Nov 28 14:57:17 volumio volumio[3276]: '-l', Nov 28 14:57:17 volumio volumio[3276]: 'warn', Nov 28 14:57:17 volumio volumio[3276]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 28 14:57:17 volumio volumio[3276]: ] Nov 28 14:57:17 volumio volumio[3276]: } Nov 28 14:57:17 volumio volumio[3276]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 14:57:17 volumio sudo[22082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-28 14:56 Nov 28 14:57:17 volumio sudo[22082]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"