-- Logs begin at Fri 2024-08-23 21:23:40 BST, end at Sat 2024-08-24 10:09:38 BST. -- Aug 24 10:08:55 volumio-decosta volumio[1085]: info: Discovery: A device disappeared from network Aug 24 10:08:55 volumio-decosta systemd[1]: Starting Daily apt upgrade and clean activities... Aug 24 10:08:55 volumio-decosta systemd[1]: Starting Daily man-db regeneration... Aug 24 10:08:55 volumio-decosta volumio[1085]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 24 10:08:55 volumio-decosta volumio[1085]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 24 10:08:55 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7404, instance 1, run: true Aug 24 10:08:55 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:55 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:55 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:55 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:55 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7427, instance 1, run: true Aug 24 10:08:55 volumio-decosta sudo[7415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 24 10:08:55 volumio-decosta sudo[7415]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 10:08:55 volumio-decosta sudo[7418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 24 10:08:55 volumio-decosta sudo[7418]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 10:08:55 volumio-decosta sudo[7418]: pam_unix(sudo:session): session closed for user root Aug 24 10:08:55 volumio-decosta sudo[7415]: pam_unix(sudo:session): session closed for user root Aug 24 10:08:56 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7438, instance 1, run: true Aug 24 10:08:56 volumio-decosta volumio[1085]: verbose: New Socket.io Connection to 192.168.0.38 from 192.168.0.28 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 17 Aug 24 10:08:56 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7446, instance 1, run: true Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetVisibleSources Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 24 10:08:56 volumio-decosta volumio[1085]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:56 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:56 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7464, instance 1, run: true Aug 24 10:08:56 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7472, instance 1, run: true Aug 24 10:08:56 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7485, instance 1, run: true Aug 24 10:08:56 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7496, instance 1, run: true Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 24 10:08:57 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7511, instance 1, run: true Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:57 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:57 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7524, instance 1, run: true Aug 24 10:08:57 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7531, instance 1, run: true Aug 24 10:08:58 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7538, instance 1, run: true Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:58 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7548, instance 1, run: true Aug 24 10:08:58 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7562, instance 1, run: true Aug 24 10:08:58 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7569, instance 1, run: true Aug 24 10:08:58 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7576, instance 1, run: true Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:58 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7587, instance 1, run: true Aug 24 10:08:58 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7597, instance 1, run: true Aug 24 10:08:58 volumio-decosta sudo[7561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 24 10:08:58 volumio-decosta sudo[7559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 24 10:08:58 volumio-decosta sudo[7559]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 10:08:58 volumio-decosta sudo[7561]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 10:08:58 volumio-decosta sudo[7561]: pam_unix(sudo:session): session closed for user root Aug 24 10:08:58 volumio-decosta sudo[7559]: pam_unix(sudo:session): session closed for user root Aug 24 10:08:58 volumio-decosta volumio[1085]: verbose: New Socket.io Connection to 192.168.0.38 from 192.168.0.28 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 17 Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:58 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7606, instance 1, run: true Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:58 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7619, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 24 10:08:59 volumio-decosta volumio[1085]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 24 10:08:59 volumio-decosta volumio[1085]: info: Listing playlists Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7626, instance 1, run: true Aug 24 10:08:59 volumio-decosta systemd[1]: man-db.service: Succeeded. Aug 24 10:08:59 volumio-decosta systemd[1]: Started Daily man-db regeneration. Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7633, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7640, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7650, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7660, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7667, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7674, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7681, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7688, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7695, instance 1, run: true Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:08:59 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:08:59 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7707, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7715, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7726, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7737, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7748, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:00 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:00 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:00 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7766, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7778, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7790, instance 1, run: true Aug 24 10:09:00 volumio-decosta systemd[1]: apt-daily-upgrade.service: Succeeded. Aug 24 10:09:00 volumio-decosta systemd[1]: Started Daily apt upgrade and clean activities. Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7799, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7806, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:00 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:00 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:00 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7816, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7826, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7833, instance 1, run: true Aug 24 10:09:00 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7840, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7847, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7854, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7861, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7874, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7881, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7888, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: Discovery: adding aca946c6-4d12-43e5-8675-dbda3a483a48 Aug 24 10:09:01 volumio-decosta volumio[1085]: info: Discovery: Found device Volumio DeCosta Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7898, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7905, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:01 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7916, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7925, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7932, instance 1, run: true Aug 24 10:09:01 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7939, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7946, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7957, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioPlay Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreStateMachine::play index undefined Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreStateMachine::startPlaybackTimer Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:02 volumio-decosta volumio[1085]: info: [1724490542147] ControllerTidal::clearAddPlayTrack Aug 24 10:09:02 volumio-decosta volumio[1085]: info: Getting stream with soundQuality LOSSLESS Aug 24 10:09:02 volumio-decosta volumio[1085]: verbose: ControllerMpd::sendMpdCommand stop Aug 24 10:09:02 volumio-decosta volumio[1085]: info: sendMpdCommand stop took 3 milliseconds Aug 24 10:09:02 volumio-decosta volumio[1085]: verbose: ControllerMpd::sendMpdCommand clear Aug 24 10:09:02 volumio-decosta volumio[1085]: info: Aug 24 10:09:02 volumio-decosta volumio[1085]: ---------------------------- MPD announces system playlist update Aug 24 10:09:02 volumio-decosta volumio[1085]: info: Ignoring MPD Status Update Aug 24 10:09:02 volumio-decosta volumio[1085]: info: sendMpdCommand clear took 6 milliseconds Aug 24 10:09:02 volumio-decosta volumio[1085]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/349542011&soundQuality=LOSSLESS" Aug 24 10:09:02 volumio-decosta volumio[1085]: error: updateQueue error: null Aug 24 10:09:02 volumio-decosta volumio[1085]: info: Aug 24 10:09:02 volumio-decosta volumio[1085]: ---------------------------- MPD announces system playlist update Aug 24 10:09:02 volumio-decosta volumio[1085]: info: Ignoring MPD Status Update Aug 24 10:09:02 volumio-decosta volumio[1085]: info: ------------------------------ 10ms Aug 24 10:09:02 volumio-decosta volumio[1085]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/349542011&soundQuality=LOSSLESS" took 5 milliseconds Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 24 10:09:02 volumio-decosta volumio[1085]: verbose: ControllerMpd::sendMpdCommand play Aug 24 10:09:02 volumio-decosta volumio[1085]: info: ------------------------------ 38ms Aug 24 10:09:02 volumio-decosta volumio[1085]: info: sendMpdCommand play took 39 milliseconds Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7968, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: STREAMING PROXY: Handling url /?data=tidal://song/349542011&soundQuality=LOSSLESS Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7975, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7982, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: Executing endpoint getStreamUrltidal Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 7989, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8001, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8009, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8016, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8023, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8030, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:02 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8037, instance 1, run: true Aug 24 10:09:02 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8050, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8057, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8064, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8071, instance 1, run: true Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.307289, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 24 10:09:03 volumio-decosta nmbd[871]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8078, instance 1, run: true Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.325901, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 24 10:09:03 volumio-decosta nmbd[871]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.326345, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 24 10:09:03 volumio-decosta nmbd[871]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.326471, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 24 10:09:03 volumio-decosta nmbd[871]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.326614, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 24 10:09:03 volumio-decosta nmbd[871]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.326719, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 24 10:09:03 volumio-decosta nmbd[871]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.326830, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 24 10:09:03 volumio-decosta nmbd[871]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.326909, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 24 10:09:03 volumio-decosta nmbd[871]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.327021, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 24 10:09:03 volumio-decosta nmbd[871]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.327128, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 24 10:09:03 volumio-decosta nmbd[871]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.327223, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 24 10:09:03 volumio-decosta nmbd[871]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 24 10:09:03 volumio-decosta nmbd[871]: [2024/08/24 10:09:03.327304, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 24 10:09:03 volumio-decosta nmbd[871]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8087, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8094, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8101, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:03 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8112, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8121, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8128, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8135, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8142, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8149, instance 1, run: true Aug 24 10:09:03 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:04 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8158, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8169, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8176, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8183, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8190, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8197, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:04 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8208, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8217, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8224, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8231, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8238, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8245, instance 1, run: true Aug 24 10:09:04 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:04 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8258, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8265, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8272, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8279, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8286, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:05 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8298, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8306, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8313, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8320, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8327, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8334, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8347, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8354, instance 1, run: true Aug 24 10:09:05 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8365, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8372, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8379, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:06 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8392, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8399, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8406, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8413, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8420, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:06 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8433, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8440, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8447, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8454, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8461, instance 1, run: true Aug 24 10:09:06 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:06 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:06 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8471, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8481, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8488, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8495, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8502, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:07 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8512, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8522, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8529, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8536, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8543, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8550, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:07 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8559, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8570, instance 1, run: true Aug 24 10:09:07 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8577, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8584, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8591, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8598, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:08 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8611, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8618, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8625, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8632, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8639, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:08 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8650, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8659, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8666, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8673, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8680, instance 1, run: true Aug 24 10:09:08 volumio-decosta volumio[1085]: info: getStreamUrl took 6487 milliseconds Aug 24 10:09:08 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:08 volumio-decosta volumio[1085]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKAgDEiRlNWNmODE5ODExN2Q1ODY2NDQ0YjNkZmIxM2Q4ZWIxOC5tcDQ/0.flac?Expires=1724494149&Signature=flQXYbUBCWBRG1OXakMa-CQKMikVhGg~tJDBv~s7NNVXGq3fEEJJI0buTvcw-6uVi0UczximR0oKZ7ikzxCmkTxlIQiaq4W~LFx~aPbG-v4VFUkduN0q-w25qb8bxwhpAsjEUwDl~nvw5DfMIPmRr~P~oN0-RsP6eR3wcJuH4HFtfDBidZMVOEz28fkhy-50WDjj1V8t877LGLvsRGAWO1~CYT3qlQ0-K3H~xxbfhvcxifrk1Pw3uo9wG-4cONcI7eZVDc5k8g4loldqBhfi~oeCYkT17Q17sQ1qUDdrHSJrWjgpNo17euuCEiGsfqdHZvfhPeVShDL98wzuF3LdvA__&Key-Pair-Id=K14LZCZ9QUI4JL Aug 24 10:09:08 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8689, instance 1, run: true Aug 24 10:09:09 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8700, instance 1, run: true Aug 24 10:09:09 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8707, instance 1, run: true Aug 24 10:09:09 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8718, instance 1, run: true Aug 24 10:09:09 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8725, instance 1, run: true Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8735, instance 1, run: true Aug 24 10:09:09 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8745, instance 1, run: true Aug 24 10:09:09 volumio-decosta volumio[1085]: STREAMING PROXY: Response: 200, length: 17006698 Aug 24 10:09:09 volumio-decosta volumio[1085]: info: Aug 24 10:09:09 volumio-decosta volumio[1085]: ---------------------------- MPD announces state update: player Aug 24 10:09:09 volumio-decosta volumio[1085]: info: ControllerMpd::getState Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Aug 24 10:09:09 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8754, instance 1, run: true Aug 24 10:09:09 volumio-decosta volumio[1085]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Aug 24 10:09:09 volumio-decosta volumio[1085]: info: FusionDsp - ---- read samplerate from file: 44100 Aug 24 10:09:09 volumio-decosta volumio[1085]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 24 10:09:09 volumio-decosta volumio[1085]: info: Aug 24 10:09:09 volumio-decosta volumio[1085]: ---------------------------- MPD announces state update: player Aug 24 10:09:09 volumio-decosta volumio[1085]: info: sendMpdCommand status took 95 milliseconds Aug 24 10:09:09 volumio-decosta volumio[1085]: info: ControllerMpd::getState Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: ControllerMpd::parseState Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 10:09:09 volumio-decosta volumio[1085]: info: sendMpdCommand status took 8 milliseconds Aug 24 10:09:09 volumio-decosta volumio[1085]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: ControllerMpd::parseState Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: ControllerMpd::parseTrackInfo Aug 24 10:09:09 volumio-decosta volumio[1085]: info: ControllerMpd::pushState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreCommandRouter::servicePushState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":142,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"349542011&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/349542011&soundQuality=LOSSLESS","trackType":"tidal"} Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: CURRENT POSITION 0 Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreStateMachine::syncState stateService play Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreStateMachine::syncState currentStatus stop Aug 24 10:09:09 volumio-decosta volumio[1085]: info: ------------------------------ 122ms Aug 24 10:09:09 volumio-decosta volumio[1085]: info: sendMpdCommand playlistinfo took 15 milliseconds Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: ControllerMpd::parseTrackInfo Aug 24 10:09:09 volumio-decosta volumio[1085]: info: ControllerMpd::pushState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreCommandRouter::servicePushState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CorePlayQueue::getTrack 0 Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":142,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"349542011&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/349542011&soundQuality=LOSSLESS","trackType":"tidal"} Aug 24 10:09:09 volumio-decosta volumio[1085]: verbose: CURRENT POSITION 0 Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreStateMachine::syncState stateService play Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreStateMachine::syncState currentStatus play Aug 24 10:09:09 volumio-decosta volumio[1085]: info: Received an update from plugin. extracting info from payload Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreStateMachine::pushState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioPushState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: MRS: Pushing multiroomSync output update for this device Aug 24 10:09:09 volumio-decosta volumio[1085]: info: MRS: Pushing multiroomSync output Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreStateMachine::pushState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioPushState Aug 24 10:09:09 volumio-decosta volumio[1085]: info: MRS: Pushing multiroomSync output update for this device Aug 24 10:09:09 volumio-decosta volumio[1085]: info: MRS: Pushing multiroomSync output Aug 24 10:09:09 volumio-decosta volumio[1085]: info: ------------------------------ 183ms Aug 24 10:09:09 volumio-decosta volumio[1085]: error: FusionDsp - WebSocket error: [object Object] Aug 24 10:09:09 volumio-decosta volumio[1085]: info: [LastFM] Current track has sufficient metadata: title (Future House) and artist (BlasterCorz) passed on explicitly Aug 24 10:09:09 volumio-decosta volumio[1085]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Aug 24 10:09:09 volumio-decosta volumio[1085]: info: PeppySpectrum ---peppyspectrum status play Aug 24 10:09:09 volumio-decosta volumio[1085]: info: PeppySpectrum ---peppyspectrum status play Aug 24 10:09:10 volumio-decosta sudo[8766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Aug 24 10:09:10 volumio-decosta sudo[8766]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 10:09:10 volumio-decosta sudo[8768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Aug 24 10:09:10 volumio-decosta sudo[8768]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 10:09:10 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8771, instance 1, run: true Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:10 volumio-decosta volumio[1085]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 24 10:09:10 volumio-decosta systemd[1]: Started peppyspectrum Daemon. Aug 24 10:09:10 volumio-decosta sudo[8766]: pam_unix(sudo:session): session closed for user root Aug 24 10:09:10 volumio-decosta sudo[8768]: pam_unix(sudo:session): session closed for user root Aug 24 10:09:10 volumio-decosta volumio[1085]: info: peppyspectrum Daemon Started Aug 24 10:09:10 volumio-decosta volumio[1085]: info: peppyspectrum Daemon Started Aug 24 10:09:10 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8787, instance 1, run: true Aug 24 10:09:10 volumio-decosta volumio[1085]: info: touch_display: Setting screensaver timeout to 0 seconds. Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:10 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8797, instance 1, run: true Aug 24 10:09:10 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8807, instance 1, run: true Aug 24 10:09:10 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8815, instance 1, run: true Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:10 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8822, instance 1, run: true Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:10 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:11 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8835, instance 1, run: true Aug 24 10:09:11 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8842, instance 1, run: true Aug 24 10:09:11 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8849, instance 1, run: true Aug 24 10:09:11 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:11 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:11 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8862, instance 1, run: true Aug 24 10:09:11 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8869, instance 1, run: true Aug 24 10:09:11 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8876, instance 1, run: true Aug 24 10:09:11 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8883, instance 1, run: true Aug 24 10:09:11 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:11 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:11 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:11 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:11 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:11 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:11 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8893, instance 1, run: true Aug 24 10:09:12 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8903, instance 1, run: true Aug 24 10:09:12 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8910, instance 1, run: true Aug 24 10:09:12 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8919, instance 1, run: true Aug 24 10:09:12 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:12 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:12 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8931, instance 1, run: true Aug 24 10:09:12 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8940, instance 1, run: true Aug 24 10:09:12 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:12 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:12 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:12 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:12 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:13 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:13 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8951, instance 1, run: true Aug 24 10:09:13 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8960, instance 1, run: true Aug 24 10:09:13 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8967, instance 1, run: true Aug 24 10:09:13 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:13 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:13 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8980, instance 1, run: true Aug 24 10:09:13 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8987, instance 1, run: true Aug 24 10:09:13 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 8994, instance 1, run: true Aug 24 10:09:13 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:13 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:13 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:13 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:13 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:14 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9007, instance 1, run: true Aug 24 10:09:14 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9014, instance 1, run: true Aug 24 10:09:14 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9021, instance 1, run: true Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:14 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9034, instance 1, run: true Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 24 10:09:14 volumio-decosta volumio[1085]: info: Discovery: Getting this device information Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 24 10:09:14 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9041, instance 1, run: true Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:14 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:15 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9054, instance 1, run: true Aug 24 10:09:15 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9061, instance 1, run: true Aug 24 10:09:15 volumio-decosta volumio[1085]: info: VolumeController::SetAlsaVolume10 Aug 24 10:09:15 volumio-decosta volumio[1085]: info: CoreStateMachine::pushState Aug 24 10:09:15 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 10:09:15 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioPushState Aug 24 10:09:15 volumio-decosta volumio[1085]: info: MRS: Pushing multiroomSync output update for this device Aug 24 10:09:15 volumio-decosta volumio[1085]: info: MRS: Pushing multiroomSync output Aug 24 10:09:15 volumio-decosta volumio[1085]: info: PeppySpectrum ---peppyspectrum status play Aug 24 10:09:15 volumio-decosta volumio[1085]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Aug 24 10:09:15 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9071, instance 1, run: true Aug 24 10:09:15 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:15 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:15 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9083, instance 1, run: true Aug 24 10:09:15 volumio-decosta sudo[9070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Aug 24 10:09:15 volumio-decosta sudo[9070]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 10:09:15 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9091, instance 1, run: true Aug 24 10:09:15 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:15 volumio-decosta sudo[9070]: pam_unix(sudo:session): session closed for user root Aug 24 10:09:15 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:16 volumio-decosta volumio[1085]: info: VolumeController::SetAlsaVolume30 Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreStateMachine::pushState Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioPushState Aug 24 10:09:16 volumio-decosta volumio[1085]: info: MRS: Pushing multiroomSync output update for this device Aug 24 10:09:16 volumio-decosta volumio[1085]: info: MRS: Pushing multiroomSync output Aug 24 10:09:16 volumio-decosta volumio[1085]: info: peppyspectrum Daemon Started Aug 24 10:09:16 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9100, instance 1, run: true Aug 24 10:09:16 volumio-decosta volumio[1085]: info: PeppySpectrum ---peppyspectrum status play Aug 24 10:09:16 volumio-decosta volumio[1085]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta sudo[9108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Aug 24 10:09:16 volumio-decosta sudo[9108]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 10:09:16 volumio-decosta volumio[1085]: info: Received Get System Version Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 24 10:09:16 volumio-decosta volumio[1085]: info: Received Get System Info Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 24 10:09:16 volumio-decosta volumio[1085]: info: Discovery: Getting this device information Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9110, instance 1, run: true Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta sudo[9108]: pam_unix(sudo:session): session closed for user root Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[8784]: libpng warning: iCCP: known incorrect sRGB profile Aug 24 10:09:16 volumio-decosta volumio[1085]: info: peppyspectrum Daemon Started Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:16 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9126, instance 1, run: true Aug 24 10:09:16 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9133, instance 1, run: true Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:16 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:17 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9140, instance 1, run: true Aug 24 10:09:17 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:17 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:17 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9153, instance 1, run: true Aug 24 10:09:17 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9160, instance 1, run: true Aug 24 10:09:17 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9167, instance 1, run: true Aug 24 10:09:17 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9174, instance 1, run: true Aug 24 10:09:17 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:17 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:17 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9187, instance 1, run: true Aug 24 10:09:17 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9194, instance 1, run: true Aug 24 10:09:17 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9201, instance 1, run: true Aug 24 10:09:17 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:17 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9209, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:18 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:18 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:18 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9221, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9229, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9236, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9243, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:18 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9255, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9263, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9270, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9277, instance 1, run: true Aug 24 10:09:18 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:18 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:19 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:19 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:19 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:19 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:19 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9286, instance 1, run: true Aug 24 10:09:19 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9297, instance 1, run: true Aug 24 10:09:19 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9304, instance 1, run: true Aug 24 10:09:19 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9311, instance 1, run: true Aug 24 10:09:19 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:19 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:19 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9324, instance 1, run: true Aug 24 10:09:19 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9331, instance 1, run: true Aug 24 10:09:19 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9338, instance 1, run: true Aug 24 10:09:19 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:19 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9351, instance 1, run: true Aug 24 10:09:20 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:20 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:20 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:20 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9358, instance 1, run: true Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9365, instance 1, run: true Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9372, instance 1, run: true Aug 24 10:09:20 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:20 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9384, instance 1, run: true Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9392, instance 1, run: true Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9399, instance 1, run: true Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9406, instance 1, run: true Aug 24 10:09:20 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:20 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:20 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9419, instance 1, run: true Aug 24 10:09:21 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:21 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:21 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:21 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:21 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9426, instance 1, run: true Aug 24 10:09:21 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9433, instance 1, run: true Aug 24 10:09:21 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:21 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:21 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9446, instance 1, run: true Aug 24 10:09:21 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9453, instance 1, run: true Aug 24 10:09:21 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9460, instance 1, run: true Aug 24 10:09:21 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:21 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:21 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9473, instance 1, run: true Aug 24 10:09:21 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9480, instance 1, run: true Aug 24 10:09:21 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9487, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:22 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9494, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:22 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9507, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9514, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9521, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:22 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9531, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9541, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9548, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9555, instance 1, run: true Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:22 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:23 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:23 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:23 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:23 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:23 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9568, instance 1, run: true Aug 24 10:09:23 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9575, instance 1, run: true Aug 24 10:09:23 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:23 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9582, instance 1, run: true Aug 24 10:09:23 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:23 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9595, instance 1, run: true Aug 24 10:09:23 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9602, instance 1, run: true Aug 24 10:09:23 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9609, instance 1, run: true Aug 24 10:09:23 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:23 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:23 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9622, instance 1, run: true Aug 24 10:09:24 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9629, instance 1, run: true Aug 24 10:09:24 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:24 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:24 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:24 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:24 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9636, instance 1, run: true Aug 24 10:09:24 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:24 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:24 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9649, instance 1, run: true Aug 24 10:09:24 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9657, instance 1, run: true Aug 24 10:09:24 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9664, instance 1, run: true Aug 24 10:09:24 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:24 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:24 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9676, instance 1, run: true Aug 24 10:09:24 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9684, instance 1, run: true Aug 24 10:09:25 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9691, instance 1, run: true Aug 24 10:09:25 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:25 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:25 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:25 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:25 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9698, instance 1, run: true Aug 24 10:09:25 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:25 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:25 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9711, instance 1, run: true Aug 24 10:09:25 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9718, instance 1, run: true Aug 24 10:09:25 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9725, instance 1, run: true Aug 24 10:09:25 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:25 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:25 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9738, instance 1, run: true Aug 24 10:09:25 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9745, instance 1, run: true Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:26 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9758, instance 1, run: true Aug 24 10:09:26 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9765, instance 1, run: true Aug 24 10:09:26 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9773, instance 1, run: true Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:26 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9786, instance 1, run: true Aug 24 10:09:26 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9793, instance 1, run: true Aug 24 10:09:26 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9800, instance 1, run: true Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:26 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:26 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9810, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9820, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:27 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:27 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:27 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9827, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:27 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9839, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9847, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9854, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9861, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:27 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9874, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9881, instance 1, run: true Aug 24 10:09:27 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9888, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9895, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:28 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9906, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9915, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9922, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9929, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:28 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9942, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9949, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9956, instance 1, run: true Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:28 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:29 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9968, instance 1, run: true Aug 24 10:09:29 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:29 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:29 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:29 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:29 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9976, instance 1, run: true Aug 24 10:09:29 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9983, instance 1, run: true Aug 24 10:09:29 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:29 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:29 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 9996, instance 1, run: true Aug 24 10:09:29 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10003, instance 1, run: true Aug 24 10:09:29 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10010, instance 1, run: true Aug 24 10:09:29 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:29 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:29 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10023, instance 1, run: true Aug 24 10:09:30 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10030, instance 1, run: true Aug 24 10:09:30 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:30 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:30 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:30 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:30 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10037, instance 1, run: true Aug 24 10:09:30 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:30 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:30 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10050, instance 1, run: true Aug 24 10:09:30 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10057, instance 1, run: true Aug 24 10:09:30 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:30 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:31 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10070, instance 1, run: true Aug 24 10:09:31 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:31 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:31 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:31 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:31 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10077, instance 1, run: true Aug 24 10:09:31 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10084, instance 1, run: true Aug 24 10:09:31 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:31 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:31 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10097, instance 1, run: true Aug 24 10:09:31 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10104, instance 1, run: true Aug 24 10:09:31 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10111, instance 1, run: true Aug 24 10:09:31 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10118, instance 1, run: true Aug 24 10:09:31 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:31 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:31 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10131, instance 1, run: true Aug 24 10:09:32 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10138, instance 1, run: true Aug 24 10:09:32 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:32 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:32 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:32 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:32 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10145, instance 1, run: true Aug 24 10:09:32 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:32 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:32 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10158, instance 1, run: true Aug 24 10:09:32 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10165, instance 1, run: true Aug 24 10:09:32 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10172, instance 1, run: true Aug 24 10:09:32 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10179, instance 1, run: true Aug 24 10:09:32 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:32 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:32 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10192, instance 1, run: true Aug 24 10:09:32 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10199, instance 1, run: true Aug 24 10:09:33 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10206, instance 1, run: true Aug 24 10:09:33 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:33 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:33 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10213, instance 1, run: true Aug 24 10:09:33 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:33 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:33 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:33 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:33 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10222, instance 1, run: true Aug 24 10:09:33 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10233, instance 1, run: true Aug 24 10:09:33 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10240, instance 1, run: true Aug 24 10:09:33 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10247, instance 1, run: true Aug 24 10:09:33 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:33 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:33 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10258, instance 1, run: true Aug 24 10:09:33 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10267, instance 1, run: true Aug 24 10:09:34 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10278, instance 1, run: true Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:34 volumio-decosta volumiologrotate[732]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Aug 24 10:09:34 volumio-decosta volumiologrotate[732]: ls: cannot access 'DECOSTA': No such file or directory Aug 24 10:09:34 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10327, instance 1, run: true Aug 24 10:09:34 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10338, instance 1, run: true Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:34 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10350, instance 1, run: true Aug 24 10:09:34 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10358, instance 1, run: true Aug 24 10:09:34 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10365, instance 1, run: true Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:34 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:34 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10375, instance 1, run: true Aug 24 10:09:35 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10385, instance 1, run: true Aug 24 10:09:35 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:35 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:35 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:35 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:35 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10392, instance 1, run: true Aug 24 10:09:35 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:35 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:35 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10404, instance 1, run: true Aug 24 10:09:35 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10412, instance 1, run: true Aug 24 10:09:35 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10419, instance 1, run: true Aug 24 10:09:35 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:35 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:35 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10431, instance 1, run: true Aug 24 10:09:35 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10439, instance 1, run: true Aug 24 10:09:36 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10446, instance 1, run: true Aug 24 10:09:36 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:36 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetQueue Aug 24 10:09:36 volumio-decosta volumio[1085]: info: CoreStateMachine::getQueue Aug 24 10:09:36 volumio-decosta volumio[1085]: info: CorePlayQueue::getQueue Aug 24 10:09:36 volumio-decosta volumio[1085]: info: camilladsp spawned new process with pid 10453, instance 1, run: true Aug 24 10:09:36 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:36 volumio-decosta volumio[1085]: info: CoreCommandRouter::volumioGetState Aug 24 10:09:36 volumio-decosta volumio[1085]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Aug 24 10:09:36 volumio-decosta volumio[1085]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Aug 24 10:09:36 volumio-decosta volumio[1085]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 24 10:09:36 volumio-decosta volumio[1085]: TypeError: Cannot read property 'then' of undefined Aug 24 10:09:36 volumio-decosta volumio[1085]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Aug 24 10:09:36 volumio-decosta volumio[1085]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2260:30) Aug 24 10:09:36 volumio-decosta volumio[1085]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1442:26) Aug 24 10:09:36 volumio-decosta volumio[1085]: at Socket.emit (events.js:315:20) Aug 24 10:09:36 volumio-decosta volumio[1085]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 24 10:09:36 volumio-decosta volumio[1085]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 24 10:09:36 volumio-decosta volumio[1085]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 24 10:09:38 volumio-decosta sudo[10479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-24 10:08 Aug 24 10:09:38 volumio-decosta sudo[10479]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"