-- Logs begin at Thu 2019-02-14 10:12:00 UTC, end at Thu 2024-11-21 18:09:47 UTC. -- Nov 21 18:08:00 kos volumio[1031]: 0+0 records in Nov 21 18:08:00 kos volumio[1031]: 0+0 records out Nov 21 18:08:00 kos volumio[1031]: 0 bytes copied, 0.000235408 s, 0.0 kB/s Nov 21 18:08:00 kos volumio[1031]: info: camilladsp spawned new process with pid 3461, instance 1, run: true Nov 21 18:08:02 kos volumio[1031]: 0+0 records in Nov 21 18:08:02 kos volumio[1031]: 0+0 records out Nov 21 18:08:02 kos volumio[1031]: 0 bytes copied, 0.000124006 s, 0.0 kB/s Nov 21 18:08:02 kos volumio[1031]: info: camilladsp spawned new process with pid 3466, instance 1, run: true Nov 21 18:08:03 kos volumio[1031]: 0+0 records in Nov 21 18:08:03 kos volumio[1031]: 0+0 records out Nov 21 18:08:03 kos volumio[1031]: 0 bytes copied, 0.000241293 s, 0.0 kB/s Nov 21 18:08:03 kos volumio[1031]: info: camilladsp spawned new process with pid 3472, instance 1, run: true Nov 21 18:08:04 kos volumio[1031]: 0+0 records in Nov 21 18:08:04 kos volumio[1031]: 0+0 records out Nov 21 18:08:04 kos volumio[1031]: 0 bytes copied, 0.000237232 s, 0.0 kB/s Nov 21 18:08:04 kos volumio[1031]: info: camilladsp spawned new process with pid 3477, instance 1, run: true Nov 21 18:08:05 kos volumio[1031]: 0+0 records in Nov 21 18:08:05 kos volumio[1031]: 0+0 records out Nov 21 18:08:05 kos volumio[1031]: 0 bytes copied, 0.000234367 s, 0.0 kB/s Nov 21 18:08:05 kos volumio[1031]: info: camilladsp spawned new process with pid 3482, instance 1, run: true Nov 21 18:08:06 kos volumio[1031]: 0+0 records in Nov 21 18:08:06 kos volumio[1031]: 0+0 records out Nov 21 18:08:06 kos volumio[1031]: 0 bytes copied, 0.000243325 s, 0.0 kB/s Nov 21 18:08:06 kos volumio[1031]: info: camilladsp spawned new process with pid 3501, instance 1, run: true Nov 21 18:08:07 kos volumio[1031]: 0+0 records in Nov 21 18:08:07 kos volumio[1031]: 0+0 records out Nov 21 18:08:07 kos volumio[1031]: 0 bytes copied, 0.000239158 s, 0.0 kB/s Nov 21 18:08:07 kos volumio[1031]: info: camilladsp spawned new process with pid 3506, instance 1, run: true Nov 21 18:08:08 kos volumio[1031]: 0+0 records in Nov 21 18:08:08 kos volumio[1031]: 0+0 records out Nov 21 18:08:08 kos volumio[1031]: 0 bytes copied, 0.000277074 s, 0.0 kB/s Nov 21 18:08:08 kos volumio[1031]: info: camilladsp spawned new process with pid 3511, instance 1, run: true Nov 21 18:08:09 kos volumio[1031]: 0+0 records in Nov 21 18:08:09 kos volumio[1031]: 0+0 records out Nov 21 18:08:09 kos volumio[1031]: 0 bytes copied, 0.000138641 s, 0.0 kB/s Nov 21 18:08:09 kos volumio[1031]: info: camilladsp spawned new process with pid 3516, instance 1, run: true Nov 21 18:08:10 kos volumio[1031]: 0+0 records in Nov 21 18:08:10 kos volumio[1031]: 0+0 records out Nov 21 18:08:10 kos volumio[1031]: 0 bytes copied, 0.000235409 s, 0.0 kB/s Nov 21 18:08:10 kos volumio[1031]: info: camilladsp spawned new process with pid 3524, instance 1, run: true Nov 21 18:08:11 kos volumio[1031]: 0+0 records in Nov 21 18:08:11 kos volumio[1031]: 0+0 records out Nov 21 18:08:11 kos volumio[1031]: 0 bytes copied, 0.000241502 s, 0.0 kB/s Nov 21 18:08:11 kos volumio[1031]: info: camilladsp spawned new process with pid 3529, instance 1, run: true Nov 21 18:08:12 kos volumio[1031]: 0+0 records in Nov 21 18:08:12 kos volumio[1031]: 0+0 records out Nov 21 18:08:12 kos volumio[1031]: 0 bytes copied, 0.000234731 s, 0.0 kB/s Nov 21 18:08:12 kos volumio[1031]: info: camilladsp spawned new process with pid 3534, instance 1, run: true Nov 21 18:08:13 kos volumio[1031]: 0+0 records in Nov 21 18:08:13 kos volumio[1031]: 0+0 records out Nov 21 18:08:13 kos volumio[1031]: 0 bytes copied, 0.000213534 s, 0.0 kB/s Nov 21 18:08:13 kos volumio[1031]: info: camilladsp spawned new process with pid 3539, instance 1, run: true Nov 21 18:08:14 kos volumio[1031]: 0+0 records in Nov 21 18:08:14 kos volumio[1031]: 0+0 records out Nov 21 18:08:14 kos volumio[1031]: 0 bytes copied, 0.000236398 s, 0.0 kB/s Nov 21 18:08:14 kos volumio[1031]: info: camilladsp spawned new process with pid 3544, instance 1, run: true Nov 21 18:08:15 kos volumio[1031]: 0+0 records in Nov 21 18:08:15 kos volumio[1031]: 0+0 records out Nov 21 18:08:15 kos volumio[1031]: 0 bytes copied, 0.000243169 s, 0.0 kB/s Nov 21 18:08:15 kos volumio[1031]: info: camilladsp spawned new process with pid 3563, instance 1, run: true Nov 21 18:08:17 kos volumio[1031]: 0+0 records in Nov 21 18:08:17 kos volumio[1031]: 0+0 records out Nov 21 18:08:17 kos volumio[1031]: 0 bytes copied, 0.000239158 s, 0.0 kB/s Nov 21 18:08:17 kos volumio[1031]: info: camilladsp spawned new process with pid 3568, instance 1, run: true Nov 21 18:08:18 kos volumio[1031]: 0+0 records in Nov 21 18:08:18 kos volumio[1031]: 0+0 records out Nov 21 18:08:18 kos volumio[1031]: 0 bytes copied, 0.000122235 s, 0.0 kB/s Nov 21 18:08:18 kos volumio[1031]: info: camilladsp spawned new process with pid 3573, instance 1, run: true Nov 21 18:08:19 kos volumio[1031]: 0+0 records in Nov 21 18:08:19 kos volumio[1031]: 0+0 records out Nov 21 18:08:19 kos volumio[1031]: 0 bytes copied, 0.000236502 s, 0.0 kB/s Nov 21 18:08:19 kos volumio[1031]: info: camilladsp spawned new process with pid 3578, instance 1, run: true Nov 21 18:08:20 kos volumio[1031]: 0+0 records in Nov 21 18:08:20 kos volumio[1031]: 0+0 records out Nov 21 18:08:20 kos volumio[1031]: 0 bytes copied, 0.000239472 s, 0.0 kB/s Nov 21 18:08:20 kos volumio[1031]: info: camilladsp spawned new process with pid 3586, instance 1, run: true Nov 21 18:08:21 kos volumio[1031]: 0+0 records in Nov 21 18:08:21 kos volumio[1031]: 0+0 records out Nov 21 18:08:21 kos volumio[1031]: 0 bytes copied, 0.0002377 s, 0.0 kB/s Nov 21 18:08:21 kos volumio[1031]: info: camilladsp spawned new process with pid 3591, instance 1, run: true Nov 21 18:08:22 kos volumio[1031]: 0+0 records in Nov 21 18:08:22 kos volumio[1031]: 0+0 records out Nov 21 18:08:22 kos volumio[1031]: 0 bytes copied, 0.000120308 s, 0.0 kB/s Nov 21 18:08:22 kos volumio[1031]: info: camilladsp spawned new process with pid 3596, instance 1, run: true Nov 21 18:08:23 kos volumio[1031]: 0+0 records in Nov 21 18:08:23 kos volumio[1031]: 0+0 records out Nov 21 18:08:23 kos volumio[1031]: 0 bytes copied, 0.000278168 s, 0.0 kB/s Nov 21 18:08:23 kos volumio[1031]: info: camilladsp spawned new process with pid 3602, instance 1, run: true Nov 21 18:08:24 kos volumio[1031]: 0+0 records in Nov 21 18:08:24 kos volumio[1031]: 0+0 records out Nov 21 18:08:24 kos volumio[1031]: 0 bytes copied, 0.000237283 s, 0.0 kB/s Nov 21 18:08:24 kos volumio[1031]: info: camilladsp spawned new process with pid 3607, instance 1, run: true Nov 21 18:08:25 kos volumio[1031]: 0+0 records in Nov 21 18:08:25 kos volumio[1031]: 0+0 records out Nov 21 18:08:25 kos volumio[1031]: 0 bytes copied, 0.000240461 s, 0.0 kB/s Nov 21 18:08:25 kos volumio[1031]: info: camilladsp spawned new process with pid 3626, instance 1, run: true Nov 21 18:08:26 kos volumio[1031]: 0+0 records in Nov 21 18:08:26 kos volumio[1031]: 0+0 records out Nov 21 18:08:26 kos volumio[1031]: 0 bytes copied, 0.000122548 s, 0.0 kB/s Nov 21 18:08:26 kos volumio[1031]: info: camilladsp spawned new process with pid 3631, instance 1, run: true Nov 21 18:08:27 kos volumio[1031]: 0+0 records in Nov 21 18:08:27 kos volumio[1031]: 0+0 records out Nov 21 18:08:27 kos volumio[1031]: 0 bytes copied, 0.000240356 s, 0.0 kB/s Nov 21 18:08:27 kos volumio[1031]: info: camilladsp spawned new process with pid 3636, instance 1, run: true Nov 21 18:08:28 kos volumio[1031]: 0+0 records in Nov 21 18:08:28 kos volumio[1031]: 0+0 records out Nov 21 18:08:28 kos volumio[1031]: 0 bytes copied, 0.00023817 s, 0.0 kB/s Nov 21 18:08:28 kos volumio[1031]: info: camilladsp spawned new process with pid 3641, instance 1, run: true Nov 21 18:08:29 kos volumio[1031]: 0+0 records in Nov 21 18:08:29 kos volumio[1031]: 0+0 records out Nov 21 18:08:29 kos volumio[1031]: 0 bytes copied, 0.000238586 s, 0.0 kB/s Nov 21 18:08:29 kos volumio[1031]: info: camilladsp spawned new process with pid 3646, instance 1, run: true Nov 21 18:08:30 kos volumio[1031]: 0+0 records in Nov 21 18:08:30 kos volumio[1031]: 0+0 records out Nov 21 18:08:30 kos volumio[1031]: 0 bytes copied, 0.00012411 s, 0.0 kB/s Nov 21 18:08:30 kos volumio[1031]: info: camilladsp spawned new process with pid 3654, instance 1, run: true Nov 21 18:08:32 kos volumio[1031]: 0+0 records in Nov 21 18:08:32 kos volumio[1031]: 0+0 records out Nov 21 18:08:32 kos volumio[1031]: 0 bytes copied, 0.00027697 s, 0.0 kB/s Nov 21 18:08:32 kos volumio[1031]: info: camilladsp spawned new process with pid 3659, instance 1, run: true Nov 21 18:08:33 kos volumio[1031]: 0+0 records in Nov 21 18:08:33 kos volumio[1031]: 0+0 records out Nov 21 18:08:33 kos volumio[1031]: 0 bytes copied, 0.000238065 s, 0.0 kB/s Nov 21 18:08:33 kos volumio[1031]: info: camilladsp spawned new process with pid 3664, instance 1, run: true Nov 21 18:08:34 kos volumio[1031]: 0+0 records in Nov 21 18:08:34 kos volumio[1031]: 0+0 records out Nov 21 18:08:34 kos volumio[1031]: 0 bytes copied, 0.000288584 s, 0.0 kB/s Nov 21 18:08:34 kos volumio[1031]: info: camilladsp spawned new process with pid 3669, instance 1, run: true Nov 21 18:08:35 kos volumio[1031]: 0+0 records in Nov 21 18:08:35 kos volumio[1031]: 0+0 records out Nov 21 18:08:35 kos volumio[1031]: 0 bytes copied, 0.00014234 s, 0.0 kB/s Nov 21 18:08:35 kos volumio[1031]: info: camilladsp spawned new process with pid 3674, instance 1, run: true Nov 21 18:08:36 kos volumio[1031]: 0+0 records in Nov 21 18:08:36 kos volumio[1031]: 0+0 records out Nov 21 18:08:36 kos volumio[1031]: 0 bytes copied, 0.000238586 s, 0.0 kB/s Nov 21 18:08:36 kos volumio[1031]: info: camilladsp spawned new process with pid 3693, instance 1, run: true Nov 21 18:08:37 kos volumio[1031]: 0+0 records in Nov 21 18:08:37 kos volumio[1031]: 0+0 records out Nov 21 18:08:37 kos volumio[1031]: 0 bytes copied, 0.000235513 s, 0.0 kB/s Nov 21 18:08:37 kos volumio[1031]: info: camilladsp spawned new process with pid 3736, instance 1, run: true Nov 21 18:08:38 kos volumio[1031]: 0+0 records in Nov 21 18:08:38 kos volumio[1031]: 0+0 records out Nov 21 18:08:38 kos volumio[1031]: 0 bytes copied, 0.000238534 s, 0.0 kB/s Nov 21 18:08:38 kos volumio[1031]: info: camilladsp spawned new process with pid 3741, instance 1, run: true Nov 21 18:08:39 kos volumio[1031]: 0+0 records in Nov 21 18:08:39 kos volumio[1031]: 0+0 records out Nov 21 18:08:39 kos volumio[1031]: 0 bytes copied, 0.000123902 s, 0.0 kB/s Nov 21 18:08:39 kos volumio[1031]: info: camilladsp spawned new process with pid 3746, instance 1, run: true Nov 21 18:08:40 kos volumio[1031]: 0+0 records in Nov 21 18:08:40 kos volumio[1031]: 0+0 records out Nov 21 18:08:40 kos volumio[1031]: 0 bytes copied, 0.000239368 s, 0.0 kB/s Nov 21 18:08:40 kos volumio[1031]: info: camilladsp spawned new process with pid 3754, instance 1, run: true Nov 21 18:08:41 kos volumio[1031]: 0+0 records in Nov 21 18:08:41 kos volumio[1031]: 0+0 records out Nov 21 18:08:41 kos volumio[1031]: 0 bytes copied, 0.00023494 s, 0.0 kB/s Nov 21 18:08:41 kos volumio[1031]: info: camilladsp spawned new process with pid 3759, instance 1, run: true Nov 21 18:08:42 kos volumio[1031]: 0+0 records in Nov 21 18:08:42 kos volumio[1031]: 0+0 records out Nov 21 18:08:42 kos volumio[1031]: 0 bytes copied, 0.000277803 s, 0.0 kB/s Nov 21 18:08:42 kos volumio[1031]: info: camilladsp spawned new process with pid 3764, instance 1, run: true Nov 21 18:08:43 kos volumio[1031]: 0+0 records in Nov 21 18:08:43 kos volumio[1031]: 0+0 records out Nov 21 18:08:43 kos volumio[1031]: 0 bytes copied, 0.000123486 s, 0.0 kB/s Nov 21 18:08:43 kos volumio[1031]: info: camilladsp spawned new process with pid 3770, instance 1, run: true Nov 21 18:08:44 kos volumio[1031]: 0+0 records in Nov 21 18:08:44 kos volumio[1031]: 0+0 records out Nov 21 18:08:44 kos volumio[1031]: 0 bytes copied, 0.000234784 s, 0.0 kB/s Nov 21 18:08:44 kos volumio[1031]: info: camilladsp spawned new process with pid 3775, instance 1, run: true Nov 21 18:08:45 kos volumio[1031]: 0+0 records in Nov 21 18:08:45 kos volumio[1031]: 0+0 records out Nov 21 18:08:45 kos volumio[1031]: 0 bytes copied, 0.000240513 s, 0.0 kB/s Nov 21 18:08:45 kos volumio[1031]: info: camilladsp spawned new process with pid 3794, instance 1, run: true Nov 21 18:08:46 kos volumio[1031]: 0+0 records in Nov 21 18:08:46 kos volumio[1031]: 0+0 records out Nov 21 18:08:46 kos volumio[1031]: 0 bytes copied, 0.000254211 s, 0.0 kB/s Nov 21 18:08:47 kos volumio[1031]: info: camilladsp spawned new process with pid 3799, instance 1, run: true Nov 21 18:08:48 kos volumio[1031]: 0+0 records in Nov 21 18:08:48 kos volumio[1031]: 0+0 records out Nov 21 18:08:48 kos volumio[1031]: 0 bytes copied, 0.000123486 s, 0.0 kB/s Nov 21 18:08:48 kos volumio[1031]: info: camilladsp spawned new process with pid 3804, instance 1, run: true Nov 21 18:08:49 kos volumio[1031]: 0+0 records in Nov 21 18:08:49 kos volumio[1031]: 0+0 records out Nov 21 18:08:49 kos volumio[1031]: 0 bytes copied, 0.00028171 s, 0.0 kB/s Nov 21 18:08:49 kos volumio[1031]: info: camilladsp spawned new process with pid 3809, instance 1, run: true Nov 21 18:08:50 kos volumio[1031]: 0+0 records in Nov 21 18:08:50 kos volumio[1031]: 0+0 records out Nov 21 18:08:50 kos volumio[1031]: 0 bytes copied, 0.000241607 s, 0.0 kB/s Nov 21 18:08:50 kos volumio[1031]: info: camilladsp spawned new process with pid 3817, instance 1, run: true Nov 21 18:08:51 kos volumio[1031]: 0+0 records in Nov 21 18:08:51 kos volumio[1031]: 0+0 records out Nov 21 18:08:51 kos volumio[1031]: 0 bytes copied, 0.000232702 s, 0.0 kB/s Nov 21 18:08:51 kos volumio[1031]: info: camilladsp spawned new process with pid 3822, instance 1, run: true Nov 21 18:08:52 kos volumio[1031]: 0+0 records in Nov 21 18:08:52 kos volumio[1031]: 0+0 records out Nov 21 18:08:52 kos volumio[1031]: 0 bytes copied, 0.000122548 s, 0.0 kB/s Nov 21 18:08:52 kos volumio[1031]: info: camilladsp spawned new process with pid 3827, instance 1, run: true Nov 21 18:08:53 kos volumio[1031]: 0+0 records in Nov 21 18:08:53 kos volumio[1031]: 0+0 records out Nov 21 18:08:53 kos volumio[1031]: 0 bytes copied, 0.000236399 s, 0.0 kB/s Nov 21 18:08:53 kos volumio[1031]: info: camilladsp spawned new process with pid 3832, instance 1, run: true Nov 21 18:08:54 kos volumio[1031]: 0+0 records in Nov 21 18:08:54 kos volumio[1031]: 0+0 records out Nov 21 18:08:54 kos volumio[1031]: 0 bytes copied, 0.000306292 s, 0.0 kB/s Nov 21 18:08:54 kos volumio[1031]: info: camilladsp spawned new process with pid 3837, instance 1, run: true Nov 21 18:08:55 kos volumio[1031]: 0+0 records in Nov 21 18:08:55 kos volumio[1031]: 0+0 records out Nov 21 18:08:55 kos volumio[1031]: 0 bytes copied, 0.000238274 s, 0.0 kB/s Nov 21 18:08:55 kos volumio[1031]: info: camilladsp spawned new process with pid 3842, instance 1, run: true Nov 21 18:08:56 kos volumio[1031]: 0+0 records in Nov 21 18:08:56 kos volumio[1031]: 0+0 records out Nov 21 18:08:56 kos volumio[1031]: 0 bytes copied, 0.000238482 s, 0.0 kB/s Nov 21 18:08:56 kos volumio[1031]: info: camilladsp spawned new process with pid 3861, instance 1, run: true Nov 21 18:08:57 kos volumio[1031]: 0+0 records in Nov 21 18:08:57 kos volumio[1031]: 0+0 records out Nov 21 18:08:57 kos volumio[1031]: 0 bytes copied, 0.000236867 s, 0.0 kB/s Nov 21 18:08:57 kos volumio[1031]: info: camilladsp spawned new process with pid 3866, instance 1, run: true Nov 21 18:08:58 kos volumio[1031]: 0+0 records in Nov 21 18:08:58 kos volumio[1031]: 0+0 records out Nov 21 18:08:58 kos volumio[1031]: 0 bytes copied, 0.00023291 s, 0.0 kB/s Nov 21 18:08:58 kos volumio[1031]: info: camilladsp spawned new process with pid 3871, instance 1, run: true Nov 21 18:08:59 kos volumio[1031]: 0+0 records in Nov 21 18:08:59 kos volumio[1031]: 0+0 records out Nov 21 18:08:59 kos volumio[1031]: 0 bytes copied, 0.00012484 s, 0.0 kB/s Nov 21 18:08:59 kos volumio[1031]: info: camilladsp spawned new process with pid 3876, instance 1, run: true Nov 21 18:09:00 kos volumio[1031]: 0+0 records in Nov 21 18:09:00 kos volumio[1031]: 0+0 records out Nov 21 18:09:00 kos volumio[1031]: 0 bytes copied, 0.000236139 s, 0.0 kB/s Nov 21 18:09:00 kos volumio[1031]: info: camilladsp spawned new process with pid 3884, instance 1, run: true Nov 21 18:09:02 kos volumio[1031]: 0+0 records in Nov 21 18:09:02 kos volumio[1031]: 0+0 records out Nov 21 18:09:02 kos volumio[1031]: 0 bytes copied, 0.000279263 s, 0.0 kB/s Nov 21 18:09:02 kos volumio[1031]: info: camilladsp spawned new process with pid 3889, instance 1, run: true Nov 21 18:09:03 kos volumio[1031]: 0+0 records in Nov 21 18:09:03 kos volumio[1031]: 0+0 records out Nov 21 18:09:03 kos volumio[1031]: 0 bytes copied, 0.000236711 s, 0.0 kB/s Nov 21 18:09:03 kos volumio[1031]: info: camilladsp spawned new process with pid 3895, instance 1, run: true Nov 21 18:09:03 kos volumio[1031]: verbose: New Socket.io Connection to 192.168.1.2 from 192.168.1.7 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 Nov 21 18:09:03 kos volumio[1031]: verbose: New Socket.io Connection to 192.168.1.2 from 192.168.1.7 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 7 Nov 21 18:09:03 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::volumioGetVisibleSources Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::volumioGetState Nov 21 18:09:04 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::volumioGetState Nov 21 18:09:04 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 21 18:09:04 kos volumio[1031]: info: Received Get System Info Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 18:09:04 kos volumio[1031]: info: Discovery: Getting this device information Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::volumioGetState Nov 21 18:09:04 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::volumioGetState Nov 21 18:09:04 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:04 kos volumio[1031]: info: Listing playlists Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::volumioGetQueue Nov 21 18:09:04 kos volumio[1031]: info: CoreStateMachine::getQueue Nov 21 18:09:04 kos volumio[1031]: info: CorePlayQueue::getQueue Nov 21 18:09:04 kos volumio[1031]: 0+0 records in Nov 21 18:09:04 kos volumio[1031]: 0+0 records out Nov 21 18:09:04 kos volumio[1031]: 0 bytes copied, 0.000239055 s, 0.0 kB/s Nov 21 18:09:04 kos volumio[1031]: info: camilladsp spawned new process with pid 3900, instance 1, run: true Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 18:09:04 kos volumio[1031]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 18:09:05 kos volumio[1031]: 0+0 records in Nov 21 18:09:05 kos volumio[1031]: 0+0 records out Nov 21 18:09:05 kos volumio[1031]: 0 bytes copied, 0.000261034 s, 0.0 kB/s Nov 21 18:09:05 kos volumio[1031]: info: camilladsp spawned new process with pid 3905, instance 1, run: true Nov 21 18:09:06 kos volumio[1031]: 0+0 records in Nov 21 18:09:06 kos volumio[1031]: 0+0 records out Nov 21 18:09:06 kos volumio[1031]: 0 bytes copied, 0.000237493 s, 0.0 kB/s Nov 21 18:09:06 kos volumio[1031]: info: camilladsp spawned new process with pid 3924, instance 1, run: true Nov 21 18:09:07 kos volumio[1031]: 0+0 records in Nov 21 18:09:07 kos volumio[1031]: 0+0 records out Nov 21 18:09:07 kos volumio[1031]: 0 bytes copied, 0.00023567 s, 0.0 kB/s Nov 21 18:09:07 kos volumio[1031]: info: camilladsp spawned new process with pid 3929, instance 1, run: true Nov 21 18:09:08 kos volumio[1031]: 0+0 records in Nov 21 18:09:08 kos volumio[1031]: 0+0 records out Nov 21 18:09:08 kos volumio[1031]: 0 bytes copied, 0.000238587 s, 0.0 kB/s Nov 21 18:09:08 kos volumio[1031]: info: camilladsp spawned new process with pid 3934, instance 1, run: true Nov 21 18:09:09 kos volumio[1031]: 0+0 records in Nov 21 18:09:09 kos volumio[1031]: 0+0 records out Nov 21 18:09:09 kos volumio[1031]: 0 bytes copied, 0.000235982 s, 0.0 kB/s Nov 21 18:09:10 kos volumio[1031]: info: camilladsp spawned new process with pid 3941, instance 1, run: true Nov 21 18:09:10 kos volumio[1031]: info: CoreCommandRouter::volumioGetState Nov 21 18:09:10 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:10 kos volumio[1031]: info: CoreCommandRouter::volumioPlay Nov 21 18:09:10 kos volumio[1031]: info: CoreStateMachine::play index undefined Nov 21 18:09:10 kos volumio[1031]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 18:09:10 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:10 kos volumio[1031]: info: CoreStateMachine::startPlaybackTimer Nov 21 18:09:10 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:10 kos volumio[1031]: verbose: ControllerMpd::clearAddPlayTracks USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac Nov 21 18:09:10 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 18:09:10 kos volumio[1031]: info: sendMpdCommand stop took 4 milliseconds Nov 21 18:09:10 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand clear Nov 21 18:09:10 kos volumio[1031]: info: Nov 21 18:09:10 kos volumio[1031]: ---------------------------- MPD announces system playlist update Nov 21 18:09:10 kos volumio[1031]: info: Ignoring MPD Status Update Nov 21 18:09:10 kos volumio[1031]: info: sendMpdCommand clear took 5 milliseconds Nov 21 18:09:10 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand add "USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac" Nov 21 18:09:10 kos volumio[1031]: error: updateQueue error: null Nov 21 18:09:10 kos volumio[1031]: info: Nov 21 18:09:10 kos volumio[1031]: ---------------------------- MPD announces system playlist update Nov 21 18:09:10 kos volumio[1031]: info: Ignoring MPD Status Update Nov 21 18:09:10 kos volumio[1031]: info: ------------------------------ 10ms Nov 21 18:09:10 kos volumio[1031]: info: sendMpdCommand add "USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac" took 6 milliseconds Nov 21 18:09:10 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand play Nov 21 18:09:10 kos volumio[1031]: info: ------------------------------ 9ms Nov 21 18:09:10 kos volumio[1031]: info: sendMpdCommand play took 6 milliseconds Nov 21 18:09:11 kos volumio[1031]: 0+0 records in Nov 21 18:09:11 kos volumio[1031]: 0+0 records out Nov 21 18:09:11 kos volumio[1031]: 0 bytes copied, 0.000290825 s, 0.0 kB/s Nov 21 18:09:11 kos volumio[1031]: info: camilladsp spawned new process with pid 3950, instance 1, run: true Nov 21 18:09:11 kos volumio[1031]: info: Nov 21 18:09:11 kos volumio[1031]: ---------------------------- MPD announces state update: player Nov 21 18:09:11 kos volumio[1031]: info: ControllerMpd::getState Nov 21 18:09:11 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand status Nov 21 18:09:11 kos volumio[1031]: info: FusionDsp - ---- read samplerate, raw: Nov 21 18:09:11 kos volumio[1031]: error: FusionDsp - invalid sample rate Nov 21 18:09:11 kos volumio[1031]: info: FusionDsp - ---- read samplerate, raw: 192000,S32_LE,2,32 Nov 21 18:09:11 kos volumio[1031]: info: FusionDsp - ---- read samplerate from file: 192000 Nov 21 18:09:11 kos volumio[1031]: info: camilladsp service terminated, instance 1 Nov 21 18:09:11 kos volumio[1031]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 18:09:11 kos volumio[1031]: info: camilladsp spawned new process with pid 3955, instance 1, run: true Nov 21 18:09:11 kos volumio[1031]: info: camilladsp service started and running in background, instance 1 Nov 21 18:09:11 kos volumio[1031]: info: Nov 21 18:09:11 kos volumio[1031]: ---------------------------- MPD announces state update: player Nov 21 18:09:11 kos volumio[1031]: info: sendMpdCommand status took 84 milliseconds Nov 21 18:09:11 kos volumio[1031]: info: ControllerMpd::getState Nov 21 18:09:11 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand status Nov 21 18:09:11 kos volumio[1031]: verbose: ControllerMpd::parseState Nov 21 18:09:11 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 18:09:11 kos volumio[1031]: info: sendMpdCommand status took 13 milliseconds Nov 21 18:09:11 kos volumio[1031]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 21 18:09:11 kos volumio[1031]: verbose: ControllerMpd::parseState Nov 21 18:09:11 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 18:09:11 kos volumio[1031]: verbose: ControllerMpd::parseTrackInfo Nov 21 18:09:11 kos volumio[1031]: info: ControllerMpd::pushState Nov 21 18:09:11 kos volumio[1031]: info: CoreCommandRouter::servicePushState Nov 21 18:09:11 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:11 kos volumio[1031]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2729,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mingus Ah Um.flac","artist":null,"album":null,"uri":"USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac","trackType":"flac"} Nov 21 18:09:11 kos volumio[1031]: verbose: CURRENT POSITION 0 Nov 21 18:09:11 kos volumio[1031]: info: CoreStateMachine::syncState stateService play Nov 21 18:09:11 kos volumio[1031]: info: CoreStateMachine::syncState currentStatus stop Nov 21 18:09:11 kos volumio[1031]: info: ------------------------------ 130ms Nov 21 18:09:11 kos volumio[1031]: info: sendMpdCommand playlistinfo took 22 milliseconds Nov 21 18:09:11 kos volumio[1031]: verbose: ControllerMpd::parseTrackInfo Nov 21 18:09:11 kos volumio[1031]: info: ControllerMpd::pushState Nov 21 18:09:11 kos volumio[1031]: info: CoreCommandRouter::servicePushState Nov 21 18:09:11 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:11 kos volumio[1031]: verbose: STATE SERVICE {"status":"play","position":0,"seek":679,"duration":2729,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4699 Kbps","isStreaming":false,"title":"Mingus Ah Um.flac","artist":null,"album":null,"uri":"USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac","trackType":"flac"} Nov 21 18:09:11 kos volumio[1031]: verbose: CURRENT POSITION 0 Nov 21 18:09:11 kos volumio[1031]: info: CoreStateMachine::syncState stateService play Nov 21 18:09:11 kos volumio[1031]: info: CoreStateMachine::syncState currentStatus play Nov 21 18:09:11 kos volumio[1031]: info: Received an update from plugin. extracting info from payload Nov 21 18:09:11 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:11 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:11 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 18:09:11 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:11 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:11 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:11 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:11 kos volumio[1031]: info: ------------------------------ 108ms Nov 21 18:09:12 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:12 kos volumio[1031]: 12+128 records in Nov 21 18:09:12 kos volumio[1031]: 12+128 records out Nov 21 18:09:12 kos volumio[1031]: 917448 bytes (917 kB, 896 KiB) copied, 0.00874136 s, 105 MB/s Nov 21 18:09:12 kos volumio[1031]: info: camilladsp spawned new process with pid 3960, instance 1, run: true Nov 21 18:09:12 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:12 kos volumio[1031]: 4+1 records in Nov 21 18:09:12 kos volumio[1031]: 4+1 records out Nov 21 18:09:12 kos volumio[1031]: 131128 bytes (131 kB, 128 KiB) copied, 0.00403853 s, 32.5 MB/s Nov 21 18:09:12 kos volumio[1031]: info: camilladsp spawned new process with pid 3965, instance 1, run: true Nov 21 18:09:13 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:13 kos volumio[1031]: 4+1 records in Nov 21 18:09:13 kos volumio[1031]: 4+1 records out Nov 21 18:09:13 kos volumio[1031]: 135168 bytes (135 kB, 132 KiB) copied, 0.00250024 s, 54.1 MB/s Nov 21 18:09:13 kos volumio[1031]: info: camilladsp spawned new process with pid 3970, instance 1, run: true Nov 21 18:09:13 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:13 kos volumio[1031]: 2+0 records in Nov 21 18:09:13 kos volumio[1031]: 2+0 records out Nov 21 18:09:13 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000724198 s, 90.5 MB/s Nov 21 18:09:13 kos volumio[1031]: info: camilladsp spawned new process with pid 3975, instance 1, run: true Nov 21 18:09:14 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:14 kos volumio[1031]: 2+0 records in Nov 21 18:09:14 kos volumio[1031]: 2+0 records out Nov 21 18:09:14 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000688262 s, 95.2 MB/s Nov 21 18:09:14 kos volumio[1031]: info: camilladsp spawned new process with pid 3980, instance 1, run: true Nov 21 18:09:14 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:14 kos volumio[1031]: 2+0 records in Nov 21 18:09:14 kos volumio[1031]: 2+0 records out Nov 21 18:09:14 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000672793 s, 97.4 MB/s Nov 21 18:09:14 kos volumio[1031]: info: camilladsp spawned new process with pid 3985, instance 1, run: true Nov 21 18:09:15 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:15 kos volumio[1031]: 2+0 records in Nov 21 18:09:15 kos volumio[1031]: 2+0 records out Nov 21 18:09:15 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000750239 s, 87.4 MB/s Nov 21 18:09:15 kos volumio[1031]: info: camilladsp spawned new process with pid 3990, instance 1, run: true Nov 21 18:09:15 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:15 kos volumio[1031]: 2+0 records in Nov 21 18:09:15 kos volumio[1031]: 2+0 records out Nov 21 18:09:15 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000699199 s, 93.7 MB/s Nov 21 18:09:15 kos volumio[1031]: info: camilladsp spawned new process with pid 4009, instance 1, run: true Nov 21 18:09:16 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:16 kos volumio[1031]: 6+0 records in Nov 21 18:09:16 kos volumio[1031]: 6+0 records out Nov 21 18:09:16 kos volumio[1031]: 196608 bytes (197 kB, 192 KiB) copied, 0.00245899 s, 80.0 MB/s Nov 21 18:09:16 kos volumio[1031]: info: camilladsp spawned new process with pid 4014, instance 1, run: true Nov 21 18:09:17 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:17 kos volumio[1031]: 121+0 records in Nov 21 18:09:17 kos volumio[1031]: 121+0 records out Nov 21 18:09:17 kos volumio[1031]: 3964928 bytes (4.0 MB, 3.8 MiB) copied, 0.0416576 s, 95.2 MB/s Nov 21 18:09:17 kos volumio[1031]: info: camilladsp spawned new process with pid 4019, instance 1, run: true Nov 21 18:09:17 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:17 kos volumio[1031]: 2+0 records in Nov 21 18:09:17 kos volumio[1031]: 2+0 records out Nov 21 18:09:17 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000687949 s, 95.3 MB/s Nov 21 18:09:17 kos volumio[1031]: info: camilladsp spawned new process with pid 4024, instance 1, run: true Nov 21 18:09:18 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:18 kos volumio[1031]: 2+0 records in Nov 21 18:09:18 kos volumio[1031]: 2+0 records out Nov 21 18:09:18 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000699876 s, 93.6 MB/s Nov 21 18:09:18 kos volumio[1031]: info: camilladsp spawned new process with pid 4029, instance 1, run: true Nov 21 18:09:18 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:18 kos volumio[1031]: 2+0 records in Nov 21 18:09:18 kos volumio[1031]: 2+0 records out Nov 21 18:09:18 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000669617 s, 97.9 MB/s Nov 21 18:09:18 kos volumio[1031]: info: camilladsp spawned new process with pid 4034, instance 1, run: true Nov 21 18:09:19 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:19 kos volumio[1031]: 2+0 records in Nov 21 18:09:19 kos volumio[1031]: 2+0 records out Nov 21 18:09:19 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000684825 s, 95.7 MB/s Nov 21 18:09:19 kos volumio[1031]: info: camilladsp spawned new process with pid 4039, instance 1, run: true Nov 21 18:09:19 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:19 kos volumio[1031]: 2+0 records in Nov 21 18:09:19 kos volumio[1031]: 2+0 records out Nov 21 18:09:19 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000676648 s, 96.9 MB/s Nov 21 18:09:19 kos volumio[1031]: info: camilladsp spawned new process with pid 4044, instance 1, run: true Nov 21 18:09:20 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:20 kos volumio[1031]: 2+0 records in Nov 21 18:09:20 kos volumio[1031]: 2+0 records out Nov 21 18:09:20 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000684564 s, 95.7 MB/s Nov 21 18:09:20 kos volumio[1031]: info: camilladsp spawned new process with pid 4052, instance 1, run: true Nov 21 18:09:20 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:20 kos volumio[1031]: 2+0 records in Nov 21 18:09:20 kos volumio[1031]: 2+0 records out Nov 21 18:09:20 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000369989 s, 177 MB/s Nov 21 18:09:20 kos volumio[1031]: info: camilladsp spawned new process with pid 4057, instance 1, run: true Nov 21 18:09:21 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:21 kos volumio[1031]: 2+0 records in Nov 21 18:09:21 kos volumio[1031]: 2+0 records out Nov 21 18:09:21 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000695449 s, 94.2 MB/s Nov 21 18:09:21 kos volumio[1031]: info: camilladsp spawned new process with pid 4062, instance 1, run: true Nov 21 18:09:21 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:21 kos volumio[1031]: 2+0 records in Nov 21 18:09:21 kos volumio[1031]: 2+0 records out Nov 21 18:09:21 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000727532 s, 90.1 MB/s Nov 21 18:09:21 kos volumio[1031]: info: camilladsp spawned new process with pid 4067, instance 1, run: true Nov 21 18:09:22 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:22 kos volumio[1031]: 2+0 records in Nov 21 18:09:22 kos volumio[1031]: 2+0 records out Nov 21 18:09:22 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000693314 s, 94.5 MB/s Nov 21 18:09:22 kos volumio[1031]: info: camilladsp spawned new process with pid 4072, instance 1, run: true Nov 21 18:09:22 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:22 kos volumio[1031]: 2+0 records in Nov 21 18:09:22 kos volumio[1031]: 2+0 records out Nov 21 18:09:22 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00068847 s, 95.2 MB/s Nov 21 18:09:23 kos volumio[1031]: info: camilladsp spawned new process with pid 4077, instance 1, run: true Nov 21 18:09:23 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:23 kos volumio[1031]: 2+0 records in Nov 21 18:09:23 kos volumio[1031]: 2+0 records out Nov 21 18:09:23 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00081805 s, 80.1 MB/s Nov 21 18:09:23 kos volumio[1031]: info: camilladsp spawned new process with pid 4083, instance 1, run: true Nov 21 18:09:24 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:24 kos volumio[1031]: 2+0 records in Nov 21 18:09:24 kos volumio[1031]: 2+0 records out Nov 21 18:09:24 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000651492 s, 101 MB/s Nov 21 18:09:24 kos volumio[1031]: info: camilladsp spawned new process with pid 4088, instance 1, run: true Nov 21 18:09:24 kos volumio[1031]: info: CoreCommandRouter::volumioPause Nov 21 18:09:24 kos volumio[1031]: info: CoreStateMachine::pause Nov 21 18:09:24 kos volumio[1031]: info: CoreStateMachine::stPlaybackTimer Nov 21 18:09:24 kos volumio[1031]: info: CoreStateMachine::servicePause Nov 21 18:09:24 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:24 kos volumio[1031]: info: CoreCommandRouter::servicePause Nov 21 18:09:24 kos volumio[1031]: info: ControllerMpd::pause Nov 21 18:09:24 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand pause Nov 21 18:09:24 kos volumio[1031]: info: sendMpdCommand pause took 1 milliseconds Nov 21 18:09:24 kos volumio[1031]: info: Nov 21 18:09:24 kos volumio[1031]: ---------------------------- MPD announces state update: player Nov 21 18:09:24 kos volumio[1031]: info: ControllerMpd::getState Nov 21 18:09:24 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand status Nov 21 18:09:24 kos volumio[1031]: info: sendMpdCommand status took 1 milliseconds Nov 21 18:09:24 kos volumio[1031]: verbose: ControllerMpd::parseState Nov 21 18:09:24 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 18:09:24 kos volumio[1031]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 21 18:09:24 kos volumio[1031]: verbose: ControllerMpd::parseTrackInfo Nov 21 18:09:24 kos volumio[1031]: info: ControllerMpd::pushState Nov 21 18:09:24 kos volumio[1031]: info: CoreCommandRouter::servicePushState Nov 21 18:09:24 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:24 kos volumio[1031]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4945,"duration":2729,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4535 Kbps","isStreaming":false,"title":"Mingus Ah Um.flac","artist":null,"album":null,"uri":"USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac","trackType":"flac"} Nov 21 18:09:24 kos volumio[1031]: verbose: CURRENT POSITION 0 Nov 21 18:09:24 kos volumio[1031]: info: CoreStateMachine::syncState stateService pause Nov 21 18:09:24 kos volumio[1031]: info: CoreStateMachine::syncState currentStatus pause Nov 21 18:09:24 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:24 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:24 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 18:09:24 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:24 kos volumio[1031]: info: CoreStateMachine::stPlaybackTimer Nov 21 18:09:24 kos volumio[1031]: info: ------------------------------ 26ms Nov 21 18:09:24 kos volumio[1031]: 0+0 records in Nov 21 18:09:24 kos volumio[1031]: 0+0 records out Nov 21 18:09:24 kos volumio[1031]: 0 bytes copied, 0.000242025 s, 0.0 kB/s Nov 21 18:09:24 kos volumio[1031]: info: camilladsp spawned new process with pid 4093, instance 1, run: true Nov 21 18:09:25 kos volumio[1031]: 0+0 records in Nov 21 18:09:25 kos volumio[1031]: 0+0 records out Nov 21 18:09:25 kos volumio[1031]: 0 bytes copied, 0.00023916 s, 0.0 kB/s Nov 21 18:09:25 kos volumio[1031]: info: camilladsp spawned new process with pid 4098, instance 1, run: true Nov 21 18:09:25 kos volumio[1031]: info: CoreCommandRouter::volumioPlay Nov 21 18:09:25 kos volumio[1031]: info: CoreStateMachine::play index undefined Nov 21 18:09:25 kos volumio[1031]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 18:09:25 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:25 kos volumio[1031]: info: CoreStateMachine::startPlaybackTimer Nov 21 18:09:25 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:25 kos volumio[1031]: info: ControllerMpd::resume Nov 21 18:09:25 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand play Nov 21 18:09:25 kos volumio[1031]: info: FusionDsp - ---- read samplerate, raw: 192000,S32_LE,2,32 Nov 21 18:09:25 kos volumio[1031]: info: FusionDsp - ---- read samplerate from file: 192000 Nov 21 18:09:25 kos volumio[1031]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 18:09:25 kos volumio[1031]: info: FusionDsp - ---- read samplerate, raw: 192000,S32_LE,2,32 Nov 21 18:09:25 kos volumio[1031]: info: FusionDsp - ---- read samplerate from file: 192000 Nov 21 18:09:25 kos volumio[1031]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 18:09:25 kos volumio[1031]: info: Nov 21 18:09:25 kos volumio[1031]: ---------------------------- MPD announces state update: player Nov 21 18:09:25 kos volumio[1031]: info: sendMpdCommand play took 68 milliseconds Nov 21 18:09:25 kos volumio[1031]: info: ControllerMpd::getState Nov 21 18:09:25 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand status Nov 21 18:09:25 kos volumio[1031]: info: sendMpdCommand status took 4 milliseconds Nov 21 18:09:25 kos volumio[1031]: verbose: ControllerMpd::parseState Nov 21 18:09:25 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 18:09:25 kos volumio[1031]: error: FusionDsp - WebSocket error: [object Object] Nov 21 18:09:25 kos volumio[1031]: error: FusionDsp - WebSocket error: [object Object] Nov 21 18:09:25 kos volumio[1031]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 21 18:09:25 kos volumio[1031]: verbose: ControllerMpd::parseTrackInfo Nov 21 18:09:25 kos volumio[1031]: info: ControllerMpd::pushState Nov 21 18:09:25 kos volumio[1031]: info: CoreCommandRouter::servicePushState Nov 21 18:09:25 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:25 kos volumio[1031]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5628,"duration":2729,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4550 Kbps","isStreaming":false,"title":"Mingus Ah Um.flac","artist":null,"album":null,"uri":"USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac","trackType":"flac"} Nov 21 18:09:25 kos volumio[1031]: verbose: CURRENT POSITION 0 Nov 21 18:09:25 kos volumio[1031]: info: CoreStateMachine::syncState stateService play Nov 21 18:09:25 kos volumio[1031]: info: CoreStateMachine::syncState currentStatus pause Nov 21 18:09:25 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:25 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:25 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 18:09:25 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:25 kos volumio[1031]: info: ------------------------------ 48ms Nov 21 18:09:25 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:25 kos volumio[1031]: 2+0 records in Nov 21 18:09:25 kos volumio[1031]: 2+0 records out Nov 21 18:09:25 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000777323 s, 84.3 MB/s Nov 21 18:09:25 kos volumio[1031]: info: camilladsp spawned new process with pid 4104, instance 1, run: true Nov 21 18:09:26 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:26 kos volumio[1031]: 10+1 records in Nov 21 18:09:26 kos volumio[1031]: 10+1 records out Nov 21 18:09:26 kos volumio[1031]: 331776 bytes (332 kB, 324 KiB) copied, 0.00651763 s, 50.9 MB/s Nov 21 18:09:26 kos volumio[1031]: info: camilladsp spawned new process with pid 4123, instance 1, run: true Nov 21 18:09:26 kos volumio[1031]: info: CoreCommandRouter::volumioSeek Nov 21 18:09:26 kos volumio[1031]: info: CoreStateMachine::seek Nov 21 18:09:26 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:26 kos volumio[1031]: info: TRACKBLOCK {"uri":"mnt/USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac","service":"mpd","name":"Mingus Ah Um.flac","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=621&web=//extralarge&path=%2FUSB%2FMy_Disk%2FMusic%2FLossLess%2FJazz%2F%40HQ%2FCharles%20Mingus%20Ah%20Um%20-%20HQ&metadata=false","duration":2729,"trackType":"flac","samplerate":"192 kHz","bitdepth":"24 bit","channels":2} Nov 21 18:09:26 kos volumio[1031]: info: CoreStateMachine::startPlaybackTimer Nov 21 18:09:26 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:26 kos volumio[1031]: info: ControllerMpd::seek Nov 21 18:09:26 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:26 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:26 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 18:09:26 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:26 kos volumio[1031]: error: null Nov 21 18:09:26 kos volumio[1031]: info: Nov 21 18:09:26 kos volumio[1031]: ---------------------------- MPD announces state update: player Nov 21 18:09:26 kos volumio[1031]: info: ControllerMpd::getState Nov 21 18:09:26 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand status Nov 21 18:09:26 kos volumio[1031]: info: sendMpdCommand status took 3 milliseconds Nov 21 18:09:26 kos volumio[1031]: verbose: ControllerMpd::parseState Nov 21 18:09:26 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 18:09:26 kos volumio[1031]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 21 18:09:26 kos volumio[1031]: verbose: ControllerMpd::parseTrackInfo Nov 21 18:09:26 kos volumio[1031]: info: ControllerMpd::pushState Nov 21 18:09:26 kos volumio[1031]: info: CoreCommandRouter::servicePushState Nov 21 18:09:26 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:26 kos volumio[1031]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478000,"duration":2729,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4564 Kbps","isStreaming":false,"title":"Mingus Ah Um.flac","artist":null,"album":null,"uri":"USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac","trackType":"flac"} Nov 21 18:09:26 kos volumio[1031]: verbose: CURRENT POSITION 0 Nov 21 18:09:26 kos volumio[1031]: info: CoreStateMachine::syncState stateService play Nov 21 18:09:26 kos volumio[1031]: info: CoreStateMachine::syncState currentStatus play Nov 21 18:09:26 kos volumio[1031]: info: Received an update from plugin. extracting info from payload Nov 21 18:09:26 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:26 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:26 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:26 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:26 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:26 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:26 kos volumio[1031]: info: ------------------------------ 79ms Nov 21 18:09:26 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:26 kos volumio[1031]: 2+0 records in Nov 21 18:09:26 kos volumio[1031]: 2+0 records out Nov 21 18:09:26 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00382885 s, 17.1 MB/s Nov 21 18:09:26 kos volumio[1031]: info: camilladsp spawned new process with pid 4128, instance 1, run: true Nov 21 18:09:27 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:27 kos volumio[1031]: 8+0 records in Nov 21 18:09:27 kos volumio[1031]: 8+0 records out Nov 21 18:09:27 kos volumio[1031]: 262144 bytes (262 kB, 256 KiB) copied, 0.00439827 s, 59.6 MB/s Nov 21 18:09:27 kos volumio[1031]: info: camilladsp spawned new process with pid 4133, instance 1, run: true Nov 21 18:09:27 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:27 kos volumio[1031]: 97+0 records in Nov 21 18:09:27 kos volumio[1031]: 97+0 records out Nov 21 18:09:27 kos volumio[1031]: 3178496 bytes (3.2 MB, 3.0 MiB) copied, 0.0336263 s, 94.5 MB/s Nov 21 18:09:27 kos volumio[1031]: info: camilladsp spawned new process with pid 4138, instance 1, run: true Nov 21 18:09:28 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:28 kos volumio[1031]: 2+0 records in Nov 21 18:09:28 kos volumio[1031]: 2+0 records out Nov 21 18:09:28 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000676336 s, 96.9 MB/s Nov 21 18:09:28 kos volumio[1031]: info: camilladsp spawned new process with pid 4143, instance 1, run: true Nov 21 18:09:28 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:28 kos volumio[1031]: 2+0 records in Nov 21 18:09:28 kos volumio[1031]: 2+0 records out Nov 21 18:09:28 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00070321 s, 93.2 MB/s Nov 21 18:09:28 kos volumio[1031]: info: camilladsp spawned new process with pid 4148, instance 1, run: true Nov 21 18:09:29 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:29 kos volumio[1031]: 63+0 records in Nov 21 18:09:29 kos volumio[1031]: 63+0 records out Nov 21 18:09:29 kos volumio[1031]: 2064384 bytes (2.1 MB, 2.0 MiB) copied, 0.0376863 s, 54.8 MB/s Nov 21 18:09:29 kos volumio[1031]: info: camilladsp spawned new process with pid 4153, instance 1, run: true Nov 21 18:09:30 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:30 kos volumio[1031]: 2+0 records in Nov 21 18:09:30 kos volumio[1031]: 2+0 records out Nov 21 18:09:30 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000670919 s, 97.7 MB/s Nov 21 18:09:30 kos volumio[1031]: info: camilladsp spawned new process with pid 4160, instance 1, run: true Nov 21 18:09:30 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:30 kos volumio[1031]: 123+0 records in Nov 21 18:09:30 kos volumio[1031]: 123+0 records out Nov 21 18:09:30 kos volumio[1031]: 4030464 bytes (4.0 MB, 3.8 MiB) copied, 0.0752034 s, 53.6 MB/s Nov 21 18:09:30 kos volumio[1031]: info: camilladsp spawned new process with pid 4167, instance 1, run: true Nov 21 18:09:31 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:31 kos volumio[1031]: 2+0 records in Nov 21 18:09:31 kos volumio[1031]: 2+0 records out Nov 21 18:09:31 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000688784 s, 95.1 MB/s Nov 21 18:09:31 kos volumio[1031]: info: camilladsp spawned new process with pid 4172, instance 1, run: true Nov 21 18:09:31 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:31 kos volumio[1031]: 2+0 records in Nov 21 18:09:31 kos volumio[1031]: 2+0 records out Nov 21 18:09:31 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000398167 s, 165 MB/s Nov 21 18:09:31 kos volumio[1031]: info: camilladsp spawned new process with pid 4177, instance 1, run: true Nov 21 18:09:32 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:32 kos volumio[1031]: 2+0 records in Nov 21 18:09:32 kos volumio[1031]: 2+0 records out Nov 21 18:09:32 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000672638 s, 97.4 MB/s Nov 21 18:09:32 kos volumio[1031]: info: camilladsp spawned new process with pid 4182, instance 1, run: true Nov 21 18:09:32 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:32 kos volumio[1031]: 2+0 records in Nov 21 18:09:32 kos volumio[1031]: 2+0 records out Nov 21 18:09:32 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00126028 s, 52.0 MB/s Nov 21 18:09:32 kos volumio[1031]: info: camilladsp spawned new process with pid 4187, instance 1, run: true Nov 21 18:09:33 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:33 kos volumio[1031]: 120+0 records in Nov 21 18:09:33 kos volumio[1031]: 120+0 records out Nov 21 18:09:33 kos volumio[1031]: 3932160 bytes (3.9 MB, 3.8 MiB) copied, 0.0718457 s, 54.7 MB/s Nov 21 18:09:33 kos volumio[1031]: info: camilladsp spawned new process with pid 4192, instance 1, run: true Nov 21 18:09:33 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:33 kos volumio[1031]: 2+0 records in Nov 21 18:09:33 kos volumio[1031]: 2+0 records out Nov 21 18:09:33 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000717741 s, 91.3 MB/s Nov 21 18:09:33 kos volumio[1031]: info: camilladsp spawned new process with pid 4197, instance 1, run: true Nov 21 18:09:34 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:34 kos volumio[1031]: 111+45 records in Nov 21 18:09:34 kos volumio[1031]: 111+45 records out Nov 21 18:09:34 kos volumio[1031]: 3821568 bytes (3.8 MB, 3.6 MiB) copied, 0.0659674 s, 57.9 MB/s Nov 21 18:09:34 kos volumio[1031]: info: camilladsp spawned new process with pid 4202, instance 1, run: true Nov 21 18:09:35 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:35 kos volumio[1031]: 2+0 records in Nov 21 18:09:35 kos volumio[1031]: 2+0 records out Nov 21 18:09:35 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.0012007 s, 54.6 MB/s Nov 21 18:09:35 kos volumio[1031]: info: camilladsp spawned new process with pid 4207, instance 1, run: true Nov 21 18:09:35 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:35 kos volumio[1031]: 3+0 records in Nov 21 18:09:35 kos volumio[1031]: 3+0 records out Nov 21 18:09:35 kos volumio[1031]: 98304 bytes (98 kB, 96 KiB) copied, 0.00121538 s, 80.9 MB/s Nov 21 18:09:35 kos volumio[1031]: info: camilladsp spawned new process with pid 4212, instance 1, run: true Nov 21 18:09:36 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:36 kos volumio[1031]: 2+0 records in Nov 21 18:09:36 kos volumio[1031]: 2+0 records out Nov 21 18:09:36 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000684356 s, 95.8 MB/s Nov 21 18:09:36 kos volumio[1031]: info: camilladsp spawned new process with pid 4231, instance 1, run: true Nov 21 18:09:36 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:36 kos volumio[1031]: 2+0 records in Nov 21 18:09:36 kos volumio[1031]: 2+0 records out Nov 21 18:09:36 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00193193 s, 33.9 MB/s Nov 21 18:09:36 kos volumio[1031]: info: camilladsp spawned new process with pid 4249, instance 1, run: true Nov 21 18:09:37 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:37 kos volumio[1031]: 2+0 records in Nov 21 18:09:37 kos volumio[1031]: 2+0 records out Nov 21 18:09:37 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000648628 s, 101 MB/s Nov 21 18:09:37 kos volumio[1031]: info: camilladsp spawned new process with pid 4279, instance 1, run: true Nov 21 18:09:37 kos volumio[1031]: info: CoreCommandRouter::volumioSeek Nov 21 18:09:37 kos volumio[1031]: info: CoreStateMachine::seek Nov 21 18:09:37 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:37 kos volumio[1031]: info: TRACKBLOCK {"uri":"mnt/USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac","service":"mpd","name":"Mingus Ah Um.flac","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=621&web=//extralarge&path=%2FUSB%2FMy_Disk%2FMusic%2FLossLess%2FJazz%2F%40HQ%2FCharles%20Mingus%20Ah%20Um%20-%20HQ&metadata=false","duration":2729,"trackType":"flac","samplerate":"192 kHz","bitdepth":"24 bit","channels":2} Nov 21 18:09:37 kos volumio[1031]: info: CoreStateMachine::startPlaybackTimer Nov 21 18:09:37 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:37 kos volumio[1031]: info: ControllerMpd::seek Nov 21 18:09:37 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:37 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:37 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 18:09:37 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:37 kos volumio[1031]: error: null Nov 21 18:09:37 kos volumio[1031]: info: Nov 21 18:09:37 kos volumio[1031]: ---------------------------- MPD announces state update: player Nov 21 18:09:37 kos volumio[1031]: info: ControllerMpd::getState Nov 21 18:09:37 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand status Nov 21 18:09:37 kos volumio[1031]: info: sendMpdCommand status took 3 milliseconds Nov 21 18:09:37 kos volumio[1031]: verbose: ControllerMpd::parseState Nov 21 18:09:37 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 18:09:37 kos volumio[1031]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 21 18:09:37 kos volumio[1031]: verbose: ControllerMpd::parseTrackInfo Nov 21 18:09:37 kos volumio[1031]: info: ControllerMpd::pushState Nov 21 18:09:37 kos volumio[1031]: info: CoreCommandRouter::servicePushState Nov 21 18:09:37 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:37 kos volumio[1031]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1264000,"duration":2729,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4869 Kbps","isStreaming":false,"title":"Mingus Ah Um.flac","artist":null,"album":null,"uri":"USB/My_Disk/Music/LossLess/Jazz/@HQ/Charles Mingus Ah Um - HQ/Mingus Ah Um.flac","trackType":"flac"} Nov 21 18:09:37 kos volumio[1031]: verbose: CURRENT POSITION 0 Nov 21 18:09:37 kos volumio[1031]: info: CoreStateMachine::syncState stateService play Nov 21 18:09:37 kos volumio[1031]: info: CoreStateMachine::syncState currentStatus play Nov 21 18:09:37 kos volumio[1031]: info: Received an update from plugin. extracting info from payload Nov 21 18:09:37 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:37 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:37 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:37 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:37 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:37 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:37 kos volumio[1031]: info: ------------------------------ 81ms Nov 21 18:09:37 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:37 kos volumio[1031]: 2+0 records in Nov 21 18:09:37 kos volumio[1031]: 2+0 records out Nov 21 18:09:37 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00120518 s, 54.4 MB/s Nov 21 18:09:37 kos volumio[1031]: info: camilladsp spawned new process with pid 4284, instance 1, run: true Nov 21 18:09:38 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:38 kos volumio[1031]: 2+0 records in Nov 21 18:09:38 kos volumio[1031]: 2+0 records out Nov 21 18:09:38 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00119445 s, 54.9 MB/s Nov 21 18:09:38 kos volumio[1031]: info: camilladsp spawned new process with pid 4289, instance 1, run: true Nov 21 18:09:38 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:38 kos volumio[1031]: 2+0 records in Nov 21 18:09:38 kos volumio[1031]: 2+0 records out Nov 21 18:09:38 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000362282 s, 181 MB/s Nov 21 18:09:38 kos volumio[1031]: info: camilladsp spawned new process with pid 4294, instance 1, run: true Nov 21 18:09:39 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:39 kos volumio[1031]: 2+0 records in Nov 21 18:09:39 kos volumio[1031]: 2+0 records out Nov 21 18:09:39 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000650192 s, 101 MB/s Nov 21 18:09:39 kos volumio[1031]: info: camilladsp spawned new process with pid 4299, instance 1, run: true Nov 21 18:09:40 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:40 kos volumio[1031]: 2+0 records in Nov 21 18:09:40 kos volumio[1031]: 2+0 records out Nov 21 18:09:40 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000671545 s, 97.6 MB/s Nov 21 18:09:40 kos volumio[1031]: info: camilladsp spawned new process with pid 4304, instance 1, run: true Nov 21 18:09:40 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:40 kos volumio[1031]: 2+0 records in Nov 21 18:09:40 kos volumio[1031]: 2+0 records out Nov 21 18:09:40 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000641806 s, 102 MB/s Nov 21 18:09:40 kos volumio[1031]: info: camilladsp spawned new process with pid 4312, instance 1, run: true Nov 21 18:09:41 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:41 kos volumio[1031]: 2+0 records in Nov 21 18:09:41 kos volumio[1031]: 2+0 records out Nov 21 18:09:41 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00071019 s, 92.3 MB/s Nov 21 18:09:41 kos volumio[1031]: info: camilladsp spawned new process with pid 4317, instance 1, run: true Nov 21 18:09:41 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:41 kos volumio[1031]: 2+0 records in Nov 21 18:09:41 kos volumio[1031]: 2+0 records out Nov 21 18:09:41 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.000672013 s, 97.5 MB/s Nov 21 18:09:41 kos volumio[1031]: info: camilladsp spawned new process with pid 4322, instance 1, run: true Nov 21 18:09:42 kos volumio[1031]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 18:09:42 kos volumio[1031]: 2+0 records in Nov 21 18:09:42 kos volumio[1031]: 2+0 records out Nov 21 18:09:42 kos volumio[1031]: 65536 bytes (66 kB, 64 KiB) copied, 0.00107096 s, 61.2 MB/s Nov 21 18:09:42 kos volumio[1031]: info: camilladsp spawned new process with pid 4327, instance 1, run: true Nov 21 18:09:42 kos volumio[1031]: info: Preload queue cleared Nov 21 18:09:42 kos volumio[1031]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 21 18:09:42 kos volumio[1031]: info: CoreStateMachine::ClearQueue Nov 21 18:09:42 kos volumio[1031]: info: CoreStateMachine::stop Nov 21 18:09:42 kos volumio[1031]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 18:09:42 kos volumio[1031]: info: CoreStateMachine::stPlaybackTimer Nov 21 18:09:42 kos volumio[1031]: info: CoreStateMachine::updateTrackBlock Nov 21 18:09:42 kos volumio[1031]: info: CorePlayQueue::getTrackBlock Nov 21 18:09:42 kos volumio[1031]: info: CoreStateMachine::pushState Nov 21 18:09:42 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:42 kos volumio[1031]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 18:09:42 kos volumio[1031]: info: CoreCommandRouter::volumioPushState Nov 21 18:09:42 kos volumio[1031]: info: CoreStateMachine::serviceStop Nov 21 18:09:42 kos volumio[1031]: info: CorePlayQueue::getTrack 0 Nov 21 18:09:42 kos volumio[1031]: info: CoreCommandRouter::serviceStop Nov 21 18:09:42 kos volumio[1031]: info: ControllerMpd::stop Nov 21 18:09:42 kos volumio[1031]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 18:09:42 kos volumio[1031]: info: CorePlayQueue::clearPlayQueue Nov 21 18:09:42 kos volumio[1031]: info: CorePlayQueue::saveQueue Nov 21 18:09:42 kos volumio[1031]: info: CoreCommandRouter::volumioPushQueue Nov 21 18:09:42 kos volumio[1031]: info: CoreStateMachine::addQueueItems Nov 21 18:09:42 kos volumio[1031]: info: CorePlayQueue::addQueueItems Nov 21 18:09:42 kos volumio[1031]: info: Preload queue cleared Nov 21 18:09:42 kos volumio[1031]: info: Adding Item to queue: music-library/USB/My_Disk/Music/LossLess/Jazz/@HQ Nov 21 18:09:42 kos volumio[1031]: info: Exploding uri music-library/USB/My_Disk/Music/LossLess/Jazz/@HQ in service mpd Nov 21 18:09:44 kos volumio[1031]: 0+0 records in Nov 21 18:09:44 kos volumio[1031]: 0+0 records out Nov 21 18:09:44 kos volumio[1031]: 0 bytes copied, 0.000236556 s, 0.0 kB/s Nov 21 18:09:44 kos volumio[1031]: info: camilladsp spawned new process with pid 4333, instance 1, run: true Nov 21 18:09:44 kos volumio[1031]: 0+0 records in Nov 21 18:09:44 kos volumio[1031]: 0+0 records out Nov 21 18:09:44 kos volumio[1031]: 0 bytes copied, 0.000242286 s, 0.0 kB/s Nov 21 18:09:44 kos volumio[1031]: info: Preload queue cleared Nov 21 18:09:44 kos volumio[1031]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 21 18:09:44 kos volumio[1031]: info: CoreStateMachine::ClearQueue Nov 21 18:09:44 kos volumio[1031]: info: CoreStateMachine::stop Nov 21 18:09:44 kos volumio[1031]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 18:09:44 kos volumio[1031]: info: CorePlayQueue::clearPlayQueue Nov 21 18:09:44 kos volumio[1031]: info: CorePlayQueue::saveQueue Nov 21 18:09:44 kos volumio[1031]: info: CoreCommandRouter::volumioPushQueue Nov 21 18:09:44 kos volumio[1031]: info: CoreStateMachine::addQueueItems Nov 21 18:09:44 kos volumio[1031]: info: CorePlayQueue::addQueueItems Nov 21 18:09:44 kos volumio[1031]: info: Preload queue cleared Nov 21 18:09:44 kos volumio[1031]: info: Adding Item to queue: music-library/USB/My_Disk/Music/LossLess/Jazz/@HQ Nov 21 18:09:44 kos volumio[1031]: info: Exploding uri music-library/USB/My_Disk/Music/LossLess/Jazz/@HQ in service mpd Nov 21 18:09:45 kos volumio[1031]: info: Preload queue cleared Nov 21 18:09:45 kos volumio[1031]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 21 18:09:45 kos volumio[1031]: info: CoreStateMachine::ClearQueue Nov 21 18:09:45 kos volumio[1031]: info: CoreStateMachine::stop Nov 21 18:09:45 kos volumio[1031]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 18:09:45 kos volumio[1031]: info: CorePlayQueue::clearPlayQueue Nov 21 18:09:45 kos volumio[1031]: info: CorePlayQueue::saveQueue Nov 21 18:09:45 kos volumio[1031]: info: CoreCommandRouter::volumioPushQueue Nov 21 18:09:45 kos volumio[1031]: info: CoreStateMachine::addQueueItems Nov 21 18:09:45 kos volumio[1031]: info: CorePlayQueue::addQueueItems Nov 21 18:09:45 kos volumio[1031]: info: Preload queue cleared Nov 21 18:09:45 kos volumio[1031]: info: Adding Item to queue: music-library/USB/My_Disk/Music/LossLess/Jazz/@HQ Nov 21 18:09:45 kos volumio[1031]: info: Exploding uri music-library/USB/My_Disk/Music/LossLess/Jazz/@HQ in service mpd Nov 21 18:09:46 kos volumio[1031]: info: ALBUMART /albumart?cacheid=621&web=%7B24-96%7D%20Herbie%20Hancock/Maiden%20Voyage/extralarge&path=%2Fmnt%2FUSB%2FMy_Disk%2FMusic%2FLossLess%2FJazz%2F%40HQ%2F1965%20-%20Herbie%20Hancock%20-%20Maiden%20Voyage%2F1965%20-%20Herbie%20Hancock%20-%20Maiden%20Voyage.cue&metadata=false Nov 21 18:09:46 kos volumio[1031]: info: URI /mnt/USB/My_Disk/Music/LossLess/Jazz/@HQ/1965 - Herbie Hancock - Maiden Voyage/1965 - Herbie Hancock - Maiden Voyage.cue Nov 21 18:09:46 kos volumio[1031]: info: ALBUMART /albumart?cacheid=621&web=%7B24-96%7D%20Herbie%20Hancock/Maiden%20Voyage/extralarge&path=%2Fmnt%2FUSB%2FMy_Disk%2FMusic%2FLossLess%2FJazz%2F%40HQ%2F1965%20-%20Herbie%20Hancock%20-%20Maiden%20Voyage%2F1965%20-%20Herbie%20Hancock%20-%20Maiden%20Voyage.cue&metadata=false Nov 21 18:09:46 kos volumio[1031]: info: URI /mnt/USB/My_Disk/Music/LossLess/Jazz/@HQ/1965 - Herbie Hancock - Maiden Voyage/1965 - Herbie Hancock - Maiden Voyage.cue Nov 21 18:09:46 kos volumio[1031]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 18:09:46 kos volumio[1031]: Error: Unable to resolve or reject the same promise twice Nov 21 18:09:46 kos volumio[1031]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Nov 21 18:09:46 kos volumio[1031]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Nov 21 18:09:46 kos volumio[1031]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Nov 21 18:09:46 kos volumio[1031]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Nov 21 18:09:46 kos volumio[1031]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Nov 21 18:09:46 kos volumio[1031]: at Socket.emit (events.js:315:20) Nov 21 18:09:46 kos volumio[1031]: at addChunk (internal/streams/readable.js:309:12) Nov 21 18:09:46 kos volumio[1031]: at readableAddChunk (internal/streams/readable.js:280:11) Nov 21 18:09:46 kos volumio[1031]: at Socket.Readable.push (internal/streams/readable.js:223:10) Nov 21 18:09:46 kos volumio[1031]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Nov 21 18:09:46 kos volumio[1031]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 18:09:47 kos sudo[4361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-21 18:08 Nov 21 18:09:47 kos sudo[4361]: 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"