-- Logs begin at Mon 2025-03-03 19:46:57 CET, end at Mon 2025-03-03 19:55:29 CET. -- Mar 03 19:54:01 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:01 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:01 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:01 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:02 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:54:02 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:54:02 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:54:02 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:54:02 volumiomain volumio[1362]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:54:02 volumiomain volumio[1362]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:54:02 volumiomain sudo[25269]: volumio : unable to resolve host volumiomain Mar 03 19:54:02 volumiomain sudo[25269]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:02 volumiomain sudo[25269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 03 19:54:02 volumiomain sudo[25269]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:02 volumiomain systemd[1]: Started Volumio Tidal Connect Service. Mar 03 19:54:02 volumiomain sudo[25269]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:02 volumiomain volumio[1362]: info: Executing endpoint tc_getconfig Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 03 19:54:02 volumiomain vtcs[25271]: STARTING TidalConnect services, version: 1.4.0.34 Mar 03 19:54:02 volumiomain vtcs[25271]: STARTED TidalConnect services. Mar 03 19:54:02 volumiomain volumio[1362]: info: Executing endpoint tc_connect Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 03 19:54:02 volumiomain volumio[1362]: info: Connecting to TidalConnect Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreCommandRouter::servicePushState Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:02 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:02 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:02 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:02 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:02 volumiomain volumio[1362]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreCommandRouter::servicePushState Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:02 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:02 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:02 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:02 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:02 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:02 volumiomain volumio[1362]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 03 19:54:02 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:02 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:03 volumiomain volumio[1362]: info: VolumeController::SetAlsaVolume88 Mar 03 19:54:03 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:03 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:03 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:54:03 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:03 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:03 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:03 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:03 volumiomain volumio[1362]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Mar 03 19:54:03 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:03 volumiomain sudo[25296]: volumio : unable to resolve host volumiomain Mar 03 19:54:03 volumiomain sudo[25296]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:03 volumiomain sudo[25296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:03 volumiomain sudo[25296]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:03 volumiomain sudo[25296]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:03 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:04 volumiomain sudo[25248]: volumio : unable to resolve host volumiomain Mar 03 19:54:04 volumiomain sudo[25248]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:04 volumiomain sudo[25248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:04 volumiomain sudo[25248]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:04 volumiomain sudo[25248]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:04 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:05 volumiomain volumio[1362]: error: Unable to start TidalConnect service: Mar 03 19:54:05 volumiomain volumio[1362]: info: TidalConnect service started! Mar 03 19:54:05 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPlay Mar 03 19:54:05 volumiomain volumio[1362]: info: CoreStateMachine::play index undefined Mar 03 19:54:05 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:54:05 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:05 volumiomain volumio[1362]: info: CoreStateMachine::startPlaybackTimer Mar 03 19:54:05 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:05 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 19:54:05 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 19:54:05 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 03 19:54:05 volumiomain volumio[1362]: info: ControllerMpd::resume Mar 03 19:54:05 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand play Mar 03 19:54:05 volumiomain volumio[1362]: info: sendMpdCommand play took 1 milliseconds Mar 03 19:54:07 volumiomain sudo[25291]: volumio : unable to resolve host volumiomain Mar 03 19:54:07 volumiomain sudo[25291]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:07 volumiomain sudo[25291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:07 volumiomain sudo[25291]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:07 volumiomain sudo[25293]: volumio : unable to resolve host volumiomain Mar 03 19:54:07 volumiomain sudo[25293]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:07 volumiomain sudo[25291]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:07 volumiomain sudo[25293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:07 volumiomain sudo[25293]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:07 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:07 volumiomain sudo[25293]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:07 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:11 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:11 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:11 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:11 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:11 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:11 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:11 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:11 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:17 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:17 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:19 volumiomain volumio[1362]: info: Executing endpoint metavolumio Mar 03 19:54:19 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 19:54:19 volumiomain volumio[1362]: info: Executing endpoint metavolumio Mar 03 19:54:19 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 19:54:19 volumiomain volumio[1362]: info: Executing endpoint metavolumio Mar 03 19:54:19 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 19:54:19 volumiomain kernel: usb 1-6: USB disconnect, device number 9 Mar 03 19:54:19 volumiomain volumio[1362]: info: Mar 03 19:54:19 volumiomain volumio[1362]: ---------------------------- USB Audio Device Detached Mar 03 19:54:19 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Mar 03 19:54:19 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:54:19 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:19 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:19 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Mar 03 19:54:21 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:21 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:21 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:21 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:24 volumiomain volumio[1362]: error: error Mar 03 19:54:24 volumiomain kernel: usb 1-6: new high-speed USB device number 10 using xhci_hcd Mar 03 19:54:24 volumiomain kernel: usb 1-6: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 2.01 Mar 03 19:54:24 volumiomain kernel: usb 1-6: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Mar 03 19:54:24 volumiomain kernel: usb 1-6: Product: E30 II Lite Mar 03 19:54:24 volumiomain kernel: usb 1-6: Manufacturer: Topping Mar 03 19:54:24 volumiomain kernel: usb 1-6: 1:3 : unsupported format bits 0x100000000 Mar 03 19:54:24 volumiomain kernel: sdhci-pci 0000:00:14.5: SDHCI controller found [8086:4df8] (rev 1) Mar 03 19:54:24 volumiomain kernel: sdhci-pci 0000:00:14.5: SDHCI controller found [8086:4df8] (rev 1) Mar 03 19:54:24 volumiomain volumio[1362]: info: Mar 03 19:54:24 volumiomain volumio[1362]: ---------------------------- USB Audio Device Attached Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::Close All Modals sent Mar 03 19:54:24 volumiomain volumio[1362]: info: Preparing to save Alsa Options, stopping services first Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:24 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPause Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreStateMachine::pause Mar 03 19:54:24 volumiomain volumio[1362]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"E30 II Lite","alsacard":"Lite"},"i2s":false} Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: info: Setting mixer E30 II Lite for card E30 II Lite Mar 03 19:54:24 volumiomain vtcs[25271]: [2025-03-03 19:54:24.451] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 03 19:54:24 volumiomain vtcs[25271]: [2025-03-03 19:54:24.451] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Mar 03 19:54:24 volumiomain sudo[25383]: volumio : unable to resolve host volumiomain Mar 03 19:54:24 volumiomain sudo[25383]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:24 volumiomain sudo[25383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:54:24 volumiomain sudo[25383]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 03 19:54:24 volumiomain volumio[1362]: info: Updating Volume Controller Parameters: Device: 5 Name: E30 II Lite Mixer: E30 II Lite Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 03 19:54:24 volumiomain volumio[1362]: info: Disabling external Volume Control Mar 03 19:54:24 volumiomain systemd[1]: Stopping Volumio Tidal Connect Service... Mar 03 19:54:24 volumiomain systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 03 19:54:24 volumiomain systemd[1]: vtcs.service: Succeeded. Mar 03 19:54:24 volumiomain systemd[1]: Stopped Volumio Tidal Connect Service. Mar 03 19:54:24 volumiomain sudo[25383]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 19:54:24 volumiomain volumio[1362]: info: Preparing to generate the ALSA configuration file Mar 03 19:54:24 volumiomain volumio[1362]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 03 19:54:24 volumiomain volumio[1362]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 03 19:54:24 volumiomain volumio[1362]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Mar 03 19:54:24 volumiomain volumio[1362]: info: Reading ALSA contributions from plugins. Mar 03 19:54:24 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:54:24 volumiomain volumio[1362]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain sudo[25390]: volumio : unable to resolve host volumiomain Mar 03 19:54:24 volumiomain sudo[25390]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:24 volumiomain sudo[25390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:54:24 volumiomain sudo[25390]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:24 volumiomain sudo[25390]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 03 19:54:24 volumiomain volumio[1362]: info: VolumeController:: Volume=undefined Mute =false Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:24 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:24 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:24 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:24 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:24 volumiomain volumio[1362]: info: Asound.conf file unchanged, so no further update is needed Mar 03 19:54:24 volumiomain volumio[1362]: info: Output device has changed, restarting MPD Mar 03 19:54:24 volumiomain volumio[1362]: info: Output device has changed, restarting Shairport Sync Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 03 19:54:24 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:24 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:24 volumiomain volumio[1362]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:24 volumiomain volumio[1362]: info: Starting Shairport Sync Mar 03 19:54:24 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:26 volumiomain volumio[1362]: error: error Mar 03 19:54:27 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:54:27 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:54:27 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:54:27 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:54:27 volumiomain volumio[1362]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:54:27 volumiomain volumio[1362]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:54:27 volumiomain sudo[25431]: volumio : unable to resolve host volumiomain Mar 03 19:54:27 volumiomain sudo[25431]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:27 volumiomain sudo[25431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 03 19:54:27 volumiomain sudo[25431]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:27 volumiomain systemd[1]: Started Volumio Tidal Connect Service. Mar 03 19:54:27 volumiomain sudo[25431]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:27 volumiomain volumio[1362]: info: Executing endpoint tc_getconfig Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 03 19:54:27 volumiomain vtcs[25433]: STARTING TidalConnect services, version: 1.4.0.34 Mar 03 19:54:27 volumiomain vtcs[25433]: STARTED TidalConnect services. Mar 03 19:54:27 volumiomain volumio[1362]: info: Executing endpoint tc_connect Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 03 19:54:27 volumiomain volumio[1362]: info: Connecting to TidalConnect Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreCommandRouter::servicePushState Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:27 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:27 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:27 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:27 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:27 volumiomain volumio[1362]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreCommandRouter::servicePushState Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:27 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:27 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:27 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:27 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:27 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:27 volumiomain volumio[1362]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 03 19:54:27 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:27 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:27 volumiomain sudo[25453]: volumio : unable to resolve host volumiomain Mar 03 19:54:27 volumiomain sudo[25453]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:27 volumiomain sudo[25453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:27 volumiomain sudo[25453]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:27 volumiomain sudo[25453]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:27 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreStateMachine::getcurrentVolume Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreCommandRouter::volumioRetrievevolume Mar 03 19:54:28 volumiomain volumio[1362]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Mar 03 19:54:28 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:28 volumiomain volumio[1362]: info: VolumeController:: Volume=undefined Mute =false Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:28 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:28 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:28 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:54:28 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreCommandRouter::volumioRetrievevolume Mar 03 19:54:28 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:28 volumiomain volumio[1362]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Mar 03 19:54:28 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:28 volumiomain volumio[1362]: info: VolumeController:: Volume=undefined Mute =false Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:28 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:28 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:28 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:28 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:28 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:28 volumiomain sudo[25481]: volumio : unable to resolve host volumiomain Mar 03 19:54:28 volumiomain sudo[25481]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:28 volumiomain sudo[25481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:28 volumiomain sudo[25481]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:28 volumiomain sudo[25481]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:28 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:29 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPlay Mar 03 19:54:29 volumiomain volumio[1362]: info: CoreStateMachine::play index undefined Mar 03 19:54:29 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:54:29 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:29 volumiomain volumio[1362]: info: CoreStateMachine::startPlaybackTimer Mar 03 19:54:29 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:29 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 19:54:29 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 19:54:29 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 03 19:54:29 volumiomain volumio[1362]: info: ControllerMpd::resume Mar 03 19:54:29 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand play Mar 03 19:54:29 volumiomain volumio[1362]: info: sendMpdCommand play took 1 milliseconds Mar 03 19:54:29 volumiomain sudo[25399]: volumio : unable to resolve host volumiomain Mar 03 19:54:29 volumiomain sudo[25399]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:29 volumiomain sudo[25399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:29 volumiomain sudo[25399]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:29 volumiomain sudo[25399]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:29 volumiomain sudo[25401]: volumio : unable to resolve host volumiomain Mar 03 19:54:29 volumiomain sudo[25401]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:29 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:29 volumiomain sudo[25401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 03 19:54:29 volumiomain sudo[25401]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:29 volumiomain sudo[25401]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:29 volumiomain volumio[1362]: info: MPD Permissions set Mar 03 19:54:29 volumiomain sudo[25403]: volumio : unable to resolve host volumiomain Mar 03 19:54:29 volumiomain sudo[25403]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:29 volumiomain sudo[25403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 19:54:29 volumiomain sudo[25403]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:29 volumiomain systemd[1]: musicservicesshield.service: Succeeded. Mar 03 19:54:29 volumiomain systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Mar 03 19:54:29 volumiomain systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Mar 03 19:54:29 volumiomain systemd[1]: Stopping Music Player Daemon... Mar 03 19:54:29 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:54:29 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 19:54:29 volumiomain systemd[1]: mpd.service: Succeeded. Mar 03 19:54:29 volumiomain systemd[1]: Stopped Music Player Daemon. Mar 03 19:54:29 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 19:54:29 volumiomain systemd[1]: Starting Music Player Daemon... Mar 03 19:54:29 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:54:30 volumiomain volumio[1362]: error: Unable to start TidalConnect service: Mar 03 19:54:30 volumiomain volumio[1362]: info: TidalConnect service started! Mar 03 19:54:31 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:31 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:31 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:31 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:31 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:31 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:31 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:31 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:32 volumiomain sudo[25455]: volumio : unable to resolve host volumiomain Mar 03 19:54:32 volumiomain sudo[25455]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:32 volumiomain sudo[25455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:32 volumiomain sudo[25455]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:32 volumiomain sudo[25455]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:32 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:33 volumiomain sudo[25478]: volumio : unable to resolve host volumiomain Mar 03 19:54:33 volumiomain sudo[25478]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:33 volumiomain sudo[25478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:33 volumiomain sudo[25478]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:33 volumiomain sudo[25478]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:33 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:34 volumiomain sudo[25410]: volumio : unable to resolve host volumiomain Mar 03 19:54:34 volumiomain sudo[25410]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:34 volumiomain sudo[25410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:54:34 volumiomain sudo[25410]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:34 volumiomain systemd[1]: Stopping Volumio Tidal Connect Service... Mar 03 19:54:34 volumiomain sudo[25412]: volumio : unable to resolve host volumiomain Mar 03 19:54:34 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:54:34 volumiomain systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 03 19:54:34 volumiomain sudo[25412]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:34 volumiomain systemd[1]: vtcs.service: Succeeded. Mar 03 19:54:34 volumiomain sudo[25412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:54:34 volumiomain systemd[1]: Stopped Volumio Tidal Connect Service. Mar 03 19:54:34 volumiomain sudo[25412]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:34 volumiomain sudo[25410]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:34 volumiomain sudo[25412]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:34 volumiomain sudo[25420]: volumio : unable to resolve host volumiomain Mar 03 19:54:34 volumiomain sudo[25420]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:34 volumiomain sudo[25420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 03 19:54:34 volumiomain sudo[25420]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:34 volumiomain systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 03 19:54:34 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:54:34 volumiomain systemd[1]: shairport-sync.service: Succeeded. Mar 03 19:54:34 volumiomain systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 03 19:54:34 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 19:54:34 volumiomain systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 03 19:54:34 volumiomain sudo[25420]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:34 volumiomain volumio[1362]: info: Shairport-Sync Started Mar 03 19:54:35 volumiomain sudo[25486]: root : unable to resolve host volumiomain Mar 03 19:54:35 volumiomain sudo[25486]: sudo: unable to resolve host volumiomain: System error Mar 03 19:54:35 volumiomain sudo[25486]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:35 volumiomain sudo[25486]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 19:54:35 volumiomain sudo[25486]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:35 volumiomain sudo[25486]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:35 volumiomain mpd[25509]: Mar 03 19:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 03 19:54:37 volumiomain systemd[1]: Started Music Player Daemon. Mar 03 19:54:37 volumiomain sudo[25403]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:37 volumiomain volumio[1362]: error: updateQueue error: null Mar 03 19:54:37 volumiomain systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Mar 03 19:54:37 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:54:37 volumiomain volumio[25512]: cset: --> shielding system active with Mar 03 19:54:37 volumiomain volumio[25512]: cset: "system" cpuset of CPUSPEC(1-3) with 223 tasks running Mar 03 19:54:37 volumiomain volumio[25512]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Mar 03 19:54:37 volumiomain systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Mar 03 19:54:37 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:54:37 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:54:37 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:54:37 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:54:37 volumiomain volumio[1362]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:54:37 volumiomain volumio[1362]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:54:37 volumiomain sudo[25536]: volumio : unable to resolve host volumiomain Mar 03 19:54:37 volumiomain sudo[25536]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:37 volumiomain sudo[25536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 03 19:54:37 volumiomain sudo[25536]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:37 volumiomain systemd[1]: Started Volumio Tidal Connect Service. Mar 03 19:54:37 volumiomain sudo[25536]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:37 volumiomain volumio[1362]: info: Executing endpoint tc_getconfig Mar 03 19:54:37 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 03 19:54:37 volumiomain vtcs[25538]: BYE Mar 03 19:54:37 volumiomain systemd[1]: vtcs.service: Succeeded. Mar 03 19:54:38 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 03 19:54:38 volumiomain volumio[1362]: info: CURURI: music-library/NAS/Music/A0001/Music/Tristania/Wasteland's Caress Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 1. Mar 03 19:54:38 volumiomain systemd[1]: Stopped Volumio Tidal Connect Service. Mar 03 19:54:38 volumiomain systemd[1]: Started Volumio Tidal Connect Service. Mar 03 19:54:38 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:54:38 volumiomain volumio[1362]: info: Executing endpoint tc_getconfig Mar 03 19:54:38 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 03 19:54:38 volumiomain vtcs[25559]: BYE Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Succeeded. Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 2. Mar 03 19:54:38 volumiomain systemd[1]: Stopped Volumio Tidal Connect Service. Mar 03 19:54:38 volumiomain systemd[1]: Started Volumio Tidal Connect Service. Mar 03 19:54:38 volumiomain volumio[1362]: info: Executing endpoint tc_getconfig Mar 03 19:54:38 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 03 19:54:38 volumiomain vtcs[25562]: BYE Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Succeeded. Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 3. Mar 03 19:54:38 volumiomain systemd[1]: Stopped Volumio Tidal Connect Service. Mar 03 19:54:38 volumiomain systemd[1]: Started Volumio Tidal Connect Service. Mar 03 19:54:38 volumiomain volumio[1362]: info: Executing endpoint tc_getconfig Mar 03 19:54:38 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 03 19:54:38 volumiomain vtcs[25565]: BYE Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Succeeded. Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 4. Mar 03 19:54:38 volumiomain systemd[1]: Stopped Volumio Tidal Connect Service. Mar 03 19:54:38 volumiomain systemd[1]: Started Volumio Tidal Connect Service. Mar 03 19:54:38 volumiomain volumio[1362]: info: Executing endpoint tc_getconfig Mar 03 19:54:38 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 03 19:54:38 volumiomain vtcs[25568]: BYE Mar 03 19:54:38 volumiomain systemd[1]: vtcs.service: Succeeded. Mar 03 19:54:39 volumiomain systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 03 19:54:39 volumiomain systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 5. Mar 03 19:54:39 volumiomain systemd[1]: Stopped Volumio Tidal Connect Service. Mar 03 19:54:39 volumiomain systemd[1]: vtcs.service: Start request repeated too quickly. Mar 03 19:54:39 volumiomain systemd[1]: vtcs.service: Failed with result 'start-limit-hit'. Mar 03 19:54:39 volumiomain systemd[1]: Failed to start Volumio Tidal Connect Service. Mar 03 19:54:39 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreStateMachine::ClearQueue Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreStateMachine::stop Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:54:39 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreStateMachine::stPlaybackTimer Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:39 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:54:39 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:40 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:40 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::serviceStop Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::serviceStop Mar 03 19:54:40 volumiomain volumio[1362]: info: ControllerMpd::stop Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand stop Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::clearPlayQueue Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::saveQueue Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushQueue Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::addQueueItems Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::addQueueItems Mar 03 19:54:40 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:54:40 volumiomain volumio[1362]: info: Adding Item to queue: music-library/NAS/Music/A0001/Music/Tristania/Wasteland's Caress/Evenfall.mp3 Mar 03 19:54:40 volumiomain volumio[1362]: info: Using cached record of: music-library/NAS/Music/A0001/Music/Tristania/Wasteland's Caress/Evenfall.mp3 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushQueue Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::saveQueue Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPlay Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::play index 0 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::stop Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::play index undefined Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::startPlaybackTimer Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/A0001/Music/Tristania/Wasteland's Caress/Evenfall.mp3 Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand stop Mar 03 19:54:40 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status stop Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand stop took 29 milliseconds Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand stop took 15 milliseconds Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand clear Mar 03 19:54:40 volumiomain volumio[1362]: info: Mar 03 19:54:40 volumiomain volumio[1362]: ---------------------------- MPD announces system playlist update Mar 03 19:54:40 volumiomain volumio[1362]: info: Ignoring MPD Status Update Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand clear took 1 milliseconds Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/A0001/Music/Tristania/Wasteland's Caress/Evenfall.mp3" Mar 03 19:54:40 volumiomain volumio[1362]: error: updateQueue error: null Mar 03 19:54:40 volumiomain volumio[1362]: info: ------------------------------ 0ms Mar 03 19:54:40 volumiomain volumio[1362]: info: Mar 03 19:54:40 volumiomain volumio[1362]: ---------------------------- MPD announces system playlist update Mar 03 19:54:40 volumiomain volumio[1362]: info: Ignoring MPD Status Update Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand add "NAS/Music/A0001/Music/Tristania/Wasteland's Caress/Evenfall.mp3" took 1 milliseconds Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand play Mar 03 19:54:40 volumiomain volumio[1362]: info: ------------------------------ 1ms Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand play took 0 milliseconds Mar 03 19:54:40 volumiomain sudo[25572]: volumio : unable to resolve host volumiomain Mar 03 19:54:40 volumiomain sudo[25572]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:40 volumiomain sudo[25572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:54:40 volumiomain sudo[25572]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:40 volumiomain volumio[1362]: info: Mar 03 19:54:40 volumiomain volumio[1362]: ---------------------------- MPD announces state update: player Mar 03 19:54:40 volumiomain volumio[1362]: info: ControllerMpd::getState Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Mar 03 19:54:40 volumiomain sudo[25572]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:40 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:54:40 volumiomain volumio[1362]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Mar 03 19:54:40 volumiomain volumio[1362]: info: FusionDsp - ---- read samplerate from file: 48000 Mar 03 19:54:40 volumiomain volumio[1362]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 03 19:54:40 volumiomain volumio[1362]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Mar 03 19:54:40 volumiomain volumio[1362]: info: FusionDsp - ---- read samplerate from file: 48000 Mar 03 19:54:40 volumiomain volumio[1362]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 03 19:54:40 volumiomain volumio[1362]: info: Mar 03 19:54:40 volumiomain volumio[1362]: ---------------------------- MPD announces state update: player Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand status took 18 milliseconds Mar 03 19:54:40 volumiomain volumio[1362]: info: ControllerMpd::getState Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::parseState Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand status took 1 milliseconds Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::parseState Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::parseTrackInfo Mar 03 19:54:40 volumiomain volumio[1362]: info: ControllerMpd::pushState Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::servicePushState Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:40 volumiomain volumio[1362]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":449,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Evenfall","artist":"Tristania","album":"Wasteland's Caress","uri":"NAS/Music/A0001/Music/Tristania/Wasteland's Caress/Evenfall.mp3","trackType":"mp3"} Mar 03 19:54:40 volumiomain volumio[1362]: verbose: CURRENT POSITION 0 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::syncState stateService play Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::syncState currentStatus stop Mar 03 19:54:40 volumiomain volumio[1362]: info: ------------------------------ 23ms Mar 03 19:54:40 volumiomain volumio[1362]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 19:54:40 volumiomain volumio[1362]: verbose: ControllerMpd::parseTrackInfo Mar 03 19:54:40 volumiomain volumio[1362]: info: ControllerMpd::pushState Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::servicePushState Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:40 volumiomain volumio[1362]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":449,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Evenfall","artist":"Tristania","album":"Wasteland's Caress","uri":"NAS/Music/A0001/Music/Tristania/Wasteland's Caress/Evenfall.mp3","trackType":"mp3"} Mar 03 19:54:40 volumiomain volumio[1362]: verbose: CURRENT POSITION 0 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::syncState stateService play Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::syncState currentStatus play Mar 03 19:54:40 volumiomain volumio[1362]: info: Received an update from plugin. extracting info from payload Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:40 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:40 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:40 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:40 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:40 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:40 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:40 volumiomain volumio[1362]: info: ------------------------------ 19ms Mar 03 19:54:40 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status play Mar 03 19:54:40 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status play Mar 03 19:54:40 volumiomain sudo[25581]: volumio : unable to resolve host volumiomain Mar 03 19:54:40 volumiomain sudo[25581]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:40 volumiomain sudo[25581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Mar 03 19:54:40 volumiomain sudo[25581]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:40 volumiomain volumio[1362]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 03 19:54:40 volumiomain volumio[1362]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 03 19:54:40 volumiomain systemd[1]: Started peppyspectrum Daemon. Mar 03 19:54:40 volumiomain sudo[25581]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:40 volumiomain volumio[1362]: info: peppyspectrum Daemon Started Mar 03 19:54:40 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25587, instance 1, run: true Mar 03 19:54:40 volumiomain volumio[25585]: libpng warning: iCCP: known incorrect sRGB profile Mar 03 19:54:40 volumiomain volumio[25585]: libpng warning: iCCP: known incorrect sRGB profile Mar 03 19:54:40 volumiomain volumio[25585]: libpng warning: iCCP: known incorrect sRGB profile Mar 03 19:54:40 volumiomain volumio[25585]: libpng warning: iCCP: known incorrect sRGB profile Mar 03 19:54:40 volumiomain volumio[1362]: error: Unable to start TidalConnect service: Mar 03 19:54:40 volumiomain volumio[1362]: info: TidalConnect service started! Mar 03 19:54:41 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:41 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:41 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:41 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:45 volumiomain sudo[25583]: volumio : unable to resolve host volumiomain Mar 03 19:54:45 volumiomain sudo[25583]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:45 volumiomain sudo[25583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Mar 03 19:54:45 volumiomain sudo[25583]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:45 volumiomain sudo[25583]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:45 volumiomain volumio[1362]: info: peppyspectrum Daemon Started Mar 03 19:54:51 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:51 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:51 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:51 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:51 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:51 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:51 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:51 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:54:57 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 03 19:54:57 volumiomain volumio[1362]: info: CURURI: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds Mar 03 19:54:57 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:54:57 volumiomain volumio[1362]: info: Preloading song: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 Mar 03 19:54:57 volumiomain volumio[1362]: info: Preloading song: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/08 Wasteland_s Caress.mp3 Mar 03 19:54:57 volumiomain volumio[1362]: info: Preloading song: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/09 ...Postludium.mp3 Mar 03 19:54:57 volumiomain volumio[1362]: info: Exploding uri music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 in service mpd Mar 03 19:54:57 volumiomain volumio[1362]: info: ALBUMART /albumart?cacheid=512&web=Tristania/Widow's%20Weeds/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FA0001%2FMusic%2FTristania%2FWidow's%20Weeds%2F06%20Angellore.mp3&metadata=false Mar 03 19:54:57 volumiomain volumio[1362]: info: URI /mnt/NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 Mar 03 19:54:57 volumiomain volumio[1362]: info: Exploding uri music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/08 Wasteland_s Caress.mp3 in service mpd Mar 03 19:54:57 volumiomain volumio[1362]: info: ALBUMART /albumart?cacheid=512&web=Tristania/Widow's%20Weeds/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FA0001%2FMusic%2FTristania%2FWidow's%20Weeds%2F08%20Wasteland_s%20Caress.mp3&metadata=false Mar 03 19:54:57 volumiomain volumio[1362]: info: URI /mnt/NAS/Music/A0001/Music/Tristania/Widow's Weeds/08 Wasteland_s Caress.mp3 Mar 03 19:54:57 volumiomain volumio[1362]: info: Exploding uri music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/09 ...Postludium.mp3 in service mpd Mar 03 19:54:57 volumiomain volumio[1362]: info: ALBUMART /albumart?cacheid=512&web=Tristania/Widow's%20Weeds/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FA0001%2FMusic%2FTristania%2FWidow's%20Weeds%2F09%20...Postludium.mp3&metadata=false Mar 03 19:54:57 volumiomain volumio[1362]: info: URI /mnt/NAS/Music/A0001/Music/Tristania/Widow's Weeds/09 ...Postludium.mp3 Mar 03 19:54:57 volumiomain kernel: xhci_hcd 0000:00:14.0: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 1 comp_code 1 Mar 03 19:54:57 volumiomain kernel: xhci_hcd 0000:00:14.0: Looking for event-dma 0000000169a50e60 trb-start 0000000169a50e70 trb-end 0000000169a50e70 seg-start 0000000169a50000 seg-end 0000000169a50ff0 Mar 03 19:54:57 volumiomain kernel: usb 1-6: USB disconnect, device number 10 Mar 03 19:54:57 volumiomain kernel: xhci_hcd 0000:00:14.0: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 1 comp_code 1 Mar 03 19:54:57 volumiomain kernel: xhci_hcd 0000:00:14.0: Looking for event-dma 0000000169a50e70 trb-start 0000000169a50e80 trb-end 0000000169a50e80 seg-start 0000000169a50000 seg-end 0000000169a50ff0 Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25644, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: Mar 03 19:54:57 volumiomain volumio[1362]: ---------------------------- USB Audio Device Detached Mar 03 19:54:57 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Mar 03 19:54:57 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:54:57 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:57 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:57 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25653, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25660, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25667, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25674, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25681, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25688, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25695, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25702, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25709, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25716, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25723, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25730, instance 1, run: true Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25741, instance 1, run: true Mar 03 19:54:57 volumiomain kernel: usb 1-6: new high-speed USB device number 11 using xhci_hcd Mar 03 19:54:57 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25758, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25765, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25772, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25782, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25789, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25796, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25803, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25811, instance 1, run: true Mar 03 19:54:58 volumiomain kernel: usb 1-6: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 2.01 Mar 03 19:54:58 volumiomain kernel: usb 1-6: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Mar 03 19:54:58 volumiomain kernel: usb 1-6: Product: E30 II Lite Mar 03 19:54:58 volumiomain kernel: usb 1-6: Manufacturer: Topping Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25818, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25825, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25832, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25839, instance 1, run: true Mar 03 19:54:58 volumiomain kernel: usb 1-6: 1:3 : unsupported format bits 0x100000000 Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25846, instance 1, run: true Mar 03 19:54:58 volumiomain kernel: sdhci-pci 0000:00:14.5: SDHCI controller found [8086:4df8] (rev 1) Mar 03 19:54:58 volumiomain kernel: sdhci-pci 0000:00:14.5: SDHCI controller found [8086:4df8] (rev 1) Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25856, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: Mar 03 19:54:58 volumiomain volumio[1362]: ---------------------------- USB Audio Device Attached Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::Close All Modals sent Mar 03 19:54:58 volumiomain volumio[1362]: info: Preparing to save Alsa Options, stopping services first Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:54:58 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPause Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreStateMachine::pause Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreStateMachine::stPlaybackTimer Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreStateMachine::servicePause Mar 03 19:54:58 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::servicePause Mar 03 19:54:58 volumiomain volumio[1362]: info: ControllerMpd::pause Mar 03 19:54:58 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand pause Mar 03 19:54:58 volumiomain volumio[1362]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"E30 II Lite","alsacard":"Lite"},"i2s":false} Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: info: Setting mixer E30 II Lite for card E30 II Lite Mar 03 19:54:58 volumiomain sudo[25874]: volumio : unable to resolve host volumiomain Mar 03 19:54:58 volumiomain sudo[25874]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:58 volumiomain sudo[25874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:54:58 volumiomain sudo[25874]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 03 19:54:58 volumiomain volumio[1362]: info: Updating Volume Controller Parameters: Device: 5 Name: E30 II Lite Mixer: E30 II Lite Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 03 19:54:58 volumiomain volumio[1362]: info: Disabling external Volume Control Mar 03 19:54:58 volumiomain sudo[25874]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 19:54:58 volumiomain volumio[1362]: info: Preparing to generate the ALSA configuration file Mar 03 19:54:58 volumiomain volumio[1362]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 03 19:54:58 volumiomain volumio[1362]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 03 19:54:58 volumiomain volumio[1362]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Mar 03 19:54:58 volumiomain volumio[1362]: info: Reading ALSA contributions from plugins. Mar 03 19:54:58 volumiomain volumio[1362]: info: Mar 03 19:54:58 volumiomain volumio[1362]: ---------------------------- MPD announces state update: player Mar 03 19:54:58 volumiomain volumio[1362]: info: sendMpdCommand pause took 130 milliseconds Mar 03 19:54:58 volumiomain volumio[1362]: info: ControllerMpd::getState Mar 03 19:54:58 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Mar 03 19:54:58 volumiomain volumio[1362]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain sudo[25881]: volumio : unable to resolve host volumiomain Mar 03 19:54:58 volumiomain sudo[25881]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:54:58 volumiomain sudo[25881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:54:58 volumiomain sudo[25881]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:54:58 volumiomain volumio[1362]: info: sendMpdCommand status took 10 milliseconds Mar 03 19:54:58 volumiomain volumio[1362]: verbose: ControllerMpd::parseState Mar 03 19:54:58 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 19:54:58 volumiomain volumio[1362]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 03 19:54:58 volumiomain volumio[1362]: verbose: ControllerMpd::parseTrackInfo Mar 03 19:54:58 volumiomain volumio[1362]: info: ControllerMpd::pushState Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::servicePushState Mar 03 19:54:58 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:58 volumiomain volumio[1362]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":19860,"duration":449,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Evenfall","artist":"Tristania","album":"Wasteland's Caress","uri":"NAS/Music/A0001/Music/Tristania/Wasteland's Caress/Evenfall.mp3","trackType":"mp3"} Mar 03 19:54:58 volumiomain volumio[1362]: verbose: CURRENT POSITION 0 Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreStateMachine::syncState stateService pause Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreStateMachine::syncState currentStatus pause Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:58 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:58 volumiomain sudo[25881]: pam_unix(sudo:session): session closed for user root Mar 03 19:54:58 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:58 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreStateMachine::stPlaybackTimer Mar 03 19:54:58 volumiomain volumio[1362]: info: ------------------------------ 27ms Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 03 19:54:58 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:58 volumiomain volumio[1362]: info: VolumeController:: Volume=undefined Mute =false Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:54:58 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:54:58 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:54:58 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:54:58 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status pause Mar 03 19:54:58 volumiomain volumio[1362]: info: camilladsp spawned new process with pid 25893, instance 1, run: true Mar 03 19:54:58 volumiomain volumio[1362]: info: Asound.conf file unchanged, so no further update is needed Mar 03 19:54:58 volumiomain volumio[1362]: info: Output device has changed, restarting MPD Mar 03 19:54:58 volumiomain volumio[1362]: info: Output device has changed, restarting Shairport Sync Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 03 19:54:58 volumiomain volumio[1362]: No protocol specified Mar 03 19:54:58 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:54:58 volumiomain volumio[1362]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 03 19:54:58 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:54:58 volumiomain volumio[1362]: info: Starting Shairport Sync Mar 03 19:54:58 volumiomain volumio[1362]: info: Preparing to generate the ALSA configuration file Mar 03 19:54:58 volumiomain volumio[1362]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 03 19:54:58 volumiomain volumio[1362]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 03 19:54:58 volumiomain volumio[1362]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Mar 03 19:54:58 volumiomain volumio[1362]: info: Reading ALSA contributions from plugins. Mar 03 19:54:58 volumiomain volumio[1362]: info: Asound.conf file written Mar 03 19:55:03 volumiomain sudo[25890]: volumio : unable to resolve host volumiomain Mar 03 19:55:03 volumiomain sudo[25890]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:03 volumiomain sudo[25890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:55:03 volumiomain sudo[25890]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:03 volumiomain systemd[1]: Stopping peppyspectrum Daemon... Mar 03 19:55:03 volumiomain systemd[1]: peppyspectrum.service: Main process exited, code=killed, status=15/TERM Mar 03 19:55:03 volumiomain sudo[25892]: volumio : unable to resolve host volumiomain Mar 03 19:55:03 volumiomain sudo[25892]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:03 volumiomain sudo[25892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:55:03 volumiomain sudo[25892]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:03 volumiomain sudo[25901]: volumio : unable to resolve host volumiomain Mar 03 19:55:03 volumiomain sudo[25901]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:03 volumiomain sudo[25901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 03 19:55:03 volumiomain sudo[25901]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:03 volumiomain sudo[25901]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:03 volumiomain systemd[1]: peppyspectrum.service: Succeeded. Mar 03 19:55:03 volumiomain systemd[1]: Stopped peppyspectrum Daemon. Mar 03 19:55:03 volumiomain sudo[25890]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:03 volumiomain sudo[25892]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:08 volumiomain sudo[25904]: volumio : unable to resolve host volumiomain Mar 03 19:55:08 volumiomain sudo[25904]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:08 volumiomain sudo[25904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 19:55:08 volumiomain sudo[25904]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:08 volumiomain systemd[1]: musicservicesshield.service: Succeeded. Mar 03 19:55:08 volumiomain systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Mar 03 19:55:08 volumiomain systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Mar 03 19:55:08 volumiomain systemd[1]: Stopping Music Player Daemon... Mar 03 19:55:08 volumiomain sudo[25911]: volumio : unable to resolve host volumiomain Mar 03 19:55:08 volumiomain sudo[25911]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:08 volumiomain sudo[25911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:55:08 volumiomain sudo[25911]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:08 volumiomain sudo[25911]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:08 volumiomain sudo[25913]: volumio : unable to resolve host volumiomain Mar 03 19:55:08 volumiomain sudo[25913]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:08 volumiomain sudo[25913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:55:08 volumiomain sudo[25913]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:08 volumiomain sudo[25913]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:08 volumiomain sudo[25921]: volumio : unable to resolve host volumiomain Mar 03 19:55:08 volumiomain sudo[25921]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:08 volumiomain sudo[25921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 03 19:55:08 volumiomain sudo[25921]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:08 volumiomain systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 03 19:55:08 volumiomain systemd[1]: shairport-sync.service: Succeeded. Mar 03 19:55:08 volumiomain systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 03 19:55:08 volumiomain systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 03 19:55:08 volumiomain sudo[25921]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:08 volumiomain systemd[1]: mpd.service: Succeeded. Mar 03 19:55:08 volumiomain systemd[1]: Stopped Music Player Daemon. Mar 03 19:55:08 volumiomain systemd[1]: Starting Music Player Daemon... Mar 03 19:55:12 volumiomain kernel: usb 1-6: USB disconnect, device number 11 Mar 03 19:55:12 volumiomain kernel: usb 1-6: new high-speed USB device number 12 using xhci_hcd Mar 03 19:55:13 volumiomain sudo[25923]: volumio : unable to resolve host volumiomain Mar 03 19:55:13 volumiomain sudo[25923]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:13 volumiomain sudo[25923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 03 19:55:13 volumiomain sudo[25923]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:13 volumiomain sudo[25923]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:13 volumiomain volumio[1362]: sudo: unable to resolve host volumiomain: System error Mar 03 19:55:13 volumiomain volumio[1362]: No protocol specified Mar 03 19:55:13 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:55:13 volumiomain volumio[1362]: info: Output device has changed, restarting MPD Mar 03 19:55:13 volumiomain volumio[1362]: info: Output device has changed, restarting Shairport Sync Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 19:55:13 volumiomain sudo[26030]: volumio : unable to resolve host volumiomain Mar 03 19:55:13 volumiomain sudo[26030]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:13 volumiomain sudo[26030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 03 19:55:13 volumiomain sudo[26030]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:13 volumiomain sudo[26030]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:13 volumiomain sudo[26032]: volumio : unable to resolve host volumiomain Mar 03 19:55:13 volumiomain sudo[26032]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:13 volumiomain sudo[26032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 19:55:13 volumiomain sudo[26032]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:13 volumiomain volumio[1362]: No protocol specified Mar 03 19:55:13 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:55:13 volumiomain volumio[1362]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 03 19:55:13 volumiomain volumio[1362]: No protocol specified Mar 03 19:55:13 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:55:13 volumiomain volumio[1362]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::getcurrentVolume Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioRetrievevolume Mar 03 19:55:13 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::ClearQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::stop Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::stPlaybackTimer Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:55:13 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:55:13 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::serviceStop Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::serviceStop Mar 03 19:55:13 volumiomain volumio[1362]: info: ControllerMpd::stop Mar 03 19:55:13 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand stop Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::clearPlayQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::saveQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::addQueueItems Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::addQueueItems Mar 03 19:55:13 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:55:13 volumiomain volumio[1362]: info: Adding Item to queue: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Using cached record of: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::ClearQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::stop Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::clearPlayQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::saveQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::addQueueItems Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::addQueueItems Mar 03 19:55:13 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:55:13 volumiomain volumio[1362]: info: Adding Item to queue: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Using cached record of: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::saveQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::saveQueue Mar 03 19:55:13 volumiomain volumio[1362]: error: MPD error: Error: write EPIPE Mar 03 19:55:13 volumiomain volumio[1362]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPlay Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::play index 0 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::addQueueItems Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::addQueueItems Mar 03 19:55:13 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:55:13 volumiomain volumio[1362]: info: Adding Item to queue: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/08 Wasteland_s Caress.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Using cached record of: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/08 Wasteland_s Caress.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Adding Item to queue: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/09 ...Postludium.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Using cached record of: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/09 ...Postludium.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPlay Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::play index 0 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::addQueueItems Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::addQueueItems Mar 03 19:55:13 volumiomain volumio[1362]: info: Preload queue cleared Mar 03 19:55:13 volumiomain volumio[1362]: info: Adding Item to queue: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/08 Wasteland_s Caress.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Using cached record of: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/08 Wasteland_s Caress.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Adding Item to queue: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/09 ...Postludium.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: Using cached record of: music-library/NAS/Music/A0001/Music/Tristania/Widow's Weeds/09 ...Postludium.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::stop Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::saveQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::stop Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::saveQueue Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::play index undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::play index undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::startPlaybackTimer Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:13 volumiomain volumio[1362]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand stop Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::startPlaybackTimer Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:13 volumiomain volumio[1362]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/A0001/Music/Tristania/Widow's Weeds/06 Angellore.mp3 Mar 03 19:55:13 volumiomain volumio[1362]: verbose: ControllerMpd::sendMpdCommand stop Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 19:55:13 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:55:13 volumiomain volumio[1362]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 03 19:55:13 volumiomain volumio[1362]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 03 19:55:13 volumiomain volumio[1362]: info: MPD Permissions set Mar 03 19:55:13 volumiomain volumio[1362]: info: Shairport-Sync Started Mar 03 19:55:13 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:55:13 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:55:13 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:55:13 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:55:13 volumiomain volumio[1362]: info: MPD Permissions set Mar 03 19:55:13 volumiomain volumio[1362]: info: peppyspectrum Daemon Stop Mar 03 19:55:13 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:55:13 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:55:13 volumiomain volumio[1362]: error: Unable to stop TidalConnect service: Mar 03 19:55:13 volumiomain volumio[1362]: info: TidalConnect service stoped! Mar 03 19:55:13 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status stop Mar 03 19:55:13 volumiomain volumio[1362]: info: VolumeController:: Volume=undefined Mute =false Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:55:13 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:55:13 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreStateMachine::updateTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrackBlock Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioRetrievevolume Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:55:13 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:13 volumiomain volumio[1362]: info: CoreCommandRouter::volumioGetState Mar 03 19:55:14 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:14 volumiomain volumio[1362]: info: Mar 03 19:55:14 volumiomain volumio[1362]: ---------------------------- USB Audio Device Detached Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 19:55:14 volumiomain volumio[1362]: No protocol specified Mar 03 19:55:14 volumiomain volumio[1362]: xcb_connection_has_error() returned true Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Mar 03 19:55:14 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status stop Mar 03 19:55:14 volumiomain volumio[1362]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 03 19:55:14 volumiomain volumio[1362]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:55:14 volumiomain volumio[1362]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 19:55:14 volumiomain volumio[1362]: info: VolumeController:: Volume=undefined Mute =false Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreStateMachine::pushState Mar 03 19:55:14 volumiomain volumio[1362]: info: CorePlayQueue::getTrack 0 Mar 03 19:55:14 volumiomain volumio[1362]: info: CoreCommandRouter::volumioPushState Mar 03 19:55:14 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output update for this device Mar 03 19:55:14 volumiomain volumio[1362]: info: MRS: Pushing multiroomSync output Mar 03 19:55:14 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:55:14 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:55:14 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:55:14 volumiomain volumio[1362]: info: Listing playlists Mar 03 19:55:14 volumiomain volumio[1362]: info: PeppySpectrum ---peppyspectrum status stop Mar 03 19:55:14 volumiomain volumio[1362]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:55:14 volumiomain volumio[1362]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 03 19:55:14 volumiomain volumio[1362]: info: Starting Shairport Sync Mar 03 19:55:16 volumiomain volumio[1362]: info: Executing endpoint metavolumio Mar 03 19:55:16 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 19:55:16 volumiomain volumio[1362]: info: Executing endpoint metavolumio Mar 03 19:55:16 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 19:55:16 volumiomain volumio[1362]: info: Executing endpoint metavolumio Mar 03 19:55:16 volumiomain volumio[1362]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 19:55:16 volumiomain kernel: usb 1-4: USB disconnect, device number 2 Mar 03 19:55:16 volumiomain kernel: ath: phy0: Failed to wakeup in 500us Mar 03 19:55:16 volumiomain dhcpcd[821]: wlan0: removing interface Mar 03 19:55:16 volumiomain kernel: ath: phy0: Failed to wakeup in 500us Mar 03 19:55:16 volumiomain systemd[1]: Stopping ifup for wlan0... Mar 03 19:55:17 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:55:17 volumiomain kernel: usb 1-4: ath9k_htc: USB layer deinitialized Mar 03 19:55:17 volumiomain systemd[1]: Starting Load/Save RF Kill Switch Status... Mar 03 19:55:17 volumiomain volumio[1362]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 19:55:17 volumiomain systemd[1]: Started Load/Save RF Kill Switch Status. Mar 03 19:55:17 volumiomain systemd[1]: ifup@wlan0.service: Succeeded. Mar 03 19:55:17 volumiomain systemd[1]: Stopped ifup for wlan0. Mar 03 19:55:17 volumiomain volumio[1362]: error: error Mar 03 19:55:18 volumiomain sudo[26041]: volumio : unable to resolve host volumiomain Mar 03 19:55:18 volumiomain sudo[26041]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:18 volumiomain sudo[26041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:55:18 volumiomain sudo[26041]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:18 volumiomain sudo[26041]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:18 volumiomain sudo[26043]: volumio : unable to resolve host volumiomain Mar 03 19:55:18 volumiomain sudo[26043]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:18 volumiomain sudo[26043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 03 19:55:18 volumiomain sudo[26043]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:18 volumiomain sudo[26043]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:19 volumiomain volumio[1362]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 19:55:19 volumiomain volumio[1362]: Error: connect ECONNREFUSED 0.0.0.0:443 Mar 03 19:55:19 volumiomain volumio[1362]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 03 19:55:19 volumiomain volumio[1362]: errno: -111, Mar 03 19:55:19 volumiomain volumio[1362]: code: 'ECONNREFUSED', Mar 03 19:55:19 volumiomain volumio[1362]: syscall: 'connect', Mar 03 19:55:19 volumiomain volumio[1362]: address: '0.0.0.0', Mar 03 19:55:19 volumiomain volumio[1362]: port: 443 Mar 03 19:55:19 volumiomain volumio[1362]: } Mar 03 19:55:19 volumiomain volumio[1362]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 19:55:20 volumiomain mpd_monitor.sh[722]: mpd: no process found Mar 03 19:55:22 volumiomain systemd[1]: systemd-rfkill.service: Succeeded. Mar 03 19:55:24 volumiomain sudo[26055]: volumio : unable to resolve host volumiomain Mar 03 19:55:24 volumiomain sudo[26055]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:24 volumiomain sudo[26055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:55:24 volumiomain sudo[26055]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:24 volumiomain sudo[26055]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:24 volumiomain sudo[26009]: root : unable to resolve host volumiomain Mar 03 19:55:24 volumiomain sudo[26009]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:24 volumiomain sudo[26009]: sudo: unable to resolve host volumiomain: System error Mar 03 19:55:24 volumiomain sudo[26009]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 19:55:24 volumiomain sudo[26009]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:24 volumiomain sudo[26009]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:24 volumiomain systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 03 19:55:24 volumiomain systemd[1]: mpd.service: Succeeded. Mar 03 19:55:24 volumiomain systemd[1]: Stopped Music Player Daemon. Mar 03 19:55:24 volumiomain systemd[1]: Starting Music Player Daemon... Mar 03 19:55:24 volumiomain sudo[26064]: volumio : unable to resolve host volumiomain Mar 03 19:55:24 volumiomain sudo[26064]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:24 volumiomain sudo[26064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:55:24 volumiomain sudo[26064]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:24 volumiomain sudo[26064]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:24 volumiomain sudo[26173]: root : unable to resolve host volumiomain Mar 03 19:55:24 volumiomain sudo[26173]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:24 volumiomain sudo[26173]: sudo: unable to resolve host volumiomain: System error Mar 03 19:55:24 volumiomain sudo[26173]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 19:55:24 volumiomain sudo[26173]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:24 volumiomain sudo[26173]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:24 volumiomain mpd[26176]: Mar 03 19:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 03 19:55:26 volumiomain systemd[1]: Started Music Player Daemon. Mar 03 19:55:26 volumiomain mpd_monitor.sh[722]: MPD restarted due to no mpc output. Mar 03 19:55:26 volumiomain sudo[26032]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:26 volumiomain sudo[25904]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:26 volumiomain systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Mar 03 19:55:26 volumiomain volumio[26180]: cset: --> shielding system active with Mar 03 19:55:26 volumiomain volumio[26180]: cset: "system" cpuset of CPUSPEC(1-3) with 237 tasks running Mar 03 19:55:26 volumiomain volumio[26180]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Mar 03 19:55:26 volumiomain systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Mar 03 19:55:29 volumiomain sudo[26077]: volumio : unable to resolve host volumiomain Mar 03 19:55:29 volumiomain sudo[26077]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:29 volumiomain sudo[26079]: volumio : unable to resolve host volumiomain Mar 03 19:55:29 volumiomain sudo[26079]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:29 volumiomain sudo[26077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 03 19:55:29 volumiomain sudo[26081]: volumio : unable to resolve host volumiomain Mar 03 19:55:29 volumiomain sudo[26081]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:29 volumiomain sudo[26077]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:29 volumiomain sudo[26079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 03 19:55:29 volumiomain sudo[26079]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:29 volumiomain sudo[26081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 03 19:55:29 volumiomain sudo[26081]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:29 volumiomain sudo[26083]: volumio : unable to resolve host volumiomain Mar 03 19:55:29 volumiomain sudo[26083]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:29 volumiomain systemd[1]: Started Volumio Tidal Connect Service. Mar 03 19:55:29 volumiomain sudo[26083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 03 19:55:29 volumiomain sudo[26083]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 19:55:29 volumiomain sudo[26079]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:29 volumiomain systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 03 19:55:29 volumiomain systemd[1]: shairport-sync.service: Succeeded. Mar 03 19:55:29 volumiomain systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 03 19:55:29 volumiomain sudo[26077]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:29 volumiomain systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 03 19:55:29 volumiomain sudo[26081]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:29 volumiomain sudo[26083]: pam_unix(sudo:session): session closed for user root Mar 03 19:55:29 volumiomain sudo[26158]: volumio : unable to resolve host volumiomain Mar 03 19:55:29 volumiomain sudo[26158]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 03 19:55:29 volumiomain sudo[26158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-03 19:54 Mar 03 19:55:29 volumiomain sudo[26158]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"