Dec 30 14:55:00 mambo4 volumio[1282]: info: Discovery: Connected to remote: 192.168.178.15 Dec 30 14:55:00 mambo4 volumio[1282]: info: Discovery: Connected to remote: 192.168.178.80 Dec 30 14:55:00 mambo4 volumio-remote-updater[766]: Test mode enabled Dec 30 14:55:00 mambo4 volumio-remote-updater[766]: Alpha mode disabled Dec 30 14:55:00 mambo4 volumio-remote-updater[766]: Alpha legacy test mode disabled Dec 30 14:55:00 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 30 14:55:00 mambo4 volumio[1282]: error: updateQueue error: null Dec 30 14:55:00 mambo4 volumio[1282]: error: updateQueue error: null Dec 30 14:55:00 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand add "http://158.69.74.203:80" Dec 30 14:55:00 mambo4 volumio[1282]: info: ------------------------------ 1158ms Dec 30 14:55:00 mambo4 volumio[1282]: info: ------------------------------ 1152ms Dec 30 14:55:00 mambo4 volumio[1282]: info: Dec 30 14:55:00 mambo4 volumio[1282]: ---------------------------- MPD announces system playlist update Dec 30 14:55:01 mambo4 volumio[1282]: info: Ignoring MPD Status Update Dec 30 14:55:01 mambo4 volumio[1282]: info: sendMpdCommand add "http://158.69.74.203:80" took 186 milliseconds Dec 30 14:55:01 mambo4 volumio[1282]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 30 14:55:01 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand play Dec 30 14:55:01 mambo4 volumio[1282]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 30 14:55:01 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 30 14:55:01 mambo4 volumio[1282]: info: Dec 30 14:55:01 mambo4 volumio[1282]: ---------------------------- MPD announces system playlist update Dec 30 14:55:01 mambo4 volumio[1282]: info: Ignoring MPD Status Update Dec 30 14:55:01 mambo4 volumio[1282]: info: Dec 30 14:55:01 mambo4 volumio[1282]: ---------------------------- MPD announces system playlist update Dec 30 14:55:01 mambo4 volumio[1282]: info: Ignoring MPD Status Update Dec 30 14:55:01 mambo4 volumio[1282]: info: Dec 30 14:55:01 mambo4 volumio[1282]: ---------------------------- MPD announces state update: player Dec 30 14:55:01 mambo4 volumio[1282]: info: ------------------------------ 729ms Dec 30 14:55:01 mambo4 volumio[1282]: info: sendMpdCommand play took 678 milliseconds Dec 30 14:55:01 mambo4 volumio[1282]: info: ------------------------------ 381ms Dec 30 14:55:01 mambo4 volumio[1282]: info: ------------------------------ 357ms Dec 30 14:55:01 mambo4 volumio[1282]: info: ControllerMpd::getState Dec 30 14:55:01 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Dec 30 14:55:01 mambo4 volumio[1282]: info: Dec 30 14:55:01 mambo4 volumio[1282]: ---------------------------- MPD announces state update: player Dec 30 14:55:01 mambo4 volumio[1282]: info: ControllerMpd::getState Dec 30 14:55:01 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Dec 30 14:55:01 mambo4 volumio[1282]: info: Dec 30 14:55:01 mambo4 volumio[1282]: ---------------------------- MPD announces state update: player Dec 30 14:55:01 mambo4 volumio[1282]: info: ControllerMpd::getState Dec 30 14:55:01 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Dec 30 14:55:01 mambo4 volumio[1282]: info: Dec 30 14:55:01 mambo4 volumio[1282]: ---------------------------- MPD announces system playlist update Dec 30 14:55:02 mambo4 volumio[1282]: info: Ignoring MPD Status Update Dec 30 14:55:02 mambo4 volumio[1282]: info: Dec 30 14:55:02 mambo4 volumio[1282]: ---------------------------- MPD announces state update: player Dec 30 14:55:02 mambo4 volumio[1282]: info: ControllerMpd::getState Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Dec 30 14:55:02 mambo4 volumio[1282]: info: sendMpdCommand status took 310 milliseconds Dec 30 14:55:02 mambo4 volumio[1282]: info: sendMpdCommand status took 275 milliseconds Dec 30 14:55:02 mambo4 volumio[1282]: info: sendMpdCommand status took 255 milliseconds Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::parseState Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::parseState Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::parseState Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 14:55:02 mambo4 volumio[1282]: info: Dec 30 14:55:02 mambo4 volumio[1282]: ---------------------------- MPD announces system playlist update Dec 30 14:55:02 mambo4 volumio[1282]: info: Ignoring MPD Status Update Dec 30 14:55:02 mambo4 volumio[1282]: info: Dec 30 14:55:02 mambo4 volumio[1282]: ---------------------------- MPD announces state update: player Dec 30 14:55:02 mambo4 volumio[1282]: info: ControllerMpd::getState Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Dec 30 14:55:02 mambo4 volumio[1282]: info: Dec 30 14:55:02 mambo4 volumio[1282]: ---------------------------- MPD announces system playlist update Dec 30 14:55:02 mambo4 volumio[1282]: info: Ignoring MPD Status Update Dec 30 14:55:02 mambo4 volumio[1282]: info: Dec 30 14:55:02 mambo4 volumio[1282]: ---------------------------- MPD announces state update: player Dec 30 14:55:02 mambo4 volumio[1282]: info: ControllerMpd::getState Dec 30 14:55:02 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Dec 30 14:55:03 mambo4 volumio[1282]: info: ------------------------------ 1004ms Dec 30 14:55:03 mambo4 volumio[1282]: info: sendMpdCommand status took 959 milliseconds Dec 30 14:55:03 mambo4 volumio[1282]: info: sendMpdCommand playlistinfo took 930 milliseconds Dec 30 14:55:03 mambo4 volumio[1282]: info: sendMpdCommand playlistinfo took 930 milliseconds Dec 30 14:55:03 mambo4 volumio[1282]: info: sendMpdCommand playlistinfo took 929 milliseconds Dec 30 14:55:03 mambo4 volumio[1282]: info: ------------------------------ 897ms Dec 30 14:55:03 mambo4 volumio[1282]: info: sendMpdCommand status took 896 milliseconds Dec 30 14:55:03 mambo4 volumio[1282]: info: ------------------------------ 895ms Dec 30 14:55:03 mambo4 volumio[1282]: info: sendMpdCommand status took 838 milliseconds Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::parseState Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::parseTrackInfo Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::parseTrackInfo Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::parseTrackInfo Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::parseState Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::parseState Dec 30 14:55:03 mambo4 volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 14:55:03 mambo4 volumio[1282]: info: ControllerMpd::pushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreCommandRouter::servicePushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CorePlayQueue::getTrack 0 Dec 30 14:55:03 mambo4 volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Cannonball Adderley - Up And At It","artist":null,"album":null,"uri":"http://158.69.74.203:80","trackType":"203:80"} Dec 30 14:55:03 mambo4 volumio[1282]: verbose: CURRENT POSITION 0 Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::syncState stateService play Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::syncState currentStatus stop Dec 30 14:55:03 mambo4 volumio[1282]: info: ControllerMpd::pushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreCommandRouter::servicePushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CorePlayQueue::getTrack 0 Dec 30 14:55:03 mambo4 volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1078,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Cannonball Adderley - Up And At It","artist":null,"album":null,"uri":"http://158.69.74.203:80","trackType":"203:80"} Dec 30 14:55:03 mambo4 volumio[1282]: verbose: CURRENT POSITION 0 Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::syncState stateService play Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::syncState currentStatus play Dec 30 14:55:03 mambo4 volumio[1282]: info: Received an update from plugin. extracting info from payload Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:03 mambo4 volumio[1282]: info: ControllerMpd::pushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreCommandRouter::servicePushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CorePlayQueue::getTrack 0 Dec 30 14:55:03 mambo4 volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1078,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Cannonball Adderley - Up And At It","artist":null,"album":null,"uri":"http://158.69.74.203:80","trackType":"203:80"} Dec 30 14:55:03 mambo4 volumio[1282]: verbose: CURRENT POSITION 0 Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::syncState stateService play Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::syncState currentStatus play Dec 30 14:55:03 mambo4 volumio[1282]: info: Received an update from plugin. extracting info from payload Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:03 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:03 mambo4 volumio[1282]: info: ------------------------------ 1795ms Dec 30 14:55:03 mambo4 volumio[1282]: info: ------------------------------ 2001ms Dec 30 14:55:03 mambo4 volumio[1282]: info: ------------------------------ 1963ms Dec 30 14:55:04 mambo4 volumio[1282]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 30 14:55:04 mambo4 volumio[1282]: info: sendMpdCommand playlistinfo took 1450 milliseconds Dec 30 14:55:04 mambo4 volumio[1282]: info: sendMpdCommand playlistinfo took 1368 milliseconds Dec 30 14:55:04 mambo4 volumio[1282]: info: sendMpdCommand playlistinfo took 1367 milliseconds Dec 30 14:55:04 mambo4 volumio[1282]: verbose: ControllerMpd::parseTrackInfo Dec 30 14:55:04 mambo4 volumio[1282]: verbose: ControllerMpd::parseTrackInfo Dec 30 14:55:04 mambo4 volumio[1282]: verbose: ControllerMpd::parseTrackInfo Dec 30 14:55:04 mambo4 volumio[1282]: info: ControllerMpd::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::servicePushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CorePlayQueue::getTrack 0 Dec 30 14:55:04 mambo4 volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1388,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Cannonball Adderley - Up And At It","artist":null,"album":null,"uri":"http://158.69.74.203:80","trackType":"203:80"} Dec 30 14:55:04 mambo4 volumio[1282]: verbose: CURRENT POSITION 0 Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::syncState stateService play Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::syncState currentStatus play Dec 30 14:55:04 mambo4 volumio[1282]: info: Received an update from plugin. extracting info from payload Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:04 mambo4 volumio[1282]: info: ControllerMpd::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::servicePushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CorePlayQueue::getTrack 0 Dec 30 14:55:04 mambo4 volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1388,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Cannonball Adderley - Up And At It","artist":null,"album":null,"uri":"http://158.69.74.203:80","trackType":"203:80"} Dec 30 14:55:04 mambo4 volumio[1282]: verbose: CURRENT POSITION 0 Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::syncState stateService play Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::syncState currentStatus play Dec 30 14:55:04 mambo4 volumio[1282]: info: Received an update from plugin. extracting info from payload Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:04 mambo4 volumio[1282]: info: ControllerMpd::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::servicePushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CorePlayQueue::getTrack 0 Dec 30 14:55:04 mambo4 volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1479,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Cannonball Adderley - Up And At It","artist":null,"album":null,"uri":"http://158.69.74.203:80","trackType":"203:80"} Dec 30 14:55:04 mambo4 volumio[1282]: verbose: CURRENT POSITION 0 Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::syncState stateService play Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::syncState currentStatus play Dec 30 14:55:04 mambo4 volumio[1282]: info: Received an update from plugin. extracting info from payload Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:04 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:05 mambo4 volumio[1282]: info: ------------------------------ 3272ms Dec 30 14:55:05 mambo4 volumio[1282]: info: ------------------------------ 3180ms Dec 30 14:55:05 mambo4 volumio[1282]: info: ------------------------------ 3123ms Dec 30 14:55:08 mambo4 volumio[1282]: info: CoreCommandRouter::volumioGetState Dec 30 14:55:12 mambo4 volumio[1282]: info: MyVolumio token set successfully Dec 30 14:55:12 mambo4 volumio[1282]: info: MYVOLUMIO: Adding device Dec 30 14:55:12 mambo4 volumio[1282]: info: MYVOLUMIO: Evaluating Server Dec 30 14:55:12 mambo4 volumio[1282]: Upnp client error: Error: This socket has been ended by the other party Dec 30 14:55:15 mambo4 volumio[1282]: info: MyVolumio Plan changed: superstar Dec 30 14:55:15 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Dec 30 14:55:15 mambo4 volumio[1282]: info: Adding audio output: Dec 30 14:55:15 mambo4 volumio[1282]: info: MYVOLUMIO: Adding device Dec 30 14:55:15 mambo4 volumio[1282]: info: MYVOLUMIO: Evaluating Server Dec 30 14:55:16 mambo4 volumio[1282]: error: MyVolumio Plugin failed to authenticate in a timely fashion Dec 30 14:55:16 mambo4 volumio[1282]: info: Completed starting MyVolumio Plugin Dec 30 14:55:16 mambo4 volumio[1282]: [Metrics] CommandRouter: 111s 634.11ms Dec 30 14:55:16 mambo4 volumio[1282]: info: CoreCommandRouter::volumiosetStartupVolume Dec 30 14:55:16 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 14:55:16 mambo4 volumio[1282]: info: VolumeController:: Setting startup Volume 30 Dec 30 14:55:16 mambo4 volumio[1282]: info: VolumeController::SetAlsaVolume30 Dec 30 14:55:16 mambo4 volumio[1282]: info: Volume script /bin/sh /data/plugins/system_hardware/allo_relay_attenuator/setvolume.sh 18 Dec 30 14:55:16 mambo4 sudo[2116]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/fn-rattenuc -c SET_VOLUME=18 Dec 30 14:55:16 mambo4 sudo[2116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 14:55:16 mambo4 sudo[2116]: pam_unix(sudo:session): session closed for user root Dec 30 14:55:16 mambo4 sudo[2121]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/fn-rattenuc -c SET_MUTE=0 Dec 30 14:55:16 mambo4 sudo[2121]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 14:55:17 mambo4 sudo[2121]: pam_unix(sudo:session): session closed for user root Dec 30 14:55:17 mambo4 volumio[1282]: info: External Volume: SUCCESS Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::Close All Modals sent Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::Close All Modals sent Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreStateMachine::pushState Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::volumioPushState Dec 30 14:55:17 mambo4 volumio[1282]: info: Setting Geolocation for MyVolumio to eu7 Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:17 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:19 mambo4 volumio[1282]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 30 14:55:19 mambo4 volumio[1282]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Dec 30 14:55:19 mambo4 volumio[1282]: aplay: main:831: audio open error: Device or resource busy Dec 30 14:55:19 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 30 14:55:19 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 30 14:55:19 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 30 14:55:19 mambo4 volumio[1282]: info: Updating MyVolumio device info Dec 30 14:55:19 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:19 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:19 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:19 mambo4 volumio[1282]: info: Remote config written successfully Dec 30 14:55:19 mambo4 volumio[1282]: info: Starting Tunnel 1 Dec 30 14:55:19 mambo4 volumio[1282]: info: Starting Tunnel Connection Checker Dec 30 14:55:20 mambo4 volumio[1282]: info: Setting Geolocation for MyVolumio to eu6 Dec 30 14:55:20 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:20 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:20 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:20 mambo4 volumio[1282]: info: MYVolumio Device enabled Dec 30 14:55:20 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Dec 30 14:55:20 mambo4 volumio[1282]: info: MyVolumio status changed Dec 30 14:55:20 mambo4 volumio[1282]: info: Streaming services startup Dec 30 14:55:20 mambo4 volumio[1282]: info: Starting Streaming Daemon Dec 30 14:55:20 mambo4 sudo[2144]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 30 14:55:20 mambo4 sudo[2144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 14:55:20 mambo4 volumio[1282]: info: Successfully Added MyVolumio device Dec 30 14:55:21 mambo4 sudo[2144]: pam_unix(sudo:session): session closed for user root Dec 30 14:55:21 mambo4 volumio[1282]: info: Updating MyVolumio device info Dec 30 14:55:21 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:21 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:21 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 14:55:22 mambo4 volumio[1282]: error: Cannot start Volumio Streaming Daemon Dec 30 14:55:22 mambo4 volumio[1282]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 30 14:55:22 mambo4 volumio[1282]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 30 14:55:24 mambo4 volumio[1282]: info: Successfully Added MyVolumio device Dec 30 14:55:25 mambo4 volumio[1282]: info: Successfully Updated MyVolumio device Dec 30 14:55:25 mambo4 volumio[1282]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 30 14:55:25 mambo4 volumio[1282]: info: BOOT COMPLETED Dec 30 14:55:26 mambo4 volumio[1282]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Dec 30 14:55:28 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Dec 30 14:55:32 mambo4 volumio[1282]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Dec 30 14:55:32 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Dec 30 14:55:55 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Dec 30 14:55:56 mambo4 sudo[2217]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Dec 30 14:55:56 mambo4 sudo[2217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 14:55:56 mambo4 sudo[2217]: pam_unix(sudo:session): session closed for user root Dec 30 14:55:57 mambo4 volumio[1282]: info: MRS: MultiRoom plugin initialized Dec 30 14:55:57 mambo4 volumio[1282]: info: MRS: STOPPING SNAPCLIENT Dec 30 14:55:57 mambo4 volumio[1282]: info: MRS: Snap server stop Dec 30 14:55:57 mambo4 volumio[1282]: info: MRS: STOPPING volumioStreaming Dec 30 14:55:57 mambo4 sudo[2248]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Dec 30 14:55:57 mambo4 sudo[2248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 14:55:57 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Dec 30 14:55:57 mambo4 sudo[2250]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Dec 30 14:55:57 mambo4 sudo[2250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 14:55:57 mambo4 sudo[2252]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Dec 30 14:55:57 mambo4 sudo[2252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 14:55:57 mambo4 sudo[2255]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 30 14:55:57 mambo4 sudo[2255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 14:55:57 mambo4 sudo[2255]: pam_unix(sudo:session): session closed for user root Dec 30 14:55:57 mambo4 sudo[2250]: pam_unix(sudo:session): session closed for user root Dec 30 14:55:57 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Dec 30 14:55:57 mambo4 sudo[2248]: pam_unix(sudo:session): session closed for user root Dec 30 14:55:58 mambo4 sudo[2252]: pam_unix(sudo:session): session closed for user root Dec 30 14:55:58 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Dec 30 14:55:58 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Dec 30 14:55:58 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Dec 30 14:55:58 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Dec 30 14:55:58 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Dec 30 14:55:59 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Dec 30 14:55:59 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Dec 30 14:55:59 mambo4 volumio[1282]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Dec 30 14:55:59 mambo4 volumio[1282]: info: Preparing to generate the ALSA configuration file Dec 30 14:56:00 mambo4 volumio[1282]: info: Successfully Updated MyVolumio device Dec 30 14:56:00 mambo4 volumio[1282]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 30 14:56:00 mambo4 volumio[1282]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 30 14:56:00 mambo4 volumio[1282]: info: Reading ALSA contributions from plugins. Dec 30 14:56:00 mambo4 volumio[1282]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Dec 30 14:56:00 mambo4 volumio[1282]: info: Discovery: Disconnected from remote: 192.168.178.80 Dec 30 14:56:00 mambo4 volumio[1282]: info: MRS: Pushing multiroomSync output for this device Dec 30 14:56:00 mambo4 volumio[1282]: info: MRS: Pushing multiroomSync output Dec 30 14:56:00 mambo4 volumio[1282]: info: Adding audio output: Dec 30 14:56:00 mambo4 volumio[1282]: info: Adding audio output: Dec 30 14:56:00 mambo4 volumio[1282]: info: Discovery: Disconnected from remote: 192.168.178.80 Dec 30 14:56:00 mambo4 volumio[1282]: info: Discovery: Disconnected from remote: 192.168.178.80 Dec 30 14:56:01 mambo4 volumio[1282]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Dec 30 14:56:02 mambo4 volumio[1282]: info: Discovery: Disconnected from remote: 192.168.178.15 Dec 30 14:56:02 mambo4 volumio[1282]: info: Discovery: Disconnected from remote: 192.168.178.15 Dec 30 14:56:02 mambo4 dbus-daemon[739]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30000ms) Dec 30 14:56:02 mambo4 volumio[1282]: info: MRS: Removed streaming files Dec 30 14:56:02 mambo4 volumio[1282]: info: MRS: volumioStreaming STOPPED Dec 30 14:56:02 mambo4 volumio[1282]: info: MRS: SNAPSERVER STOPPED Dec 30 14:56:02 mambo4 volumio[1282]: info: MRS: SNAPCLIENT STOPPED Dec 30 14:56:03 mambo4 volumio[1282]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 14:56:03 mambo4 volumio[1282]: Error: write EPIPE Dec 30 14:56:03 mambo4 volumio[1282]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Dec 30 14:56:03 mambo4 volumio[1282]: at writeGeneric (node:internal/stream_base_commons:151:3) Dec 30 14:56:03 mambo4 volumio[1282]: at Socket._writeGeneric (node:net:952:11) Dec 30 14:56:03 mambo4 volumio[1282]: at Socket._write (node:net:964:8) Dec 30 14:56:03 mambo4 volumio[1282]: at writeOrBuffer (node:internal/streams/writable:399:12) Dec 30 14:56:03 mambo4 volumio[1282]: at _write (node:internal/streams/writable:340:10) Dec 30 14:56:03 mambo4 volumio[1282]: at Writable.write (node:internal/streams/writable:344:10) Dec 30 14:56:03 mambo4 volumio[1282]: at /myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:89:18 Dec 30 14:56:03 mambo4 volumio[1282]: at Socket.readable (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/readline.js:12:11) Dec 30 14:56:03 mambo4 volumio[1282]: at Socket.emit (node:events:514:28) Dec 30 14:56:03 mambo4 volumio[1282]: at emitReadable_ (node:internal/streams/readable:609:12) Dec 30 14:56:03 mambo4 volumio[1282]: at process.processTicksAndRejections (node:internal/process/task_queues:81:21) { Dec 30 14:56:03 mambo4 volumio[1282]: errno: -32, Dec 30 14:56:03 mambo4 volumio[1282]: code: 'EPIPE', Dec 30 14:56:03 mambo4 volumio[1282]: syscall: 'write' Dec 30 14:56:03 mambo4 volumio[1282]: } Dec 30 14:56:03 mambo4 volumio[1282]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 14:56:14 mambo4 sudo[2306]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-30 14:55' Dec 30 14:56:14 mambo4 sudo[2306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"