-- Logs begin at Thu 2019-02-14 19:12:00 JST, end at Sat 2024-10-19 12:59:38 JST. -- Oct 19 12:58:02 volumio volumio[966]: info: CoreCommandRouter::volumioPlay Oct 19 12:58:02 volumio volumio[966]: info: CoreStateMachine::play index undefined Oct 19 12:58:02 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 12:58:02 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:02 volumio volumio[966]: info: CoreStateMachine::startPlaybackTimer Oct 19 12:58:02 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:02 volumio volumio[966]: info: [1729310282402] ControllerUPNPBrowser::clearAddPlayTrack Oct 19 12:58:02 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 12:58:02 volumio volumio[966]: info: sendMpdCommand stop took 1 milliseconds Oct 19 12:58:02 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Oct 19 12:58:02 volumio volumio[966]: info: Oct 19 12:58:02 volumio volumio[966]: ---------------------------- MPD announces system playlist update Oct 19 12:58:02 volumio volumio[966]: info: Ignoring MPD Status Update Oct 19 12:58:02 volumio volumio[966]: info: sendMpdCommand clear took 2 milliseconds Oct 19 12:58:02 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.21:32469/object/fad4c95c97b8be2f284c/file.flac" Oct 19 12:58:02 volumio volumio[966]: error: updateQueue error: null Oct 19 12:58:02 volumio volumio[966]: info: ------------------------------ 3ms Oct 19 12:58:03 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.21:32469/object/fad4c95c97b8be2f284c/file.flac" Oct 19 12:58:03 volumio volumio[966]: info: Oct 19 12:58:03 volumio volumio[966]: ---------------------------- MPD announces system playlist update Oct 19 12:58:03 volumio volumio[966]: info: Ignoring MPD Status Update Oct 19 12:58:03 volumio volumio[966]: info: sendMpdCommand add "http://192.168.1.21:32469/object/fad4c95c97b8be2f284c/file.flac" took 2 milliseconds Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand play Oct 19 12:58:03 volumio volumio[966]: info: ------------------------------ 4ms Oct 19 12:58:03 volumio volumio[966]: info: sendMpdCommand play took 2 milliseconds Oct 19 12:58:03 volumio volumio[966]: info: Oct 19 12:58:03 volumio volumio[966]: ---------------------------- MPD announces state update: player Oct 19 12:58:03 volumio volumio[966]: info: ControllerMpd::getState Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Oct 19 12:58:03 volumio volumio[966]: info: FusionDsp - ---- read samplerate, raw: Oct 19 12:58:03 volumio volumio[966]: error: FusionDsp - invalid sample rate Oct 19 12:58:03 volumio volumio[966]: info: FusionDsp - ---- read samplerate, raw: 96000,S32_LE,2,32 Oct 19 12:58:03 volumio volumio[966]: info: FusionDsp - ---- read samplerate from file: 96000 Oct 19 12:58:03 volumio volumio[966]: info: camilladsp stopping service pid 1432... Oct 19 12:58:03 volumio volumio[966]: info: camilladsp service terminated, instance 1 Oct 19 12:58:03 volumio volumio[966]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 19 12:58:03 volumio volumio[966]: info: camilladsp service started and running in background, instance 1 Oct 19 12:58:03 volumio volumio[966]: info: Oct 19 12:58:03 volumio volumio[966]: ---------------------------- MPD announces state update: player Oct 19 12:58:03 volumio volumio[966]: info: sendMpdCommand status took 60 milliseconds Oct 19 12:58:03 volumio volumio[966]: info: ControllerMpd::getState Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::parseState Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 12:58:03 volumio volumio[966]: info: sendMpdCommand status took 3 milliseconds Oct 19 12:58:03 volumio volumio[966]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::parseState Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Oct 19 12:58:03 volumio volumio[966]: info: ControllerMpd::pushState Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::servicePushState Oct 19 12:58:03 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:03 volumio volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.21:32469/object/fad4c95c97b8be2f284c/file.flac","trackType":"flac"} Oct 19 12:58:03 volumio volumio[966]: verbose: CURRENT POSITION 0 Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::syncState stateService play Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Oct 19 12:58:03 volumio volumio[966]: info: ------------------------------ 70ms Oct 19 12:58:03 volumio volumio[966]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Oct 19 12:58:03 volumio volumio[966]: info: ControllerMpd::pushState Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::servicePushState Oct 19 12:58:03 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:03 volumio volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.21:32469/object/fad4c95c97b8be2f284c/file.flac","trackType":"flac"} Oct 19 12:58:03 volumio volumio[966]: verbose: CURRENT POSITION 0 Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::syncState stateService play Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus play Oct 19 12:58:03 volumio volumio[966]: info: Received an update from plugin. extracting info from payload Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:03 volumio volumio[966]: info: ------------------------------ 31ms Oct 19 12:58:03 volumio volumio[966]: info: Oct 19 12:58:03 volumio volumio[966]: ---------------------------- MPD announces system playlist update Oct 19 12:58:03 volumio volumio[966]: info: Ignoring MPD Status Update Oct 19 12:58:03 volumio volumio[966]: info: Oct 19 12:58:03 volumio volumio[966]: ---------------------------- MPD announces state update: player Oct 19 12:58:03 volumio volumio[966]: info: ControllerMpd::getState Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Oct 19 12:58:03 volumio volumio[966]: info: ------------------------------ 6ms Oct 19 12:58:03 volumio volumio[966]: info: sendMpdCommand status took 3 milliseconds Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::parseState Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 12:58:03 volumio volumio[966]: info: camilladsp spawned new process with pid 1613, instance 1, run: true Oct 19 12:58:03 volumio volumio[966]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 19 12:58:03 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Oct 19 12:58:03 volumio volumio[966]: info: ControllerMpd::pushState Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::servicePushState Oct 19 12:58:03 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:03 volumio volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":866,"duration":265,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2218 Kbps","isStreaming":false,"title":"ベルガマスク組曲「月の光」 (Premium Piano ver.)","artist":"Cafe lounge Jazz","album":"First Class Lounge ～じっくり味わうクラシックピアノ～","uri":"http://192.168.1.21:32469/object/fad4c95c97b8be2f284c/file.flac","trackType":"flac"} Oct 19 12:58:03 volumio volumio[966]: verbose: CURRENT POSITION 0 Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::syncState stateService play Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus play Oct 19 12:58:03 volumio volumio[966]: info: Received an update from plugin. extracting info from payload Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:03 volumio volumio[966]: info: ------------------------------ 52ms Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::getQueue Oct 19 12:58:03 volumio volumio[966]: info: CorePlayQueue::getQueue Oct 19 12:58:03 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Oct 19 12:58:03 volumio volumio[966]: info: CoreStateMachine::getQueue Oct 19 12:58:03 volumio volumio[966]: info: CorePlayQueue::getQueue Oct 19 12:58:05 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 19 12:58:12 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 12:58:14 volumio volumio[966]: info: Discovery: Getting this device information Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 19 12:58:14 volumio volumio[966]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 19 12:58:14 volumio volumio[966]: info: Received Get System Version Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 19 12:58:14 volumio volumio[966]: info: Received Get System Info Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 12:58:14 volumio volumio[966]: info: Discovery: Getting this device information Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Oct 19 12:58:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 12:58:17 volumio volumio[966]: info: CoreCommandRouter::volumioPause Oct 19 12:58:17 volumio volumio[966]: info: CoreStateMachine::pause Oct 19 12:58:17 volumio volumio[966]: info: CoreStateMachine::stPlaybackTimer Oct 19 12:58:17 volumio volumio[966]: info: CoreStateMachine::servicePause Oct 19 12:58:17 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:17 volumio volumio[966]: info: CoreCommandRouter::servicePause Oct 19 12:58:17 volumio volumio[966]: info: [1729310297516] ControllerUPNPBrowser::pause Oct 19 12:58:17 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand pause Oct 19 12:58:17 volumio volumio[966]: info: Oct 19 12:58:17 volumio volumio[966]: ---------------------------- MPD announces state update: player Oct 19 12:58:17 volumio volumio[966]: info: sendMpdCommand pause took 1 milliseconds Oct 19 12:58:17 volumio volumio[966]: info: ControllerMpd::getState Oct 19 12:58:17 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Oct 19 12:58:17 volumio volumio[966]: info: sendMpdCommand status took 1 milliseconds Oct 19 12:58:17 volumio volumio[966]: verbose: ControllerMpd::parseState Oct 19 12:58:17 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 12:58:17 volumio volumio[966]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 19 12:58:17 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Oct 19 12:58:17 volumio volumio[966]: info: ControllerMpd::pushState Oct 19 12:58:17 volumio volumio[966]: info: CoreCommandRouter::servicePushState Oct 19 12:58:17 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:17 volumio volumio[966]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":14994,"duration":265,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2213 Kbps","isStreaming":false,"title":"ベルガマスク組曲「月の光」 (Premium Piano ver.)","artist":"Cafe lounge Jazz","album":"First Class Lounge ～じっくり味わうクラシックピアノ～","uri":"http://192.168.1.21:32469/object/fad4c95c97b8be2f284c/file.flac","trackType":"flac"} Oct 19 12:58:17 volumio volumio[966]: verbose: CURRENT POSITION 0 Oct 19 12:58:17 volumio volumio[966]: info: CoreStateMachine::syncState stateService pause Oct 19 12:58:17 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus pause Oct 19 12:58:17 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:17 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 12:58:17 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:17 volumio volumio[966]: info: CoreStateMachine::stPlaybackTimer Oct 19 12:58:17 volumio volumio[966]: info: ------------------------------ 14ms Oct 19 12:58:17 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Oct 19 12:58:17 volumio volumio[966]: info: CoreStateMachine::getQueue Oct 19 12:58:17 volumio volumio[966]: info: CorePlayQueue::getQueue Oct 19 12:58:17 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:17 volumio volumio[966]: info: camilladsp spawned new process with pid 1620, instance 1, run: true Oct 19 12:58:17 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:17 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:18 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio volumio[966]: info: camilladsp spawned new process with pid 1627, instance 1, run: true Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:18 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio volumio[966]: info: camilladsp spawned new process with pid 1634, instance 1, run: true Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:18 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio volumio[966]: info: camilladsp spawned new process with pid 1641, instance 1, run: true Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:18 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio volumio[966]: info: camilladsp spawned new process with pid 1648, instance 1, run: true Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:18 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio volumio[966]: info: camilladsp spawned new process with pid 1655, instance 1, run: true Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:18 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio volumio[966]: info: camilladsp spawned new process with pid 1662, instance 1, run: true Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:18 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio volumio[966]: info: camilladsp spawned new process with pid 1669, instance 1, run: true Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:18 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio volumio[966]: info: camilladsp spawned new process with pid 1676, instance 1, run: true Oct 19 12:58:18 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:18 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:19 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio volumio[966]: info: camilladsp spawned new process with pid 1683, instance 1, run: true Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:19 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio volumio[966]: info: camilladsp spawned new process with pid 1690, instance 1, run: true Oct 19 12:58:19 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Oct 19 12:58:19 volumio volumio[966]: info: CoreStateMachine::getQueue Oct 19 12:58:19 volumio volumio[966]: info: CorePlayQueue::getQueue Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:19 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio volumio[966]: info: camilladsp spawned new process with pid 1697, instance 1, run: true Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:19 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio volumio[966]: info: camilladsp spawned new process with pid 1704, instance 1, run: true Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:19 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio volumio[966]: info: camilladsp spawned new process with pid 1711, instance 1, run: true Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:19 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio volumio[966]: info: camilladsp spawned new process with pid 1718, instance 1, run: true Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:19 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio volumio[966]: info: camilladsp spawned new process with pid 1725, instance 1, run: true Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:19 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio volumio[966]: info: camilladsp spawned new process with pid 1732, instance 1, run: true Oct 19 12:58:19 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:19 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio volumio[966]: info: camilladsp spawned new process with pid 1739, instance 1, run: true Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio volumio[966]: info: camilladsp spawned new process with pid 1746, instance 1, run: true Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio volumio[966]: info: camilladsp spawned new process with pid 1753, instance 1, run: true Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio volumio[966]: info: camilladsp spawned new process with pid 1760, instance 1, run: true Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio volumio[966]: info: camilladsp spawned new process with pid 1767, instance 1, run: true Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio volumio[966]: info: camilladsp spawned new process with pid 1774, instance 1, run: true Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio volumio[966]: info: camilladsp spawned new process with pid 1781, instance 1, run: true Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio volumio[966]: info: camilladsp spawned new process with pid 1788, instance 1, run: true Oct 19 12:58:20 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:20 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:20 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio volumio[966]: info: camilladsp spawned new process with pid 1795, instance 1, run: true Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:21 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio volumio[966]: info: camilladsp spawned new process with pid 1802, instance 1, run: true Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:21 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio volumio[966]: info: camilladsp spawned new process with pid 1809, instance 1, run: true Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:21 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio volumio[966]: info: camilladsp spawned new process with pid 1816, instance 1, run: true Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:21 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio volumio[966]: info: camilladsp spawned new process with pid 1823, instance 1, run: true Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:21 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio volumio[966]: info: camilladsp spawned new process with pid 1830, instance 1, run: true Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:21 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio volumio[966]: info: camilladsp spawned new process with pid 1837, instance 1, run: true Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:21 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio volumio[966]: info: camilladsp spawned new process with pid 1844, instance 1, run: true Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:21 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:21 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:21 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1851, instance 1, run: true Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:22 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1858, instance 1, run: true Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:22 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1865, instance 1, run: true Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:22 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1872, instance 1, run: true Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:22 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1879, instance 1, run: true Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:22 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1886, instance 1, run: true Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:22 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1893, instance 1, run: true Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:22 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1900, instance 1, run: true Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:22 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:22 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:22 volumio volumio[966]: info: camilladsp spawned new process with pid 1907, instance 1, run: true Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:23 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio volumio[966]: info: camilladsp spawned new process with pid 1914, instance 1, run: true Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:23 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio volumio[966]: info: camilladsp spawned new process with pid 1921, instance 1, run: true Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:23 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio volumio[966]: info: camilladsp spawned new process with pid 1928, instance 1, run: true Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:23 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio volumio[966]: info: camilladsp spawned new process with pid 1935, instance 1, run: true Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:23 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio volumio[966]: info: camilladsp spawned new process with pid 1942, instance 1, run: true Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:23 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio volumio[966]: info: camilladsp spawned new process with pid 1949, instance 1, run: true Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:23 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio volumio[966]: info: camilladsp spawned new process with pid 1956, instance 1, run: true Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:23 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:23 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:23 volumio volumio[966]: info: camilladsp spawned new process with pid 1963, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:24 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio volumio[966]: info: camilladsp spawned new process with pid 1970, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:24 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio volumio[966]: info: camilladsp spawned new process with pid 1977, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:24 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio volumio[966]: info: camilladsp spawned new process with pid 1984, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:24 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio volumio[966]: info: camilladsp spawned new process with pid 1991, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:24 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio volumio[966]: info: camilladsp spawned new process with pid 1998, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:24 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio volumio[966]: info: camilladsp spawned new process with pid 2005, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:24 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio volumio[966]: info: camilladsp spawned new process with pid 2012, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:24 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:24 volumio volumio[966]: info: camilladsp spawned new process with pid 2019, instance 1, run: true Oct 19 12:58:24 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:25 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio volumio[966]: info: camilladsp spawned new process with pid 2026, instance 1, run: true Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:25 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio volumio[966]: info: camilladsp spawned new process with pid 2033, instance 1, run: true Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:25 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio volumio[966]: info: camilladsp spawned new process with pid 2040, instance 1, run: true Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:25 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio volumio[966]: info: camilladsp spawned new process with pid 2047, instance 1, run: true Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:25 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio volumio[966]: info: camilladsp spawned new process with pid 2054, instance 1, run: true Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:25 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio volumio[966]: info: camilladsp spawned new process with pid 2061, instance 1, run: true Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:25 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio volumio[966]: info: camilladsp spawned new process with pid 2068, instance 1, run: true Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:25 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:25 volumio volumio[966]: info: camilladsp spawned new process with pid 2076, instance 1, run: true Oct 19 12:58:25 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:26 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio volumio[966]: info: camilladsp spawned new process with pid 2083, instance 1, run: true Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:26 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio volumio[966]: info: camilladsp spawned new process with pid 2090, instance 1, run: true Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:26 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio volumio[966]: info: camilladsp spawned new process with pid 2097, instance 1, run: true Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:26 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio volumio[966]: info: camilladsp spawned new process with pid 2104, instance 1, run: true Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:26 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio volumio[966]: info: camilladsp spawned new process with pid 2111, instance 1, run: true Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:26 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio volumio[966]: info: camilladsp spawned new process with pid 2118, instance 1, run: true Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:26 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio volumio[966]: info: camilladsp spawned new process with pid 2125, instance 1, run: true Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:26 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:26 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:26 volumio volumio[966]: info: camilladsp spawned new process with pid 2132, instance 1, run: true Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:27 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio volumio[966]: info: camilladsp spawned new process with pid 2139, instance 1, run: true Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:27 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio volumio[966]: info: camilladsp spawned new process with pid 2146, instance 1, run: true Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:27 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio volumio[966]: info: camilladsp spawned new process with pid 2153, instance 1, run: true Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:27 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio volumio[966]: info: camilladsp spawned new process with pid 2160, instance 1, run: true Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:27 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio volumio[966]: info: camilladsp spawned new process with pid 2167, instance 1, run: true Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:27 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio volumio[966]: info: camilladsp spawned new process with pid 2174, instance 1, run: true Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:27 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio volumio[966]: info: camilladsp spawned new process with pid 2181, instance 1, run: true Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:27 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:27 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:27 volumio volumio[966]: info: camilladsp spawned new process with pid 2188, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:28 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio volumio[966]: info: camilladsp spawned new process with pid 2195, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:28 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio volumio[966]: info: camilladsp spawned new process with pid 2202, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:28 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio volumio[966]: info: camilladsp spawned new process with pid 2209, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:28 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio volumio[966]: info: camilladsp spawned new process with pid 2216, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:28 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio volumio[966]: info: camilladsp spawned new process with pid 2223, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:28 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio volumio[966]: info: camilladsp spawned new process with pid 2230, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:28 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio volumio[966]: info: camilladsp spawned new process with pid 2237, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:28 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:28 volumio volumio[966]: info: camilladsp spawned new process with pid 2244, instance 1, run: true Oct 19 12:58:28 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:29 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio volumio[966]: info: camilladsp spawned new process with pid 2251, instance 1, run: true Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:29 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio volumio[966]: info: camilladsp spawned new process with pid 2258, instance 1, run: true Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:29 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio volumio[966]: info: camilladsp spawned new process with pid 2265, instance 1, run: true Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:29 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio volumio[966]: info: camilladsp spawned new process with pid 2272, instance 1, run: true Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:29 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio volumio[966]: info: camilladsp spawned new process with pid 2279, instance 1, run: true Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:29 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio volumio[966]: info: camilladsp spawned new process with pid 2286, instance 1, run: true Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:29 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio volumio[966]: info: camilladsp spawned new process with pid 2293, instance 1, run: true Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:29 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:29 volumio volumio[966]: info: camilladsp spawned new process with pid 2300, instance 1, run: true Oct 19 12:58:29 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:30 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio volumio[966]: info: camilladsp spawned new process with pid 2307, instance 1, run: true Oct 19 12:58:30 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:30 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio volumio[966]: info: camilladsp spawned new process with pid 2314, instance 1, run: true Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:30 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio volumio[966]: info: camilladsp spawned new process with pid 2321, instance 1, run: true Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:30 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio volumio[966]: info: camilladsp spawned new process with pid 2328, instance 1, run: true Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:30 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio volumio[966]: info: camilladsp spawned new process with pid 2335, instance 1, run: true Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:30 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio volumio[966]: info: camilladsp spawned new process with pid 2342, instance 1, run: true Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:30 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio volumio[966]: info: camilladsp spawned new process with pid 2349, instance 1, run: true Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:30 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio volumio[966]: info: camilladsp spawned new process with pid 2356, instance 1, run: true Oct 19 12:58:30 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:30 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio volumio[966]: info: camilladsp spawned new process with pid 2363, instance 1, run: true Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio volumio[966]: info: camilladsp spawned new process with pid 2370, instance 1, run: true Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio volumio[966]: info: camilladsp spawned new process with pid 2377, instance 1, run: true Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio volumio[966]: info: camilladsp spawned new process with pid 2384, instance 1, run: true Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio volumio[966]: info: camilladsp spawned new process with pid 2391, instance 1, run: true Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio volumio[966]: info: camilladsp spawned new process with pid 2398, instance 1, run: true Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio volumio[966]: info: camilladsp spawned new process with pid 2405, instance 1, run: true Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio volumio[966]: info: camilladsp spawned new process with pid 2412, instance 1, run: true Oct 19 12:58:31 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:31 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:31 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio volumio[966]: info: camilladsp spawned new process with pid 2419, instance 1, run: true Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:32 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio volumio[966]: info: camilladsp spawned new process with pid 2426, instance 1, run: true Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:32 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio volumio[966]: info: camilladsp spawned new process with pid 2433, instance 1, run: true Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:32 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio volumio[966]: info: camilladsp spawned new process with pid 2478, instance 1, run: true Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:32 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio volumio[966]: info: camilladsp spawned new process with pid 2485, instance 1, run: true Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:32 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio volumio[966]: info: camilladsp spawned new process with pid 2492, instance 1, run: true Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:32 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio volumio[966]: info: camilladsp spawned new process with pid 2499, instance 1, run: true Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:32 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio volumio[966]: info: camilladsp spawned new process with pid 2506, instance 1, run: true Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:32 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:32 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:32 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2513, instance 1, run: true Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:33 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2520, instance 1, run: true Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:33 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2527, instance 1, run: true Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:33 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2534, instance 1, run: true Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:33 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2541, instance 1, run: true Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:33 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2548, instance 1, run: true Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:33 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2555, instance 1, run: true Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:33 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2562, instance 1, run: true Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:33 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:33 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:33 volumio volumio[966]: info: camilladsp spawned new process with pid 2569, instance 1, run: true Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:34 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio volumio[966]: info: camilladsp spawned new process with pid 2576, instance 1, run: true Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:34 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio volumio[966]: info: camilladsp spawned new process with pid 2583, instance 1, run: true Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:34 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio volumio[966]: info: camilladsp spawned new process with pid 2590, instance 1, run: true Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:34 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio volumio[966]: info: camilladsp spawned new process with pid 2597, instance 1, run: true Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:34 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio volumio[966]: info: camilladsp spawned new process with pid 2604, instance 1, run: true Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:34 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio volumio[966]: info: camilladsp spawned new process with pid 2611, instance 1, run: true Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:34 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio volumio[966]: info: camilladsp spawned new process with pid 2618, instance 1, run: true Oct 19 12:58:34 volumio kernel: usb 1-1.1: 1:0: usb_set_interface failed (-71) Oct 19 12:58:34 volumio kernel: usb 1-1.1: USB disconnect, device number 3 Oct 19 12:58:34 volumio kernel: usb 1-1.1: uac_clock_source_is_valid(): cannot get clock validity for id 33 Oct 19 12:58:34 volumio kernel: usb 1-1.1: clock source 33 is not valid, cannot use Oct 19 12:58:34 volumio volumio[966]: info: camilladsp spawned new process with pid 2628, instance 1, run: true Oct 19 12:58:34 volumio volumio[966]: info: Oct 19 12:58:34 volumio volumio[966]: ---------------------------- USB Audio Device Detached Oct 19 12:58:34 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Oct 19 12:58:34 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 12:58:35 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:35 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2638, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2645, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2652, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2659, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2666, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2673, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2680, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2687, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2694, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2701, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2708, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2715, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2722, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2729, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2736, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2743, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2750, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2757, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2764, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2771, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2778, instance 1, run: true Oct 19 12:58:35 volumio volumio[966]: info: camilladsp spawned new process with pid 2785, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2792, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2799, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2806, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2813, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2820, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2827, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2834, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2841, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2848, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2855, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2862, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2869, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2876, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2883, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2890, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2897, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2904, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2911, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2918, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2925, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2932, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2939, instance 1, run: true Oct 19 12:58:36 volumio volumio[966]: info: camilladsp spawned new process with pid 2946, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 2953, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 2960, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 2967, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 2974, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 2981, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 2988, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 2995, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3002, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3009, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3016, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3023, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3030, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3037, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3044, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3051, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3058, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3065, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3072, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3079, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3086, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3093, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3100, instance 1, run: true Oct 19 12:58:37 volumio volumio[966]: info: camilladsp spawned new process with pid 3107, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3114, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3121, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3128, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3135, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3142, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3149, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3156, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3163, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3170, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3177, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3184, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3191, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3198, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3205, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3212, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3219, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3226, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3233, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3240, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3247, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3254, instance 1, run: true Oct 19 12:58:38 volumio volumio[966]: info: camilladsp spawned new process with pid 3261, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3268, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3275, instance 1, run: true Oct 19 12:58:39 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3282, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3289, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3296, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3303, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3310, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3317, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3324, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3331, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3338, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3345, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3352, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3359, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3366, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3373, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3380, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3387, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3394, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3401, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3408, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3415, instance 1, run: true Oct 19 12:58:39 volumio volumio[966]: info: camilladsp spawned new process with pid 3422, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3429, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3436, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3443, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3450, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3457, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3464, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3471, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3478, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3485, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3492, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3499, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3506, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3513, instance 1, run: true Oct 19 12:58:40 volumio kernel: usb 1-1.1: new high-speed USB device number 4 using xhci_hcd Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3520, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3527, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3534, instance 1, run: true Oct 19 12:58:40 volumio kernel: usb 1-1.1: New USB device found, idVendor=0644, idProduct=804a, bcdDevice= 1.00 Oct 19 12:58:40 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Oct 19 12:58:40 volumio kernel: usb 1-1.1: Product: TEAC UD-301 Oct 19 12:58:40 volumio kernel: usb 1-1.1: Manufacturer: TEAC Corporation Oct 19 12:58:40 volumio kernel: usb 1-1.1: SerialNumber: 002B00003DE974014E452827500C0024 Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3542, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3549, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3556, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3563, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3570, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3577, instance 1, run: true Oct 19 12:58:40 volumio volumio[966]: info: camilladsp spawned new process with pid 3584, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3591, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3598, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3605, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3612, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3619, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3626, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3633, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3640, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3647, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3654, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3661, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3668, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3675, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3682, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3689, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3696, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3703, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3710, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3717, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: camilladsp spawned new process with pid 3724, instance 1, run: true Oct 19 12:58:41 volumio volumio[966]: info: Oct 19 12:58:41 volumio volumio[966]: ---------------------------- USB Audio Device Attached Oct 19 12:58:41 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Oct 19 12:58:41 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:41 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Oct 19 12:58:41 volumio volumio[966]: info: Preparing to save Alsa Options, stopping services first Oct 19 12:58:41 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Oct 19 12:58:41 volumio volumio[966]: info: CoreCommandRouter::volumioPause Oct 19 12:58:41 volumio volumio[966]: info: CoreStateMachine::pause Oct 19 12:58:41 volumio volumio[966]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"TEAC UD-301","alsacard":"UD301"},"i2s":false} Oct 19 12:58:41 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 12:58:42 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:42 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 12:58:42 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:42 volumio volumio[966]: info: Device 5 does not have any Mixer Control Available Oct 19 12:58:42 volumio vtcs[1362]: [2024-10-19 12:58:42.118] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Oct 19 12:58:42 volumio vtcs[1362]: [2024-10-19 12:58:42.119] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=5 errorno=104 error=Connection reset by peer Oct 19 12:58:42 volumio vtcs[1362]: [2024-10-19 12:58:42.119] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Oct 19 12:58:42 volumio sudo[3745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 19 12:58:42 volumio sudo[3745]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:42 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Oct 19 12:58:42 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Oct 19 12:58:42 volumio systemd[1]: vtcs.service: Succeeded. Oct 19 12:58:42 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Oct 19 12:58:42 volumio sudo[3745]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:42 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 19 12:58:42 volumio volumio[966]: info: Updating Volume Controller Parameters: Device: 5 Name: TEAC UD-301 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 19 12:58:42 volumio volumio[966]: info: Disabling external Volume Control Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 12:58:42 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:42 volumio volumio[966]: info: Preparing to generate the ALSA configuration file Oct 19 12:58:42 volumio volumio[966]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 19 12:58:42 volumio volumio[966]: info: Reading ALSA contributions from plugins. Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Oct 19 12:58:42 volumio volumio[966]: info: CoreStateMachine::getQueue Oct 19 12:58:42 volumio volumio[966]: info: CorePlayQueue::getQueue Oct 19 12:58:42 volumio sudo[3751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 19 12:58:42 volumio sudo[3751]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:42 volumio volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 19 12:58:42 volumio sudo[3751]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:42 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 12:58:42 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 12:58:42 volumio volumio[966]: info: Asound.conf file unchanged, so no further update is needed Oct 19 12:58:42 volumio volumio[966]: info: Output device has changed, restarting MPD Oct 19 12:58:42 volumio sudo[3759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 19 12:58:42 volumio sudo[3759]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:42 volumio volumio[966]: info: Output device has changed, restarting Shairport Sync Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 12:58:42 volumio sudo[3759]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:42 volumio sudo[3762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 19 12:58:42 volumio sudo[3762]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:42 volumio systemd[1]: Stopping Music Player Daemon... Oct 19 12:58:42 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:42 volumio volumio[966]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 12:58:42 volumio volumio[966]: xcb_connection_has_error() returned true Oct 19 12:58:42 volumio volumio[966]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio systemd[1]: mpd.service: Succeeded. Oct 19 12:58:42 volumio systemd[1]: Stopped Music Player Daemon. Oct 19 12:58:42 volumio sudo[3771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 19 12:58:42 volumio sudo[3771]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:42 volumio systemd[1]: Starting Music Player Daemon... Oct 19 12:58:42 volumio sudo[3774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 19 12:58:42 volumio volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 19 12:58:42 volumio sudo[3774]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:42 volumio volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 19 12:58:42 volumio volumio[966]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Oct 19 12:58:42 volumio volumio[966]: info: MPD Permissions set Oct 19 12:58:42 volumio sudo[3771]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:42 volumio volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio sudo[3774]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 12:58:42 volumio volumio[966]: info: Starting Shairport Sync Oct 19 12:58:42 volumio sudo[3769]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 19 12:58:42 volumio sudo[3769]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:42 volumio sudo[3769]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:42 volumio sudo[3784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 12:58:42 volumio sudo[3784]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:42 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 19 12:58:42 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 19 12:58:42 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 19 12:58:42 volumio volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 19 12:58:42 volumio volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 19 12:58:42 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 12:58:42 volumio sudo[3784]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:42 volumio volumio[966]: info: Shairport-Sync Started Oct 19 12:58:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Oct 19 12:58:43 volumio mpd[3785]: Oct 19 12:58 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 19 12:58:43 volumio systemd[1]: Started Music Player Daemon. Oct 19 12:58:43 volumio sudo[3762]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:43 volumio volumio[966]: error: updateQueue error: null Oct 19 12:58:43 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 12:58:43 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 12:58:43 volumio volumio[966]: info: Discovery: Getting this device information Oct 19 12:58:43 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Oct 19 12:58:43 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 12:58:45 volumio volumio[966]: info: TidalConnect service stoped! Oct 19 12:58:45 volumio volumio[966]: info: TidalConnect service stoped! Oct 19 12:58:45 volumio volumio[966]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 19 12:58:45 volumio volumio[966]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 19 12:58:45 volumio sudo[3801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 19 12:58:45 volumio sudo[3801]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:45 volumio systemd[1]: Started Volumio Tidal Connect Service. Oct 19 12:58:45 volumio sudo[3801]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:45 volumio volumio[966]: info: Executing endpoint tc_getconfig Oct 19 12:58:45 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 19 12:58:45 volumio vtcs[3803]: STARTING TidalConnect services, version: 1.4.0.34 Oct 19 12:58:45 volumio volumio[966]: info: TidalConnect service stoped! Oct 19 12:58:45 volumio volumio[966]: info: TidalConnect service stoped! Oct 19 12:58:45 volumio vtcs[3803]: STARTED TidalConnect services. Oct 19 12:58:45 volumio volumio[966]: info: Executing endpoint tc_connect Oct 19 12:58:45 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 19 12:58:45 volumio volumio[966]: info: Connecting to TidalConnect Oct 19 12:58:45 volumio volumio[966]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 19 12:58:45 volumio volumio[966]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 19 12:58:45 volumio volumio[966]: info: CoreCommandRouter::servicePushState Oct 19 12:58:45 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:45 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:45 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:45 volumio volumio[966]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Oct 19 12:58:45 volumio volumio[966]: info: CoreCommandRouter::servicePushState Oct 19 12:58:45 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:45 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:45 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:45 volumio volumio[966]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Oct 19 12:58:45 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Oct 19 12:58:45 volumio volumio[966]: info: CoreStateMachine::getQueue Oct 19 12:58:45 volumio volumio[966]: info: CorePlayQueue::getQueue Oct 19 12:58:45 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Oct 19 12:58:45 volumio volumio[966]: info: CoreStateMachine::getQueue Oct 19 12:58:45 volumio volumio[966]: info: CorePlayQueue::getQueue Oct 19 12:58:45 volumio sudo[3831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 19 12:58:45 volumio sudo[3831]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 12:58:45 volumio sudo[3831]: pam_unix(sudo:session): session closed for user root Oct 19 12:58:46 volumio volumio[966]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 19 12:58:46 volumio volumio[966]: info: CoreStateMachine::getcurrentVolume Oct 19 12:58:46 volumio volumio[966]: info: CoreCommandRouter::volumioRetrievevolume Oct 19 12:58:46 volumio volumio[966]: info: CoreStateMachine::pushState Oct 19 12:58:46 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Oct 19 12:58:46 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Oct 19 12:58:46 volumio volumio[966]: info: CoreStateMachine::getQueue Oct 19 12:58:46 volumio volumio[966]: info: CorePlayQueue::getQueue Oct 19 12:58:48 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:58:48 volumio volumio[966]: info: TidalConnect service started! Oct 19 12:58:48 volumio volumio[966]: info: TidalConnect service started! Oct 19 12:58:49 volumio volumio[966]: info: CoreCommandRouter::volumioPlay Oct 19 12:58:49 volumio volumio[966]: info: CoreStateMachine::play index undefined Oct 19 12:58:49 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 12:58:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:49 volumio volumio[966]: info: CoreStateMachine::startPlaybackTimer Oct 19 12:58:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:49 volumio volumio[966]: info: [1729310329336] ControllerUPNPBrowser::resume Oct 19 12:58:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand play Oct 19 12:58:49 volumio volumio[966]: info: sendMpdCommand play took 1 milliseconds Oct 19 12:58:57 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:58:59 volumio volumio[966]: info: CoreCommandRouter::volumioPlay Oct 19 12:58:59 volumio volumio[966]: info: CoreStateMachine::play index undefined Oct 19 12:58:59 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 12:58:59 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:59 volumio volumio[966]: info: CoreStateMachine::startPlaybackTimer Oct 19 12:58:59 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:58:59 volumio volumio[966]: info: [1729310339806] ControllerUPNPBrowser::resume Oct 19 12:58:59 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand play Oct 19 12:58:59 volumio volumio[966]: info: sendMpdCommand play took 1 milliseconds Oct 19 12:59:00 volumio volumio[966]: info: CoreCommandRouter::volumioPlay Oct 19 12:59:00 volumio volumio[966]: info: CoreStateMachine::play index undefined Oct 19 12:59:00 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 12:59:00 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:59:00 volumio volumio[966]: info: CoreStateMachine::startPlaybackTimer Oct 19 12:59:00 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:59:00 volumio volumio[966]: info: [1729310340600] ControllerUPNPBrowser::resume Oct 19 12:59:00 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand play Oct 19 12:59:00 volumio volumio[966]: info: sendMpdCommand play took 1 milliseconds Oct 19 12:59:06 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:59:13 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 12:59:13 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 12:59:13 volumio volumio[966]: info: Discovery: Getting this device information Oct 19 12:59:13 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Oct 19 12:59:13 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Oct 19 12:59:13 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 12:59:15 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:59:24 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:59:24 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 12:59:24 volumio volumio[966]: info: Preload queue cleared Oct 19 12:59:26 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 12:59:26 volumio volumio[966]: info: Preload queue cleared Oct 19 12:59:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 12:59:28 volumio volumio[966]: info: Preload queue cleared Oct 19 12:59:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 12:59:30 volumio volumio[966]: info: Preload queue cleared Oct 19 12:59:33 volumio wpa_supplicant[882]: RRM: Ignoring radio measurement request: Not RRM network Oct 19 12:59:37 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 12:59:37 volumio volumio[966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 12:59:37 volumio volumio[966]: TypeError: Cannot read property 'length' of undefined Oct 19 12:59:37 volumio volumio[966]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 19 12:59:37 volumio volumio[966]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 19 12:59:37 volumio volumio[966]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 19 12:59:37 volumio volumio[966]: at Parser.emit (events.js:315:20) Oct 19 12:59:37 volumio volumio[966]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 19 12:59:37 volumio volumio[966]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 19 12:59:37 volumio volumio[966]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 19 12:59:37 volumio volumio[966]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 19 12:59:37 volumio volumio[966]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 19 12:59:37 volumio volumio[966]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 19 12:59:37 volumio volumio[966]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 19 12:59:37 volumio volumio[966]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 19 12:59:37 volumio volumio[966]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 19 12:59:37 volumio volumio[966]: at IncomingMessage.emit (events.js:327:22) Oct 19 12:59:37 volumio volumio[966]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 19 12:59:37 volumio volumio[966]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 19 12:59:37 volumio volumio[966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 12:59:38 volumio sudo[3884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 12:58 Oct 19 12:59:38 volumio sudo[3884]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"