-- Logs begin at Fri 2026-08-28 20:48:01 UTC, end at Sat 2026-08-29 07:52:58 UTC. -- Aug 29 07:51:03 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 07:51:03 stream-box-s2-ultra volumio[1036]: info: CURURI: music-library Aug 29 07:51:03 stream-box-s2-ultra volumio[1036]: error: Failed LSINFO: null Aug 29 07:51:05 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 07:51:05 stream-box-s2-ultra volumio[1036]: info: CURURI: artists:// Aug 29 07:51:05 stream-box-s2-ultra volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dance%20Wave!/d56e4e42-2ab9-4b93-b856-dabdbee5ed8c.jpg' Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: Received Push USB{"activeRoute":"1","powerShutdown":"0"} Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: inputs , enablePCInput Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioStop Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stop Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stPlaybackTimer Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::updateTrackBlock Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrackBlock Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::serviceStop Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::serviceStop Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: [1787989870094] ControllerWebradio::stop Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand stop took 34 milliseconds Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces state update: player Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::getState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand status Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand status took 2 milliseconds Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseTrackInfo Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::pushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::servicePushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 22ms Aug 29 07:51:10 stream-box-s2-ultra kernel: usb 1-1.4: USB disconnect, device number 4 Aug 29 07:51:10 stream-box-s2-ultra kernel: usb 1-1.4.2: USB disconnect, device number 6 Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: ---------------------------- USB Audio Device Detached Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: inputs , usbAudioDetach Aug 29 07:51:10 stream-box-s2-ultra systemd[1]: Service sound.target is not needed anymore. Stopping. Aug 29 07:51:10 stream-box-s2-ultra systemd[1]: Stopping Sound Card. Aug 29 07:51:10 stream-box-s2-ultra systemd[1]: Stopped target Sound Card. Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: Notifying PC INPUT Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::servicePushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumiosetSourceActivepc_input Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::servicePushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:51:10 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:51:25 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 07:51:25 stream-box-s2-ultra volumio[1036]: info: CURURI: music-library Aug 29 07:51:25 stream-box-s2-ultra volumio[1036]: error: Failed LSINFO: null Aug 29 07:51:27 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 07:51:27 stream-box-s2-ultra volumio[1036]: info: CURURI: artists:// Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: ---------------------------- Client requests Volumio play Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPlay Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::servicePushState Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received inputs Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumiosetSourceActivempd Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::play index undefined Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: Received Push USB{"activeRoute":"0","powerShutdown":"0"} Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: inputs , setPCInputReturn Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus Aug 29 07:51:56 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: inputs , disablePCInput Aug 29 07:51:56 stream-box-s2-ultra kernel: usb 1-1.4: new high-speed USB device number 7 using dwc_otg Aug 29 07:51:56 stream-box-s2-ultra kernel: usb 1-1.4: New USB device found, idVendor=0424, idProduct=2412 Aug 29 07:51:56 stream-box-s2-ultra kernel: usb 1-1.4: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Aug 29 07:51:56 stream-box-s2-ultra kernel: hub 1-1.4:1.0: USB hub found Aug 29 07:51:56 stream-box-s2-ultra kernel: hub 1-1.4:1.0: 2 ports detected Aug 29 07:51:57 stream-box-s2-ultra kernel: usb 1-1.4.2: new high-speed USB device number 8 using dwc_otg Aug 29 07:51:57 stream-box-s2-ultra kernel: usb 1-1.4.2: New USB device found, idVendor=2772, idProduct=0230 Aug 29 07:51:57 stream-box-s2-ultra kernel: usb 1-1.4.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Aug 29 07:51:57 stream-box-s2-ultra kernel: usb 1-1.4.2: Product: Pre Box S2 Digital Aug 29 07:51:57 stream-box-s2-ultra kernel: usb 1-1.4.2: Manufacturer: Pro-Ject Aug 29 07:51:57 stream-box-s2-ultra kernel: input: Pro-Ject Pre Box S2 Digital as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4.2/1-1.4.2:1.3/0003:2772:0230.0002/input/input1 Aug 29 07:51:57 stream-box-s2-ultra kernel: hid-generic 0003:2772:0230.0002: input,hidraw0: USB HID v1.10 Device [Pro-Ject Pre Box S2 Digital] on usb-3f980000.usb-1.4.2/input3 Aug 29 07:51:57 stream-box-s2-ultra systemd[1]: Starting Sound Card. Aug 29 07:51:57 stream-box-s2-ultra systemd[1]: Reached target Sound Card. Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: ---------------------------- USB Audio Device Attached Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: inputs , usbAudioAttach Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: raat , returnFromUSB Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: error: Could not retrieve plugin music_service raat Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: No protocol specified Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: xcb_connection_has_error() returned true Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDefaultMixer Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: No protocol specified Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: xcb_connection_has_error() returned true Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: No protocol specified Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: xcb_connection_has_error() returned true Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: Setting mixer Pre Box S2 Digital for card Pre Box S2 Digital Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: [SpotifyConnect] Creating VLS config file Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: No protocol specified Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: xcb_connection_has_error() returned true Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Pre Box S2 Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::Close All Modals sent Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: [SpotifyConnect] Restarting Vollibrespot Daemon Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: xcb_connection_has_error() returned true Aug 29 07:51:57 stream-box-s2-ultra sudo[3654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Aug 29 07:51:57 stream-box-s2-ultra sudo[3654]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 07:51:57 stream-box-s2-ultra systemd[1]: Stopping Volspotconnect2 Daemon... Aug 29 07:51:57 stream-box-s2-ultra systemd[1]: Starting Volspotconnect2 Daemon... Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Aug 29 07:51:57 stream-box-s2-ultra systemd[1]: Started Volspotconnect2 Daemon. Aug 29 07:51:57 stream-box-s2-ultra sudo[3654]: pam_unix(sudo:session): session closed for user root Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: VolumeController:: Volume=undefined Mute =false Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:51:57 stream-box-s2-ultra volumio[3661]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Aug 29 07:51:57 stream-box-s2-ultra volumio[3661]: Reading Config from "/tmp/volspotify.toml" Aug 29 07:51:57 stream-box-s2-ultra volumio[3661]: [Vollibrespot] : Using Alsa backend with device: plughw:5 Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: Updating push state because input changed Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumiosetSourceActivempd Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Aug 29 07:51:57 stream-box-s2-ultra volumio[1036]: [SpotifyConnect] Vollibrespot Daemon service restarted! Aug 29 07:51:57 stream-box-s2-ultra volumio[3661]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::getcurrentVolume Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioRetrievevolume Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: VolumeController:: Volume=100 Mute =false Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::updateTrackBlock Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrackBlock Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioRetrievevolume Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: VolumeController:: Volume=100 Mute =false Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:00 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:03 stream-box-s2-ultra volumio[1036]: info: Checking Spotify Web API Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioStop Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stop Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stPlaybackTimer Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::updateTrackBlock Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrackBlock Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::serviceStop Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::serviceStop Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: [1787989947319] ControllerWebradio::stop Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 07:52:27 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand stop took 13 milliseconds Aug 29 07:52:32 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 29 07:52:34 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::ClearQueue Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stop Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::clearPlayQueue Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::saveQueue Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushQueue Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::addQueueItems Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::addQueueItems Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: Adding Item to queue: http://stream-dc1.radioparadise.com/rp_192m.ogg Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::saveQueue Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushQueue Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::updateTrackBlock Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrackBlock Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPlay Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::play index 0 Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stop Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::play index undefined Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::startPlaybackTimer Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: [1787989957510] ControllerWebradio::clearAddPlayTrack Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: Updating push state because input changed Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumiosetSourceActivempd Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand stop took 30 milliseconds Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand clear Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces system playlist update Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: Ignoring MPD Status Update Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand clear took 4 milliseconds Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand load "http://stream-dc1.radioparadise.com/rp_192m.ogg" Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: error: updateQueue error: null Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 9ms Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand add "http://stream-dc1.radioparadise.com/rp_192m.ogg" Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces system playlist update Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: Ignoring MPD Status Update Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand add "http://stream-dc1.radioparadise.com/rp_192m.ogg" took 2 milliseconds Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand play Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 4ms Aug 29 07:52:37 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand play took 2 milliseconds Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces state update: player Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::getState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand status Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand status took 22 milliseconds Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces system playlist update Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: Ignoring MPD Status Update Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces state update: player Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::getState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand status Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 4ms Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand status took 3 milliseconds Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseTrackInfo Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::pushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::servicePushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Be Good Tanyas - Broken Telephone","artist":"Radio Paradise (192k Ogg/Vorbis)","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: CURRENT POSITION 0 Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::syncState stateService play Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::syncState currentStatus stop Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 54ms Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand playlistinfo took 20 milliseconds Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseTrackInfo Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::pushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::servicePushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":241876,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Be Good Tanyas - Broken Telephone","artist":"Radio Paradise (192k Ogg/Vorbis)","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: verbose: CURRENT POSITION 0 Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::syncState stateService play Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::syncState currentStatus play Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: Received an update from plugin. extracting info from payload Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 54ms Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: Updating push state because input changed Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumiosetSourceActivempd Aug 29 07:52:38 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::ClearQueue Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stop Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stPlaybackTimer Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::updateTrackBlock Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrackBlock Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::serviceStop Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::serviceStop Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: [1787989971281] ControllerWebradio::stop Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::clearPlayQueue Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::saveQueue Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushQueue Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::addQueueItems Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::addQueueItems Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: Adding Item to queue: http://mscp3.live-streams.nl:8360/flac.flac Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::saveQueue Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushQueue Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::updateTrackBlock Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrackBlock Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPlay Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::play index 0 Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::stop Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: UNSET VOLATILE Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::play index undefined Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::startPlaybackTimer Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: [1787989971317] ControllerWebradio::clearAddPlayTrack Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: Updating push state because input changed Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumiosetSourceActivempd Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces state update: player Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand stop took 102 milliseconds Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::getState Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand status Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand stop took 67 milliseconds Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand clear Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces system playlist update Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: Ignoring MPD Status Update Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand status took 5 milliseconds Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand clear took 4 milliseconds Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseState Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 07:52:51 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8360/flac.flac" Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: error: updateQueue error: null Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 665ms Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand playlistinfo took 660 milliseconds Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8360/flac.flac" Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseTrackInfo Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 673ms Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces system playlist update Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: Ignoring MPD Status Update Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8360/flac.flac" took 6 milliseconds Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand play Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 6ms Aug 29 07:52:52 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand play took 7 milliseconds Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces state update: player Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::getState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand status Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces state update: player Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand status took 13 milliseconds Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::getState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand status Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: ---------------------------- MPD announces system playlist update Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: Ignoring MPD Status Update Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand status took 4 milliseconds Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 5ms Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseTrackInfo Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: ControllerMpd::parseTrackInfo Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::pushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::servicePushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":232,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Naim Radio","album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"} Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: CURRENT POSITION 0 Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::syncState stateService play Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::syncState currentStatus stop Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: ControllerMpd::pushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::servicePushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CorePlayQueue::getTrack 0 Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Naim Radio","album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"} Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: verbose: CURRENT POSITION 0 Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::syncState stateService play Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::syncState currentStatus play Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: Received an update from plugin. extracting info from payload Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreStateMachine::pushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumioPushState Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 63ms Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: ------------------------------ 52ms Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: Updating push state because input changed Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::volumiosetSourceActivempd Aug 29 07:52:54 stream-box-s2-ultra volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: { Error: connect ETIMEDOUT 80.239.138.35:443 Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: at Object._errnoException (util.js:1022:11) Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: at _exceptionWithHostPort (util.js:1044:20) Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: code: 'ETIMEDOUT', Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: errno: 'ETIMEDOUT', Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: syscall: 'connect', Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: address: '80.239.138.35', Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: port: 443 } Aug 29 07:52:57 stream-box-s2-ultra volumio[1036]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 07:52:58 stream-box-s2-ultra sudo[4132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-29 07:51 Aug 29 07:52:58 stream-box-s2-ultra sudo[4132]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="projectsbus2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 17:22:02 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Pro-Ject Audio Systems" VOLUMIO_MODEL="Stream Box S2 ultra" VOLUMIO_VENDOR_MODEL="Pro-Ject Stream Box S2 ultra" VOLUMIO_HASH="a5127ace113e6b9fcf2a1eaed5431093"