-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2024-07-20 10:44:07 UTC. --
Jul 20 10:43:35 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 20 10:43:35 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 20 10:43:35 volumiooffice volumio[938]: info: Discovery: Getting this device information
Jul 20 10:43:35 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:35 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 10:43:45 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 20 10:43:45 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 20 10:43:45 volumiooffice volumio[938]: info: Discovery: Getting this device information
Jul 20 10:43:45 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:45 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 10:43:45 volumiooffice volumio[938]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.30 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 6
Jul 20 10:43:45 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:45 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jul 20 10:43:45 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jul 20 10:43:46 volumiooffice sudo[2453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 20 10:43:46 volumiooffice sudo[2453]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:43:46 volumiooffice sudo[2453]: pam_unix(sudo:session): session closed for user root
Jul 20 10:43:46 volumiooffice sudo[2455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 20 10:43:46 volumiooffice sudo[2455]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:43:46 volumiooffice sudo[2455]: pam_unix(sudo:session): session closed for user root
Jul 20 10:43:46 volumiooffice volumio[938]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.30 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 7
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 20 10:43:46 volumiooffice volumio[938]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 20 10:43:46 volumiooffice volumio[938]: info: Received Get System Info
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 20 10:43:46 volumiooffice volumio[938]: info: Discovery: Getting this device information
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:46 volumiooffice volumio[938]: info: Listing playlists
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 20 10:43:46 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::volumioPause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::stPlaybackTimer
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::servicePause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CorePlayQueue::getTrack 1
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::servicePause
Jul 20 10:43:48 volumiooffice volumio[938]: info: [1721472228357] ControllerQobuz::pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::pause
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand pause
Jul 20 10:43:48 volumiooffice volumio[938]: info:
Jul 20 10:43:48 volumiooffice volumio[938]: ---------------------------- MPD announces state update: player
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand pause took 2 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::getState
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand status
Jul 20 10:43:48 volumiooffice volumio[938]: info:
Jul 20 10:43:48 volumiooffice volumio[938]: ---------------------------- MPD announces state update: player
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::getState
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand status
Jul 20 10:43:48 volumiooffice volumio[938]: info:
Jul 20 10:43:48 volumiooffice volumio[938]: ---------------------------- MPD announces state update: player
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::getState
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand status
Jul 20 10:43:48 volumiooffice volumio[938]: info:
Jul 20 10:43:48 volumiooffice volumio[938]: ---------------------------- MPD announces state update: player
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::getState
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand status
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand status took 4 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand status took 3 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand status took 3 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand status took 2 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::parseState
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::parseState
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::parseState
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::parseState
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::parseTrackInfo
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::parseTrackInfo
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::parseTrackInfo
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: ControllerMpd::parseTrackInfo
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::pushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::servicePushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CorePlayQueue::getTrack 1
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":117342,"duration":244,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2721 Kbps","isStreaming":false,"title":"159767389","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/159767389","trackType":"qobuz"}
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: CURRENT POSITION 1
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::syncState stateService pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::syncState currentStatus pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::pushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::volumioPushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: MRS: Pushing multiroomSync output update for this device
Jul 20 10:43:48 volumiooffice volumio[938]: info: MRS: Pushing multiroomSync output
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::stPlaybackTimer
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::pushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::servicePushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CorePlayQueue::getTrack 1
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":117342,"duration":244,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2721 Kbps","isStreaming":false,"title":"159767389","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/159767389","trackType":"qobuz"}
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: CURRENT POSITION 1
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::syncState stateService pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::syncState currentStatus pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::pushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::volumioPushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: MRS: Pushing multiroomSync output update for this device
Jul 20 10:43:48 volumiooffice volumio[938]: info: MRS: Pushing multiroomSync output
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::stPlaybackTimer
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::pushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::servicePushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CorePlayQueue::getTrack 1
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":117342,"duration":244,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2721 Kbps","isStreaming":false,"title":"159767389","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/159767389","trackType":"qobuz"}
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: CURRENT POSITION 1
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::syncState stateService pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::syncState currentStatus pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::pushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::volumioPushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: MRS: Pushing multiroomSync output update for this device
Jul 20 10:43:48 volumiooffice volumio[938]: info: MRS: Pushing multiroomSync output
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::stPlaybackTimer
Jul 20 10:43:48 volumiooffice volumio[938]: info: ControllerMpd::pushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::servicePushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CorePlayQueue::getTrack 1
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":117342,"duration":244,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2721 Kbps","isStreaming":false,"title":"159767389","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/159767389","trackType":"qobuz"}
Jul 20 10:43:48 volumiooffice volumio[938]: verbose: CURRENT POSITION 1
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::syncState stateService pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::syncState currentStatus pause
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::pushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::volumioPushState
Jul 20 10:43:48 volumiooffice volumio[938]: info: MRS: Pushing multiroomSync output update for this device
Jul 20 10:43:48 volumiooffice volumio[938]: info: MRS: Pushing multiroomSync output
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreStateMachine::stPlaybackTimer
Jul 20 10:43:48 volumiooffice volumio[938]: info: ------------------------------ 30ms
Jul 20 10:43:48 volumiooffice volumio[938]: info: ------------------------------ 29ms
Jul 20 10:43:48 volumiooffice volumio[938]: info: ------------------------------ 28ms
Jul 20 10:43:48 volumiooffice volumio[938]: info: ------------------------------ 28ms
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 20 10:43:48 volumiooffice volumio[938]: info: Received Get System Info
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 20 10:43:48 volumiooffice volumio[938]: info: Discovery: Getting this device information
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 10:43:48 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jul 20 10:43:51 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 20 10:43:51 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jul 20 10:43:54 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 20 10:43:54 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 20 10:43:54 volumiooffice volumio[938]: info: Discovery: Getting this device information
Jul 20 10:43:54 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:54 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 10:43:56 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 20 10:43:56 volumiooffice volumio[938]: info: Received Get System Info
Jul 20 10:43:56 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 20 10:43:56 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 20 10:43:56 volumiooffice volumio[938]: info: Discovery: Getting this device information
Jul 20 10:43:56 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:43:56 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 10:43:56 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 20 10:43:57 volumiooffice volumio[938]: STREAMING PROXY: Client dropped request, destroying
Jul 20 10:44:04 volumiooffice volumio[938]: info: Enabling plugin fusiondsp
Jul 20 10:44:04 volumiooffice volumio[938]: info: Loading plugin "fusiondsp"...
Jul 20 10:44:04 volumiooffice volumio[938]: info: Preparing to generate the ALSA configuration file
Jul 20 10:44:04 volumiooffice volumio[938]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jul 20 10:44:04 volumiooffice volumio[938]: info: Reading ALSA contributions from plugins.
Jul 20 10:44:04 volumiooffice volumio[938]: info: Asound.conf file unchanged, so no further update is needed
Jul 20 10:44:04 volumiooffice volumio[938]: info: Output device has changed, restarting MPD
Jul 20 10:44:04 volumiooffice sudo[2500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 20 10:44:04 volumiooffice sudo[2500]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:04 volumiooffice volumio[938]: info: Output device has changed, restarting Shairport Sync
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 20 10:44:04 volumiooffice sudo[2500]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:04 volumiooffice sudo[2502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 20 10:44:04 volumiooffice sudo[2502]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:04 volumiooffice systemd[1]: Stopping Music Player Daemon...
Jul 20 10:44:04 volumiooffice volumio[938]: xcb_connection_has_error() returned true
Jul 20 10:44:04 volumiooffice volumio[938]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 20 10:44:04 volumiooffice volumio[938]: xcb_connection_has_error() returned true
Jul 20 10:44:04 volumiooffice volumio[938]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice systemd[1]: mpd.service: Succeeded.
Jul 20 10:44:04 volumiooffice systemd[1]: Stopped Music Player Daemon.
Jul 20 10:44:04 volumiooffice vtcs[1751]: [2024-07-20 10:44:04.618] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Jul 20 10:44:04 volumiooffice vtcs[1751]: [2024-07-20 10:44:04.618] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected
Jul 20 10:44:04 volumiooffice volumio[938]: info: PLUGIN START: fusiondsp
Jul 20 10:44:04 volumiooffice volumio[938]: info: Loading i18n strings for locale de
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: FusionDsp - mixtype--------------------- None
Jul 20 10:44:04 volumiooffice volumio[938]: info: Preparing to generate the ALSA configuration file
Jul 20 10:44:04 volumiooffice sudo[2511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 20 10:44:04 volumiooffice volumio[938]: info: Done.
Jul 20 10:44:04 volumiooffice systemd[1]: Starting Music Player Daemon...
Jul 20 10:44:04 volumiooffice sudo[2511]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:04 volumiooffice systemd[1]: Stopping Volumio Tidal Connect Service...
Jul 20 10:44:04 volumiooffice systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Jul 20 10:44:04 volumiooffice systemd[1]: vtcs.service: Succeeded.
Jul 20 10:44:04 volumiooffice systemd[1]: Stopped Volumio Tidal Connect Service.
Jul 20 10:44:04 volumiooffice sudo[2511]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:04 volumiooffice volumio[938]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jul 20 10:44:04 volumiooffice volumio[938]: info: Reading ALSA contributions from plugins.
Jul 20 10:44:04 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 20 10:44:04 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 20 10:44:04 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 20 10:44:04 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 20 10:44:04 volumiooffice sudo[2515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 20 10:44:04 volumiooffice sudo[2515]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 20 10:44:04 volumiooffice volumio[938]: info: MPD Permissions set
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice sudo[2515]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice sudo[2509]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 20 10:44:04 volumiooffice sudo[2509]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:04 volumiooffice sudo[2509]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:04 volumiooffice volumio[938]: info: Starting Shairport Sync
Jul 20 10:44:04 volumiooffice volumio[938]: info: Asound.conf file unchanged, so no further update is needed
Jul 20 10:44:04 volumiooffice volumio[938]: info: Output device has changed, restarting MPD
Jul 20 10:44:04 volumiooffice sudo[2526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 20 10:44:04 volumiooffice sudo[2526]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:04 volumiooffice systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 20 10:44:04 volumiooffice systemd[1]: shairport-sync.service: Succeeded.
Jul 20 10:44:04 volumiooffice systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 20 10:44:04 volumiooffice volumio[938]: info: Output device has changed, restarting Shairport Sync
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:04 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 20 10:44:04 volumiooffice sudo[2530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 20 10:44:04 volumiooffice sudo[2530]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:05 volumiooffice sudo[2530]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:05 volumiooffice sudo[2532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 20 10:44:05 volumiooffice sudo[2532]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:05 volumiooffice systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 20 10:44:05 volumiooffice sudo[2526]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:05 volumiooffice systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jul 20 10:44:05 volumiooffice systemd[1]: mpd.service: Succeeded.
Jul 20 10:44:05 volumiooffice systemd[1]: Stopped Music Player Daemon.
Jul 20 10:44:05 volumiooffice systemd[1]: Starting Music Player Daemon...
Jul 20 10:44:05 volumiooffice volumio[938]: xcb_connection_has_error() returned true
Jul 20 10:44:05 volumiooffice volumio[938]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 20 10:44:05 volumiooffice volumio[938]: xcb_connection_has_error() returned true
Jul 20 10:44:05 volumiooffice volumio[938]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:05 volumiooffice sudo[2539]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 20 10:44:05 volumiooffice sudo[2539]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:05 volumiooffice sudo[2545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 20 10:44:05 volumiooffice sudo[2545]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:05 volumiooffice sudo[2539]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:05 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 20 10:44:05 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 20 10:44:05 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 20 10:44:05 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 20 10:44:05 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 20 10:44:05 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 20 10:44:05 volumiooffice sudo[2545]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:05 volumiooffice sudo[2549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 20 10:44:05 volumiooffice sudo[2549]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:05 volumiooffice volumio[938]: info: MPD Permissions set
Jul 20 10:44:05 volumiooffice volumio[938]: info: Shairport-Sync Started
Jul 20 10:44:05 volumiooffice volumio[938]: (node:938) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jul 20 10:44:05 volumiooffice volumio[938]: (Use `node --trace-warnings ...` to show where the warning was created)
Jul 20 10:44:05 volumiooffice volumio[938]: (node:938) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jul 20 10:44:05 volumiooffice volumio[938]: (node:938) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jul 20 10:44:05 volumiooffice volumio[938]: (node:938) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jul 20 10:44:05 volumiooffice volumio[938]: (node:938) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:05 volumiooffice sudo[2549]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:05 volumiooffice volumio[938]: info: Starting Shairport Sync
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 20 10:44:05 volumiooffice volumio[938]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 20 10:44:05 volumiooffice volumio[938]: info: Received Get System Version
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 20 10:44:05 volumiooffice volumio[938]: info: Received Get System Info
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 20 10:44:05 volumiooffice volumio[938]: info: Discovery: Getting this device information
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::volumioGetState
Jul 20 10:44:05 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 10:44:05 volumiooffice sudo[2559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 20 10:44:05 volumiooffice sudo[2559]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:05 volumiooffice systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 20 10:44:05 volumiooffice systemd[1]: shairport-sync.service: Succeeded.
Jul 20 10:44:05 volumiooffice systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 20 10:44:05 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 20 10:44:05 volumiooffice volumio[938]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 20 10:44:05 volumiooffice systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 20 10:44:05 volumiooffice sudo[2559]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:05 volumiooffice volumio[938]: info: Shairport-Sync Started
Jul 20 10:44:05 volumiooffice mpd[2550]: Jul 20 10:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 20 10:44:05 volumiooffice systemd[1]: Started Music Player Daemon.
Jul 20 10:44:05 volumiooffice sudo[2532]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:05 volumiooffice sudo[2502]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:05 volumiooffice volumio[938]: error: MPD error: The expression evaluated to a falsy value:
Jul 20 10:44:05 volumiooffice volumio[938]: assert.ok(self.idling)
Jul 20 10:44:05 volumiooffice volumio[938]: error: The expression evaluated to a falsy value:
Jul 20 10:44:05 volumiooffice volumio[938]: assert.ok(self.idling)
Jul 20 10:44:05 volumiooffice volumio[938]: error: updateQueue error: null
Jul 20 10:44:06 volumiooffice volumio[938]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Jul 20 10:44:06 volumiooffice volumio[938]: info: camilladsp service started and running in background, instance 1
Jul 20 10:44:06 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 20 10:44:06 volumiooffice volumio[938]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jul 20 10:44:06 volumiooffice volumio[938]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Jul 20 10:44:06 volumiooffice volumio[938]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jul 20 10:44:06 volumiooffice volumio[938]: info: FusionDsp loaded
Jul 20 10:44:06 volumiooffice volumio[938]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 20 10:44:06 volumiooffice sudo[2577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Jul 20 10:44:06 volumiooffice sudo[2577]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 20 10:44:06 volumiooffice volumio[938]: info: FusionDsp - Reporting Fusion DSP Enabled
Jul 20 10:44:06 volumiooffice volumio[938]: info: Adding Signal Path Element [object Object]
Jul 20 10:44:06 volumiooffice volumio[938]: info: Adding fusiondspeq DSP Signal Path Element
Jul 20 10:44:06 volumiooffice volumio[938]: info: FusionDsp - ---- installed callbackRead
Jul 20 10:44:06 volumiooffice volumio[938]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 20 10:44:06 volumiooffice sudo[2577]: pam_unix(sudo:session): session closed for user root
Jul 20 10:44:06 volumiooffice volumio[938]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Jul 20 10:44:06 volumiooffice volumio[938]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Jul 20 10:44:06 volumiooffice volumio[938]: at onErrorNT (internal/child_process.js:465:16)
Jul 20 10:44:06 volumiooffice volumio[938]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Jul 20 10:44:06 volumiooffice volumio[938]: errno: -2,
Jul 20 10:44:06 volumiooffice volumio[938]: code: 'ENOENT',
Jul 20 10:44:06 volumiooffice volumio[938]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Jul 20 10:44:06 volumiooffice volumio[938]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Jul 20 10:44:06 volumiooffice volumio[938]: spawnargs: [
Jul 20 10:44:06 volumiooffice volumio[938]: '-p',
Jul 20 10:44:06 volumiooffice volumio[938]: 9876,
Jul 20 10:44:06 volumiooffice volumio[938]: '-o',
Jul 20 10:44:06 volumiooffice volumio[938]: '/tmp/camilladsp.log',
Jul 20 10:44:06 volumiooffice volumio[938]: '-l',
Jul 20 10:44:06 volumiooffice volumio[938]: 'warn',
Jul 20 10:44:06 volumiooffice volumio[938]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Jul 20 10:44:06 volumiooffice volumio[938]: ]
Jul 20 10:44:06 volumiooffice volumio[938]: }
Jul 20 10:44:06 volumiooffice volumio[938]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 20 10:44:07 volumiooffice sudo[2588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-20 10:43
Jul 20 10:44:07 volumiooffice sudo[2588]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"