-- Logs begin at Tue 2025-02-18 20:57:43 IST, end at Tue 2025-02-18 21:24:18 IST. -- Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 29984, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 29991, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 29998, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30005, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30012, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30019, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30026, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30033, instance 1, run: true Feb 18 21:23:00 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:00 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:00 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:00 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30040, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30047, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30054, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30061, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30068, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30075, instance 1, run: true Feb 18 21:23:00 volumio volumio[815]: info: camilladsp spawned new process with pid 30082, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30089, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30098, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30105, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30112, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30119, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30126, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30133, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30140, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30147, instance 1, run: true Feb 18 21:23:01 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:01 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:01 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:01 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30154, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30161, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30168, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30175, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30182, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30189, instance 1, run: true Feb 18 21:23:01 volumio volumio[815]: info: camilladsp spawned new process with pid 30196, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30203, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30212, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30219, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30226, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30233, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30240, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30247, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30254, instance 1, run: true Feb 18 21:23:02 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:02 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:02 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:02 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30261, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30268, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30275, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30282, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30289, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30296, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30303, instance 1, run: true Feb 18 21:23:02 volumio volumio[815]: info: camilladsp spawned new process with pid 30310, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30317, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30326, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30333, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30340, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30347, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30354, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30361, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30368, instance 1, run: true Feb 18 21:23:03 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:03 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:03 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:03 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30378, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30385, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30392, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30399, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30406, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30413, instance 1, run: true Feb 18 21:23:03 volumio volumio[815]: info: camilladsp spawned new process with pid 30420, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30427, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30434, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30443, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30450, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30457, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30464, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30471, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30491, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30499, instance 1, run: true Feb 18 21:23:04 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:04 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:04 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:04 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30506, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30513, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30520, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30527, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30534, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30541, instance 1, run: true Feb 18 21:23:04 volumio volumio[815]: info: camilladsp spawned new process with pid 30548, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30555, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30562, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30571, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30578, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30585, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30592, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30599, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30606, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 21:23:05 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 21:23:05 volumio volumio[815]: info: Discovery: Getting this device information Feb 18 21:23:05 volumio volumio[815]: info: CoreCommandRouter::volumioGetState Feb 18 21:23:05 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:05 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 21:23:05 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 21:23:05 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 21:23:05 volumio volumio[815]: info: Discovery: Getting this device information Feb 18 21:23:05 volumio volumio[815]: info: CoreCommandRouter::volumioGetState Feb 18 21:23:05 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:05 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 21:23:05 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:05 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:05 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:05 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30613, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30620, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30627, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30634, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30641, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30648, instance 1, run: true Feb 18 21:23:05 volumio volumio[815]: info: camilladsp spawned new process with pid 30655, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30662, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30669, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30676, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30685, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30692, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30699, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30706, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30713, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30720, instance 1, run: true Feb 18 21:23:06 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:06 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:06 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:06 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30727, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30734, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30741, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30748, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30755, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30762, instance 1, run: true Feb 18 21:23:06 volumio volumio[815]: info: camilladsp spawned new process with pid 30769, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30776, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30783, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30790, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30799, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30806, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30813, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 21:23:07 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 21:23:07 volumio volumio[815]: info: Discovery: Getting this device information Feb 18 21:23:07 volumio volumio[815]: info: CoreCommandRouter::volumioGetState Feb 18 21:23:07 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:07 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30820, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30827, instance 1, run: true Feb 18 21:23:07 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:07 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:07 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:07 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30834, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30841, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30848, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30855, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30862, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30869, instance 1, run: true Feb 18 21:23:07 volumio volumio[815]: info: camilladsp spawned new process with pid 30876, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30883, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30890, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30897, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30904, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: verbose: New Socket.io Connection to 192.168.29.24:3000 from 192.168.29.202 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 16 Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30913, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30920, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30927, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30934, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30941, instance 1, run: true Feb 18 21:23:08 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:08 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:08 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:08 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30948, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30955, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30962, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30969, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30976, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30983, instance 1, run: true Feb 18 21:23:08 volumio volumio[815]: info: camilladsp spawned new process with pid 30990, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 30997, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31004, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31011, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31018, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31027, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31034, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31041, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31048, instance 1, run: true Feb 18 21:23:09 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:09 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:09 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:09 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31055, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31062, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31069, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31076, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31083, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31090, instance 1, run: true Feb 18 21:23:09 volumio volumio[815]: info: camilladsp spawned new process with pid 31097, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31104, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31111, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31118, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31125, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31132, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31141, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31148, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31155, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31162, instance 1, run: true Feb 18 21:23:10 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:10 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:10 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:10 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31169, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31176, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31183, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31190, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31197, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31204, instance 1, run: true Feb 18 21:23:10 volumio volumio[815]: info: camilladsp spawned new process with pid 31211, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31218, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31225, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31232, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31239, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31246, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31255, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31262, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31269, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31276, instance 1, run: true Feb 18 21:23:11 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:11 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:11 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:11 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31283, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31290, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31297, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31304, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31311, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31318, instance 1, run: true Feb 18 21:23:11 volumio volumio[815]: info: camilladsp spawned new process with pid 31325, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31332, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31339, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31346, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31353, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31360, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31369, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31376, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31383, instance 1, run: true Feb 18 21:23:12 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:12 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:12 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:12 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31390, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31397, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31404, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31411, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31418, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31425, instance 1, run: true Feb 18 21:23:12 volumio volumio[815]: info: camilladsp spawned new process with pid 31432, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31439, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31446, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31453, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31460, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31467, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31474, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31483, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31490, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31497, instance 1, run: true Feb 18 21:23:13 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:13 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:13 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:13 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31507, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31515, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31522, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31529, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31536, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31543, instance 1, run: true Feb 18 21:23:13 volumio volumio[815]: info: camilladsp spawned new process with pid 31550, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31557, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31564, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31571, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31578, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31585, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31592, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31601, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31612, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31629, instance 1, run: true Feb 18 21:23:14 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:14 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:14 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:14 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31636, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31643, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31650, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31657, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31664, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31671, instance 1, run: true Feb 18 21:23:14 volumio volumio[815]: info: camilladsp spawned new process with pid 31678, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31685, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31692, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31699, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31706, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31713, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31720, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31729, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31736, instance 1, run: true Feb 18 21:23:15 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:15 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:15 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:15 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31743, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31750, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31757, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31764, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31771, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31778, instance 1, run: true Feb 18 21:23:15 volumio volumio[815]: info: camilladsp spawned new process with pid 31785, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31792, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31799, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31806, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31813, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31820, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31827, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31834, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31843, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 21:23:16 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 21:23:16 volumio volumio[815]: info: Discovery: Getting this device information Feb 18 21:23:16 volumio volumio[815]: info: CoreCommandRouter::volumioGetState Feb 18 21:23:16 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:16 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31850, instance 1, run: true Feb 18 21:23:16 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:16 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:16 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:16 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31857, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31864, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31871, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31878, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31885, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31892, instance 1, run: true Feb 18 21:23:16 volumio volumio[815]: info: camilladsp spawned new process with pid 31899, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31906, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31913, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31920, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31927, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31934, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31941, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31948, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31957, instance 1, run: true Feb 18 21:23:17 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:17 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:17 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31964, instance 1, run: true Feb 18 21:23:17 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31971, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31978, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31985, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31992, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 31999, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: info: camilladsp spawned new process with pid 32006, instance 1, run: true Feb 18 21:23:17 volumio volumio[815]: Searching plugin music_service/spop Feb 18 21:23:17 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: spop , search Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32014, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32021, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32028, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32035, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32042, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32049, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32056, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32063, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32072, instance 1, run: true Feb 18 21:23:18 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:18 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:18 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:18 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32079, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: All search sources collected, pushing search results Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32086, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32093, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32100, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32107, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32114, instance 1, run: true Feb 18 21:23:18 volumio volumio[815]: info: camilladsp spawned new process with pid 32121, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32128, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32135, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32142, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32150, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32157, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32164, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32171, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32178, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32187, instance 1, run: true Feb 18 21:23:19 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:19 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:19 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:19 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32194, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32201, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32208, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32215, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32222, instance 1, run: true Feb 18 21:23:19 volumio volumio[815]: info: camilladsp spawned new process with pid 32229, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32236, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32243, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32250, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32257, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32264, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32271, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32278, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32285, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32292, instance 1, run: true Feb 18 21:23:20 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:20 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:20 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:20 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32301, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32308, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32315, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32322, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32329, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32336, instance 1, run: true Feb 18 21:23:20 volumio volumio[815]: info: camilladsp spawned new process with pid 32343, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32350, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32357, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32364, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32371, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32378, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32385, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32392, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32399, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32406, instance 1, run: true Feb 18 21:23:21 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:21 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:21 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:21 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32415, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32422, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32429, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32436, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32443, instance 1, run: true Feb 18 21:23:21 volumio volumio[815]: info: camilladsp spawned new process with pid 32450, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32457, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32464, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32471, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32478, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32485, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Feb 18 21:23:22 volumio volumio[815]: info: In handleBrowseUri, curUri=spotify:artist:0qAzLiq8xpR9JbRRehpbja Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32492, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32499, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32506, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32513, instance 1, run: true Feb 18 21:23:22 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:22 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:22 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:22 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32520, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32529, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32536, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32543, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32550, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32557, instance 1, run: true Feb 18 21:23:22 volumio volumio[815]: info: camilladsp spawned new process with pid 32564, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32571, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32578, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32585, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32592, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32599, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32606, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32613, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32620, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:23 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:23 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32627, instance 1, run: true Feb 18 21:23:23 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:23 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:23 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:23 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32637, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32646, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32653, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32660, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32667, instance 1, run: true Feb 18 21:23:23 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:23 volumio volumio[815]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::ClearQueue Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::stop Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::clearPlayQueue Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:23 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::addQueueItems Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::addQueueItems Feb 18 21:23:23 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:4qAs1JB2dx9MewzhVCWu9Q Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:4qAs1JB2dx9MewzhVCWu9Q Feb 18 21:23:23 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::updateTrackBlock Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::getTrackBlock Feb 18 21:23:23 volumio volumio[815]: info: CoreCommandRouter::volumioPlay Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::play index 0 Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::addQueueItems Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::addQueueItems Feb 18 21:23:23 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:7apisHUvPKI2FYVPYWYZmc Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:7apisHUvPKI2FYVPYWYZmc Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:7JL7Bnya26SuSmcl1oJHEm Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:7JL7Bnya26SuSmcl1oJHEm Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:2S2g8RcpZ59BdRozZTi7Mk Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:2S2g8RcpZ59BdRozZTi7Mk Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:6KmTfIBvhs0fMxyheH9ZAK Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:6KmTfIBvhs0fMxyheH9ZAK Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:2v4UXZLOfUVlSl8mve7Avx Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:2v4UXZLOfUVlSl8mve7Avx Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:5yqTXtk2ihmkKyYJTZ6HhV Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:5yqTXtk2ihmkKyYJTZ6HhV Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:51jzNn0PvW2BjOZDwV4fWy Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:51jzNn0PvW2BjOZDwV4fWy Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:22zJPqL8KIWHq7oKc0A2d4 Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:22zJPqL8KIWHq7oKc0A2d4 Feb 18 21:23:23 volumio volumio[815]: info: Adding Item to queue: spotify:track:5GaprdZbhanrNJosv9AREB Feb 18 21:23:23 volumio volumio[815]: info: Using cached record of: spotify:track:5GaprdZbhanrNJosv9AREB Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::stop Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:23 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::play index undefined Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::updateTrackBlock Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::getTrackBlock Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:23 volumio volumio[815]: info: CoreStateMachine::startPlaybackTimer Feb 18 21:23:23 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:23 volumio volumio[815]: info: [1739894003947] ControllerSpotify::clearAddPlayTrack Feb 18 21:23:23 volumio volumio[815]: info: Sending Spotify command with payload to local API: /player/play Feb 18 21:23:23 volumio volumio[815]: info: camilladsp spawned new process with pid 32674, instance 1, run: true Feb 18 21:23:24 volumio go-librespot[22788]: time="2025-02-18T21:23:24+05:30" level=debug msg="resolved context of track" uri="spotify:track:4qAs1JB2dx9MewzhVCWu9Q" Feb 18 21:23:24 volumio go-librespot[22788]: time="2025-02-18T21:23:24+05:30" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:track:4qAs1JB2dx9MewzhVCWu9Q" Feb 18 21:23:24 volumio go-librespot[22788]: time="2025-02-18T21:23:24+05:30" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:4qAs1JB2dx9MewzhVCWu9Q" Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32681, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32688, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32695, instance 1, run: true Feb 18 21:23:24 volumio go-librespot[22788]: time="2025-02-18T21:23:24+05:30" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 21:23:24 volumio go-librespot[22788]: time="2025-02-18T21:23:24+05:30" level=trace msg="emitting websocket event: will_play" Feb 18 21:23:24 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4qAs1JB2dx9MewzhVCWu9Q","play_origin":"go-librespot"}} Feb 18 21:23:24 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4qAs1JB2dx9MewzhVCWu9Q","play_origin":"go-librespot"}} Feb 18 21:23:24 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4qAs1JB2dx9MewzhVCWu9Q","play_origin":"go-librespot"}} Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32702, instance 1, run: true Feb 18 21:23:24 volumio go-librespot[22788]: time="2025-02-18T21:23:24+05:30" level=debug msg="selected format OGG_VORBIS_320 (e3a35536fbdf253cc424982ed633b2e2ef287aa0)" uri="spotify:track:4qAs1JB2dx9MewzhVCWu9Q" Feb 18 21:23:24 volumio go-librespot[22788]: time="2025-02-18T21:23:24+05:30" level=debug msg="requested aes key for file e3a35536fbdf253cc424982ed633b2e2ef287aa0, gid: 4qAs1JB2dx9MewzhVCWu9Q" Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32709, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32716, instance 1, run: true Feb 18 21:23:24 volumio go-librespot[22788]: time="2025-02-18T21:23:24+05:30" level=error msg="failed handling request play" error="failed loading context: failed loading current track (load context): failed creating stream for spotify:track:4qAs1JB2dx9MewzhVCWu9Q: failed retrieving audio key: failed retrieving aes key with code 1" Feb 18 21:23:24 volumio volumio[815]: error: Failed to send command to Spotify local API: /player/play: Error: Internal Server Error Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32723, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32730, instance 1, run: true Feb 18 21:23:24 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:24 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:24 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:24 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32751, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32758, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 32767, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 308, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 315, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 322, instance 1, run: true Feb 18 21:23:24 volumio volumio[815]: info: camilladsp spawned new process with pid 329, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 337, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 344, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 351, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 358, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 367, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 374, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 381, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 388, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 395, instance 1, run: true Feb 18 21:23:25 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:25 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:25 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:25 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 409, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 416, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 425, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 432, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 439, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 446, instance 1, run: true Feb 18 21:23:25 volumio volumio[815]: info: camilladsp spawned new process with pid 453, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 460, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 467, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 474, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 481, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 488, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 495, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 502, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 509, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 516, instance 1, run: true Feb 18 21:23:26 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:26 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:26 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:26 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 526, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 535, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 550, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 558, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 565, instance 1, run: true Feb 18 21:23:26 volumio volumio[815]: info: camilladsp spawned new process with pid 573, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 580, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 589, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 596, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 603, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 611, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 618, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 625, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 632, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 639, instance 1, run: true Feb 18 21:23:27 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:27 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:27 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:27 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 646, instance 1, run: true Feb 18 21:23:27 volumio go-librespot[22788]: time="2025-02-18T21:23:27+05:30" level=trace msg="sent dealer ping" Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 653, instance 1, run: true Feb 18 21:23:27 volumio go-librespot[22788]: time="2025-02-18T21:23:27+05:30" level=trace msg="received dealer pong" Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 660, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 669, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 676, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 683, instance 1, run: true Feb 18 21:23:27 volumio volumio[815]: info: camilladsp spawned new process with pid 690, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 697, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 704, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 711, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 718, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 725, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 732, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 739, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 746, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 753, instance 1, run: true Feb 18 21:23:28 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:28 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:28 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:28 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 760, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 767, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 774, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 784, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 793, instance 1, run: true Feb 18 21:23:28 volumio volumio[815]: info: camilladsp spawned new process with pid 803, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 810, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 824, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 832, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 839, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 850, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 857, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 864, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 871, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 879, instance 1, run: true Feb 18 21:23:29 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:29 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:29 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:29 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 886, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 893, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 900, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 937, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 946, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 953, instance 1, run: true Feb 18 21:23:29 volumio volumio[815]: info: camilladsp spawned new process with pid 961, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 968, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 975, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 982, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 989, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 996, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1003, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1018, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1025, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1036, instance 1, run: true Feb 18 21:23:30 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:30 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:30 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:30 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1043, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1050, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1057, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1064, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1073, instance 1, run: true Feb 18 21:23:30 volumio volumio[815]: info: camilladsp spawned new process with pid 1080, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1087, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1094, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1101, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1108, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1115, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1122, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1129, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1136, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1144, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1151, instance 1, run: true Feb 18 21:23:31 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:31 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:31 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:31 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1158, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1165, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1172, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1179, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1188, instance 1, run: true Feb 18 21:23:31 volumio volumio[815]: info: camilladsp spawned new process with pid 1195, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1203, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1211, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1222, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1237, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1244, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1251, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1258, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1265, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1272, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1279, instance 1, run: true Feb 18 21:23:32 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:32 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:32 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:32 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1286, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1293, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1300, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1307, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1316, instance 1, run: true Feb 18 21:23:32 volumio volumio[815]: info: camilladsp spawned new process with pid 1323, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1330, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1337, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1344, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1351, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1359, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1366, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1373, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1380, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1387, instance 1, run: true Feb 18 21:23:33 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:33 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:33 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:33 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1397, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:33 volumio volumio[815]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::ClearQueue Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::stop Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:33 volumio volumio[815]: info: CorePlayQueue::clearPlayQueue Feb 18 21:23:33 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:33 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::addQueueItems Feb 18 21:23:33 volumio volumio[815]: info: CorePlayQueue::addQueueItems Feb 18 21:23:33 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:33 volumio volumio[815]: info: Adding Item to queue: spotify:track:6KmTfIBvhs0fMxyheH9ZAK Feb 18 21:23:33 volumio volumio[815]: info: Using cached record of: spotify:track:6KmTfIBvhs0fMxyheH9ZAK Feb 18 21:23:33 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:33 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::updateTrackBlock Feb 18 21:23:33 volumio volumio[815]: info: CorePlayQueue::getTrackBlock Feb 18 21:23:33 volumio volumio[815]: info: CoreCommandRouter::volumioPlay Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::play index 0 Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::stop Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::play index undefined Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:33 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:33 volumio volumio[815]: info: CoreStateMachine::startPlaybackTimer Feb 18 21:23:33 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:33 volumio volumio[815]: info: [1739894013667] ControllerSpotify::clearAddPlayTrack Feb 18 21:23:33 volumio volumio[815]: info: Sending Spotify command with payload to local API: /player/play Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1404, instance 1, run: true Feb 18 21:23:33 volumio go-librespot[22788]: time="2025-02-18T21:23:33+05:30" level=debug msg="resolved context of track" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:33 volumio go-librespot[22788]: time="2025-02-18T21:23:33+05:30" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:33 volumio go-librespot[22788]: time="2025-02-18T21:23:33+05:30" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1411, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1426, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1433, instance 1, run: true Feb 18 21:23:33 volumio go-librespot[22788]: time="2025-02-18T21:23:33+05:30" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 21:23:33 volumio go-librespot[22788]: time="2025-02-18T21:23:33+05:30" level=trace msg="emitting websocket event: will_play" Feb 18 21:23:33 volumio volumio[815]: info: camilladsp spawned new process with pid 1443, instance 1, run: true Feb 18 21:23:33 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:33 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:33 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1450, instance 1, run: true Feb 18 21:23:34 volumio go-librespot[22788]: time="2025-02-18T21:23:34+05:30" level=debug msg="selected format OGG_VORBIS_320 (9d41312b0426baa28d59697df2f701680454dd40)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:34 volumio go-librespot[22788]: time="2025-02-18T21:23:34+05:30" level=debug msg="requested aes key for file 9d41312b0426baa28d59697df2f701680454dd40, gid: 6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1457, instance 1, run: true Feb 18 21:23:34 volumio go-librespot[22788]: time="2025-02-18T21:23:34+05:30" level=error msg="failed handling request play" error="failed loading context: failed loading current track (load context): failed creating stream for spotify:track:6KmTfIBvhs0fMxyheH9ZAK: failed retrieving audio key: failed retrieving aes key with code 1" Feb 18 21:23:34 volumio volumio[815]: error: Failed to send command to Spotify local API: /player/play: Error: Internal Server Error Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1464, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1471, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1478, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1485, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1492, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1499, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1506, instance 1, run: true Feb 18 21:23:34 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:34 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:34 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:34 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1527, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1534, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1541, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1548, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1555, instance 1, run: true Feb 18 21:23:34 volumio volumio[815]: info: camilladsp spawned new process with pid 1562, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1571, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1578, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1585, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1592, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1599, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1606, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1613, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1620, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1627, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1634, instance 1, run: true Feb 18 21:23:35 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:35 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:35 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:35 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1641, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1648, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1655, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1662, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1669, instance 1, run: true Feb 18 21:23:35 volumio volumio[815]: info: camilladsp spawned new process with pid 1676, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1685, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1692, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1699, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1706, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1713, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1720, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1727, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1734, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1741, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1748, instance 1, run: true Feb 18 21:23:36 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:36 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:36 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:36 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1755, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1762, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1769, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1776, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1783, instance 1, run: true Feb 18 21:23:36 volumio volumio[815]: info: camilladsp spawned new process with pid 1790, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1799, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1806, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1813, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1820, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1827, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1834, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1841, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1848, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1855, instance 1, run: true Feb 18 21:23:37 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:37 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:37 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:37 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1862, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1869, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1876, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1883, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1890, instance 1, run: true Feb 18 21:23:37 volumio volumio[815]: info: camilladsp spawned new process with pid 1897, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1904, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1913, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1920, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1927, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1934, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1941, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1948, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1955, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1962, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1969, instance 1, run: true Feb 18 21:23:38 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:38 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:38 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:38 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1976, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1983, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1990, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 1997, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 2004, instance 1, run: true Feb 18 21:23:38 volumio volumio[815]: info: camilladsp spawned new process with pid 2011, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2018, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2027, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2034, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2052, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2077, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2105, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2119, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2126, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2133, instance 1, run: true Feb 18 21:23:39 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:39 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:39 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:39 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2140, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2147, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2154, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2161, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2168, instance 1, run: true Feb 18 21:23:39 volumio volumio[815]: info: camilladsp spawned new process with pid 2175, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2182, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2191, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2198, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2205, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2212, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2219, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2226, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2233, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2240, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2247, instance 1, run: true Feb 18 21:23:40 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:40 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:40 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:40 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2254, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2261, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2268, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2275, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2282, instance 1, run: true Feb 18 21:23:40 volumio volumio[815]: info: camilladsp spawned new process with pid 2289, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2297, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2306, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2313, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2320, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2327, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2334, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2341, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2348, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2355, instance 1, run: true Feb 18 21:23:41 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:41 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:41 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:41 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2362, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2369, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2376, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2383, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2390, instance 1, run: true Feb 18 21:23:41 volumio volumio[815]: info: camilladsp spawned new process with pid 2397, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2404, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2411, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2418, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2427, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2434, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2441, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2448, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2455, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2462, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2469, instance 1, run: true Feb 18 21:23:42 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:42 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:42 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:42 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2476, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2483, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2490, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2497, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2504, instance 1, run: true Feb 18 21:23:42 volumio volumio[815]: info: camilladsp spawned new process with pid 2511, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2518, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2525, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2532, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2541, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2548, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2555, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2562, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2569, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2576, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2583, instance 1, run: true Feb 18 21:23:43 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:43 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:43 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:43 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2593, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2600, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2607, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2614, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2621, instance 1, run: true Feb 18 21:23:43 volumio volumio[815]: info: camilladsp spawned new process with pid 2628, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2635, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2642, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2649, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2658, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2665, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2672, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2679, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2686, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2693, instance 1, run: true Feb 18 21:23:44 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:44 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:44 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:44 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2710, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2721, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2728, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2735, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2742, instance 1, run: true Feb 18 21:23:44 volumio volumio[815]: info: camilladsp spawned new process with pid 2749, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2756, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2763, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2770, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2777, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2786, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2793, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2800, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2807, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2814, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2821, instance 1, run: true Feb 18 21:23:45 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:45 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:45 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:45 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2828, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2835, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2842, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2849, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2856, instance 1, run: true Feb 18 21:23:45 volumio volumio[815]: info: camilladsp spawned new process with pid 2863, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2870, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2877, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2884, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2891, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2900, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2907, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2914, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2921, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2928, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2935, instance 1, run: true Feb 18 21:23:46 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:46 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:46 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:46 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2942, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2949, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2956, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2963, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2970, instance 1, run: true Feb 18 21:23:46 volumio volumio[815]: info: camilladsp spawned new process with pid 2977, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 2984, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 2991, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 2998, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3005, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3014, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3021, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3028, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3035, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3042, instance 1, run: true Feb 18 21:23:47 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:47 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:47 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:47 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3049, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3056, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3063, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3070, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3077, instance 1, run: true Feb 18 21:23:47 volumio volumio[815]: info: camilladsp spawned new process with pid 3084, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3091, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3098, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3105, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3112, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3119, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3128, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3135, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3142, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3149, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3156, instance 1, run: true Feb 18 21:23:48 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:48 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:48 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:48 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3163, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3171, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3178, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3185, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3194, instance 1, run: true Feb 18 21:23:48 volumio volumio[815]: info: camilladsp spawned new process with pid 3211, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3218, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3225, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3232, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3239, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3246, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3256, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3265, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3272, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3279, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3286, instance 1, run: true Feb 18 21:23:49 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:49 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:49 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:49 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3293, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3313, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3336, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3345, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3354, instance 1, run: true Feb 18 21:23:49 volumio volumio[815]: info: camilladsp spawned new process with pid 3362, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3375, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3396, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3403, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3410, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3417, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3426, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3433, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3440, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3447, instance 1, run: true Feb 18 21:23:50 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:50 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:50 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:50 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3454, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3461, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3468, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3475, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3482, instance 1, run: true Feb 18 21:23:50 volumio volumio[815]: info: camilladsp spawned new process with pid 3489, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3496, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3503, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3510, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 21:23:51 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 21:23:51 volumio volumio[815]: info: Discovery: Getting this device information Feb 18 21:23:51 volumio volumio[815]: info: CoreCommandRouter::volumioGetState Feb 18 21:23:51 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:51 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3517, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3524, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3531, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3540, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3547, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3554, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3561, instance 1, run: true Feb 18 21:23:51 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:51 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:51 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:51 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3568, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3575, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: CoreCommandRouter::volumioPlay Feb 18 21:23:51 volumio volumio[815]: info: CoreStateMachine::play index undefined Feb 18 21:23:51 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:51 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:51 volumio volumio[815]: info: CoreStateMachine::startPlaybackTimer Feb 18 21:23:51 volumio volumio[815]: info: CorePlayQueue::getTrack 0 Feb 18 21:23:51 volumio volumio[815]: info: [1739894031727] ControllerSpotify::clearAddPlayTrack Feb 18 21:23:51 volumio volumio[815]: info: Sending Spotify command with payload to local API: /player/play Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3582, instance 1, run: true Feb 18 21:23:51 volumio go-librespot[22788]: time="2025-02-18T21:23:51+05:30" level=debug msg="resolved context of track" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:51 volumio go-librespot[22788]: time="2025-02-18T21:23:51+05:30" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:51 volumio go-librespot[22788]: time="2025-02-18T21:23:51+05:30" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3589, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3596, instance 1, run: true Feb 18 21:23:51 volumio volumio[815]: info: camilladsp spawned new process with pid 3603, instance 1, run: true Feb 18 21:23:51 volumio go-librespot[22788]: time="2025-02-18T21:23:51+05:30" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 21:23:51 volumio go-librespot[22788]: time="2025-02-18T21:23:51+05:30" level=trace msg="emitting websocket event: will_play" Feb 18 21:23:51 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:51 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:51 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3610, instance 1, run: true Feb 18 21:23:52 volumio go-librespot[22788]: time="2025-02-18T21:23:52+05:30" level=debug msg="selected format OGG_VORBIS_320 (9d41312b0426baa28d59697df2f701680454dd40)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:52 volumio go-librespot[22788]: time="2025-02-18T21:23:52+05:30" level=debug msg="requested aes key for file 9d41312b0426baa28d59697df2f701680454dd40, gid: 6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3617, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3624, instance 1, run: true Feb 18 21:23:52 volumio go-librespot[22788]: time="2025-02-18T21:23:52+05:30" level=error msg="failed handling request play" error="failed loading context: failed loading current track (load context): failed creating stream for spotify:track:6KmTfIBvhs0fMxyheH9ZAK: failed retrieving audio key: failed retrieving aes key with code 1" Feb 18 21:23:52 volumio volumio[815]: error: Failed to send command to Spotify local API: /player/play: Error: Internal Server Error Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3631, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3638, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3645, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3654, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3661, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3668, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3675, instance 1, run: true Feb 18 21:23:52 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:52 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:52 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:52 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3682, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3689, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3696, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3703, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3710, instance 1, run: true Feb 18 21:23:52 volumio volumio[815]: info: camilladsp spawned new process with pid 3717, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3724, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3731, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3738, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3745, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3752, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3759, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3768, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3775, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3782, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3791, instance 1, run: true Feb 18 21:23:53 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:53 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:53 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:53 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3800, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3807, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3814, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3821, instance 1, run: true Feb 18 21:23:53 volumio volumio[815]: info: camilladsp spawned new process with pid 3828, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3835, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3842, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3849, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3856, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3863, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3870, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3877, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3886, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3893, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3901, instance 1, run: true Feb 18 21:23:54 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:54 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:54 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:54 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3908, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3929, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3936, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3943, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3950, instance 1, run: true Feb 18 21:23:54 volumio volumio[815]: info: camilladsp spawned new process with pid 3957, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 3964, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 3971, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 3978, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 3985, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 3992, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 3999, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4006, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4015, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4022, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4029, instance 1, run: true Feb 18 21:23:55 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:55 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:55 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:55 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4036, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4043, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4050, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4057, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4064, instance 1, run: true Feb 18 21:23:55 volumio volumio[815]: info: camilladsp spawned new process with pid 4071, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4078, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4085, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4092, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4099, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4106, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4113, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4120, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4129, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4136, instance 1, run: true Feb 18 21:23:56 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:56 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:56 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:56 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4143, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4150, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4157, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4164, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4171, instance 1, run: true Feb 18 21:23:56 volumio volumio[815]: info: camilladsp spawned new process with pid 4178, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4185, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4193, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4200, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4207, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4214, instance 1, run: true Feb 18 21:23:57 volumio go-librespot[22788]: time="2025-02-18T21:23:57+05:30" level=trace msg="received accesspoint ping" Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4221, instance 1, run: true Feb 18 21:23:57 volumio go-librespot[22788]: time="2025-02-18T21:23:57+05:30" level=trace msg="received accesspoint pong ack" Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4228, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4235, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4244, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4251, instance 1, run: true Feb 18 21:23:57 volumio go-librespot[22788]: time="2025-02-18T21:23:57+05:30" level=trace msg="sent dealer ping" Feb 18 21:23:57 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:57 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:57 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:57 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4258, instance 1, run: true Feb 18 21:23:57 volumio go-librespot[22788]: time="2025-02-18T21:23:57+05:30" level=trace msg="received dealer pong" Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4265, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4272, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4279, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4286, instance 1, run: true Feb 18 21:23:57 volumio volumio[815]: info: camilladsp spawned new process with pid 4293, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4300, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::ClearQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::stop Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::clearPlayQueue Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::addQueueItems Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::addQueueItems Feb 18 21:23:58 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:4qAs1JB2dx9MewzhVCWu9Q Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:4qAs1JB2dx9MewzhVCWu9Q Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:7apisHUvPKI2FYVPYWYZmc Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:7apisHUvPKI2FYVPYWYZmc Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:7JL7Bnya26SuSmcl1oJHEm Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:7JL7Bnya26SuSmcl1oJHEm Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:2S2g8RcpZ59BdRozZTi7Mk Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:2S2g8RcpZ59BdRozZTi7Mk Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:6KmTfIBvhs0fMxyheH9ZAK Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:6KmTfIBvhs0fMxyheH9ZAK Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::updateTrackBlock Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::getTrackBlock Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioPlay Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::play index 4 Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::addQueueItems Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::addQueueItems Feb 18 21:23:58 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:2v4UXZLOfUVlSl8mve7Avx Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:2v4UXZLOfUVlSl8mve7Avx Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:5yqTXtk2ihmkKyYJTZ6HhV Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:5yqTXtk2ihmkKyYJTZ6HhV Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:51jzNn0PvW2BjOZDwV4fWy Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:51jzNn0PvW2BjOZDwV4fWy Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:22zJPqL8KIWHq7oKc0A2d4 Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:22zJPqL8KIWHq7oKc0A2d4 Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:5GaprdZbhanrNJosv9AREB Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:5GaprdZbhanrNJosv9AREB Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::stop Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::play index undefined Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::updateTrackBlock Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::getTrackBlock Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::getTrack 4 Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::startPlaybackTimer Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::getTrack 4 Feb 18 21:23:58 volumio volumio[815]: info: [1739894038122] ControllerSpotify::clearAddPlayTrack Feb 18 21:23:58 volumio volumio[815]: info: Sending Spotify command with payload to local API: /player/play Feb 18 21:23:58 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::ClearQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::stop Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::clearPlayQueue Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::addQueueItems Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::addQueueItems Feb 18 21:23:58 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:4qAs1JB2dx9MewzhVCWu9Q Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:4qAs1JB2dx9MewzhVCWu9Q Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:7apisHUvPKI2FYVPYWYZmc Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:7apisHUvPKI2FYVPYWYZmc Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:7JL7Bnya26SuSmcl1oJHEm Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:7JL7Bnya26SuSmcl1oJHEm Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:2S2g8RcpZ59BdRozZTi7Mk Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:2S2g8RcpZ59BdRozZTi7Mk Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:6KmTfIBvhs0fMxyheH9ZAK Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:6KmTfIBvhs0fMxyheH9ZAK Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::updateTrackBlock Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::getTrackBlock Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioPlay Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::play index 4 Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::addQueueItems Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::addQueueItems Feb 18 21:23:58 volumio volumio[815]: info: Preload queue cleared Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:2v4UXZLOfUVlSl8mve7Avx Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:2v4UXZLOfUVlSl8mve7Avx Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:5yqTXtk2ihmkKyYJTZ6HhV Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:5yqTXtk2ihmkKyYJTZ6HhV Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:51jzNn0PvW2BjOZDwV4fWy Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:51jzNn0PvW2BjOZDwV4fWy Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:22zJPqL8KIWHq7oKc0A2d4 Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:22zJPqL8KIWHq7oKc0A2d4 Feb 18 21:23:58 volumio volumio[815]: info: Adding Item to queue: spotify:track:5GaprdZbhanrNJosv9AREB Feb 18 21:23:58 volumio volumio[815]: info: Using cached record of: spotify:track:5GaprdZbhanrNJosv9AREB Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::stop Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:58 volumio volumio[815]: info: CoreCommandRouter::volumioPushQueue Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::saveQueue Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::play index undefined Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::updateTrackBlock Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::getTrackBlock Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::getTrack 4 Feb 18 21:23:58 volumio volumio[815]: info: CoreStateMachine::startPlaybackTimer Feb 18 21:23:58 volumio volumio[815]: info: CorePlayQueue::getTrack 4 Feb 18 21:23:58 volumio volumio[815]: info: [1739894038175] ControllerSpotify::clearAddPlayTrack Feb 18 21:23:58 volumio volumio[815]: info: Sending Spotify command with payload to local API: /player/play Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4308, instance 1, run: true Feb 18 21:23:58 volumio go-librespot[22788]: time="2025-02-18T21:23:58+05:30" level=debug msg="resolved context of track" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:58 volumio go-librespot[22788]: time="2025-02-18T21:23:58+05:30" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:58 volumio go-librespot[22788]: time="2025-02-18T21:23:58+05:30" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4315, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4322, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4329, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4336, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4345, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4352, instance 1, run: true Feb 18 21:23:58 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:58 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:58 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:58 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4359, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4366, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4373, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4380, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4387, instance 1, run: true Feb 18 21:23:58 volumio volumio[815]: info: camilladsp spawned new process with pid 4394, instance 1, run: true Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=trace msg="emitting websocket event: will_play" Feb 18 21:23:59 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:59 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4401, instance 1, run: true Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4408, instance 1, run: true Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=debug msg="selected format OGG_VORBIS_320 (9d41312b0426baa28d59697df2f701680454dd40)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=debug msg="requested aes key for file 9d41312b0426baa28d59697df2f701680454dd40, gid: 6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4415, instance 1, run: true Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=error msg="failed handling request play" error="failed loading context: failed loading current track (load context): failed creating stream for spotify:track:6KmTfIBvhs0fMxyheH9ZAK: failed retrieving audio key: failed retrieving aes key with code 1" Feb 18 21:23:59 volumio volumio[815]: error: Failed to send command to Spotify local API: /player/play: Error: Internal Server Error Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4422, instance 1, run: true Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=debug msg="resolved context of track" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4430, instance 1, run: true Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4437, instance 1, run: true Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4444, instance 1, run: true Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=trace msg="emitting websocket event: will_play" Feb 18 21:23:59 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:59 volumio volumio[815]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6KmTfIBvhs0fMxyheH9ZAK","play_origin":"go-librespot"}} Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4451, instance 1, run: true Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=debug msg="selected format OGG_VORBIS_320 (9d41312b0426baa28d59697df2f701680454dd40)" uri="spotify:track:6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=debug msg="requested aes key for file 9d41312b0426baa28d59697df2f701680454dd40, gid: 6KmTfIBvhs0fMxyheH9ZAK" Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4458, instance 1, run: true Feb 18 21:23:59 volumio go-librespot[22788]: time="2025-02-18T21:23:59+05:30" level=error msg="failed handling request play" error="failed loading context: failed loading current track (load context): failed creating stream for spotify:track:6KmTfIBvhs0fMxyheH9ZAK: failed retrieving audio key: failed retrieving aes key with code 1" Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4467, instance 1, run: true Feb 18 21:23:59 volumio volumio[815]: error: Failed to send command to Spotify local API: /player/play: Error: Internal Server Error Feb 18 21:23:59 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:59 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:59 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:23:59 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4474, instance 1, run: true Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4481, instance 1, run: true Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4488, instance 1, run: true Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4495, instance 1, run: true Feb 18 21:23:59 volumio volumio[815]: info: camilladsp spawned new process with pid 4502, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4509, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4516, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4523, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4530, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4537, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4544, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4551, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4558, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4565, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4572, instance 1, run: true Feb 18 21:24:00 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:00 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:00 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:00 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4581, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4588, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4595, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4602, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4609, instance 1, run: true Feb 18 21:24:00 volumio volumio[815]: info: camilladsp spawned new process with pid 4616, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4623, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4630, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4637, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4644, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4651, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4658, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4665, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4672, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4679, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4686, instance 1, run: true Feb 18 21:24:01 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:01 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:01 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:01 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4695, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4702, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4709, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4716, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4723, instance 1, run: true Feb 18 21:24:01 volumio volumio[815]: info: camilladsp spawned new process with pid 4730, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4737, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4744, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4751, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4758, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4765, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4772, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4779, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4786, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4793, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4800, instance 1, run: true Feb 18 21:24:02 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:02 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:02 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:02 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4809, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4816, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4823, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4830, instance 1, run: true Feb 18 21:24:02 volumio volumio[815]: info: camilladsp spawned new process with pid 4837, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4844, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4851, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4858, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4865, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4872, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4879, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4886, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4893, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4900, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4907, instance 1, run: true Feb 18 21:24:03 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:03 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:03 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:03 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4917, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4926, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4933, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: Preload queue cleared Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4942, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4949, instance 1, run: true Feb 18 21:24:03 volumio volumio[815]: info: camilladsp spawned new process with pid 4956, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 4964, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 4971, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 4978, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 4986, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 4993, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5000, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5007, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5014, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5021, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5028, instance 1, run: true Feb 18 21:24:04 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:04 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:04 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:04 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5035, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5058, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5065, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5072, instance 1, run: true Feb 18 21:24:04 volumio volumio[815]: info: camilladsp spawned new process with pid 5079, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5086, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5093, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5100, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5107, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5114, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5121, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5128, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5135, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5142, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5149, instance 1, run: true Feb 18 21:24:05 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:05 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:05 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:05 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5156, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5163, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5172, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5179, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5186, instance 1, run: true Feb 18 21:24:05 volumio volumio[815]: info: camilladsp spawned new process with pid 5193, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5200, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5207, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5214, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5221, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5228, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5235, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5242, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5249, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5256, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5263, instance 1, run: true Feb 18 21:24:06 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:06 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:06 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:06 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5270, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5277, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5286, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5293, instance 1, run: true Feb 18 21:24:06 volumio volumio[815]: info: camilladsp spawned new process with pid 5300, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5307, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5314, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5321, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5328, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5335, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5342, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5349, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5356, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5363, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5370, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5377, instance 1, run: true Feb 18 21:24:07 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:07 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:07 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:07 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5384, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5391, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5400, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5407, instance 1, run: true Feb 18 21:24:07 volumio volumio[815]: info: camilladsp spawned new process with pid 5414, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5421, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5428, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5435, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5442, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5449, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5456, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5463, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5470, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5477, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5484, instance 1, run: true Feb 18 21:24:08 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:08 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:08 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:08 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5491, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5498, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5505, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5514, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5521, instance 1, run: true Feb 18 21:24:08 volumio volumio[815]: info: camilladsp spawned new process with pid 5528, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5535, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5542, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5549, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5556, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5563, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5570, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5577, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5584, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5591, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5598, instance 1, run: true Feb 18 21:24:09 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:09 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:09 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:09 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5605, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5612, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5619, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5628, instance 1, run: true Feb 18 21:24:09 volumio volumio[815]: info: camilladsp spawned new process with pid 5635, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5642, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5649, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5656, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5663, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5670, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5677, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: Preload queue cleared Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5684, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5691, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5698, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5705, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5712, instance 1, run: true Feb 18 21:24:10 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:10 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:10 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:10 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5719, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5726, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5733, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5742, instance 1, run: true Feb 18 21:24:10 volumio volumio[815]: info: camilladsp spawned new process with pid 5749, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5756, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5763, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5770, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5777, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5784, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5791, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5798, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5805, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5812, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5819, instance 1, run: true Feb 18 21:24:11 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:11 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:11 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:11 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5826, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5833, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5840, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5847, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5856, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 18 21:24:11 volumio volumio[815]: info: camilladsp spawned new process with pid 5863, instance 1, run: true Feb 18 21:24:11 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5870, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5877, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: Preload queue cleared Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5884, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: Preload queue cleared Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5891, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5898, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5905, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5912, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5919, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5926, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5933, instance 1, run: true Feb 18 21:24:12 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:12 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:12 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:12 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5940, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5947, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5954, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5961, instance 1, run: true Feb 18 21:24:12 volumio volumio[815]: info: camilladsp spawned new process with pid 5970, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 5977, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 5984, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 5991, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 5998, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6005, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6012, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6019, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6026, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6033, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6040, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6047, instance 1, run: true Feb 18 21:24:13 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:13 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:13 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:13 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6057, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6064, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6071, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6078, instance 1, run: true Feb 18 21:24:13 volumio volumio[815]: info: camilladsp spawned new process with pid 6088, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6095, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6102, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6109, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6116, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6123, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6130, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6137, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6144, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6151, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6158, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 18 21:24:14 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:14 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:14 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:14 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6165, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6172, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6193, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6200, instance 1, run: true Feb 18 21:24:14 volumio volumio[815]: info: camilladsp spawned new process with pid 6207, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6216, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: Preload queue cleared Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6223, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6230, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6237, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6244, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6251, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6258, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6265, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6272, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6279, instance 1, run: true Feb 18 21:24:15 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:15 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:15 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:15 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6286, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6293, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6300, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6307, instance 1, run: true Feb 18 21:24:15 volumio volumio[815]: info: camilladsp spawned new process with pid 6314, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6323, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6330, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6337, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6344, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6351, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6358, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6365, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6372, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6379, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6386, instance 1, run: true Feb 18 21:24:16 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:16 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:16 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:16 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6393, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6400, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6407, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6414, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6421, instance 1, run: true Feb 18 21:24:16 volumio volumio[815]: info: camilladsp spawned new process with pid 6428, instance 1, run: true Feb 18 21:24:17 volumio volumio[815]: info: camilladsp spawned new process with pid 6437, instance 1, run: true Feb 18 21:24:17 volumio volumio[815]: info: camilladsp spawned new process with pid 6444, instance 1, run: true Feb 18 21:24:17 volumio volumio[815]: info: camilladsp spawned new process with pid 6451, instance 1, run: true Feb 18 21:24:17 volumio volumio[815]: info: camilladsp spawned new process with pid 6458, instance 1, run: true Feb 18 21:24:17 volumio volumio[815]: info: camilladsp spawned new process with pid 6465, instance 1, run: true Feb 18 21:24:17 volumio volumio[815]: info: camilladsp spawned new process with pid 6472, instance 1, run: true Feb 18 21:24:17 volumio volumio[815]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 18 21:24:17 volumio volumio[815]: info: camilladsp spawned new process with pid 6479, instance 1, run: true Feb 18 21:24:17 volumio volumio[815]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 21:24:17 volumio volumio[815]: TypeError: Cannot read property 'length' of undefined Feb 18 21:24:17 volumio volumio[815]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Feb 18 21:24:17 volumio volumio[815]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Feb 18 21:24:17 volumio volumio[815]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Feb 18 21:24:17 volumio volumio[815]: at Parser.emit (events.js:315:20) Feb 18 21:24:17 volumio volumio[815]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Feb 18 21:24:17 volumio volumio[815]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Feb 18 21:24:17 volumio volumio[815]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Feb 18 21:24:17 volumio volumio[815]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Feb 18 21:24:17 volumio volumio[815]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Feb 18 21:24:17 volumio volumio[815]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Feb 18 21:24:17 volumio volumio[815]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Feb 18 21:24:17 volumio volumio[815]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Feb 18 21:24:17 volumio volumio[815]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Feb 18 21:24:17 volumio volumio[815]: at IncomingMessage.emit (events.js:327:22) Feb 18 21:24:17 volumio volumio[815]: at endReadableNT (internal/streams/readable.js:1327:12) Feb 18 21:24:17 volumio volumio[815]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 18 21:24:17 volumio volumio[815]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 21:24:17 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:17 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:17 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:17 volumio lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:18 volumio sudo[6496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-18 21:23 Feb 18 21:24:18 volumio sudo[6496]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 21:24:18 volumio lircd[6589]: lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:18 volumio lircd[6589]: lircd-0.10.1[6589]: default_init(): No such file or directory Feb 18 21:24:18 volumio lircd-0.10.1[6589]: Error: could not get file information for /dev/lirc0 Feb 18 21:24:18 volumio lircd-0.10.1[6589]: default_init(): No such file or directory 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"