-- Logs begin at Mon 2025-05-19 09:15:15 AEST, end at Mon 2025-05-19 10:49:23 AEST. --
May 19 10:48:00 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:00 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:00 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:00 rivoplus volumio[3140]: 64544 bytes (65 kB, 63 KiB) copied, 0.0008375 s, 77.1 MB/s
May 19 10:48:00 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25229, instance 4, run: true
May 19 10:48:01 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:01 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:01 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:01 rivoplus volumio[3140]: 63280 bytes (63 kB, 62 KiB) copied, 0.000985292 s, 64.2 MB/s
May 19 10:48:01 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25234, instance 4, run: true
May 19 10:48:02 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:02 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:02 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:02 rivoplus volumio[3140]: 63008 bytes (63 kB, 62 KiB) copied, 0.00103387 s, 60.9 MB/s
May 19 10:48:02 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25239, instance 4, run: true
May 19 10:48:03 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:03 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:03 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:03 rivoplus volumio[3140]: 63280 bytes (63 kB, 62 KiB) copied, 0.000975958 s, 64.8 MB/s
May 19 10:48:03 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25261, instance 4, run: true
May 19 10:48:05 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:05 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:05 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:05 rivoplus volumio[3140]: 63008 bytes (63 kB, 62 KiB) copied, 0.00066875 s, 94.2 MB/s
May 19 10:48:05 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25266, instance 4, run: true
May 19 10:48:06 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:06 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:06 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:06 rivoplus volumio[3140]: 58160 bytes (58 kB, 57 KiB) copied, 0.00058075 s, 100 MB/s
May 19 10:48:06 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25271, instance 4, run: true
May 19 10:48:06 rivoplus kernel: aml_tdm_open
May 19 10:48:06 rivoplus kernel: Not init audio effects
May 19 10:48:06 rivoplus kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1
May 19 10:48:06 rivoplus kernel: set mclk:24576000, mpll:49152000, get mclk:24575987, mpll:49151974
May 19 10:48:06 rivoplus kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc03d2e8c18, id(1), clksel(1)
May 19 10:48:06 rivoplus kernel: aml_dai_set_tdm_fmt(), fmt not change
May 19 10:48:06 rivoplus kernel: dump_pcm_setting(ffffffc03d2e8c18)
May 19 10:48:06 rivoplus kernel: pcm_mode(1)
May 19 10:48:06 rivoplus kernel: sysclk(24576000)
May 19 10:48:06 rivoplus kernel: sysclk_bclk_ratio(4)
May 19 10:48:06 rivoplus kernel: bclk(6144000)
May 19 10:48:06 rivoplus kernel: bclk_lrclk_ratio(64)
May 19 10:48:06 rivoplus kernel: lrclk(96000)
May 19 10:48:06 rivoplus kernel: tx_mask(0x3)
May 19 10:48:06 rivoplus kernel: rx_mask(0x3)
May 19 10:48:06 rivoplus kernel: slots(2)
May 19 10:48:06 rivoplus kernel: slot_width(32)
May 19 10:48:06 rivoplus kernel: lane_mask_in(0x2)
May 19 10:48:06 rivoplus kernel: lane_mask_out(0x1)
May 19 10:48:06 rivoplus kernel: lane_oe_mask_in(0x0)
May 19 10:48:06 rivoplus kernel: lane_oe_mask_out(0x0)
May 19 10:48:06 rivoplus kernel: lane_lb_mask_in(0x0)
May 19 10:48:06 rivoplus kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk
May 19 10:48:06 rivoplus kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk
May 19 10:48:06 rivoplus kernel: set mclk:24576000, mpll:49152000, get mclk:24575987, mpll:49151974
May 19 10:48:06 rivoplus kernel: aml_dai_set_clkdiv, div 4, clksel(1)
May 19 10:48:06 rivoplus kernel: aml_dai_set_bclk_ratio, select I2S mode
May 19 10:48:06 rivoplus kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B
May 19 10:48:06 rivoplus kernel: aml_tdm_prepare(), reset fddr
May 19 10:48:06 rivoplus kernel: spdif_a fifo ctrl, frddr:0 type:3, 32 bits, chmask 0x3, swap 0x10
May 19 10:48:06 rivoplus kernel: spdif_info: rate: 96000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0xa00, ch1_r:0xa00
May 19 10:48:06 rivoplus kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
May 19 10:48:06 rivoplus kernel: tdm playback mute: 0, lane_cnt = 8
May 19 10:48:06 rivoplus kernel: aml_tdm_open
May 19 10:48:06 rivoplus kernel: audio_ddr_mngr: toddrs[0] registered by device ff660000.audiobus:tdm@1
May 19 10:48:06 rivoplus kernel: tdm capture mute: 1
May 19 10:48:06 rivoplus kernel: audio_ddr_mngr: toddrs[0] released by device ff660000.audiobus:tdm@1
May 19 10:48:06 rivoplus kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
May 19 10:48:06 rivoplus kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B
May 19 10:48:06 rivoplus kernel: tdm playback mute: 1, lane_cnt = 8
May 19 10:48:06 rivoplus kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1
May 19 10:48:06 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25279, instance 3, run: true
May 19 10:48:07 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:07 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:07 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:07 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000904709 s, 72.4 MB/s
May 19 10:48:07 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25291, instance 4, run: true
May 19 10:48:07 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:07 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:07 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:07 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000527959 s, 124 MB/s
May 19 10:48:07 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25296, instance 3, run: true
May 19 10:48:08 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:08 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:08 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:08 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000715583 s, 86.2 MB/s
May 19 10:48:08 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25301, instance 4, run: true
May 19 10:48:08 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:08 rivoplus volumio[3140]: 18+1 records in
May 19 10:48:08 rivoplus volumio[3140]: 18+1 records out
May 19 10:48:08 rivoplus volumio[3140]: 619312 bytes (619 kB, 605 KiB) copied, 0.0192904 s, 32.1 MB/s
May 19 10:48:08 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25306, instance 3, run: true
May 19 10:48:09 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:09 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:09 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:09 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000888709 s, 69.4 MB/s
May 19 10:48:09 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25311, instance 4, run: true
May 19 10:48:09 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:09 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:09 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:09 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000528541 s, 124 MB/s
May 19 10:48:09 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25316, instance 3, run: true
May 19 10:48:10 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:10 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:10 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:10 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000915708 s, 71.6 MB/s
May 19 10:48:10 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25321, instance 4, run: true
May 19 10:48:10 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:10 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:10 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:10 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000963959 s, 64.0 MB/s
May 19 10:48:10 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25326, instance 3, run: true
May 19 10:48:11 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:11 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:11 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:11 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.00100238 s, 65.4 MB/s
May 19 10:48:11 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25331, instance 4, run: true
May 19 10:48:11 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:11 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:11 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:11 rivoplus volumio[3140]: 65024 bytes (65 kB, 64 KiB) copied, 0.000535958 s, 121 MB/s
May 19 10:48:11 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25336, instance 3, run: true
May 19 10:48:12 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:12 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:12 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:12 rivoplus volumio[3140]: 62224 bytes (62 kB, 61 KiB) copied, 0.00075125 s, 82.8 MB/s
May 19 10:48:12 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25341, instance 4, run: true
May 19 10:48:12 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 19 10:48:12 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 19 10:48:12 rivoplus volumio[3140]: info: Discovery: Getting this device information
May 19 10:48:12 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:12 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:12 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 19 10:48:12 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:12 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:12 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:12 rivoplus volumio[3140]: 61872 bytes (62 kB, 60 KiB) copied, 0.000995125 s, 62.2 MB/s
May 19 10:48:12 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25346, instance 3, run: true
May 19 10:48:13 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:13 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:13 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:13 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000681417 s, 96.2 MB/s
May 19 10:48:13 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25371, instance 4, run: true
May 19 10:48:14 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:14 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:14 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:14 rivoplus volumio[3140]: 62656 bytes (63 kB, 61 KiB) copied, 0.000723666 s, 86.6 MB/s
May 19 10:48:14 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25376, instance 3, run: true
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPause
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::pause
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::stPlaybackTimer
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::servicePause
May 19 10:48:14 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::servicePause
May 19 10:48:14 rivoplus volumio[3140]: info: ControllerMpd::pause
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand pause
May 19 10:48:14 rivoplus volumio[3140]: info: sendMpdCommand pause took 2 milliseconds
May 19 10:48:14 rivoplus volumio[3140]: info:
May 19 10:48:14 rivoplus volumio[3140]: ---------------------------- MPD announces state update: player
May 19 10:48:14 rivoplus volumio[3140]: info: ControllerMpd::getState
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand status
May 19 10:48:14 rivoplus volumio[3140]: info:
May 19 10:48:14 rivoplus volumio[3140]: ---------------------------- MPD announces state update: player
May 19 10:48:14 rivoplus volumio[3140]: info: ControllerMpd::getState
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand status
May 19 10:48:14 rivoplus volumio[3140]: info: sendMpdCommand status took 2 milliseconds
May 19 10:48:14 rivoplus volumio[3140]: info: sendMpdCommand status took 2 milliseconds
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::parseState
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::parseState
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 10:48:14 rivoplus volumio[3140]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 19 10:48:14 rivoplus volumio[3140]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::parseTrackInfo
May 19 10:48:14 rivoplus volumio[3140]: verbose: ControllerMpd::parseTrackInfo
May 19 10:48:14 rivoplus volumio[3140]: info: ControllerMpd::pushState
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::servicePushState
May 19 10:48:14 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:14 rivoplus volumio[3140]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":52982,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1464 Kbps","isStreaming":false,"title":"Yan Benimle","artist":"Sila","album":"Mürekkep","uri":"NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac","trackType":"flac"}
May 19 10:48:14 rivoplus volumio[3140]: verbose: CURRENT POSITION 4
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::syncState stateService pause
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::syncState currentStatus pause
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:14 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:14 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::stPlaybackTimer
May 19 10:48:14 rivoplus volumio[3140]: info: ControllerMpd::pushState
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::servicePushState
May 19 10:48:14 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:14 rivoplus volumio[3140]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":52982,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1464 Kbps","isStreaming":false,"title":"Yan Benimle","artist":"Sila","album":"Mürekkep","uri":"NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac","trackType":"flac"}
May 19 10:48:14 rivoplus volumio[3140]: verbose: CURRENT POSITION 4
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::syncState stateService pause
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::syncState currentStatus pause
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:14 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:14 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:14 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:14 rivoplus volumio[3140]: info: CoreStateMachine::stPlaybackTimer
May 19 10:48:14 rivoplus volumio[3140]: info: ------------------------------ 35ms
May 19 10:48:14 rivoplus volumio[3140]: info: ------------------------------ 34ms
May 19 10:48:14 rivoplus volumio[3140]: info: MCU Signalled Playback Inactive
May 19 10:48:14 rivoplus volumio[3140]: 0+0 records in
May 19 10:48:14 rivoplus volumio[3140]: 0+0 records out
May 19 10:48:14 rivoplus volumio[3140]: 0 bytes copied, 0.000344041 s, 0.0 kB/s
May 19 10:48:14 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25381, instance 4, run: true
May 19 10:48:15 rivoplus volumio[3140]: 0+0 records in
May 19 10:48:15 rivoplus volumio[3140]: 0+0 records out
May 19 10:48:15 rivoplus volumio[3140]: 0 bytes copied, 0.000187541 s, 0.0 kB/s
May 19 10:48:15 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25386, instance 3, run: true
May 19 10:48:15 rivoplus volumio[3140]: 0+0 records in
May 19 10:48:15 rivoplus volumio[3140]: 0+0 records out
May 19 10:48:15 rivoplus volumio[3140]: 0 bytes copied, 0.00018875 s, 0.0 kB/s
May 19 10:48:15 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25391, instance 4, run: true
May 19 10:48:16 rivoplus volumio[3140]: 0+0 records in
May 19 10:48:16 rivoplus volumio[3140]: 0+0 records out
May 19 10:48:16 rivoplus volumio[3140]: 0 bytes copied, 0.000352 s, 0.0 kB/s
May 19 10:48:16 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25396, instance 3, run: true
May 19 10:48:16 rivoplus volumio[3140]: 0+0 records in
May 19 10:48:16 rivoplus volumio[3140]: 0+0 records out
May 19 10:48:16 rivoplus volumio[3140]: 0 bytes copied, 0.000337375 s, 0.0 kB/s
May 19 10:48:16 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25401, instance 4, run: true
May 19 10:48:17 rivoplus volumio[3140]: 0+0 records in
May 19 10:48:17 rivoplus volumio[3140]: 0+0 records out
May 19 10:48:17 rivoplus volumio[3140]: 0 bytes copied, 0.000188125 s, 0.0 kB/s
May 19 10:48:17 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25406, instance 3, run: true
May 19 10:48:17 rivoplus volumio[3140]: info: Preload queue cleared
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::ClearQueue
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::stop
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::setConsumeUpdateService undefined
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::updateTrackBlock
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrackBlock
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::stPlaybackTimer
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::serviceStop
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::serviceStop
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::stop
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand stop
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::clearPlayQueue
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::saveQueue
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushQueue
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::addQueueItems
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::addQueueItems
May 19 10:48:17 rivoplus volumio[3140]: info: Preload queue cleared
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Ziyan.mp3
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Ziyan.mp3
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Can Dostum.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Can Dostum.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Afitap.mp3
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Afitap.mp3
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Müstehcen.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Müstehcen.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushQueue
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::saveQueue
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::updateTrackBlock
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrackBlock
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPlay
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::play index 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::setConsumeUpdateService undefined
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::addQueueItems
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::addQueueItems
May 19 10:48:17 rivoplus volumio[3140]: info: Preload queue cleared
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Bırak.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Bırak.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Münferit.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Münferit.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Kursun.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Kursun.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Adding Item to queue: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Günaydın Sevgilim.flac
May 19 10:48:17 rivoplus volumio[3140]: info: Using cached record of: music-library/NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Günaydın Sevgilim.flac
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::stop
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::setConsumeUpdateService undefined
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushQueue
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::saveQueue
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::play index undefined
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::setConsumeUpdateService undefined
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::updateTrackBlock
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrackBlock
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::startPlaybackTimer
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand stop
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces state update: player
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand stop took 54 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::getState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand status
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand stop took 23 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand clear
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces state update: player
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::getState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand status
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces system playlist update
May 19 10:48:17 rivoplus volumio[3140]: info: Ignoring MPD Status Update
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand status took 5 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand clear took 5 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand status took 3 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac"
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseState
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::servicePushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 19 10:48:17 rivoplus volumio[3140]: verbose: CURRENT POSITION 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState stateService stop
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState currentStatus stop
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: No code
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 32ms
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces system playlist update
May 19 10:48:17 rivoplus volumio[3140]: info: Ignoring MPD Status Update
May 19 10:48:17 rivoplus volumio[3140]: error: updateQueue error: null
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces system playlist update
May 19 10:48:17 rivoplus volumio[3140]: info: Ignoring MPD Status Update
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 38ms
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand playlistinfo took 36 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand add "NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac" took 37 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 9ms
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseTrackInfo
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand play
May 19 10:48:17 rivoplus volumio[3140]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 48ms
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces system playlist update
May 19 10:48:17 rivoplus volumio[3140]: info: Ignoring MPD Status Update
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 30ms
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand play took 26 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 25ms
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces state update: player
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::getState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand status
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces state update: player
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::getState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand status
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate from file: 44100
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate from file: 44100
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate from file: 44100
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate from file: 44100
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate from file: 44100
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate from file: 44100
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate from file: 44100
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - ---- read samplerate from file: 44100
May 19 10:48:17 rivoplus volumio[3140]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces state update: player
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand status took 75 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::getState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand status
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand status took 74 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 10:48:17 rivoplus volumio[3140]: info:
May 19 10:48:17 rivoplus volumio[3140]: ---------------------------- MPD announces state update: player
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::getState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand status
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand status took 11 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand playlistinfo took 10 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand playlistinfo took 9 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand status took 8 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseTrackInfo
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseTrackInfo
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseState
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::servicePushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Yan Benimle","artist":"Sila","album":"Mürekkep","uri":"NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac","trackType":"flac"}
May 19 10:48:17 rivoplus volumio[3140]: verbose: CURRENT POSITION 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState stateService play
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState currentStatus stop
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::servicePushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Yan Benimle","artist":"Sila","album":"Mürekkep","uri":"NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac","trackType":"flac"}
May 19 10:48:17 rivoplus volumio[3140]: verbose: CURRENT POSITION 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState stateService play
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState currentStatus play
May 19 10:48:17 rivoplus volumio[3140]: info: Received an update from plugin. extracting info from payload
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 106ms
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 115ms
May 19 10:48:17 rivoplus volumio[3140]: error: FusionDsp - WebSocket error: [object Object]
May 19 10:48:17 rivoplus volumio[3140]: error: FusionDsp - WebSocket error: [object Object]
May 19 10:48:17 rivoplus volumio[3140]: error: FusionDsp - WebSocket error: [object Object]
May 19 10:48:17 rivoplus volumio[3140]: error: FusionDsp - WebSocket error: [object Object]
May 19 10:48:17 rivoplus volumio[3140]: error: FusionDsp - WebSocket error: [object Object]
May 19 10:48:17 rivoplus volumio[3140]: error: FusionDsp - WebSocket error: [object Object]
May 19 10:48:17 rivoplus volumio[3140]: error: FusionDsp - WebSocket error: [object Object]
May 19 10:48:17 rivoplus volumio[3140]: error: FusionDsp - WebSocket error: [object Object]
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand playlistinfo took 36 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: info: sendMpdCommand playlistinfo took 35 milliseconds
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseTrackInfo
May 19 10:48:17 rivoplus volumio[3140]: verbose: ControllerMpd::parseTrackInfo
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::servicePushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1173 Kbps","isStreaming":false,"title":"Yan Benimle","artist":"Sila","album":"Mürekkep","uri":"NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac","trackType":"flac"}
May 19 10:48:17 rivoplus volumio[3140]: verbose: CURRENT POSITION 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState stateService play
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState currentStatus play
May 19 10:48:17 rivoplus volumio[3140]: info: Received an update from plugin. extracting info from payload
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: ControllerMpd::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::servicePushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1173 Kbps","isStreaming":false,"title":"Yan Benimle","artist":"Sila","album":"Mürekkep","uri":"NAS/Music_Library/Yerli/Sila/Mürekkep/Sila - Mürekkep - Yan Benimle.flac","trackType":"flac"}
May 19 10:48:17 rivoplus volumio[3140]: verbose: CURRENT POSITION 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState stateService play
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::syncState currentStatus play
May 19 10:48:17 rivoplus volumio[3140]: info: Received an update from plugin. extracting info from payload
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreStateMachine::pushState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioPushState
May 19 10:48:17 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:17 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 91ms
May 19 10:48:17 rivoplus volumio[3140]: info: ------------------------------ 86ms
May 19 10:48:17 rivoplus volumio[3140]: info: Signalling Playback active due to playback status change
May 19 10:48:17 rivoplus volumio[3140]: info: MCU Signalled Playback Active
May 19 10:48:17 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:17 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:17 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:17 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000980458 s, 66.8 MB/s
May 19 10:48:17 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25412, instance 4, run: true
May 19 10:48:18 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:18 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:18 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:18 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000604 s, 109 MB/s
May 19 10:48:18 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25417, instance 3, run: true
May 19 10:48:18 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:18 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:18 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:18 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000519708 s, 119 MB/s
May 19 10:48:18 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25422, instance 4, run: true
May 19 10:48:19 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:19 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:19 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:19 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000546125 s, 120 MB/s
May 19 10:48:19 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25427, instance 3, run: true
May 19 10:48:20 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:20 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:20 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:20 rivoplus volumio[3140]: 62640 bytes (63 kB, 61 KiB) copied, 0.000882 s, 71.0 MB/s
May 19 10:48:20 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25432, instance 4, run: true
May 19 10:48:20 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:20 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:20 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:20 rivoplus volumio[3140]: 64608 bytes (65 kB, 63 KiB) copied, 0.000522583 s, 124 MB/s
May 19 10:48:20 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25437, instance 3, run: true
May 19 10:48:21 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:21 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:21 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:21 rivoplus volumio[3140]: 63584 bytes (64 kB, 62 KiB) copied, 0.0005435 s, 117 MB/s
May 19 10:48:21 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25442, instance 4, run: true
May 19 10:48:21 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:21 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:21 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:21 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000956416 s, 68.5 MB/s
May 19 10:48:21 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25447, instance 3, run: true
May 19 10:48:22 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:22 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:22 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:22 rivoplus volumio[3140]: 62656 bytes (63 kB, 61 KiB) copied, 0.000555708 s, 113 MB/s
May 19 10:48:22 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25452, instance 4, run: true
May 19 10:48:22 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:22 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:22 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:22 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000548625 s, 119 MB/s
May 19 10:48:22 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25457, instance 3, run: true
May 19 10:48:23 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:23 rivoplus volumio[3140]: 90+1 records in
May 19 10:48:23 rivoplus volumio[3140]: 90+1 records out
May 19 10:48:23 rivoplus volumio[3140]: 2979328 bytes (3.0 MB, 2.8 MiB) copied, 0.0437045 s, 68.2 MB/s
May 19 10:48:23 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25480, instance 4, run: true
May 19 10:48:23 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:23 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:23 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:23 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000845125 s, 77.5 MB/s
May 19 10:48:23 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25485, instance 3, run: true
May 19 10:48:24 rivoplus volumio[23242]: ERROR:aiohttp.server:Error handling request
May 19 10:48:24 rivoplus volumio[23242]: Traceback (most recent call last):
May 19 10:48:24 rivoplus volumio[23242]: File "/usr/lib/python3/dist-packages/aiohttp/web_protocol.py", line 406, in start
May 19 10:48:24 rivoplus volumio[23242]: resp = await task
May 19 10:48:24 rivoplus volumio[23242]: File "/usr/lib/python3/dist-packages/aiohttp/web_app.py", line 435, in _handle
May 19 10:48:24 rivoplus volumio[23242]: resp = await handler(request)
May 19 10:48:24 rivoplus volumio[23242]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/views.py", line 278, in get_config_file
May 19 10:48:24 rivoplus volumio[23242]: json_config = new_config_with_relative_filter_paths(get_yaml_as_json(request, config_file), config_dir)
May 19 10:48:24 rivoplus volumio[23242]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/filemanagement.py", line 163, in new_config_with_relative_filter_paths
May 19 10:48:24 rivoplus volumio[23242]: return new_config_with_paths_converted(json_config, conversion)
May 19 10:48:24 rivoplus volumio[23242]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/filemanagement.py", line 168, in new_config_with_paths_converted
May 19 10:48:24 rivoplus volumio[23242]: filters = config["filters"]
May 19 10:48:24 rivoplus volumio[23242]: TypeError: 'NoneType' object is not subscriptable
May 19 10:48:24 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:24 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:24 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:24 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000521249 s, 118 MB/s
May 19 10:48:24 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25491, instance 4, run: true
May 19 10:48:24 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:24 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:24 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:24 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000508334 s, 129 MB/s
May 19 10:48:24 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25496, instance 3, run: true
May 19 10:48:25 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:25 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:25 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:25 rivoplus volumio[3140]: 65456 bytes (65 kB, 64 KiB) copied, 0.0005575 s, 117 MB/s
May 19 10:48:25 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25501, instance 4, run: true
May 19 10:48:25 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:25 rivoplus volumio[3140]: 81+1 records in
May 19 10:48:25 rivoplus volumio[3140]: 81+1 records out
May 19 10:48:25 rivoplus volumio[3140]: 2679120 bytes (2.7 MB, 2.6 MiB) copied, 0.0304138 s, 88.1 MB/s
May 19 10:48:25 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25506, instance 3, run: true
May 19 10:48:26 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:26 rivoplus volumio[3140]: 90+1 records in
May 19 10:48:26 rivoplus volumio[3140]: 90+1 records out
May 19 10:48:26 rivoplus volumio[3140]: 2974224 bytes (3.0 MB, 2.8 MiB) copied, 0.0333172 s, 89.3 MB/s
May 19 10:48:26 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25511, instance 4, run: true
May 19 10:48:26 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:26 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:26 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:26 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000995708 s, 65.8 MB/s
May 19 10:48:26 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25516, instance 3, run: true
May 19 10:48:27 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:27 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:27 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:27 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000552625 s, 119 MB/s
May 19 10:48:27 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25521, instance 4, run: true
May 19 10:48:27 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:27 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:27 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:27 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000715209 s, 86.3 MB/s
May 19 10:48:27 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25526, instance 3, run: true
May 19 10:48:28 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:28 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:28 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:28 rivoplus volumio[3140]: 62736 bytes (63 kB, 61 KiB) copied, 0.000879458 s, 71.3 MB/s
May 19 10:48:28 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25531, instance 4, run: true
May 19 10:48:29 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:29 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:29 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:29 rivoplus volumio[3140]: 64576 bytes (65 kB, 63 KiB) copied, 0.000907 s, 71.2 MB/s
May 19 10:48:29 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25536, instance 3, run: true
May 19 10:48:29 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:29 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:29 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:29 rivoplus volumio[3140]: 65472 bytes (65 kB, 64 KiB) copied, 0.000831625 s, 78.7 MB/s
May 19 10:48:29 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25541, instance 4, run: true
May 19 10:48:30 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:30 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:30 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:30 rivoplus volumio[3140]: 62720 bytes (63 kB, 61 KiB) copied, 0.00095775 s, 65.5 MB/s
May 19 10:48:30 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25546, instance 3, run: true
May 19 10:48:30 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:30 rivoplus volumio[3140]: 10+1 records in
May 19 10:48:30 rivoplus volumio[3140]: 10+1 records out
May 19 10:48:30 rivoplus volumio[3140]: 359712 bytes (360 kB, 351 KiB) copied, 0.0040765 s, 88.2 MB/s
May 19 10:48:30 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25551, instance 4, run: true
May 19 10:48:31 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:31 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:31 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:31 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000627292 s, 104 MB/s
May 19 10:48:31 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25556, instance 3, run: true
May 19 10:48:31 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:31 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:31 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:31 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000866125 s, 71.3 MB/s
May 19 10:48:31 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25561, instance 4, run: true
May 19 10:48:32 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:32 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:32 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:32 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.00120154 s, 54.5 MB/s
May 19 10:48:32 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25566, instance 3, run: true
May 19 10:48:32 rivoplus volumio[23242]: ERROR:aiohttp.server:Error handling request
May 19 10:48:32 rivoplus volumio[23242]: Traceback (most recent call last):
May 19 10:48:32 rivoplus volumio[23242]: File "/usr/lib/python3/dist-packages/aiohttp/web_protocol.py", line 406, in start
May 19 10:48:32 rivoplus volumio[23242]: resp = await task
May 19 10:48:32 rivoplus volumio[23242]: File "/usr/lib/python3/dist-packages/aiohttp/web_app.py", line 435, in _handle
May 19 10:48:32 rivoplus volumio[23242]: resp = await handler(request)
May 19 10:48:32 rivoplus volumio[23242]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/views.py", line 90, in get_param
May 19 10:48:32 rivoplus volumio[23242]: result = cdsp.get_volume()
May 19 10:48:32 rivoplus volumio[23242]: File "/usr/local/lib/python3.7/dist-packages/camilladsp/camilladsp.py", line 276, in get_volume
May 19 10:48:32 rivoplus volumio[23242]: vol = self._query("GetVolume")
May 19 10:48:32 rivoplus volumio[23242]: File "/usr/local/lib/python3.7/dist-packages/camilladsp/camilladsp.py", line 134, in _query
May 19 10:48:32 rivoplus volumio[23242]: raise IOError("Not connected to CamillaDSP")
May 19 10:48:32 rivoplus volumio[23242]: OSError: Not connected to CamillaDSP
May 19 10:48:32 rivoplus volumio[23242]: ERROR:aiohttp.server:Error handling request
May 19 10:48:32 rivoplus volumio[23242]: Traceback (most recent call last):
May 19 10:48:32 rivoplus volumio[23242]: File "/usr/lib/python3/dist-packages/aiohttp/web_protocol.py", line 406, in start
May 19 10:48:32 rivoplus volumio[23242]: resp = await task
May 19 10:48:32 rivoplus volumio[23242]: File "/usr/lib/python3/dist-packages/aiohttp/web_app.py", line 435, in _handle
May 19 10:48:32 rivoplus volumio[23242]: resp = await handler(request)
May 19 10:48:32 rivoplus volumio[23242]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/views.py", line 92, in get_param
May 19 10:48:32 rivoplus volumio[23242]: result = cdsp.get_mute()
May 19 10:48:32 rivoplus volumio[23242]: File "/usr/local/lib/python3.7/dist-packages/camilladsp/camilladsp.py", line 289, in get_mute
May 19 10:48:32 rivoplus volumio[23242]: mute = self._query("GetMute")
May 19 10:48:32 rivoplus volumio[23242]: File "/usr/local/lib/python3.7/dist-packages/camilladsp/camilladsp.py", line 134, in _query
May 19 10:48:32 rivoplus volumio[23242]: raise IOError("Not connected to CamillaDSP")
May 19 10:48:32 rivoplus volumio[23242]: OSError: Not connected to CamillaDSP
May 19 10:48:32 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:32 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:32 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:32 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000555958 s, 111 MB/s
May 19 10:48:32 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25571, instance 4, run: true
May 19 10:48:33 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:33 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:33 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:33 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000562292 s, 117 MB/s
May 19 10:48:33 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25596, instance 3, run: true
May 19 10:48:34 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:34 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:34 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:34 rivoplus volumio[3140]: 61696 bytes (62 kB, 60 KiB) copied, 0.000571667 s, 108 MB/s
May 19 10:48:34 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25601, instance 4, run: true
May 19 10:48:34 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:34 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:34 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:34 rivoplus volumio[3140]: 61456 bytes (61 kB, 60 KiB) copied, 0.000870291 s, 70.6 MB/s
May 19 10:48:34 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25606, instance 3, run: true
May 19 10:48:35 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:35 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:35 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:35 rivoplus volumio[3140]: 62640 bytes (63 kB, 61 KiB) copied, 0.000860792 s, 72.8 MB/s
May 19 10:48:35 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25611, instance 4, run: true
May 19 10:48:35 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:35 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:35 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:35 rivoplus volumio[3140]: 64576 bytes (65 kB, 63 KiB) copied, 0.000928917 s, 69.5 MB/s
May 19 10:48:35 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25654, instance 3, run: true
May 19 10:48:36 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:36 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:36 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:36 rivoplus volumio[3140]: 61472 bytes (61 kB, 60 KiB) copied, 0.000536458 s, 115 MB/s
May 19 10:48:36 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25659, instance 4, run: true
May 19 10:48:36 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:36 rivoplus volumio[3140]: 72+1 records in
May 19 10:48:36 rivoplus volumio[3140]: 72+1 records out
May 19 10:48:36 rivoplus volumio[3140]: 2391504 bytes (2.4 MB, 2.3 MiB) copied, 0.0263015 s, 90.9 MB/s
May 19 10:48:36 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25664, instance 3, run: true
May 19 10:48:37 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:37 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:37 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:37 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000529625 s, 117 MB/s
May 19 10:48:37 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25669, instance 4, run: true
May 19 10:48:37 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:37 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:37 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:37 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000868375 s, 75.5 MB/s
May 19 10:48:37 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25674, instance 3, run: true
May 19 10:48:38 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:38 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:38 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:38 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000942834 s, 69.5 MB/s
May 19 10:48:38 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25679, instance 4, run: true
May 19 10:48:38 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:38 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:38 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:38 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000527375 s, 117 MB/s
May 19 10:48:38 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25684, instance 3, run: true
May 19 10:48:39 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:39 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:39 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:39 rivoplus volumio[3140]: 62384 bytes (62 kB, 61 KiB) copied, 0.000864 s, 72.2 MB/s
May 19 10:48:39 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25689, instance 4, run: true
May 19 10:48:39 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:39 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:39 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:39 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000848083 s, 77.3 MB/s
May 19 10:48:39 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25694, instance 3, run: true
May 19 10:48:40 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:40 rivoplus volumio[3140]: 78+1 records in
May 19 10:48:40 rivoplus volumio[3140]: 78+1 records out
May 19 10:48:40 rivoplus volumio[3140]: 2587712 bytes (2.6 MB, 2.5 MiB) copied, 0.0277574 s, 93.2 MB/s
May 19 10:48:40 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25699, instance 4, run: true
May 19 10:48:40 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:40 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:40 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:40 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000774624 s, 84.6 MB/s
May 19 10:48:40 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25704, instance 3, run: true
May 19 10:48:41 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:41 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:41 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:41 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000896125 s, 68.9 MB/s
May 19 10:48:41 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25709, instance 4, run: true
May 19 10:48:41 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:41 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:41 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:41 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000917583 s, 71.4 MB/s
May 19 10:48:41 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25714, instance 3, run: true
May 19 10:48:42 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:42 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:42 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:42 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000549417 s, 112 MB/s
May 19 10:48:42 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25719, instance 4, run: true
May 19 10:48:42 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 19 10:48:42 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 19 10:48:42 rivoplus volumio[3140]: info: Discovery: Getting this device information
May 19 10:48:42 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:42 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:42 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 19 10:48:42 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:42 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:42 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:42 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000556 s, 118 MB/s
May 19 10:48:42 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25725, instance 3, run: true
May 19 10:48:43 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:43 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:43 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:43 rivoplus volumio[3140]: 65248 bytes (65 kB, 64 KiB) copied, 0.0010675 s, 61.1 MB/s
May 19 10:48:43 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25747, instance 4, run: true
May 19 10:48:44 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:44 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:44 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:44 rivoplus volumio[3140]: 62000 bytes (62 kB, 61 KiB) copied, 0.000982584 s, 63.1 MB/s
May 19 10:48:44 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25752, instance 3, run: true
May 19 10:48:44 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:44 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:44 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:44 rivoplus volumio[3140]: 62096 bytes (62 kB, 61 KiB) copied, 0.000555959 s, 112 MB/s
May 19 10:48:44 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25757, instance 4, run: true
May 19 10:48:45 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:45 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:45 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:45 rivoplus volumio[3140]: 64576 bytes (65 kB, 63 KiB) copied, 0.000552458 s, 117 MB/s
May 19 10:48:45 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25762, instance 3, run: true
May 19 10:48:45 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:45 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:45 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:45 rivoplus volumio[3140]: 62016 bytes (62 kB, 61 KiB) copied, 0.000529541 s, 117 MB/s
May 19 10:48:45 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25767, instance 4, run: true
May 19 10:48:46 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:46 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:46 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:46 rivoplus volumio[3140]: 62080 bytes (62 kB, 61 KiB) copied, 0.000967917 s, 64.1 MB/s
May 19 10:48:46 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25772, instance 3, run: true
May 19 10:48:46 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:46 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:46 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:46 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000902166 s, 72.6 MB/s
May 19 10:48:46 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25777, instance 4, run: true
May 19 10:48:47 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:47 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:47 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:47 rivoplus volumio[3140]: 62656 bytes (63 kB, 61 KiB) copied, 0.00133471 s, 46.9 MB/s
May 19 10:48:47 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25782, instance 3, run: true
May 19 10:48:47 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:48:47 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:48:47 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:47 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:47 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:47 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000822708 s, 79.7 MB/s
May 19 10:48:48 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25787, instance 4, run: true
May 19 10:48:48 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:48 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:48 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:48 rivoplus volumio[3140]: 64224 bytes (64 kB, 63 KiB) copied, 0.00097875 s, 65.6 MB/s
May 19 10:48:48 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25792, instance 3, run: true
May 19 10:48:48 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 19 10:48:48 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 19 10:48:49 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:49 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:49 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:49 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000544416 s, 120 MB/s
May 19 10:48:49 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25797, instance 4, run: true
May 19 10:48:49 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:49 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:49 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:49 rivoplus volumio[3140]: 65184 bytes (65 kB, 64 KiB) copied, 0.000958208 s, 68.0 MB/s
May 19 10:48:49 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25802, instance 3, run: true
May 19 10:48:49 rivoplus volumio[3140]: info: Executing endpoint metavolumio
May 19 10:48:49 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 10:48:49 rivoplus volumio[3140]: info: Executing endpoint metavolumio
May 19 10:48:49 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 10:48:49 rivoplus volumio[3140]: info: Executing endpoint metavolumio
May 19 10:48:49 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 10:48:50 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:50 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:50 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:50 rivoplus volumio[3140]: 62064 bytes (62 kB, 61 KiB) copied, 0.000876375 s, 70.8 MB/s
May 19 10:48:50 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25807, instance 4, run: true
May 19 10:48:50 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:50 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:50 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:50 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.00107129 s, 61.2 MB/s
May 19 10:48:50 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25812, instance 3, run: true
May 19 10:48:51 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:51 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:51 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:51 rivoplus volumio[3140]: 65168 bytes (65 kB, 64 KiB) copied, 0.00053175 s, 123 MB/s
May 19 10:48:51 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25817, instance 4, run: true
May 19 10:48:51 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:51 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:51 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:51 rivoplus volumio[3140]: 62080 bytes (62 kB, 61 KiB) copied, 0.000677458 s, 91.6 MB/s
May 19 10:48:51 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25822, instance 3, run: true
May 19 10:48:51 rivoplus volumio[3140]: info: CoreCommandRouter::getUIConfigOnPlugin
May 19 10:48:51 rivoplus volumio[3140]: info: FusionDsp - IP adress is ---------------------------192.168.0.40
May 19 10:48:52 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:52 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:52 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:52 rivoplus volumio[3140]: 62016 bytes (62 kB, 61 KiB) copied, 0.000548458 s, 113 MB/s
May 19 10:48:52 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25827, instance 4, run: true
May 19 10:48:52 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:52 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:52 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:52 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000937541 s, 69.9 MB/s
May 19 10:48:52 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25832, instance 3, run: true
May 19 10:48:53 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:53 rivoplus volumio[3140]: 2+8 records in
May 19 10:48:53 rivoplus volumio[3140]: 2+8 records out
May 19 10:48:53 rivoplus volumio[3140]: 142656 bytes (143 kB, 139 KiB) copied, 0.0008005 s, 178 MB/s
May 19 10:48:53 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25849, instance 4, run: true
May 19 10:48:53 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:53 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:53 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:53 rivoplus volumio[3140]: 62112 bytes (62 kB, 61 KiB) copied, 0.000543084 s, 114 MB/s
May 19 10:48:53 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25862, instance 3, run: true
May 19 10:48:54 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:54 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:54 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:54 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000911417 s, 71.9 MB/s
May 19 10:48:54 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25867, instance 4, run: true
May 19 10:48:54 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:54 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:54 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:54 rivoplus volumio[3140]: 65120 bytes (65 kB, 64 KiB) copied, 0.000592541 s, 110 MB/s
May 19 10:48:54 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25872, instance 3, run: true
May 19 10:48:55 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:55 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:55 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:55 rivoplus volumio[3140]: 62128 bytes (62 kB, 61 KiB) copied, 0.000586792 s, 106 MB/s
May 19 10:48:55 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25877, instance 4, run: true
May 19 10:48:55 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:55 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:55 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:55 rivoplus volumio[3140]: 61968 bytes (62 kB, 61 KiB) copied, 0.000834333 s, 74.3 MB/s
May 19 10:48:55 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25882, instance 3, run: true
May 19 10:48:56 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:56 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:56 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:56 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000954916 s, 68.6 MB/s
May 19 10:48:56 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25887, instance 4, run: true
May 19 10:48:56 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:56 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:56 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:56 rivoplus volumio[3140]: 62656 bytes (63 kB, 61 KiB) copied, 0.00054875 s, 114 MB/s
May 19 10:48:56 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25892, instance 3, run: true
May 19 10:48:57 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:57 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:57 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:57 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000607791 s, 108 MB/s
May 19 10:48:57 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25897, instance 4, run: true
May 19 10:48:57 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:57 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:57 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:57 rivoplus volumio[3140]: 64336 bytes (64 kB, 63 KiB) copied, 0.000873208 s, 73.7 MB/s
May 19 10:48:58 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25902, instance 3, run: true
May 19 10:48:58 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:58 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:58 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:58 rivoplus volumio[3140]: 62896 bytes (63 kB, 61 KiB) copied, 0.0008925 s, 70.5 MB/s
May 19 10:48:58 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25907, instance 4, run: true
May 19 10:48:59 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:59 rivoplus volumio[3140]: 2+0 records in
May 19 10:48:59 rivoplus volumio[3140]: 2+0 records out
May 19 10:48:59 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000560333 s, 117 MB/s
May 19 10:48:59 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25912, instance 3, run: true
May 19 10:48:59 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:48:59 rivoplus volumio[3140]: 1+1 records in
May 19 10:48:59 rivoplus volumio[3140]: 1+1 records out
May 19 10:48:59 rivoplus volumio[3140]: 64352 bytes (64 kB, 63 KiB) copied, 0.000508167 s, 127 MB/s
May 19 10:48:59 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25917, instance 4, run: true
May 19 10:49:00 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:00 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:00 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:00 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000888667 s, 73.7 MB/s
May 19 10:49:00 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25922, instance 3, run: true
May 19 10:49:00 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:00 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:00 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:00 rivoplus volumio[3140]: 65056 bytes (65 kB, 64 KiB) copied, 0.000903542 s, 72.0 MB/s
May 19 10:49:00 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25927, instance 4, run: true
May 19 10:49:01 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:01 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:01 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:01 rivoplus volumio[3140]: 62192 bytes (62 kB, 61 KiB) copied, 0.000771042 s, 80.7 MB/s
May 19 10:49:01 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25932, instance 3, run: true
May 19 10:49:01 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:01 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:01 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:01 rivoplus volumio[3140]: 61904 bytes (62 kB, 60 KiB) copied, 0.000548208 s, 113 MB/s
May 19 10:49:02 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25937, instance 4, run: true
May 19 10:49:02 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:02 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:02 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:02 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000941417 s, 69.6 MB/s
May 19 10:49:02 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25942, instance 3, run: true
May 19 10:49:03 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:03 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:03 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:03 rivoplus volumio[3140]: 62656 bytes (63 kB, 61 KiB) copied, 0.00102496 s, 61.1 MB/s
May 19 10:49:03 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25948, instance 4, run: true
May 19 10:49:03 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:03 rivoplus volumio[3140]: 14+1 records in
May 19 10:49:03 rivoplus volumio[3140]: 14+1 records out
May 19 10:49:03 rivoplus volumio[3140]: 486832 bytes (487 kB, 475 KiB) copied, 0.005644 s, 86.3 MB/s
May 19 10:49:03 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25953, instance 3, run: true
May 19 10:49:04 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:04 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:04 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:04 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000809459 s, 81.0 MB/s
May 19 10:49:04 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25975, instance 4, run: true
May 19 10:49:04 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:04 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:04 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:04 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000555792 s, 118 MB/s
May 19 10:49:04 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25980, instance 3, run: true
May 19 10:49:05 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:05 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:05 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:05 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.00108529 s, 56.9 MB/s
May 19 10:49:05 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25985, instance 4, run: true
May 19 10:49:05 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:05 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:05 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:05 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000861875 s, 76.0 MB/s
May 19 10:49:05 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25990, instance 3, run: true
May 19 10:49:06 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:06 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:06 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:06 rivoplus volumio[3140]: 64960 bytes (65 kB, 63 KiB) copied, 0.00114775 s, 56.6 MB/s
May 19 10:49:06 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 25995, instance 4, run: true
May 19 10:49:06 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:06 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:06 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:06 rivoplus volumio[3140]: 62288 bytes (62 kB, 61 KiB) copied, 0.00100387 s, 62.0 MB/s
May 19 10:49:06 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26000, instance 3, run: true
May 19 10:49:07 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:07 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:07 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:07 rivoplus volumio[3140]: 61808 bytes (62 kB, 60 KiB) copied, 0.00054975 s, 112 MB/s
May 19 10:49:07 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26005, instance 4, run: true
May 19 10:49:07 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:07 rivoplus volumio[3140]: 92+1 records in
May 19 10:49:07 rivoplus volumio[3140]: 92+1 records out
May 19 10:49:07 rivoplus volumio[3140]: 3043488 bytes (3.0 MB, 2.9 MiB) copied, 0.034807 s, 87.4 MB/s
May 19 10:49:07 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26010, instance 3, run: true
May 19 10:49:08 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:08 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:08 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:08 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000918791 s, 67.2 MB/s
May 19 10:49:08 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26015, instance 4, run: true
May 19 10:49:08 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:08 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:08 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:08 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.00089075 s, 73.6 MB/s
May 19 10:49:08 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26020, instance 3, run: true
May 19 10:49:09 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:09 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:09 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:09 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000778125 s, 84.2 MB/s
May 19 10:49:09 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26025, instance 4, run: true
May 19 10:49:09 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:09 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:09 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:09 rivoplus volumio[3140]: 58640 bytes (59 kB, 57 KiB) copied, 0.000526958 s, 111 MB/s
May 19 10:49:09 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26030, instance 3, run: true
May 19 10:49:10 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:10 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:10 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:10 rivoplus volumio[3140]: 64576 bytes (65 kB, 63 KiB) copied, 0.000838833 s, 77.0 MB/s
May 19 10:49:10 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26035, instance 4, run: true
May 19 10:49:10 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:10 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:10 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:10 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000850917 s, 77.0 MB/s
May 19 10:49:10 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26040, instance 3, run: true
May 19 10:49:11 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:11 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:11 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:11 rivoplus volumio[3140]: 58560 bytes (59 kB, 57 KiB) copied, 0.000910375 s, 64.3 MB/s
May 19 10:49:11 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26045, instance 4, run: true
May 19 10:49:12 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:12 rivoplus volumio[3140]: 92+1 records in
May 19 10:49:12 rivoplus volumio[3140]: 92+1 records out
May 19 10:49:12 rivoplus volumio[3140]: 3046944 bytes (3.0 MB, 2.9 MiB) copied, 0.0380104 s, 80.2 MB/s
May 19 10:49:12 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26050, instance 3, run: true
May 19 10:49:12 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 19 10:49:12 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 19 10:49:12 rivoplus volumio[3140]: info: Discovery: Getting this device information
May 19 10:49:12 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:49:12 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:49:12 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 19 10:49:12 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:12 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:12 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:12 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000613167 s, 107 MB/s
May 19 10:49:12 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26055, instance 4, run: true
May 19 10:49:13 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:13 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:13 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:13 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000871709 s, 70.8 MB/s
May 19 10:49:13 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26060, instance 3, run: true
May 19 10:49:13 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:13 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:13 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:13 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.00100312 s, 65.3 MB/s
May 19 10:49:13 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26085, instance 4, run: true
May 19 10:49:14 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:14 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:14 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:14 rivoplus volumio[3140]: 61712 bytes (62 kB, 60 KiB) copied, 0.000565666 s, 109 MB/s
May 19 10:49:14 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26090, instance 3, run: true
May 19 10:49:14 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:14 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:14 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:14 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000874458 s, 74.9 MB/s
May 19 10:49:14 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26095, instance 4, run: true
May 19 10:49:15 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:15 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:15 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:15 rivoplus volumio[3140]: 64320 bytes (64 kB, 63 KiB) copied, 0.000932125 s, 69.0 MB/s
May 19 10:49:15 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26100, instance 3, run: true
May 19 10:49:15 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 19 10:49:15 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 19 10:49:15 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:15 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:15 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:15 rivoplus volumio[3140]: 62928 bytes (63 kB, 61 KiB) copied, 0.000895708 s, 70.3 MB/s
May 19 10:49:15 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26105, instance 4, run: true
May 19 10:49:16 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:16 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:16 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:16 rivoplus volumio[3140]: 65264 bytes (65 kB, 64 KiB) copied, 0.000847208 s, 77.0 MB/s
May 19 10:49:16 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26110, instance 3, run: true
May 19 10:49:16 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:16 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:16 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:16 rivoplus volumio[3140]: 64576 bytes (65 kB, 63 KiB) copied, 0.000528916 s, 122 MB/s
May 19 10:49:17 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26115, instance 4, run: true
May 19 10:49:17 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:17 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:17 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:17 rivoplus volumio[3140]: 62944 bytes (63 kB, 61 KiB) copied, 0.000895083 s, 70.3 MB/s
May 19 10:49:17 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26120, instance 3, run: true
May 19 10:49:18 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:18 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:18 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:18 rivoplus volumio[3140]: 65248 bytes (65 kB, 64 KiB) copied, 0.00106 s, 61.6 MB/s
May 19 10:49:18 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26125, instance 4, run: true
May 19 10:49:18 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:18 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:18 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:18 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.000535958 s, 122 MB/s
May 19 10:49:18 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26130, instance 3, run: true
May 19 10:49:19 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:19 rivoplus volumio[3140]: 1+1 records in
May 19 10:49:19 rivoplus volumio[3140]: 1+1 records out
May 19 10:49:19 rivoplus volumio[3140]: 58560 bytes (59 kB, 57 KiB) copied, 0.000594083 s, 98.6 MB/s
May 19 10:49:19 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26135, instance 4, run: true
May 19 10:49:19 rivoplus volumio[3140]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable
May 19 10:49:19 rivoplus volumio[3140]: 2+0 records in
May 19 10:49:19 rivoplus volumio[3140]: 2+0 records out
May 19 10:49:19 rivoplus volumio[3140]: 65536 bytes (66 kB, 64 KiB) copied, 0.0005185 s, 126 MB/s
May 19 10:49:19 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26140, instance 3, run: true
May 19 10:49:19 rivoplus volumio[3140]: info: Starting Uninstall of plugin audio_interface - fusiondsp
May 19 10:49:19 rivoplus volumio[3140]: info: Uninstalling plugin fusiondsp
May 19 10:49:19 rivoplus volumio[3140]: info: FusionDsp - Stopping FusionDsp service
May 19 10:49:19 rivoplus volumio[3140]: info: camilladsp service terminated, instance 4
May 19 10:49:19 rivoplus volumio[3140]: info: Disabling plugin fusiondsp
May 19 10:49:19 rivoplus volumio[3140]: info: Preparing to generate the ALSA configuration file
May 19 10:49:19 rivoplus sudo[26144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service
May 19 10:49:19 rivoplus sudo[26144]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:19 rivoplus systemd[1]: Stopping FusionDsp Daemon...
May 19 10:49:19 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 19 10:49:19 rivoplus volumio[23242]: Backend configuration:
May 19 10:49:19 rivoplus volumio[23242]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
May 19 10:49:19 rivoplus volumio[23242]: active_config_txt: null
May 19 10:49:19 rivoplus volumio[23242]: camilla_host: 127.0.0.1
May 19 10:49:19 rivoplus volumio[23242]: camilla_port: 9876
May 19 10:49:19 rivoplus volumio[23242]: coeff_dir: /data/INTERNAL/FusionDsp/filters
May 19 10:49:19 rivoplus volumio[23242]: config_dir: /data/configuration/audio_interface/fusiondsp
May 19 10:49:19 rivoplus volumio[23242]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
May 19 10:49:19 rivoplus volumio[23242]: log_file: /tmp/camilladsp.log
May 19 10:49:19 rivoplus volumio[23242]: on_get_active_config: null
May 19 10:49:19 rivoplus volumio[23242]: on_set_active_config: null
May 19 10:49:19 rivoplus volumio[23242]: port: 5011
May 19 10:49:19 rivoplus volumio[23242]: supported_capture_types: null
May 19 10:49:19 rivoplus volumio[23242]: supported_playback_types: null
May 19 10:49:19 rivoplus volumio[23242]: update_config_symlink: false
May 19 10:49:19 rivoplus volumio[23242]: update_config_txt: false
May 19 10:49:19 rivoplus volumio[23242]: ======== Running on http://0.0.0.0:5011 ========
May 19 10:49:19 rivoplus volumio[23242]: (Press CTRL+C to quit)
May 19 10:49:19 rivoplus volumio[3140]: info: Asound.conf file written
May 19 10:49:19 rivoplus sudo[26148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
May 19 10:49:19 rivoplus sudo[26148]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:19 rivoplus sudo[26148]: pam_unix(sudo:session): session closed for user root
May 19 10:49:19 rivoplus kernel: Fine tdm clk setting range (0~2000000), 12287994
May 19 10:49:19 rivoplus kernel: Fine spdif sysclk setting range(0~2000000), 6143997
May 19 10:49:19 rivoplus kernel: out of value, fixed it
May 19 10:49:19 rivoplus kernel: id=0 set inskew=0
May 19 10:49:19 rivoplus volumio[3140]: xcb_connection_has_error() returned true
May 19 10:49:19 rivoplus volumio[3140]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted
May 19 10:49:19 rivoplus volumio[3140]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted
May 19 10:49:19 rivoplus volumio[3140]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted
May 19 10:49:19 rivoplus volumio[3140]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted
May 19 10:49:19 rivoplus volumio[3140]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted
May 19 10:49:19 rivoplus volumio[3140]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Qutest Validity:0' : Operation not permitted
May 19 10:49:19 rivoplus volumio[3140]: info: Output device has changed, restarting MPD
May 19 10:49:20 rivoplus sudo[26153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 19 10:49:20 rivoplus sudo[26153]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus volumio[3140]: info: Output device has changed, restarting Shairport Sync
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 19 10:49:20 rivoplus sudo[26153]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus systemd[1]: fusiondsp.service: Succeeded.
May 19 10:49:20 rivoplus systemd[1]: Stopped FusionDsp Daemon.
May 19 10:49:20 rivoplus sudo[26144]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus sudo[26156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 19 10:49:20 rivoplus sudo[26156]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus systemd[1]: Stopping Music Player Daemon...
May 19 10:49:20 rivoplus volumio[3140]: xcb_connection_has_error() returned true
May 19 10:49:20 rivoplus volumio[3140]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 19 10:49:20 rivoplus volumio[3140]: xcb_connection_has_error() returned true
May 19 10:49:20 rivoplus volumio[3140]: info: QobuzConnect: setDeactiveState invoked
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:49:20 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:49:20 rivoplus volumio[3140]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus vtcs[24054]: [2025-05-19 10:49:20.161] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
May 19 10:49:20 rivoplus vtcs[24054]: [2025-05-19 10:49:20.162] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected
May 19 10:49:20 rivoplus systemd[1]: mpd.service: Succeeded.
May 19 10:49:20 rivoplus systemd[1]: Stopped Music Player Daemon.
May 19 10:49:20 rivoplus volumio[3140]: info: Checking if uninstall.sh is present
May 19 10:49:20 rivoplus systemd[1]: Starting Music Player Daemon...
May 19 10:49:20 rivoplus sudo[26164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
May 19 10:49:20 rivoplus sudo[26164]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus sudo[26171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
May 19 10:49:20 rivoplus sudo[26171]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service...
May 19 10:49:20 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
May 19 10:49:20 rivoplus systemd[1]: vtcs.service: Succeeded.
May 19 10:49:20 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service.
May 19 10:49:20 rivoplus sudo[26164]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus volumio[3140]: info: Executing uninstall.sh
May 19 10:49:20 rivoplus sudo[26171]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus sudo[26179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
May 19 10:49:20 rivoplus sudo[26179]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 19 10:49:20 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 19 10:49:20 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 19 10:49:20 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 19 10:49:20 rivoplus sudo[26179]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus sudo[26165]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 19 10:49:20 rivoplus sudo[26165]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus sudo[26165]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus volumio[3140]: info: MPD Permissions set
May 19 10:49:20 rivoplus volumio[3140]: info: FusionDsp - Reporting Fusion DSP Disabled
May 19 10:49:20 rivoplus volumio[3140]: info: Removing fusiondspeq DSP Signal Path Element
May 19 10:49:20 rivoplus volumio[3140]: info: Additional DSP elements updated
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: Updating RAAT Signal Path
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus sudo[26186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
May 19 10:49:20 rivoplus sudo[26186]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service...
May 19 10:49:20 rivoplus qobuz-connect[23865]: 20250519 10:49:20.435 [23865.23865] INFO SampleApp: Stopping Local configuration server
May 19 10:49:20 rivoplus qobuz-connect[23865]: 20250519 10:49:20.446 [23865.23865] INFO SampleApp: shat down connection on UNIX socket
May 19 10:49:20 rivoplus sudo[26185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 19 10:49:20 rivoplus sudo[26185]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus systemd[1]: qobuz-connect.service: Succeeded.
May 19 10:49:20 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service.
May 19 10:49:20 rivoplus systemd[1]: Started Volumio Qobuz Connect Service.
May 19 10:49:20 rivoplus sudo[26186]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:20 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 19 10:49:20 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 19 10:49:20 rivoplus volumio[3140]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
May 19 10:49:20 rivoplus volumio[3140]: info: QobuzConnect: setDeactiveState invoked
May 19 10:49:20 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:49:20 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:49:20 rivoplus volumio[3140]: info: Starting Shairport Sync
May 19 10:49:20 rivoplus sudo[26205]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /etc/systemd/system/multi-user.target.wants/fusiondsp.service
May 19 10:49:20 rivoplus sudo[26206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 19 10:49:20 rivoplus sudo[26205]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus sudo[26206]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:20 rivoplus sudo[26205]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus sudo[26185]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus volumio[3140]: 0+0 records in
May 19 10:49:20 rivoplus volumio[3140]: 0+0 records out
May 19 10:49:20 rivoplus volumio[3140]: 0 bytes copied, 0.000203709 s, 0.0 kB/s
May 19 10:49:20 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 19 10:49:20 rivoplus systemd[1]: shairport-sync.service: Succeeded.
May 19 10:49:20 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 19 10:49:20 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 19 10:49:20 rivoplus volumio[3140]: info: camilladsp spawned new process with pid 26211, instance 3, run: true
May 19 10:49:20 rivoplus sudo[26206]: pam_unix(sudo:session): session closed for user root
May 19 10:49:20 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 19 10:49:20 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 19 10:49:20 rivoplus volumio[3140]: info: Uninstall script completed
May 19 10:49:20 rivoplus volumio[3140]: info: Removing plugin fusiondsp from configuration
May 19 10:49:20 rivoplus volumio[3140]: info: Successfully removed fusiondsp configuration files
May 19 10:49:20 rivoplus volumio[3140]: info: Plugin folders cleanup
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning into folder /volumio/app/plugins/
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning category audio_interface
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning category miscellanea
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning category music_service
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning category plugins.json
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning category system_controller
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning category user_interface
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning into folder /data/plugins/
May 19 10:49:20 rivoplus volumio[3140]: info: Scanning category audio_interface
May 19 10:49:20 rivoplus volumio[3140]: info: Cleaning folder for fusiondsp
May 19 10:49:21 rivoplus volumio[3140]: info: Scanning category music_service
May 19 10:49:21 rivoplus volumio[3140]: info: Plugin folders cleanup completed
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 19 10:49:21 rivoplus volumio[3140]: info: [{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.12","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true}]
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 19 10:49:21 rivoplus volumio[3140]: info: Not Reporting Auto name since its the default one
May 19 10:49:21 rivoplus volumio[3140]: info: Executing endpoint qc_getconfig
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.333 [26198.26198] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
May 19 10:49:21 rivoplus volumio[3140]: info: Shairport-Sync Started
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.339 [26198.26198] INFO VolumeManager: [0xac8357b0]: Setting new playback volume: 75
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.339 [26198.26198] INFO VolumeManager: [0xac8357b0]: Setting new mute state: 0
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.339 [26198.26198] INFO QobuzConnect: [0xac836180]: Client initialized!
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.339 [26198.26198] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp
May 19 10:49:21 rivoplus volumio[3140]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
May 19 10:49:21 rivoplus volumio[3140]: info: QobuzConnect: QOBUZ Connect daemon connected
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.354 [26198.26198] INFO LocalConfigManager: [0xac835090]: Starting Local Configuration server
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.354 [26198.26198] INFO SampleApp: Starting Local configuration server
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.355 [26198.26198] INFO SampleApp: Connected to UNIX socket client 0xac82aed8
May 19 10:49:21 rivoplus volumio[3140]: xcb_connection_has_error() returned true
May 19 10:49:21 rivoplus sudo[26231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
May 19 10:49:21 rivoplus sudo[26231]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:21 rivoplus qobuz-connect[26198]: 20250519 10:49:21.482 [26198.26198] INFO SampleApp: Playback volume changed: 75
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::volumioGetState
May 19 10:49:21 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:49:21 rivoplus sudo[26231]: pam_unix(sudo:session): session closed for user root
May 19 10:49:21 rivoplus sudo[26233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
May 19 10:49:21 rivoplus sudo[26233]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 19 10:49:21 rivoplus systemd[1]: Stopping RAAT DAEMON...
May 19 10:49:21 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
May 19 10:49:21 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 19 10:49:21 rivoplus systemd[1]: raat-daemon.service: Succeeded.
May 19 10:49:21 rivoplus systemd[1]: Stopped RAAT DAEMON.
May 19 10:49:21 rivoplus volumio[3140]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 19 10:49:21 rivoplus systemd[1]: Started RAAT DAEMON.
May 19 10:49:21 rivoplus sudo[26233]: pam_unix(sudo:session): session closed for user root
May 19 10:49:21 rivoplus volumio[3140]: info: Raat Daemon started successfully
May 19 10:49:21 rivoplus volumio[3140]: info: Executing endpoint restartRAATSocket
May 19 10:49:21 rivoplus volumio[3140]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
May 19 10:49:21 rivoplus volumio[3140]: info: CorePlayQueue::getTrack 4
May 19 10:49:21 rivoplus volumio[3140]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13
May 19 10:49:22 rivoplus volumio[3140]: 0+0 records in
May 19 10:49:22 rivoplus volumio[3140]: 0+0 records out
May 19 10:49:22 rivoplus volumio[3140]: 0 bytes copied, 0.000208708 s, 0.0 kB/s
May 19 10:49:22 rivoplus mpd[26190]: May 19 10:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 19 10:49:22 rivoplus volumio[3140]: info: camilladsp spawned new process with pid undefined, instance 3, run: true
May 19 10:49:22 rivoplus volumio[3140]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 19 10:49:22 rivoplus volumio[3140]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
May 19 10:49:22 rivoplus volumio[3140]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19)
May 19 10:49:22 rivoplus volumio[3140]: at onErrorNT (internal/child_process.js:472:16)
May 19 10:49:22 rivoplus volumio[3140]: at processTicksAndRejections (internal/process/task_queues.js:82:21) {
May 19 10:49:22 rivoplus volumio[3140]: errno: -2,
May 19 10:49:22 rivoplus volumio[3140]: code: 'ENOENT',
May 19 10:49:22 rivoplus volumio[3140]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
May 19 10:49:22 rivoplus volumio[3140]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
May 19 10:49:22 rivoplus volumio[3140]: spawnargs: [
May 19 10:49:22 rivoplus volumio[3140]: '-p',
May 19 10:49:22 rivoplus volumio[3140]: 9876,
May 19 10:49:22 rivoplus volumio[3140]: '-o',
May 19 10:49:22 rivoplus volumio[3140]: '/tmp/camilladsp.log',
May 19 10:49:22 rivoplus volumio[3140]: '-l',
May 19 10:49:22 rivoplus volumio[3140]: 'warn',
May 19 10:49:22 rivoplus volumio[3140]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
May 19 10:49:22 rivoplus volumio[3140]: ]
May 19 10:49:22 rivoplus volumio[3140]: }
May 19 10:49:22 rivoplus volumio[3140]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 19 10:49:22 rivoplus systemd[1]: Started Music Player Daemon.
May 19 10:49:22 rivoplus sudo[26156]: pam_unix(sudo:session): session closed for user root
May 19 10:49:23 rivoplus sudo[26263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-19 10:48
May 19 10:49:23 rivoplus sudo[26263]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivoplus"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 06:04:38 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="0064c1a7ac4363e567dacab062cb5da8"