-- Logs begin at Fri 2024-11-01 10:41:42 UTC, end at Fri 2024-11-01 10:57:30 UTC. -- Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetQueue Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::getQueue Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CorePlayQueue::getQueue Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Listing playlists Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 01 10:56:03 musical-fidelity volumio[1053]: error: Could not retrieve plugin audio_interface outputs Nov 01 10:56:03 musical-fidelity volumio[1053]: error: WARNING: No Audio Output plugin found Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetQueue Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::getQueue Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CorePlayQueue::getQueue Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Listing playlists Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPlay Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: UNSET VOLATILE Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Bluetooth Detach Command Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::play index undefined Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::startPlaybackTimer Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:03 musical-fidelity volumio[1053]: info: ControllerMpd::resume Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: ControllerMpd::sendMpdCommand play Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Nov 01 10:56:03 musical-fidelity volumio[1053]: ---------------------------- MPD announces state update: player Nov 01 10:56:03 musical-fidelity volumio[1053]: info: sendMpdCommand play took 24 milliseconds Nov 01 10:56:03 musical-fidelity volumio[1053]: info: ControllerMpd::getState Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: ControllerMpd::sendMpdCommand clearerror Nov 01 10:56:03 musical-fidelity volumio[1053]: info: sendMpdCommand status took 15 milliseconds Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: ControllerMpd::parseState Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 10:56:03 musical-fidelity volumio[1053]: info: sendMpdCommand clearerror took 8 milliseconds Nov 01 10:56:03 musical-fidelity volumio[1053]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: ControllerMpd::parseTrackInfo Nov 01 10:56:03 musical-fidelity volumio[1053]: info: ControllerMpd::pushState Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::servicePushState Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":142,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daniel Barenboim,Frédéric François Chopin - 12 Études, Op. 10：No. 4 in C Sharp Minor ＂Torrent＂","artist":null,"album":null,"uri":"USB/DC5C533E5C53129E/古典/a01/Encores/Daniel Barenboim,Frédéric François Chopin - 12 Études, Op. 10：No. 4 in C Sharp Minor ＂Torrent＂.flac","trackType":"flac"} Nov 01 10:56:03 musical-fidelity volumio[1053]: verbose: CURRENT POSITION 55 Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::syncState stateService pause Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::syncState currentStatus pause Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreStateMachine::stPlaybackTimer Nov 01 10:56:03 musical-fidelity volumio[1053]: info: ------------------------------ 59ms Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Updating push state because input changed Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumiosetSourceActivempd Nov 01 10:56:03 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 10:56:03 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:56:03 musical-fidelity volumio[1053]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E6%B4%81%E4%BB%AA/%E6%8F%AD%E6%99%93/efd2b03b-1b3c-48c7-972f-b21a2f2335b2.jpg' Nov 01 10:56:04 musical-fidelity volumio[1053]: info: Bluetooth Audio successfully Disabled Nov 01 10:56:04 musical-fidelity volumio[1053]: info: Bluetooth Successfully Detached Nov 01 10:56:04 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 01 10:56:04 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 01 10:56:04 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 01 10:56:04 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:56:12 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:12 musical-fidelity volumio[1053]: info: Received Push USB{"activeRoute":"1","powerShutdown":"0"} Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , enablePCInput Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioStop Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::stop Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:56:12 musical-fidelity volumio[1053]: verbose: UNSET VOLATILE Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::updateTrackBlock Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrackBlock Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::stPlaybackTimer Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::serviceStop Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::serviceStop Nov 01 10:56:12 musical-fidelity volumio[1053]: info: ControllerMpd::stop Nov 01 10:56:12 musical-fidelity volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 10:56:12 musical-fidelity ntfs-3g[967]: Unmounting /dev/sda1 () Nov 01 10:56:12 musical-fidelity ntfs-3g[967]: Failed to sync device /dev/sda1: Input/output error Nov 01 10:56:12 musical-fidelity ntfs-3g[967]: Failed to close volume /dev/sda1: Input/output error Nov 01 10:56:12 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:56:12 musical-fidelity volumio[1053]: info: sendMpdCommand stop took 63 milliseconds Nov 01 10:56:12 musical-fidelity volumio[1053]: info: Nov 01 10:56:12 musical-fidelity volumio[1053]: ---------------------------- MPD announces state update: player Nov 01 10:56:12 musical-fidelity volumio[1053]: info: ControllerMpd::getState Nov 01 10:56:12 musical-fidelity volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Nov 01 10:56:12 musical-fidelity volumio[1053]: info: sendMpdCommand status took 2 milliseconds Nov 01 10:56:12 musical-fidelity volumio[1053]: verbose: ControllerMpd::parseState Nov 01 10:56:12 musical-fidelity volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 10:56:12 musical-fidelity volumio[1053]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 10:56:12 musical-fidelity volumio[1053]: verbose: ControllerMpd::parseTrackInfo Nov 01 10:56:12 musical-fidelity volumio[1053]: info: ControllerMpd::pushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::servicePushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:56:12 musical-fidelity kernel: usb 1-1.4: USB disconnect, device number 4 Nov 01 10:56:12 musical-fidelity kernel: usb 1-1.4.2: USB disconnect, device number 7 Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:12 musical-fidelity volumio[1053]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daniel Barenboim,Frédéric François Chopin - 12 Études, Op. 10：No. 4 in C Sharp Minor ＂Torrent＂","artist":null,"album":null,"uri":"USB/DC5C533E5C53129E/古典/a01/Encores/Daniel Barenboim,Frédéric François Chopin - 12 Études, Op. 10：No. 4 in C Sharp Minor ＂Torrent＂.flac","trackType":"flac"} Nov 01 10:56:12 musical-fidelity volumio[1053]: verbose: CURRENT POSITION 55 Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::syncState stateService stop Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:56:12 musical-fidelity volumio[1053]: info: No code Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:56:12 musical-fidelity volumio[1053]: info: ------------------------------ 79ms Nov 01 10:56:12 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:56:12 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:56:12 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:56:12 musical-fidelity volumio[1053]: info: Nov 01 10:56:12 musical-fidelity volumio[1053]: ---------------------------- USB Audio Device Detached Nov 01 10:56:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , usbAudioDetach Nov 01 10:56:12 musical-fidelity systemd[1]: Service sound.target is not needed anymore. Stopping. Nov 01 10:56:12 musical-fidelity systemd[1]: Stopping Sound Card. Nov 01 10:56:12 musical-fidelity systemd[1]: Stopped target Sound Card. Nov 01 10:56:12 musical-fidelity volumio[1053]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Nov 01 10:56:12 musical-fidelity volumio[1053]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Nov 01 10:56:13 musical-fidelity volumio[1053]: info: Notifying PC INPUT Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreCommandRouter::servicePushState Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumiosetSourceActivepc_input Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 10:56:13 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreCommandRouter::servicePushState Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:56:13 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:56:13 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:56:16 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:56:16 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:56:16 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:56:16 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:17 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:56:17 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:17 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:26 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:56:26 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:56:26 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:56:26 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:26 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:56:26 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:26 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:28 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:56:28 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:56:28 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:56:28 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:28 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:56:28 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:28 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:41 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:56:41 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:56:41 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:56:41 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:41 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:56:41 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:41 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:55 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:56:55 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:56:55 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:56:55 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:56:55 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:56:55 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:56:55 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:57:09 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:57:09 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:57:09 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:57:09 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:57:09 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:57:09 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:57:09 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:57:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:57:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:57:12 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:57:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:57:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:57:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:57:12 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: bluetooth , getBTStatus Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: bluetooth , startBluetoothOnDemand Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:57:22 musical-fidelity volumio[1053]: verbose: UNSET VOLATILE Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioStop Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::stop Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:57:22 musical-fidelity volumio[1053]: verbose: UNSET VOLATILE Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::stPlaybackTimer Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::updateTrackBlock Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrackBlock Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::serviceStop Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CorePlayQueue::getTrack 55 Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::serviceStop Nov 01 10:57:22 musical-fidelity volumio[1053]: info: ControllerMpd::stop Nov 01 10:57:22 musical-fidelity volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 10:57:22 musical-fidelity volumio[1053]: info: Enabling Bluetooth Audio Output Nov 01 10:57:22 musical-fidelity volumio[1053]: info: Updating push state because input changed Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumiosetSourceActivempd Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 10:57:22 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:57:22 musical-fidelity volumio[1053]: info: sendMpdCommand stop took 56 milliseconds Nov 01 10:57:22 musical-fidelity pulseaudio[1454]: Failed to load module "module-alsa-sink" (argument: "device=plughw:5,0"): initialization failed. Nov 01 10:57:22 musical-fidelity volumio[1053]: info: Received Push USB{"activeRoute":"0","powerShutdown":"0"} Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , setPCInputReturn Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , disablePCInput Nov 01 10:57:22 musical-fidelity volumio[1053]: error: Cannot load module of audio hardware: Error: Command failed: /usr/bin/pactl load-module module-alsa-sink device=plughw:5,0 Nov 01 10:57:22 musical-fidelity volumio[1053]: No protocol specified Nov 01 10:57:22 musical-fidelity volumio[1053]: xcb_connection_has_error() returned true Nov 01 10:57:22 musical-fidelity volumio[1053]: Failure: Module initialization failed Nov 01 10:57:22 musical-fidelity volumio[1053]: No protocol specified Nov 01 10:57:22 musical-fidelity volumio[1053]: xcb_connection_has_error() returned true Nov 01 10:57:22 musical-fidelity kernel: usb 1-1.4: new high-speed USB device number 9 using dwc_otg Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::servicePushState Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:57:22 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:57:22 musical-fidelity kernel: usb 1-1.4: New USB device found, idVendor=0424, idProduct=2412 Nov 01 10:57:22 musical-fidelity kernel: usb 1-1.4: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Nov 01 10:57:22 musical-fidelity kernel: hub 1-1.4:1.0: USB hub found Nov 01 10:57:22 musical-fidelity kernel: hub 1-1.4:1.0: 2 ports detected Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::servicePushState Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumiosetSourceActivebluetooth Nov 01 10:57:22 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 10:57:22 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:57:22 musical-fidelity kernel: usb 1-1.4.2: new full-speed USB device number 10 using dwc_otg Nov 01 10:57:23 musical-fidelity kernel: usb 1-1.4.2: New USB device found, idVendor=25b0, idProduct=0015 Nov 01 10:57:23 musical-fidelity kernel: usb 1-1.4.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Nov 01 10:57:23 musical-fidelity kernel: usb 1-1.4.2: Product: M3i Integrated 24/96 Nov 01 10:57:23 musical-fidelity kernel: usb 1-1.4.2: Manufacturer: Musical Fidelity Nov 01 10:57:23 musical-fidelity systemd[1]: Starting Sound Card. Nov 01 10:57:23 musical-fidelity systemd[1]: Reached target Sound Card. Nov 01 10:57:23 musical-fidelity volumio[1053]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Nov 01 10:57:23 musical-fidelity volumio[1053]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Nov 01 10:57:23 musical-fidelity volumio[1053]: info: Nov 01 10:57:23 musical-fidelity volumio[1053]: ---------------------------- USB Audio Device Attached Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , usbAudioAttach Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: raat , returnFromUSB Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Nov 01 10:57:23 musical-fidelity volumio[1053]: No protocol specified Nov 01 10:57:23 musical-fidelity volumio[1053]: xcb_connection_has_error() returned true Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDefaultMixer Nov 01 10:57:23 musical-fidelity volumio[1053]: No protocol specified Nov 01 10:57:23 musical-fidelity volumio[1053]: xcb_connection_has_error() returned true Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 01 10:57:23 musical-fidelity volumio[1053]: No protocol specified Nov 01 10:57:23 musical-fidelity volumio[1053]: xcb_connection_has_error() returned true Nov 01 10:57:23 musical-fidelity volumio[1053]: info: Device 5 does not have any Mixer Control Available, setting a softvol device Nov 01 10:57:23 musical-fidelity volumio[1053]: [SpotifyConnect] Creating VLS config file Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 10:57:23 musical-fidelity volumio[1053]: No protocol specified Nov 01 10:57:23 musical-fidelity volumio[1053]: xcb_connection_has_error() returned true Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 01 10:57:23 musical-fidelity volumio[1053]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::Close All Modals sent Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:57:23 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:57:23 musical-fidelity volumio[1053]: info: Enabling Bluetooth Audio Output Nov 01 10:57:23 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:57:23 musical-fidelity volumio[1053]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 01 10:57:23 musical-fidelity sudo[8310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 01 10:57:23 musical-fidelity sudo[8310]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 10:57:23 musical-fidelity systemd[1]: Stopping Volspotconnect2 Daemon... Nov 01 10:57:23 musical-fidelity volumio[1053]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Nov 01 10:57:23 musical-fidelity systemd[1]: Starting Volspotconnect2 Daemon... Nov 01 10:57:23 musical-fidelity systemd[1]: Started Volspotconnect2 Daemon. Nov 01 10:57:23 musical-fidelity volumio[1053]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Nov 01 10:57:23 musical-fidelity volumio[1053]: info: Bluetooth Audio successfully Enabled Nov 01 10:57:23 musical-fidelity sudo[8310]: pam_unix(sudo:session): session closed for user root Nov 01 10:57:23 musical-fidelity volumio[1053]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 01 10:57:23 musical-fidelity volumio[8319]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Nov 01 10:57:23 musical-fidelity volumio[8319]: Reading Config from "/tmp/volspotify.toml" Nov 01 10:57:23 musical-fidelity volumio[8319]: [Vollibrespot] : Using Alsa backend with device: plughw:5 Nov 01 10:57:23 musical-fidelity volumio[8319]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Nov 01 10:57:24 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:57:24 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:57:24 musical-fidelity volumio[1053]: info: Discovery: Getting this device information Nov 01 10:57:24 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioGetState Nov 01 10:57:24 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Nov 01 10:57:24 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:57:24 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConf Nov 01 10:57:25 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 01 10:57:25 musical-fidelity volumio[1053]: info: CoreStateMachine::getcurrentVolume Nov 01 10:57:25 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioRetrievevolume Nov 01 10:57:25 musical-fidelity volumio[1053]: info: CoreStateMachine::pushState Nov 01 10:57:25 musical-fidelity volumio[1053]: info: CoreCommandRouter::volumioPushState Nov 01 10:57:25 musical-fidelity volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:57:25 musical-fidelity volumio[1053]: info: Updating RAAT Signal Path Nov 01 10:57:29 musical-fidelity volumio[1053]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 10:57:29 musical-fidelity volumio[1053]: { Error: connect ETIMEDOUT 74.86.12.173:443 Nov 01 10:57:29 musical-fidelity volumio[1053]: at Object._errnoException (util.js:1022:11) Nov 01 10:57:29 musical-fidelity volumio[1053]: at _exceptionWithHostPort (util.js:1044:20) Nov 01 10:57:29 musical-fidelity volumio[1053]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Nov 01 10:57:29 musical-fidelity volumio[1053]: code: 'ETIMEDOUT', Nov 01 10:57:29 musical-fidelity volumio[1053]: errno: 'ETIMEDOUT', Nov 01 10:57:29 musical-fidelity volumio[1053]: syscall: 'connect', Nov 01 10:57:29 musical-fidelity volumio[1053]: address: '74.86.12.173', Nov 01 10:57:29 musical-fidelity volumio[1053]: port: 443 } Nov 01 10:57:29 musical-fidelity volumio[1053]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 10:57:30 musical-fidelity sudo[8380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-01 10:56 Nov 01 10:57:30 musical-fidelity sudo[8380]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"