-- Logs begin at Thu 2025-04-24 20:27:25 CEST, end at Wed 2025-05-14 09:50:55 CEST. -- May 14 09:49:01 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 14 09:49:01 volumioorange volumio[22632]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 14 09:49:01 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 14 09:49:01 volumioorange volumio[22632]: info: Received Get System Version May 14 09:49:01 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 14 09:49:01 volumioorange volumio[22632]: info: Received Get System Info May 14 09:49:01 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 09:49:01 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 09:49:01 volumioorange volumio[22632]: info: Discovery: Getting this device information May 14 09:49:01 volumioorange volumio[22632]: info: CoreCommandRouter::volumioGetState May 14 09:49:01 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 09:49:55 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 14 09:49:55 volumioorange volumio[22632]: info: CoreCommandRouter::volumioGetQueue May 14 09:49:55 volumioorange volumio[22632]: info: CoreStateMachine::getQueue May 14 09:49:55 volumioorange volumio[22632]: info: CorePlayQueue::getQueue May 14 09:49:55 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:49:57 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 14 09:49:57 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:50:11 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 14 09:50:11 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 14 09:50:19 volumioorange volumio[22632]: info: minidlna: Stopping minidlna.service May 14 09:50:19 volumioorange sudo[23316]: volumio : unable to resolve host volumioorange May 14 09:50:19 volumioorange sudo[23316]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; May 14 09:50:19 volumioorange sudo[23316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop minidlna.service May 14 09:50:19 volumioorange sudo[23316]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 09:50:19 volumioorange systemd[1]: Stopping MiniDLNA lightweight DLNA/UPnP-AV server... May 14 09:50:19 volumioorange systemd[1]: minidlna.service: Succeeded. May 14 09:50:19 volumioorange systemd[1]: Stopped MiniDLNA lightweight DLNA/UPnP-AV server. May 14 09:50:19 volumioorange sudo[23316]: pam_unix(sudo:session): session closed for user root May 14 09:50:19 volumioorange volumio[22632]: info: minidlna: systemctl stop minidlna.service succeeded. May 14 09:50:19 volumioorange volumio[22632]: info: Disabling plugin minidlna May 14 09:50:19 volumioorange volumio[22632]: info: Done. May 14 09:50:26 volumioorange volumio[22632]: info: [ASDebug] Port: 14 May 14 09:50:26 volumioorange volumio[22632]: info: [ASDebug] Inverted: true May 14 09:50:26 volumioorange volumio[22632]: info: [ASDebug] Delay: 720 May 14 09:50:36 volumioorange sudo[23361]: volumio : unable to resolve host volumioorange May 14 09:50:36 volumioorange sudo[23361]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; May 14 09:50:36 volumioorange sudo[23361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 14 09:50:36 volumioorange sudo[23361]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 09:50:36 volumioorange sudo[23361]: pam_unix(sudo:session): session closed for user root May 14 09:50:36 volumioorange sudo[23363]: volumio : unable to resolve host volumioorange May 14 09:50:36 volumioorange sudo[23363]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; May 14 09:50:36 volumioorange sudo[23363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 09:50:36 volumioorange sudo[23363]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 09:50:36 volumioorange sudo[23363]: pam_unix(sudo:session): session closed for user root May 14 09:50:36 volumioorange volumio[22632]: verbose: New Socket.io Connection to 192.168.190.74 from 192.168.190.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::volumioGetVisibleSources May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::volumioGetState May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::volumioGetQueue May 14 09:50:36 volumioorange volumio[22632]: info: CoreStateMachine::getQueue May 14 09:50:36 volumioorange volumio[22632]: info: CorePlayQueue::getQueue May 14 09:50:36 volumioorange volumio[22632]: info: Listing playlists May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 14 09:50:36 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 14 09:50:38 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 14 09:50:38 volumioorange volumio[22632]: info: Received Get System Info May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 09:50:38 volumioorange volumio[22632]: info: Discovery: Getting this device information May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::volumioGetState May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 14 09:50:38 volumioorange volumio[22632]: info: Received Get System Info May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 09:50:38 volumioorange volumio[22632]: info: Discovery: Getting this device information May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::volumioGetState May 14 09:50:38 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 09:50:40 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 14 09:50:40 volumioorange volumio[22632]: error: Error browsing0:Error: connect ECONNREFUSED 192.168.190.74:8200 May 14 09:50:40 volumioorange volumio[22632]: error: Failed to execute browseSource: May 14 09:50:43 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 14 09:50:43 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:50:46 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 14 09:50:46 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:50:47 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 14 09:50:47 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:50:49 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 14 09:50:49 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:50:49 volumioorange volumio[22632]: info: Preloading song: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@71c59b2a544f11889fc09032ba3dfc0c May 14 09:50:49 volumioorange volumio[22632]: info: Preloading song: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@5e1a05edaf7a6c08444a98a7bc67897c May 14 09:50:49 volumioorange volumio[22632]: info: Preloading song: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@c9f55075d7b496f681d0816a823dc588 May 14 09:50:49 volumioorange volumio[22632]: info: Exploding uri upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@71c59b2a544f11889fc09032ba3dfc0c in service upnp_browser May 14 09:50:49 volumioorange volumio[22632]: info: Exploding uri upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@5e1a05edaf7a6c08444a98a7bc67897c in service upnp_browser May 14 09:50:49 volumioorange volumio[22632]: info: Exploding uri upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@c9f55075d7b496f681d0816a823dc588 in service upnp_browser May 14 09:50:52 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::ClearQueue May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::stop May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::updateTrackBlock May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::getTrackBlock May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::stPlaybackTimer May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::serviceStop May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::serviceStop May 14 09:50:52 volumioorange volumio[22632]: info: [1747209052859] ControllerUPNPBrowser::stop May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand stop May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::clearPlayQueue May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::saveQueue May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushQueue May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::addQueueItems May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::addQueueItems May 14 09:50:52 volumioorange volumio[22632]: info: Preload queue cleared May 14 09:50:52 volumioorange volumio[22632]: info: Adding Item to queue: upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@ST-cd134ecc81850dc76ed64daa82a63edc May 14 09:50:52 volumioorange volumio[22632]: info: Exploding uri upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@ST-cd134ecc81850dc76ed64daa82a63edc in service upnp_browser May 14 09:50:52 volumioorange volumio[22632]: info: Adding Item to queue: upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@SF-8fde5c155d3bc2467b970b4209e6c389 May 14 09:50:52 volumioorange volumio[22632]: info: Exploding uri upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@SF-8fde5c155d3bc2467b970b4209e6c389 in service upnp_browser May 14 09:50:52 volumioorange volumio[22632]: info: Adding Item to queue: upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@TF-ccf3b19fd08b719944713d1ff87a1d8b May 14 09:50:52 volumioorange volumio[22632]: info: Exploding uri upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@TF-ccf3b19fd08b719944713d1ff87a1d8b in service upnp_browser May 14 09:50:52 volumioorange volumio[22632]: info: Adding Item to queue: upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@SF-5f9be3f8ab6a5bec00c826ab1b1f70b5 May 14 09:50:52 volumioorange volumio[22632]: info: Exploding uri upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@SF-5f9be3f8ab6a5bec00c826ab1b1f70b5 in service upnp_browser May 14 09:50:52 volumioorange volumio[22632]: info: Adding Item to queue: upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@UF-89dd869f21164a1697781591f56708ee May 14 09:50:52 volumioorange volumio[22632]: info: Exploding uri upnp/folder/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@UF-89dd869f21164a1697781591f56708ee in service upnp_browser May 14 09:50:52 volumioorange volumio[22632]: info: Adding Item to queue: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@71c59b2a544f11889fc09032ba3dfc0c May 14 09:50:52 volumioorange volumio[22632]: info: Using cached record of: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@71c59b2a544f11889fc09032ba3dfc0c May 14 09:50:52 volumioorange volumio[22632]: info: Adding Item to queue: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@5e1a05edaf7a6c08444a98a7bc67897c May 14 09:50:52 volumioorange volumio[22632]: info: Using cached record of: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@5e1a05edaf7a6c08444a98a7bc67897c May 14 09:50:52 volumioorange volumio[22632]: info: Adding Item to queue: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@c9f55075d7b496f681d0816a823dc588 May 14 09:50:52 volumioorange volumio[22632]: info: Using cached record of: upnp/http://192.168.190.40:45397/UPnPServices/ContentDirectory/control@c9f55075d7b496f681d0816a823dc588 May 14 09:50:52 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:52 volumioorange volumio[22632]: info: May 14 09:50:52 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:52 volumioorange volumio[22632]: info: sendMpdCommand stop took 74 milliseconds May 14 09:50:52 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:52 volumioorange volumio[22632]: info: May 14 09:50:52 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:52 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:52 volumioorange volumio[22632]: info: May 14 09:50:52 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:52 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:52 volumioorange volumio[22632]: info: sendMpdCommand status took 12 milliseconds May 14 09:50:52 volumioorange volumio[22632]: info: sendMpdCommand status took 10 milliseconds May 14 09:50:52 volumioorange volumio[22632]: info: sendMpdCommand status took 7 milliseconds May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:52 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 5 milliseconds May 14 09:50:52 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 5 milliseconds May 14 09:50:52 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 5 milliseconds May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::parseTrackInfo May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::parseTrackInfo May 14 09:50:52 volumioorange volumio[22632]: verbose: ControllerMpd::parseTrackInfo May 14 09:50:52 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:52 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-ba13a10659d7df256dedb7e45710b4b8.flac%3Ftranscoding%3D1%3Bclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D30064771072%3Bfileext%3D.flac","artist":null,"album":null,"uri":"http://192.168.190.40:45397/MediaServer/AudioItems/T-ba13a10659d7df256dedb7e45710b4b8.flac%3Ftranscoding%3D1%3Bclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D30064771072%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:52 volumioorange volumio[22632]: verbose: CURRENT POSITION 6 May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService stop May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus stop May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:52 volumioorange volumio[22632]: info: No code May 14 09:50:52 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:52 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:52 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:53 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-ba13a10659d7df256dedb7e45710b4b8.flac%3Ftranscoding%3D1%3Bclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D30064771072%3Bfileext%3D.flac","artist":null,"album":null,"uri":"http://192.168.190.40:45397/MediaServer/AudioItems/T-ba13a10659d7df256dedb7e45710b4b8.flac%3Ftranscoding%3D1%3Bclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D30064771072%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:53 volumioorange volumio[22632]: verbose: CURRENT POSITION 6 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService stop May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus stop May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: No code May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:53 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-ba13a10659d7df256dedb7e45710b4b8.flac%3Ftranscoding%3D1%3Bclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D30064771072%3Bfileext%3D.flac","artist":null,"album":null,"uri":"http://192.168.190.40:45397/MediaServer/AudioItems/T-ba13a10659d7df256dedb7e45710b4b8.flac%3Ftranscoding%3D1%3Bclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D30064771072%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:53 volumioorange volumio[22632]: verbose: CURRENT POSITION 6 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService stop May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus stop May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: No code May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 6 May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 222ms May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 220ms May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 218ms May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: stop PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushQueue May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::saveQueue May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::updateTrackBlock May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrackBlock May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPlay May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::play index 5 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::stop May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::play index undefined May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 5 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::startPlaybackTimer May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 5 May 14 09:50:53 volumioorange volumio[22632]: info: [1747209053358] ControllerUPNPBrowser::clearAddPlayTrack May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand stop May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand stop took 9 milliseconds May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand clear May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand clear took 4 milliseconds May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac" May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: error: updateQueue error: null May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 11ms May 14 09:50:53 volumioorange volumio[22632]: error: updateQueue error: null May 14 09:50:53 volumioorange volumio[22632]: error: updateQueue error: null May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac" May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 22ms May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 20ms May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand add "http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac" took 6 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand play May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 17ms May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand play took 14 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 13ms May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 14ms May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand status took 38 milliseconds May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand status took 49 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand status took 47 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 19 milliseconds May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseTrackInfo May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 5 May 14 09:50:53 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"525 Kbps","isStreaming":false,"title":"Beauty in the World (Island Mix)","artist":"Macy Gray","album":"Beauty in the World","uri":"http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:53 volumioorange volumio[22632]: verbose: CURRENT POSITION 5 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService play May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus stop May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 82ms May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces system playlist update May 14 09:50:53 volumioorange volumio[22632]: info: Ignoring MPD Status Update May 14 09:50:53 volumioorange volumio[22632]: info: May 14 09:50:53 volumioorange volumio[22632]: ---------------------------- MPD announces state update: player May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::getState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand status May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 57ms May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand status took 45 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 38 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 37 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 26ms May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand status took 21 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 20ms May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand status took 16 milliseconds May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseTrackInfo May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseState May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 5 May 14 09:50:53 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":160,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"525 Kbps","isStreaming":false,"title":"Beauty in the World (Island Mix)","artist":"Macy Gray","album":"Beauty in the World","uri":"http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:53 volumioorange volumio[22632]: verbose: CURRENT POSITION 5 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService play May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus play May 14 09:50:53 volumioorange volumio[22632]: info: Received an update from plugin. extracting info from payload May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 5 May 14 09:50:53 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":205,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1066 Kbps","isStreaming":false,"title":"Beauty in the World (Island Mix)","artist":"Macy Gray","album":"Beauty in the World","uri":"http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:53 volumioorange volumio[22632]: verbose: CURRENT POSITION 5 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService play May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus play May 14 09:50:53 volumioorange volumio[22632]: info: Received an update from plugin. extracting info from payload May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 270ms May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 264ms May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 166 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 163 milliseconds May 14 09:50:53 volumioorange volumio[22632]: info: sendMpdCommand playlistinfo took 163 milliseconds May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseTrackInfo May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseTrackInfo May 14 09:50:53 volumioorange volumio[22632]: verbose: ControllerMpd::parseTrackInfo May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 5 May 14 09:50:53 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1121,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"960 Kbps","isStreaming":false,"title":"Beauty in the World (Island Mix)","artist":"Macy Gray","album":"Beauty in the World","uri":"http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:53 volumioorange volumio[22632]: verbose: CURRENT POSITION 5 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService play May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus play May 14 09:50:53 volumioorange volumio[22632]: info: Received an update from plugin. extracting info from payload May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 5 May 14 09:50:53 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1121,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"960 Kbps","isStreaming":false,"title":"Beauty in the World (Island Mix)","artist":"Macy Gray","album":"Beauty in the World","uri":"http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:53 volumioorange volumio[22632]: verbose: CURRENT POSITION 5 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService play May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus play May 14 09:50:53 volumioorange volumio[22632]: info: Received an update from plugin. extracting info from payload May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: ControllerMpd::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::servicePushState May 14 09:50:53 volumioorange volumio[22632]: info: CorePlayQueue::getTrack 5 May 14 09:50:53 volumioorange volumio[22632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1121,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"960 Kbps","isStreaming":false,"title":"Beauty in the World (Island Mix)","artist":"Macy Gray","album":"Beauty in the World","uri":"http://192.168.190.40:45397/MediaServer/AudioItems/5e1a05edaf7a6c08444a98a7bc67897c.flac%3Fclientuuid%3Dc62523bc-edad-4714-b7a2-2fb3e99c490c%3Binfokey%3D4a1c95805f9938cdf561ec396d441711%3Bupdateid%3D38654705664%3Bfileext%3D.flac","trackType":"flac"} May 14 09:50:53 volumioorange volumio[22632]: verbose: CURRENT POSITION 5 May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState stateService play May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::syncState currentStatus play May 14 09:50:53 volumioorange volumio[22632]: info: Received an update from plugin. extracting info from payload May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreStateMachine::pushState May 14 09:50:53 volumioorange volumio[22632]: info: CoreCommandRouter::volumioPushState May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 409ms May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 376ms May 14 09:50:53 volumioorange volumio[22632]: info: ------------------------------ 371ms May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] CurState: play PrevState: pause May 14 09:50:53 volumioorange volumio[22632]: info: [ASDebug] Togle GPIO: ON May 14 09:50:53 volumioorange volumio[22632]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 09:50:53 volumioorange volumio[22632]: Error: ESPIPE: invalid seek, write May 14 09:50:53 volumioorange volumio[22632]: at Object.writeSync (fs.js:737:3) May 14 09:50:53 volumioorange volumio[22632]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) May 14 09:50:53 volumioorange volumio[22632]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:209:23) May 14 09:50:53 volumioorange volumio[22632]: at AmpSwitchController.parseStatus (/data/plugins/system_controller/ampswitch/index.js:190:86) May 14 09:50:53 volumioorange volumio[22632]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) May 14 09:50:53 volumioorange volumio[22632]: at Socket.onevent (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:278:10) May 14 09:50:53 volumioorange volumio[22632]: at Socket.onpacket (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:236:12) May 14 09:50:53 volumioorange volumio[22632]: at Manager. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) May 14 09:50:53 volumioorange volumio[22632]: at Manager.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) May 14 09:50:53 volumioorange volumio[22632]: at Manager.ondecoded (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:349:8) May 14 09:50:53 volumioorange volumio[22632]: at Decoder. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) May 14 09:50:53 volumioorange volumio[22632]: at Decoder.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) May 14 09:50:53 volumioorange volumio[22632]: at Decoder.add (/data/plugins/system_controller/ampswitch/node_modules/socket.io-parser/index.js:254:12) May 14 09:50:53 volumioorange volumio[22632]: at Manager.ondata (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:339:16) May 14 09:50:53 volumioorange volumio[22632]: at Socket. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) May 14 09:50:53 volumioorange volumio[22632]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) { May 14 09:50:53 volumioorange volumio[22632]: errno: -29, May 14 09:50:53 volumioorange volumio[22632]: syscall: 'write', May 14 09:50:53 volumioorange volumio[22632]: code: 'ESPIPE' May 14 09:50:53 volumioorange volumio[22632]: } May 14 09:50:53 volumioorange volumio[22632]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 09:50:55 volumioorange sudo[23383]: volumio : unable to resolve host volumioorange May 14 09:50:55 volumioorange sudo[23383]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; May 14 09:50:55 volumioorange sudo[23383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-14 09:49 May 14 09:50:55 volumioorange sudo[23383]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 10:02:06 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="orangepione" VOLUMIO_DEVICENAME="Orange Pi One" VOLUMIO_HASH="196dbf07455fd638bf5080f981aa4211"