-- Logs begin at Tue 2025-06-24 14:14:37 CST, end at Tue 2025-06-24 16:12:41 CST. -- Jun 24 16:11:02 ft1905-febf volumio[22021]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jun 24 16:11:02 ft1905-febf volumio[22021]: info: CoreCommandRouter::Close All Modals sent Jun 24 16:11:02 ft1905-febf volumio[22021]: info: CoreCommandRouter::Close All Modals sent Jun 24 16:11:02 ft1905-febf volumio[22021]: Express server listening on port 3000 Jun 24 16:11:02 ft1905-febf volumio[22021]: [Metrics] WebUI: 16s 944.02ms Jun 24 16:11:02 ft1905-febf volumio[22021]: (node:22021) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jun 24 16:11:02 ft1905-febf volumio[22021]: info: [1750752662738] ControllerPandora::validateAndSetAccountOptions Jun 24 16:11:02 ft1905-febf volumio[22021]: error: [1750752662742] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Jun 24 16:11:02 ft1905-febf volumio[22021]: info: CoreStateMachine::resetVolumioState Jun 24 16:11:02 ft1905-febf volumio[22021]: info: CoreStateMachine::getcurrentVolume Jun 24 16:11:02 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioRetrievevolume Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 16:11:03 ft1905-febf volumio[22021]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 24 16:11:03 ft1905-febf sudo[22145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 24 16:11:03 ft1905-febf sudo[22146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 24 16:11:03 ft1905-febf volumio[22021]: Device response: { 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:03 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:02 GMT', Jun 24 16:11:03 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:03 ft1905-febf volumio[22021]: LOCATION: 'http://192.168.2.1:4044/dev.xml', Jun 24 16:11:03 ft1905-febf volumio[22021]: SERVER: 'eXtensible UPnP agent', Jun 24 16:11:03 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:03 ft1905-febf volumio[22021]: USN: Jun 24 16:11:03 ft1905-febf volumio[22021]: 'uuid:60bd2fb3-dabe-cb14-c766-0e319b54c29a::urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:11:03 ft1905-febf volumio[22021]: Device IP: 192.168.2.1 Jun 24 16:11:03 ft1905-febf volumio[22021]: Device response: { 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:03 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:03 GMT', Jun 24 16:11:03 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:03 ft1905-febf volumio[22021]: LOCATION: 'http://192.168.2.1:4044/dev.xml', Jun 24 16:11:03 ft1905-febf volumio[22021]: SERVER: 'eXtensible UPnP agent', Jun 24 16:11:03 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:03 ft1905-febf volumio[22021]: USN: Jun 24 16:11:03 ft1905-febf volumio[22021]: 'uuid:60bd2fb3-dabe-cb14-c766-0e319b54c29a::urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:11:03 ft1905-febf volumio[22021]: Device IP: 192.168.2.1 Jun 24 16:11:03 ft1905-febf volumio[22021]: Device response: { 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:03 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:02 GMT', Jun 24 16:11:03 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:03 ft1905-febf volumio[22021]: LOCATION: 'http://192.168.2.1:4044/dev.xml', Jun 24 16:11:03 ft1905-febf volumio[22021]: SERVER: 'eXtensible UPnP agent', Jun 24 16:11:03 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:03 ft1905-febf volumio[22021]: USN: Jun 24 16:11:03 ft1905-febf volumio[22021]: 'uuid:60bd2fb3-dabe-cb14-c766-0e319b54c29a::urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:11:03 ft1905-febf volumio[22021]: Device IP: 192.168.2.1 Jun 24 16:11:03 ft1905-febf volumio[22021]: Device response: { 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:03 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:03 GMT', Jun 24 16:11:03 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:03 ft1905-febf volumio[22021]: LOCATION: 'http://192.168.2.1:4044/dev.xml', Jun 24 16:11:03 ft1905-febf volumio[22021]: SERVER: 'eXtensible UPnP agent', Jun 24 16:11:03 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:03 ft1905-febf volumio[22021]: USN: Jun 24 16:11:03 ft1905-febf volumio[22021]: 'uuid:60bd2fb3-dabe-cb14-c766-0e319b54c29a::urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:11:03 ft1905-febf volumio[22021]: Device IP: 192.168.2.1 Jun 24 16:11:03 ft1905-febf sudo[22145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 16:11:03 ft1905-febf sudo[22146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 16:11:03 ft1905-febf volumio[22021]: info: this.stateMachine.currentVolume: null, vol: 0 Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreStateMachine::updateTrackBlock Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrackBlock Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioRetrievevolume Jun 24 16:11:03 ft1905-febf sudo[22145]: pam_unix(sudo:session): session closed for user root Jun 24 16:11:03 ft1905-febf sudo[22146]: pam_unix(sudo:session): session closed for user root Jun 24 16:11:03 ft1905-febf volumio[22021]: info: MPD Permissions set Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 24 16:11:03 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:04 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:04 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:04 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:04 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:04 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:04 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:04 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:04 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:04 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:04 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:04 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:04 ft1905-febf volumio[22021]: info: Spotify config file written Jun 24 16:11:04 ft1905-febf sudo[22196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart go-librespot-daemon.service Jun 24 16:11:04 ft1905-febf sudo[22196]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 16:11:04 ft1905-febf systemd[1]: Stopping go-librespot Daemon... Jun 24 16:11:04 ft1905-febf systemd[1]: go-librespot-daemon.service: Succeeded. Jun 24 16:11:04 ft1905-febf systemd[1]: Stopped go-librespot Daemon. Jun 24 16:11:04 ft1905-febf systemd[1]: Started go-librespot Daemon. Jun 24 16:11:04 ft1905-febf sudo[22196]: pam_unix(sudo:session): session closed for user root Jun 24 16:11:04 ft1905-febf go-librespot[22202]: go-librespot daemon starting... Jun 24 16:11:05 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:05+08:00" level=info msg="running go-librespot 0.2.0" Jun 24 16:11:05 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:05+08:00" level=debug msg="app state loaded" Jun 24 16:11:05 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:05+08:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 24 16:11:05 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:11:05 ft1905-febf volumio[22021]: sendCommand: Command { name: 'lsinfo "USB"', args: [] } Jun 24 16:11:05 ft1905-febf volumio[22021]: sendCommand: Command { name: 'search album ""', args: [] } Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:05 ft1905-febf volumio[22170]: Forking 1 albumart workers Jun 24 16:11:05 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:05 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:05 ft1905-febf volumio[22021]: Device response: { 'BOOTID.UPNP.ORG': '1750147265', Jun 24 16:11:05 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'http://192.168.2.143:9365/MediaServer/DeviceDescription.xml', Jun 24 16:11:05 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'Mac-OS-X/13.7.4 UPnP/1.1 DLNADOC/1.5 Cyaneous-FireStream/2.0', Jun 24 16:11:05 ft1905-febf volumio[22021]: USN: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'uuid:3fdad695-204c-65d4-4e83-c8f2cf400401::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:05 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:05 ft1905-febf volumio[22021]: 'CONFIGID.UPNP.ORG': '0', Jun 24 16:11:05 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:03 GMT', Jun 24 16:11:05 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:05 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800' } Jun 24 16:11:05 ft1905-febf volumio[22021]: Device IP: 192.168.2.143 Jun 24 16:11:05 ft1905-febf volumio[22021]: Device response: { LOCATION: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'http://192.168.2.143:9365/MediaServer/DeviceDescription.xml', Jun 24 16:11:05 ft1905-febf volumio[22021]: 'CONFIGID.UPNP.ORG': '0', Jun 24 16:11:05 ft1905-febf volumio[22021]: 'BOOTID.UPNP.ORG': '1750147265', Jun 24 16:11:05 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'Mac-OS-X/13.7.4 UPnP/1.1 DLNADOC/1.5 Cyaneous-FireStream/2.0', Jun 24 16:11:05 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:05 ft1905-febf volumio[22021]: USN: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'uuid:3fdad695-204c-65d4-4e83-c8f2cf400401::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:05 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:02 GMT', Jun 24 16:11:05 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:05 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800' } Jun 24 16:11:05 ft1905-febf volumio[22021]: Device IP: 192.168.2.143 Jun 24 16:11:05 ft1905-febf volumio[22021]: Device response: { EXT: '', Jun 24 16:11:05 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:05 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'Linux/5.4.259-qgki-g6f25851aad0d UPnP/1.0 BubbleUPnP/4.4.13', Jun 24 16:11:05 ft1905-febf volumio[22021]: USN: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'uuid:da1e268e-e6e8-4a0f-ac9a-688b73f80eac::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:05 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:05 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:11:05 ft1905-febf volumio[22021]: 'http://192.168.2.175:58645/dev/da1e268e-e6e8-4a0f-ac9a-688b73f80eac/desc.xml' } Jun 24 16:11:05 ft1905-febf volumio[22021]: Device IP: 192.168.2.175 Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:05 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:05 ft1905-febf volumio[22021]: info: MPD running with PID22101 Jun 24 16:11:05 ft1905-febf volumio[22021]: ,establishing connection Jun 24 16:11:05 ft1905-febf volumio[22021]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jun 24 16:11:05 ft1905-febf volumio[22021]: sudo: /usr/sbin/i2cdetect: command not found Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 16:11:05 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 24 16:11:06 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 16:11:06 ft1905-febf volumio[22021]: info: No need to fix Spotify hosts Jun 24 16:11:06 ft1905-febf volumio[22021]: error: updateQueue error: null Jun 24 16:11:06 ft1905-febf volumio[22021]: Device response: { 'BOOTID.UPNP.ORG': '1750147265', Jun 24 16:11:06 ft1905-febf volumio[22021]: 'CONFIGID.UPNP.ORG': '0', Jun 24 16:11:06 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'Mac-OS-X/13.7.4 UPnP/1.1 DLNADOC/1.5 Cyaneous-FireStream/2.0', Jun 24 16:11:06 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'http://192.168.2.143:9365/MediaServer/DeviceDescription.xml', Jun 24 16:11:06 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:06 ft1905-febf volumio[22021]: USN: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'uuid:3fdad695-204c-65d4-4e83-c8f2cf400401::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:06 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:02 GMT', Jun 24 16:11:06 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:06 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:11:06 ft1905-febf volumio[22021]: Device IP: 192.168.2.143 Jun 24 16:11:06 ft1905-febf volumio[22021]: Device response: { 'BOOTID.UPNP.ORG': '1750147265', Jun 24 16:11:06 ft1905-febf volumio[22021]: 'CONFIGID.UPNP.ORG': '0', Jun 24 16:11:06 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'Mac-OS-X/13.7.4 UPnP/1.1 DLNADOC/1.5 Cyaneous-FireStream/2.0', Jun 24 16:11:06 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'http://192.168.2.143:9365/MediaServer/DeviceDescription.xml', Jun 24 16:11:06 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:06 ft1905-febf volumio[22021]: USN: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'uuid:3fdad695-204c-65d4-4e83-c8f2cf400401::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:06 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:03 GMT', Jun 24 16:11:06 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:06 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800' } Jun 24 16:11:06 ft1905-febf volumio[22021]: Device IP: 192.168.2.143 Jun 24 16:11:06 ft1905-febf volumio[22021]: Device response: { EXT: '', Jun 24 16:11:06 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:06 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'Linux/5.4.259-qgki-g6f25851aad0d UPnP/1.0 BubbleUPnP/4.4.13', Jun 24 16:11:06 ft1905-febf volumio[22021]: USN: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'uuid:da1e268e-e6e8-4a0f-ac9a-688b73f80eac::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:06 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:06 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:11:06 ft1905-febf volumio[22021]: 'http://192.168.2.175:58645/dev/da1e268e-e6e8-4a0f-ac9a-688b73f80eac/desc.xml' } Jun 24 16:11:06 ft1905-febf volumio[22021]: Device IP: 192.168.2.175 Jun 24 16:11:06 ft1905-febf volumio[22021]: info: CoreStateMachine::setRepeat null single undefined Jun 24 16:11:06 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:06 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:06 ft1905-febf volumio[22021]: info: CoreStateMachine::setRandom false Jun 24 16:11:06 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:06 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:07 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:11:07 ft1905-febf volumio[22021]: error: updateQueue error: null Jun 24 16:11:07 ft1905-febf volumio[22021]: info: Starting Shairport Sync Jun 24 16:11:07 ft1905-febf sudo[22234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 24 16:11:07 ft1905-febf volumio[22021]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 24 16:11:07 ft1905-febf volumio[22021]: SPOTIFY: BQAOk4Opco0pHhGBOH6L4KRSPqVmILiv7-Ox19R5fA_EJkm4BiVeopY9-7FoM9CAaY02StI8OvnUz3zylQeOqHYgp-aWMNKkJJkDfrsWNfWZKkBWSI4yGlqqhmesVa7dolr7mE8qxKAo1FNMSoQxNPztzwfIo1eU5TT9MIi1lXXf3nuEAfzSjSU8X7XrUcrrdYUYiN-tHl1NiNhEvzAJynkIg5yRnq5e02t5pQAQbiyFP0pL7GRQqH8W14_U7XNWt4LL2lKK0QshoB5Cd7MeqrnQc4OU-bduBhRLrR8s23t7amXAT94 Jun 24 16:11:07 ft1905-febf volumio[22021]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 24 16:11:07 ft1905-febf volumio[22021]: info: New Spotify access token = BQAOk4Opco0pHhGBOH6L4KRSPqVmILiv7-Ox19R5fA_EJkm4BiVeopY9-7FoM9CAaY02StI8OvnUz3zylQeOqHYgp-aWMNKkJJkDfrsWNfWZKkBWSI4yGlqqhmesVa7dolr7mE8qxKAo1FNMSoQxNPztzwfIo1eU5TT9MIi1lXXf3nuEAfzSjSU8X7XrUcrrdYUYiN-tHl1NiNhEvzAJynkIg5yRnq5e02t5pQAQbiyFP0pL7GRQqH8W14_U7XNWt4LL2lKK0QshoB5Cd7MeqrnQc4OU-bduBhRLrR8s23t7amXAT94 Jun 24 16:11:07 ft1905-febf volumio[22021]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 24 16:11:07 ft1905-febf volumio[22216]: Starting albumart workers Jun 24 16:11:07 ft1905-febf sudo[22234]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 16:11:07 ft1905-febf sudo[22237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 24 16:11:07 ft1905-febf sudo[22237]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 16:11:07 ft1905-febf systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 24 16:11:07 ft1905-febf systemd[1]: shairport-sync.service: Succeeded. Jun 24 16:11:07 ft1905-febf systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 24 16:11:07 ft1905-febf systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 24 16:11:08 ft1905-febf sudo[22234]: pam_unix(sudo:session): session closed for user root Jun 24 16:11:08 ft1905-febf sudo[22237]: pam_unix(sudo:session): session closed for user root Jun 24 16:11:08 ft1905-febf volumio[22021]: Discovery: adding 28bc41e0-af37-44db-b28c-6c26e99ff0b2 Jun 24 16:11:08 ft1905-febf volumio[22021]: info: mDNS: Found device FT1905-febf Jun 24 16:11:08 ft1905-febf volumio[22021]: error: Could not retrieve plugin audio_interface multiroom Jun 24 16:11:08 ft1905-febf volumio[22021]: error: Could not retrieve plugin audio_interface multiroom Jun 24 16:11:08 ft1905-febf volumio[22021]: Discovery: this is already registered, 28bc41e0-af37-44db-b28c-6c26e99ff0b2 Jun 24 16:11:08 ft1905-febf volumio[22021]: info: mDNS: Found device FT1905-febf Jun 24 16:11:08 ft1905-febf volumio[22021]: error: Could not retrieve plugin audio_interface multiroom Jun 24 16:11:08 ft1905-febf volumio[22021]: error: Could not retrieve plugin audio_interface multiroom Jun 24 16:11:08 ft1905-febf volumio[22021]: info: Upmpdcli Daemon Started Jun 24 16:11:08 ft1905-febf volumio[22021]: info: Shairport-Sync Started Jun 24 16:11:08 ft1905-febf volumio[22021]: Error adding Membership: Error: addMembership EINVAL Jun 24 16:11:08 ft1905-febf volumio[22021]: Discovery: this is already registered, 28bc41e0-af37-44db-b28c-6c26e99ff0b2 Jun 24 16:11:08 ft1905-febf volumio[22021]: info: mDNS: Found device FT1905-febf Jun 24 16:11:08 ft1905-febf volumio[22021]: error: Could not retrieve plugin audio_interface multiroom Jun 24 16:11:08 ft1905-febf volumio[22021]: error: Could not retrieve plugin audio_interface multiroom Jun 24 16:11:09 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:09 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:09 ft1905-febf volumio[22021]: info: go-librespot daemon successfully initialized Jun 24 16:11:10 ft1905-febf volumio[22021]: SPOTIFY: User informations: {"country":"NG","display_name":"surui2","email":"surui2@126.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31dobbykadpjqbg53ytmzna3bo7u"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31dobbykadpjqbg53ytmzna3bo7u","id":"31dobbykadpjqbg53ytmzna3bo7u","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee850b8b915c295ca470ca2440a0","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b820b8b915c295ca470ca2440a0","width":64}],"product":"premium","type":"user","uri":"spotify:user:31dobbykadpjqbg53ytmzna3bo7u"} Jun 24 16:11:10 ft1905-febf volumio[22021]: info: Spotify Successfully logged in Jun 24 16:11:10 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 24 16:11:10 ft1905-febf volumio[22021]: info: [1750752670164] CoreMusicLibrary::Adding element Spotify Jun 24 16:11:10 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 24 16:11:10 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:11 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioGetVisibleSources Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 24 16:11:11 ft1905-febf volumio[22021]: info: [pushCmd] {"desc":"getToneInfo","index":5,"getinfo":4} Jun 24 16:11:11 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:11+08:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Jun 24 16:11:11 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:11+08:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jun 24 16:11:11 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:11+08:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 24 16:11:11 ft1905-febf volumio[22021]: error: Could not retrieve plugin audio_interface multiroom Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioGetQueue Jun 24 16:11:11 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:11+08:00" level=info msg="zeroconf server listening on port 46335" Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreStateMachine::getQueue Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CorePlayQueue::getQueue Jun 24 16:11:11 ft1905-febf volumio[22021]: info: Listing playlists Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioGetVisibleSources Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 24 16:11:11 ft1905-febf volumio[22021]: info: [pushCmd] {"desc":"getToneInfo","index":5,"getinfo":4} Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 24 16:11:11 ft1905-febf volumio[22021]: error: Could not retrieve plugin audio_interface multiroom Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioGetQueue Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CoreStateMachine::getQueue Jun 24 16:11:11 ft1905-febf volumio[22021]: info: CorePlayQueue::getQueue Jun 24 16:11:11 ft1905-febf volumio[22021]: info: Listing playlists Jun 24 16:11:12 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:12+08:00" level=debug msg="obtained new client token: AADJTBsO4e45nj8aKrHXa4O4D7YXjy5m3xr2z6EV3J0RpBz3rkhtySK20VzzKMcwMZY5YnjGRAaBOML+4IeSaHoB/5PBCsoytsr16/RIcT5DoIUi9UG712VZzXZeCAtmpE+kFY8AJpI7CkBVJhd04bgaT5X1Jdj5Qso0GL+dGZxcpY3XsZUxEy+rLgR14FXJAMXsVaLhd0/IMFB1Qw6/Ao+CmXzDdH2auWv1w08uA+RaGW8dSQJGeidFdJM=" Jun 24 16:11:12 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:12+08:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Jun 24 16:11:12 ft1905-febf volumio[22021]: info: Initializing connection to go-librespot Websocket Jun 24 16:11:12 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:12+08:00" level=debug msg="new websocket client" Jun 24 16:11:12 ft1905-febf volumio[22021]: info: Connection to go-librespot Websocket established Jun 24 16:11:13 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:13+08:00" level=debug msg="completed keyexchange" Jun 24 16:11:13 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:13+08:00" level=debug msg="completed challenge" Jun 24 16:11:14 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:13+08:00" level=info msg="authenticated AP as 31dobbykadpjqbg53ytmzna3bo7u" Jun 24 16:11:15 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:15+08:00" level=info msg="authenticated Login5 as 31dobbykadpjqbg53ytmzna3bo7u" Jun 24 16:11:15 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:15+08:00" level=debug msg="initializing zeroconf session, username: 31dobbykadpjqbg53ytmzna3bo7u" Jun 24 16:11:15 ft1905-febf socketio[2451]: [2025-06-24 16:11:15] [connect] Successful connection Jun 24 16:11:15 ft1905-febf socketio[2451]: [2025-06-24 16:11:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1750752675 101 Jun 24 16:11:15 ft1905-febf socketio[2451]: sio connected Jun 24 16:11:15 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:15 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:15 ft1905-febf socketio[2451]: socket send Jun 24 16:11:15 ft1905-febf socketio[2451]: command_len 356 Jun 24 16:11:15 ft1905-febf socketio[2451]: pushSrctotal Jun 24 16:11:15 ft1905-febf socketio[2451]: { Jun 24 16:11:15 ft1905-febf socketio[2451]: "total": 7, Jun 24 16:11:15 ft1905-febf socketio[2451]: "cur": 0, Jun 24 16:11:15 ft1905-febf socketio[2451]: "source": [{ Jun 24 16:11:15 ft1905-febf socketio[2451]: "type": 0, Jun 24 16:11:15 ft1905-febf socketio[2451]: "name": "Media Player" Jun 24 16:11:15 ft1905-febf socketio[2451]: }, { Jun 24 16:11:15 ft1905-febf socketio[2451]: "type": 4, Jun 24 16:11:15 ft1905-febf socketio[2451]: "name": "Bluetooth" Jun 24 16:11:15 ft1905-febf socketio[2451]: }, { Jun 24 16:11:15 ft1905-febf socketio[2451]: "type": 6, Jun 24 16:11:15 ft1905-febf socketio[2451]: "name": "AUX" Jun 24 16:11:15 ft1905-febf socketio[2451]: }, { Jun 24 16:11:15 ft1905-febf socketio[2451]: "type": 5, Jun 24 16:11:15 ft1905-febf socketio[2451]: "name": "DIGITAL OPT1" Jun 24 16:11:15 ft1905-febf socketio[2451]: }, { Jun 24 16:11:15 ft1905-febf socketio[2451]: "type": 5, Jun 24 16:11:15 ft1905-febf socketio[2451]: "name": "DIGITAL OPT2" Jun 24 16:11:15 ft1905-febf socketio[2451]: }, { Jun 24 16:11:15 ft1905-febf socketio[2451]: "type": 5, Jun 24 16:11:15 ft1905-febf socketio[2451]: "name": "HDMI ARC" Jun 24 16:11:15 ft1905-febf socketio[2451]: }, { Jun 24 16:11:15 ft1905-febf socketio[2451]: "type": 0, Jun 24 16:11:15 ft1905-febf socketio[2451]: "name": "USB" Jun 24 16:11:15 ft1905-febf socketio[2451]: }] Jun 24 16:11:15 ft1905-febf socketio[2451]: } Jun 24 16:11:15 ft1905-febf volumio[22021]: info: [pushSrctotal] {"cur":0,"source":[{"name":"Media Player","type":0},{"name":"Bluetooth","type":4},{"name":"AUX","type":6},{"name":"DIGITAL OPT1","type":5},{"name":"DIGITAL OPT2","type":5},{"name":"HDMI ARC","type":5},{"name":"USB","type":0}],"total":7} Jun 24 16:11:15 ft1905-febf volumio[22021]: info: [pushCmd] {"desc":"getSourceInfo","index":5,"getinfo":1} Jun 24 16:11:15 ft1905-febf socketio[2451]: socket send Jun 24 16:11:15 ft1905-febf socketio[2451]: command_len 31 Jun 24 16:11:15 ft1905-febf socketio[2451]: pushSourceInfo Jun 24 16:11:15 ft1905-febf socketio[2451]: { Jun 24 16:11:15 ft1905-febf socketio[2451]: "source": 0 Jun 24 16:11:15 ft1905-febf socketio[2451]: } Jun 24 16:11:15 ft1905-febf volumio[22021]: info: [pushSourceInfo] {"source":0} Jun 24 16:11:15 ft1905-febf volumio[22021]: info: [pushCmd] {"desc":"getSourceInfo","index":5,"getinfo":1} Jun 24 16:11:15 ft1905-febf socketio[2451]: socket send Jun 24 16:11:15 ft1905-febf socketio[2451]: command_len 31 Jun 24 16:11:15 ft1905-febf socketio[2451]: pushSourceInfo Jun 24 16:11:15 ft1905-febf socketio[2451]: { Jun 24 16:11:15 ft1905-febf socketio[2451]: "source": 0 Jun 24 16:11:15 ft1905-febf socketio[2451]: } Jun 24 16:11:15 ft1905-febf volumio[22021]: info: [pushSourceInfo] {"source":0} Jun 24 16:11:15 ft1905-febf volumio[22021]: SPOTIFY: resetSpotifyState Jun 24 16:11:15 ft1905-febf volumio[22021]: info: Getting Spotify volume Jun 24 16:11:15 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jun 24 16:11:16 ft1905-febf volumio[22021]: info: [pushCmd] {"index":5,"getInfo":0} Jun 24 16:11:16 ft1905-febf socketio[2451]: socket send Jun 24 16:11:16 ft1905-febf socketio[2451]: command_len 356 Jun 24 16:11:16 ft1905-febf socketio[2451]: pushSrctotal Jun 24 16:11:16 ft1905-febf socketio[2451]: { Jun 24 16:11:16 ft1905-febf socketio[2451]: "total": 7, Jun 24 16:11:16 ft1905-febf socketio[2451]: "cur": 0, Jun 24 16:11:16 ft1905-febf socketio[2451]: "source": [{ Jun 24 16:11:16 ft1905-febf socketio[2451]: "type": 0, Jun 24 16:11:16 ft1905-febf socketio[2451]: "name": "Media Player" Jun 24 16:11:16 ft1905-febf socketio[2451]: }, { Jun 24 16:11:16 ft1905-febf socketio[2451]: "type": 4, Jun 24 16:11:16 ft1905-febf socketio[2451]: "name": "Bluetooth" Jun 24 16:11:16 ft1905-febf socketio[2451]: }, { Jun 24 16:11:16 ft1905-febf socketio[2451]: "type": 6, Jun 24 16:11:16 ft1905-febf socketio[2451]: "name": "AUX" Jun 24 16:11:16 ft1905-febf socketio[2451]: }, { Jun 24 16:11:16 ft1905-febf socketio[2451]: "type": 5, Jun 24 16:11:16 ft1905-febf socketio[2451]: "name": "DIGITAL OPT1" Jun 24 16:11:16 ft1905-febf socketio[2451]: }, { Jun 24 16:11:16 ft1905-febf socketio[2451]: "type": 5, Jun 24 16:11:16 ft1905-febf socketio[2451]: "name": "DIGITAL OPT2" Jun 24 16:11:16 ft1905-febf socketio[2451]: }, { Jun 24 16:11:16 ft1905-febf socketio[2451]: "type": 5, Jun 24 16:11:16 ft1905-febf socketio[2451]: "name": "HDMI ARC" Jun 24 16:11:16 ft1905-febf socketio[2451]: }, { Jun 24 16:11:16 ft1905-febf socketio[2451]: "type": 0, Jun 24 16:11:16 ft1905-febf socketio[2451]: "name": "USB" Jun 24 16:11:16 ft1905-febf socketio[2451]: }] Jun 24 16:11:16 ft1905-febf socketio[2451]: } Jun 24 16:11:16 ft1905-febf volumio[22021]: info: [pushSrctotal] {"cur":0,"source":[{"name":"Media Player","type":0},{"name":"Bluetooth","type":4},{"name":"AUX","type":6},{"name":"DIGITAL OPT1","type":5},{"name":"DIGITAL OPT2","type":5},{"name":"HDMI ARC","type":5},{"name":"USB","type":0}],"total":7} Jun 24 16:11:16 ft1905-febf volumio[22021]: info: [pushCmd] {"desc":"getSourceInfo","index":5,"getinfo":1} Jun 24 16:11:16 ft1905-febf socketio[2451]: socket send Jun 24 16:11:16 ft1905-febf socketio[2451]: command_len 31 Jun 24 16:11:16 ft1905-febf socketio[2451]: pushSourceInfo Jun 24 16:11:16 ft1905-febf socketio[2451]: { Jun 24 16:11:16 ft1905-febf socketio[2451]: "source": 0 Jun 24 16:11:16 ft1905-febf socketio[2451]: } Jun 24 16:11:16 ft1905-febf volumio[22021]: info: [pushSourceInfo] {"source":0} Jun 24 16:11:16 ft1905-febf volumio[22021]: info: [pushCmd] {"desc":"getSourceInfo","index":5,"getinfo":1} Jun 24 16:11:16 ft1905-febf socketio[2451]: socket send Jun 24 16:11:16 ft1905-febf socketio[2451]: command_len 31 Jun 24 16:11:16 ft1905-febf socketio[2451]: pushSourceInfo Jun 24 16:11:16 ft1905-febf socketio[2451]: { Jun 24 16:11:16 ft1905-febf socketio[2451]: "source": 0 Jun 24 16:11:16 ft1905-febf socketio[2451]: } Jun 24 16:11:16 ft1905-febf volumio[22021]: info: [pushSourceInfo] {"source":0} Jun 24 16:11:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:16+08:00" level=debug msg="dealer connection opened" Jun 24 16:11:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:16+08:00" level=trace msg="starting accesspoint recv loop" Jun 24 16:11:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:16+08:00" level=trace msg="starting dealer recv loop" Jun 24 16:11:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:16+08:00" level=debug msg="received connection id: NTUzYmIzNDktNTc0MS00Njc4LTk3NmUtZWJlZmFlN2QwMGY4K2RlYWxlcit0Y3A6Ly8wYWNiZjlhZC5pcC5ndWUxLnNwb3RpZnkubmV0OjU3MDArQzk4M0E1ODU5RjA2QjUwRDVDNDc2QTkxNUVCQ0U0MUU1NjI5NTQwRjYwQTFDNEQzMUFEQjcwNUI5OEMxQzY1Qg==" Jun 24 16:11:16 ft1905-febf volumio[22021]: info: Spotify volume: 100 Jun 24 16:11:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:16+08:00" level=trace msg="received accesspoint ping" Jun 24 16:11:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:16+08:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 24 16:11:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:16+08:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 24 16:11:17 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:17+08:00" level=debug msg="put connect state because NEW_DEVICE" Jun 24 16:11:17 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:17+08:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 24 16:11:17 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:17+08:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 24 16:11:17 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:17+08:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 24 16:11:17 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:17+08:00" level=trace msg="received accesspoint pong ack" Jun 24 16:11:27 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 24 16:11:27 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioReplaceAndPlayItems Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CoreStateMachine::ClearQueue Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CoreStateMachine::stop Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CoreStateMachine::serviceStop Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CoreStateMachine::serviceStop trackBlock undefined Jun 24 16:11:29 ft1905-febf volumio[22021]: info: ControllerMpd::stop Jun 24 16:11:29 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CorePlayQueue::clearPlayQueue Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CorePlayQueue::saveQueue Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioPushQueue Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CoreStateMachine::addQueueItems Jun 24 16:11:29 ft1905-febf volumio[22021]: info: CorePlayQueue::addQueueItems Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136948303 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689146] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136948303 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/137473592 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689175] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/137473592 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135460168 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689183] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135460168 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136412327 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689217] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136412327 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135487846 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689227] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135487846 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948330 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689235] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948330 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123794560 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689241] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123794560 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844159 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689250] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844159 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/131664137 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689254] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/131664137 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136948305 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689259] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136948305 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952904 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689263] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952904 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110926514 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689267] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110926514 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664349 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689272] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664349 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948331 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689277] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948331 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844160 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689281] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844160 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/51966596 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689285] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/51966596 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110926515 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689289] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110926515 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135525907 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689294] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135525907 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844161 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689298] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844161 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664434 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689302] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664434 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/131664153 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689307] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/131664153 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948324 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689311] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948324 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844165 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689315] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844165 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/138862049 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689320] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/138862049 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135826100 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689324] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135826100 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/128936920 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689328] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/128936920 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126331261 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689332] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126331261 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136412230 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689337] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136412230 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844163 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689341] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844163 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/133243357 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689345] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/133243357 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/139057202 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689350] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/139057202 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463355 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689356] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463355 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/138862050 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689361] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/138862050 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/137631648 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689371] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/137631648 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132652266 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689375] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132652266 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123773438 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689379] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123773438 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/133925808 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689383] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/133925808 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/134020772 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689388] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/134020772 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844166 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689392] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844166 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/138862052 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689396] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/138862052 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952905 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689401] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952905 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948313 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689405] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948313 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/139057204 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689409] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/139057204 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844167 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689413] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844167 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/138862051 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689418] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/138862051 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136262387 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689423] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136262387 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132679728 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689427] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132679728 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463353 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689431] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463353 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/129006029 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689436] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/129006029 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844168 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689440] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844168 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948306 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689444] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948306 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463354 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689448] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463354 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/139057209 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689453] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/139057209 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/134020654 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689528] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/134020654 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110211822 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689542] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110211822 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952907 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689559] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952907 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463363 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689576] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463363 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/51966603 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689590] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/51966603 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123119433 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689607] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123119433 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126331262 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689620] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126331262 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948315 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689640] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948315 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/129806489 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689653] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/129806489 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948321 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689671] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948321 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123213870 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689688] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123213870 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948314 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689695] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948314 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952906 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689703] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952906 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136262428 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689710] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136262428 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463362 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689718] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463362 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463349 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689734] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463349 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/54823281 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689740] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/54823281 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463352 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689744] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463352 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132679730 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689750] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132679730 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136074057 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689757] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136074057 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/131664110 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689768] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/131664110 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948327 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689773] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948327 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948320 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689784] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948320 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135487855 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689791] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135487855 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664366 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689797] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664366 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/51966600 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689805] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/51966600 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948312 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689811] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948312 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463369 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689817] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463369 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132652260 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689824] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132652260 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952908 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689830] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952908 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136262422 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689836] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136262422 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463638 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689842] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463638 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123254462 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689848] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123254462 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664489 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689857] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664489 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135526035 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689865] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135526035 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664438 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689871] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664438 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132652324 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689877] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132652324 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136262404 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689884] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136262404 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948326 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689890] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948326 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136311304 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689896] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136311304 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136057674 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689904] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136057674 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/131664129 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689911] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/131664129 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136057680 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689917] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136057680 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/137631644 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689925] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/137631644 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664412 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689931] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664412 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463357 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689938] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463357 Jun 24 16:11:29 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135526030 in service yandex_browser Jun 24 16:11:29 ft1905-febf volumio[22021]: info: [1750752689944] ControllerYandexPlugin::explodeUri Jun 24 16:11:29 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135526030 Jun 24 16:11:29 ft1905-febf volumio[22021]: sendCommand: Command { name: 'stop', args: [] } Jun 24 16:11:29 ft1905-febf socketio[2451]: socket send Jun 24 16:11:29 ft1905-febf socketio[2451]: socket send Jun 24 16:11:29 ft1905-febf socketio[2451]: socket send Jun 24 16:11:30 ft1905-febf volumio[22021]: info: sendMpdCommand stop took 1655 milliseconds Jun 24 16:11:30 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:11:30 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:11:30 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:11:30 ft1905-febf volumio[22021]: info: sendMpdCommand status took 5 milliseconds Jun 24 16:11:30 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:11:30 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:11:30 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: stop Jun 24 16:11:30 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:11:30 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:30 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:30 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null,"service":"mpd"} Jun 24 16:11:30 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 0 Jun 24 16:11:30 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService stop Jun 24 16:11:30 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus stop Jun 24 16:11:30 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:30 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:30 ft1905-febf volumio[22021]: info: No code Jun 24 16:11:30 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:30 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:30 ft1905-febf socketio[2451]: socket send Jun 24 16:11:30 ft1905-febf socketio[2451]: socket send Jun 24 16:11:30 ft1905-febf socketio[2451]: socket send Jun 24 16:11:30 ft1905-febf volumio[22021]: info: [pushCmd] {"desc":"changeSource","index":0} Jun 24 16:11:30 ft1905-febf socketio[2451]: socket send Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CorePlayQueue::saveQueue Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioPushQueue Jun 24 16:11:35 ft1905-febf socketio[2451]: socket send Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::updateTrackBlock Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrackBlock Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioPlay Jun 24 16:11:35 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:11:35 ft1905-febf volumio[22021]: !! !! Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 16:11:35 ft1905-febf volumio[22021]: !! !! Jun 24 16:11:35 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:11:35 ft1905-febf volumio[22021]: verbose: UNSET VOLATILE undefined Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::play index 0 currentPosition 0 Jun 24 16:11:35 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:11:35 ft1905-febf volumio[22021]: !! !! Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 16:11:35 ft1905-febf volumio[22021]: !! !! Jun 24 16:11:35 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::stop Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::serviceStop Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::serviceStop trackBlock {"uri":"yandex/track/136948303","service":"yandex_browser","type":"song","albumart":"https://avatars.yandex.net/get-music-content/14439424/867d97d3.a.35745775-1/200x200","artist":"Leader Beats, Deep House, Hans Zimmer","album":null,"name":"Gladiator 2","title":"Gladiator 2"} Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreCommandRouter::serviceStop Jun 24 16:11:35 ft1905-febf volumio[22021]: info: [1750752695796] ControllerYandexPlugin::stop Jun 24 16:11:35 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 16:11:35 ft1905-febf volumio[22021]: sendCommand: Command { name: 'stop', args: [] } Jun 24 16:11:35 ft1905-febf volumio[22021]: info: sendMpdCommand stop took 9 milliseconds Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::play index undefined currentPosition 0 Jun 24 16:11:35 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:11:35 ft1905-febf volumio[22021]: !! !! Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 16:11:35 ft1905-febf volumio[22021]: !! !! Jun 24 16:11:35 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:11:35 ft1905-febf volumio[22021]: play trackBlock: {"uri":"yandex/track/136948303","service":"yandex_browser","type":"song","albumart":"https://avatars.yandex.net/get-music-content/14439424/867d97d3.a.35745775-1/200x200","artist":"Leader Beats, Deep House, Hans Zimmer","album":null,"name":"Gladiator 2","title":"Gladiator 2"} Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::startPlaybackTimer Jun 24 16:11:35 ft1905-febf volumio[22021]: info: [1750752695814] ControllerYandexPlugin::clearAddPlayTrack Jun 24 16:11:35 ft1905-febf volumio[22021]: info: clearAddPlayTrack track: {"uri":"yandex/track/136948303","service":"yandex_browser","type":"song","albumart":"https://avatars.yandex.net/get-music-content/14439424/867d97d3.a.35745775-1/200x200","artist":"Leader Beats, Deep House, Hans Zimmer","album":null,"name":"Gladiator 2","title":"Gladiator 2"} Jun 24 16:11:35 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 16:11:35 ft1905-febf socketio[2451]: socket send Jun 24 16:11:35 ft1905-febf volumio[22021]: sendCommand: Command { name: 'stop', args: [] } Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CoreStateMachine::updateTrackBlock Jun 24 16:11:35 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrackBlock Jun 24 16:11:35 ft1905-febf volumio[22021]: info: sendMpdCommand stop took 17 milliseconds Jun 24 16:11:35 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand clear Jun 24 16:11:35 ft1905-febf volumio[22021]: sendCommand: Command { name: 'clear', args: [] } Jun 24 16:11:35 ft1905-febf volumio[22021]: info: Jun 24 16:11:35 ft1905-febf volumio[22021]: ---------------------------- MPD announces system playlist update Jun 24 16:11:35 ft1905-febf volumio[22021]: info: Ignoring MPD Status Update Jun 24 16:11:35 ft1905-febf volumio[22021]: info: sendMpdCommand clear took 9 milliseconds Jun 24 16:11:35 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:11:35 ft1905-febf volumio[22021]: info: Jun 24 16:11:35 ft1905-febf volumio[22021]: ---------------------------- MPD announces system playlist update Jun 24 16:11:35 ft1905-febf volumio[22021]: info: Ignoring MPD Status Update Jun 24 16:11:35 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:11:35 ft1905-febf volumio[22021]: error: updateQueue error: null Jun 24 16:11:35 ft1905-febf volumio[22021]: error: updateQueue error: null Jun 24 16:11:35 ft1905-febf volumio[22021]: info: ------------------------------ 36ms Jun 24 16:11:35 ft1905-febf volumio[22021]: info: ------------------------------ 19ms Jun 24 16:11:38 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand load "https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad" Jun 24 16:11:38 ft1905-febf volumio[22021]: sendCommand: Command { Jun 24 16:11:38 ft1905-febf volumio[22021]: name: Jun 24 16:11:38 ft1905-febf volumio[22021]: 'load "https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad"', Jun 24 16:11:38 ft1905-febf volumio[22021]: args: [] } Jun 24 16:11:39 ft1905-febf volumio[22021]: error: clearAddPlayTrack error: Error: [50@0] {load} No such playlist Jun 24 16:11:39 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand add "https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad" Jun 24 16:11:39 ft1905-febf volumio[22021]: sendCommand: Command { Jun 24 16:11:39 ft1905-febf volumio[22021]: name: Jun 24 16:11:39 ft1905-febf volumio[22021]: 'add "https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad"', Jun 24 16:11:39 ft1905-febf volumio[22021]: args: [] } Jun 24 16:11:39 ft1905-febf volumio[22021]: info: sendMpdCommand add "https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad" took 4 milliseconds Jun 24 16:11:39 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:11:39 ft1905-febf volumio[22021]: !! !! Jun 24 16:11:39 ft1905-febf volumio[22021]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 24 16:11:39 ft1905-febf volumio[22021]: !! !! Jun 24 16:11:39 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:11:39 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand play Jun 24 16:11:39 ft1905-febf volumio[22021]: sendCommand: Command { name: 'play', args: [] } Jun 24 16:11:39 ft1905-febf volumio[22021]: info: Jun 24 16:11:39 ft1905-febf volumio[22021]: ---------------------------- MPD announces system playlist update Jun 24 16:11:39 ft1905-febf volumio[22021]: info: Ignoring MPD Status Update Jun 24 16:11:39 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:11:39 ft1905-febf volumio[22021]: info: Jun 24 16:11:39 ft1905-febf volumio[22021]: ---------------------------- MPD announces system playlist update Jun 24 16:11:39 ft1905-febf volumio[22021]: info: Ignoring MPD Status Update Jun 24 16:11:39 ft1905-febf volumio[22021]: info: sendMpdCommand play took 35 milliseconds Jun 24 16:11:39 ft1905-febf volumio[22021]: info: ------------------------------ 32ms Jun 24 16:11:39 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:11:39 ft1905-febf volumio[22021]: info: ------------------------------ 26ms Jun 24 16:11:41 ft1905-febf volumio[22021]: info: Jun 24 16:11:41 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:11:41 ft1905-febf kernel: sunxi-spdif 2036000.spdif: active: 1 Jun 24 16:11:41 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:11:41 ft1905-febf volumio[22021]: info: Jun 24 16:11:41 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:11:41 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:11:41 ft1905-febf volumio[22021]: info: Jun 24 16:11:41 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:11:41 ft1905-febf volumio[22021]: info: sendMpdCommand status took 44 milliseconds Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:11:41 ft1905-febf volumio[22021]: info: sendMpdCommand status took 12 milliseconds Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:11:41 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:11:41 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:11:41 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:11:41 ft1905-febf volumio[22021]: info: Jun 24 16:11:41 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:11:41 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:11:41 ft1905-febf volumio[22021]: info: sendMpdCommand status took 30 milliseconds Jun 24 16:11:41 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 26 milliseconds Jun 24 16:11:41 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 22 milliseconds Jun 24 16:11:41 ft1905-febf volumio[22021]: info: sendMpdCommand status took 11 milliseconds Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:11:41 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: play Jun 24 16:11:41 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:11:41 ft1905-febf volumio[22021]: set volatileService undefined Jun 24 16:11:41 ft1905-febf volumio[22021]: info: volatileService: undefined Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","artist":null,"album":null,"uri":"https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","trackType":"","service":"mpd"} Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 0 Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService play Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus stop Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: play Jun 24 16:11:41 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:11:41 ft1905-febf volumio[22021]: set volatileService undefined Jun 24 16:11:41 ft1905-febf volumio[22021]: info: volatileService: undefined Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","artist":null,"album":null,"uri":"https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","trackType":"","service":"mpd"} Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 0 Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService play Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus play Jun 24 16:11:41 ft1905-febf volumio[22021]: info: Received an update from plugin. extracting info from payload Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:11:41 ft1905-febf socketio[2451]: socket send Jun 24 16:11:41 ft1905-febf socketio[2451]: socket send Jun 24 16:11:41 ft1905-febf socketio[2451]: socket send Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ------------------------------ 230ms Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ------------------------------ 202ms Jun 24 16:11:41 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 164 milliseconds Jun 24 16:11:41 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 147 milliseconds Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: play Jun 24 16:11:41 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:11:41 ft1905-febf volumio[22021]: set volatileService undefined Jun 24 16:11:41 ft1905-febf volumio[22021]: info: volatileService: undefined Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","artist":null,"album":null,"uri":"https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","trackType":"","service":"mpd"} Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 0 Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService play Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus play Jun 24 16:11:41 ft1905-febf volumio[22021]: info: Received an update from plugin. extracting info from payload Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: play Jun 24 16:11:41 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:11:41 ft1905-febf volumio[22021]: set volatileService undefined Jun 24 16:11:41 ft1905-febf volumio[22021]: info: volatileService: undefined Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","artist":null,"album":null,"uri":"https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","trackType":"","service":"mpd"} Jun 24 16:11:41 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 0 Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService play Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus play Jun 24 16:11:41 ft1905-febf volumio[22021]: info: Received an update from plugin. extracting info from payload Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:11:41 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:11:41 ft1905-febf socketio[2451]: socket send Jun 24 16:11:41 ft1905-febf socketio[2451]: socket send Jun 24 16:11:41 ft1905-febf socketio[2451]: socket send Jun 24 16:11:41 ft1905-febf socketio[2451]: socket send Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ------------------------------ 351ms Jun 24 16:11:41 ft1905-febf volumio[22021]: info: ------------------------------ 327ms Jun 24 16:11:46 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:46+08:00" level=trace msg="sent dealer ping" Jun 24 16:11:46 ft1905-febf volumio[22021]: Device response: { 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:46 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:46 GMT', Jun 24 16:11:46 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:46 ft1905-febf volumio[22021]: LOCATION: 'http://192.168.2.1:4044/dev.xml', Jun 24 16:11:46 ft1905-febf volumio[22021]: SERVER: 'eXtensible UPnP agent', Jun 24 16:11:46 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:46 ft1905-febf volumio[22021]: USN: Jun 24 16:11:46 ft1905-febf volumio[22021]: 'uuid:60bd2fb3-dabe-cb14-c766-0e319b54c29a::urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:11:46 ft1905-febf volumio[22021]: Device IP: 192.168.2.1 Jun 24 16:11:46 ft1905-febf volumio[22021]: Device response: { 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:46 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:46 GMT', Jun 24 16:11:46 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:46 ft1905-febf volumio[22021]: LOCATION: 'http://192.168.2.1:4044/dev.xml', Jun 24 16:11:46 ft1905-febf volumio[22021]: SERVER: 'eXtensible UPnP agent', Jun 24 16:11:46 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:46 ft1905-febf volumio[22021]: USN: Jun 24 16:11:46 ft1905-febf volumio[22021]: 'uuid:60bd2fb3-dabe-cb14-c766-0e319b54c29a::urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:11:46 ft1905-febf volumio[22021]: Device IP: 192.168.2.1 Jun 24 16:11:47 ft1905-febf go-librespot[22206]: time="2025-06-24T16:11:47+08:00" level=trace msg="received dealer pong" Jun 24 16:11:48 ft1905-febf volumio[22021]: Device response: { LOCATION: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'http://192.168.2.143:9365/MediaServer/DeviceDescription.xml', Jun 24 16:11:48 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'Mac-OS-X/13.7.4 UPnP/1.1 DLNADOC/1.5 Cyaneous-FireStream/2.0', Jun 24 16:11:48 ft1905-febf volumio[22021]: 'CONFIGID.UPNP.ORG': '0', Jun 24 16:11:48 ft1905-febf volumio[22021]: USN: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'uuid:3fdad695-204c-65d4-4e83-c8f2cf400401::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:48 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:48 ft1905-febf volumio[22021]: 'BOOTID.UPNP.ORG': '1750147265', Jun 24 16:11:48 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:46 GMT', Jun 24 16:11:48 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:48 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800' } Jun 24 16:11:48 ft1905-febf volumio[22021]: Device IP: 192.168.2.143 Jun 24 16:11:48 ft1905-febf volumio[22021]: Device response: { LOCATION: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'http://192.168.2.143:9365/MediaServer/DeviceDescription.xml', Jun 24 16:11:48 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'Mac-OS-X/13.7.4 UPnP/1.1 DLNADOC/1.5 Cyaneous-FireStream/2.0', Jun 24 16:11:48 ft1905-febf volumio[22021]: 'CONFIGID.UPNP.ORG': '0', Jun 24 16:11:48 ft1905-febf volumio[22021]: USN: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'uuid:3fdad695-204c-65d4-4e83-c8f2cf400401::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:48 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:11:48 ft1905-febf volumio[22021]: 'BOOTID.UPNP.ORG': '1750147265', Jun 24 16:11:48 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:11:46 GMT', Jun 24 16:11:48 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:48 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800' } Jun 24 16:11:48 ft1905-febf volumio[22021]: Device IP: 192.168.2.143 Jun 24 16:11:48 ft1905-febf volumio[22021]: Device response: { EXT: '', Jun 24 16:11:48 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:48 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'Linux/5.4.259-qgki-g6f25851aad0d UPnP/1.0 BubbleUPnP/4.4.13', Jun 24 16:11:48 ft1905-febf volumio[22021]: USN: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'uuid:da1e268e-e6e8-4a0f-ac9a-688b73f80eac::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:48 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:48 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:11:48 ft1905-febf volumio[22021]: 'http://192.168.2.175:58645/dev/da1e268e-e6e8-4a0f-ac9a-688b73f80eac/desc.xml' } Jun 24 16:11:48 ft1905-febf volumio[22021]: Device IP: 192.168.2.175 Jun 24 16:11:49 ft1905-febf volumio[22021]: Device response: { EXT: '', Jun 24 16:11:49 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:49 ft1905-febf volumio[22021]: SERVER: Jun 24 16:11:49 ft1905-febf volumio[22021]: 'Linux/5.4.259-qgki-g6f25851aad0d UPnP/1.0 BubbleUPnP/4.4.13', Jun 24 16:11:49 ft1905-febf volumio[22021]: USN: Jun 24 16:11:49 ft1905-febf volumio[22021]: 'uuid:da1e268e-e6e8-4a0f-ac9a-688b73f80eac::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:11:49 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:11:49 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:11:49 ft1905-febf volumio[22021]: 'http://192.168.2.175:58645/dev/da1e268e-e6e8-4a0f-ac9a-688b73f80eac/desc.xml' } Jun 24 16:11:49 ft1905-febf volumio[22021]: Device IP: 192.168.2.175 Jun 24 16:12:02 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: yandex_browser , handleBrowseUri Jun 24 16:12:02 ft1905-febf volumio[22021]: info: [1750752722658] ControllerYandexPlugin::handleBrowseUri Jun 24 16:12:02 ft1905-febf volumio[22021]: info: handleBrowseUri: "yandex/artist/770028" Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioReplaceAndPlayItems Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreStateMachine::ClearQueue Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreStateMachine::stop Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreStateMachine::serviceStop Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreStateMachine::serviceStop trackBlock {"uri":"yandex/track/136948303","service":"yandex_browser","type":"song","albumart":"https://avatars.yandex.net/get-music-content/14439424/867d97d3.a.35745775-1/200x200","artist":"Leader Beats, Deep House, Hans Zimmer","album":null,"name":"Gladiator 2","title":"Gladiator 2","bitdepth":320,"samplerate":"320 kHz","trackType":"mp3"} Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreCommandRouter::serviceStop Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727046] ControllerYandexPlugin::stop Jun 24 16:12:07 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CorePlayQueue::clearPlayQueue Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CorePlayQueue::saveQueue Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioPushQueue Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CoreStateMachine::addQueueItems Jun 24 16:12:07 ft1905-febf volumio[22021]: info: CorePlayQueue::addQueueItems Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136948303 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727086] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136948303 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/137473592 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727091] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/137473592 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135460168 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727095] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135460168 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136412327 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727099] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136412327 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135487846 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727104] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135487846 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948330 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727108] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948330 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123794560 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727112] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123794560 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844159 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727117] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844159 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/131664137 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727121] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/131664137 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136948305 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727125] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136948305 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952904 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727129] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952904 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110926514 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727134] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110926514 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664349 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727138] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664349 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948331 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727142] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948331 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844160 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727147] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844160 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/51966596 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727151] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/51966596 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110926515 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727156] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110926515 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135525907 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727160] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135525907 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844161 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727165] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844161 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664434 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727169] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664434 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/131664153 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727173] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/131664153 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948324 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727177] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948324 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844165 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727181] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844165 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/138862049 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727185] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/138862049 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135826100 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727190] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135826100 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/128936920 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727194] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/128936920 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126331261 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727198] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126331261 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136412230 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727202] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136412230 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844163 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727206] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844163 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/133243357 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727212] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/133243357 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/139057202 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727216] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/139057202 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463355 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727220] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463355 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/138862050 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727224] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/138862050 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/137631648 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727229] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/137631648 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132652266 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727233] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132652266 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123773438 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727237] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123773438 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/133925808 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727241] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/133925808 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/134020772 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727246] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/134020772 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844166 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727250] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844166 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/138862052 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727254] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/138862052 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952905 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727259] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952905 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948313 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727263] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948313 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/139057204 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727267] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/139057204 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844167 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727272] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844167 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/138862051 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727276] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/138862051 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136262387 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727280] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136262387 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132679728 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727284] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132679728 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463353 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727288] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463353 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/129006029 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727292] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/129006029 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126844168 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727296] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126844168 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948306 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727301] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948306 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463354 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727305] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463354 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/139057209 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727309] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/139057209 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/134020654 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727313] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/134020654 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110211822 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727318] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110211822 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952907 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727322] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952907 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463363 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727327] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463363 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/51966603 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727331] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/51966603 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123119433 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727335] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123119433 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/126331262 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727339] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/126331262 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948315 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727344] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948315 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/129806489 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727348] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/129806489 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948321 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727353] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948321 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123213870 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727357] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123213870 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948314 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727361] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948314 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952906 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727366] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952906 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136262428 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727370] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136262428 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463362 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727374] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463362 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463349 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727379] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463349 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/54823281 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727383] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/54823281 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463352 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727389] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463352 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132679730 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727393] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132679730 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136074057 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727401] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136074057 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/131664110 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727410] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/131664110 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948327 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727436] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948327 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948320 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727440] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948320 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135487855 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727444] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135487855 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664366 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727448] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664366 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/51966600 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727452] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/51966600 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948312 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727457] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948312 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463369 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727461] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463369 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132652260 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727467] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132652260 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/110952908 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727471] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/110952908 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136262422 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727480] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136262422 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463638 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727484] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463638 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/123254462 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727488] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/123254462 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664489 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727492] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664489 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135526035 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727496] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135526035 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664438 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727500] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664438 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/132652324 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727504] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/132652324 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136262404 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727508] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136262404 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135948326 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727512] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135948326 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136311304 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727517] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136311304 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136057674 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727521] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136057674 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/131664129 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727525] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/131664129 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/136057680 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727529] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/136057680 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/137631644 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727533] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/137631644 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/130664412 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727537] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/130664412 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135463357 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727541] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135463357 Jun 24 16:12:07 ft1905-febf volumio[22021]: info: Exploding uri yandex/track/135526030 in service yandex_browser Jun 24 16:12:07 ft1905-febf volumio[22021]: info: [1750752727546] ControllerYandexPlugin::explodeUri Jun 24 16:12:07 ft1905-febf volumio[22021]: info: explodeUri uri: yandex/track/135526030 Jun 24 16:12:07 ft1905-febf volumio[22021]: sendCommand: Command { name: 'stop', args: [] } Jun 24 16:12:07 ft1905-febf socketio[2451]: socket send Jun 24 16:12:07 ft1905-febf socketio[2451]: socket send Jun 24 16:12:07 ft1905-febf socketio[2451]: socket send Jun 24 16:12:08 ft1905-febf volumio[22021]: info: Jun 24 16:12:08 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:12:08 ft1905-febf volumio[22021]: info: sendMpdCommand stop took 1272 milliseconds Jun 24 16:12:08 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:12:08 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:12:08 ft1905-febf volumio[22021]: info: Jun 24 16:12:08 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:12:08 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:12:08 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:12:08 ft1905-febf volumio[22021]: info: sendMpdCommand status took 12 milliseconds Jun 24 16:12:08 ft1905-febf volumio[22021]: info: sendMpdCommand status took 7 milliseconds Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:12:08 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:12:08 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:12:08 ft1905-febf volumio[22021]: info: [pushCmd] {"desc":"changeSource","index":0} Jun 24 16:12:08 ft1905-febf socketio[2451]: socket send Jun 24 16:12:08 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 88 milliseconds Jun 24 16:12:08 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 88 milliseconds Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:12:08 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:12:08 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: stop Jun 24 16:12:08 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:08 ft1905-febf volumio[22021]: 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":"0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","artist":null,"album":null,"uri":"https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","trackType":"","service":"mpd"} Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 0 Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService stop Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus play Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::stPlaybackTimer Jun 24 16:12:08 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:12:08 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: stop Jun 24 16:12:08 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:08 ft1905-febf volumio[22021]: 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":"0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","artist":null,"album":null,"uri":"https://s541vla.storage.yandex.net/get-mp3/b243c7bbe2d521a3ae0fff166f8d707d/0006384db74209b0/rmusic/U2FsdGVkX18uBDDO8yaNO2de7FiDwZxOyqDpSdC2CbRI9_EYtx5JsNEaq_YOn9t_yYaeSySMv7ZUvFrCkqLCg84qHyeqcVgnE8Nz6TlsaD0/0bd703241a371c7d8fb6e9dbd1330ea22d032923e3a85d4c9d284fc87c92a7ad","trackType":"","service":"mpd"} Jun 24 16:12:08 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 0 Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService stop Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus stop Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:08 ft1905-febf volumio[22021]: info: No code Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:08 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:08 ft1905-febf socketio[2451]: socket send Jun 24 16:12:08 ft1905-febf socketio[2451]: socket send Jun 24 16:12:08 ft1905-febf socketio[2451]: socket send Jun 24 16:12:08 ft1905-febf socketio[2451]: socket send Jun 24 16:12:08 ft1905-febf socketio[2451]: socket send Jun 24 16:12:08 ft1905-febf volumio[22021]: info: ------------------------------ 204ms Jun 24 16:12:08 ft1905-febf volumio[22021]: info: ------------------------------ 196ms Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CorePlayQueue::saveQueue Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioPushQueue Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::updateTrackBlock Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrackBlock Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreCommandRouter::volumioPlay Jun 24 16:12:14 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:12:14 ft1905-febf volumio[22021]: !! !! Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 16:12:14 ft1905-febf volumio[22021]: !! !! Jun 24 16:12:14 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:12:14 ft1905-febf volumio[22021]: verbose: UNSET VOLATILE undefined Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::play index 1 currentPosition 0 Jun 24 16:12:14 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:12:14 ft1905-febf volumio[22021]: !! !! Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 16:12:14 ft1905-febf volumio[22021]: !! !! Jun 24 16:12:14 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::stop Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::serviceStop Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::serviceStop trackBlock {"uri":"yandex/track/136948303","service":"yandex_browser","type":"song","albumart":"https://avatars.yandex.net/get-music-content/14439424/867d97d3.a.35745775-1/200x200","artist":"Leader Beats, Deep House, Hans Zimmer","album":null,"name":"Gladiator 2","title":"Gladiator 2"} Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreCommandRouter::serviceStop Jun 24 16:12:14 ft1905-febf volumio[22021]: info: [1750752734530] ControllerYandexPlugin::stop Jun 24 16:12:14 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 16:12:14 ft1905-febf volumio[22021]: sendCommand: Command { name: 'stop', args: [] } Jun 24 16:12:14 ft1905-febf volumio[22021]: info: sendMpdCommand stop took 9 milliseconds Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::currentPosition changed from 0 to 1 Jun 24 16:12:14 ft1905-febf volumio[22021]: Error Jun 24 16:12:14 ft1905-febf volumio[22021]: at CoreStateMachine.set [as currentPosition] (webpack://Volumio2/./app/statemachine.js?:29:21) Jun 24 16:12:14 ft1905-febf volumio[22021]: at Promise.eval [as _successFn] (webpack://Volumio2/./app/statemachine.js?:1006:34) Jun 24 16:12:14 ft1905-febf volumio[22021]: at nextTickCallback (webpack://Volumio2/./node_modules/kew/kew.js?:47:28) Jun 24 16:12:14 ft1905-febf volumio[22021]: at process._tickCallback (internal/process/next_tick.js:61:11) Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::play index undefined currentPosition 1 Jun 24 16:12:14 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:12:14 ft1905-febf volumio[22021]: !! !! Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 16:12:14 ft1905-febf volumio[22021]: !! !! Jun 24 16:12:14 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:14 ft1905-febf volumio[22021]: play trackBlock: {"uri":"yandex/track/137473592","service":"yandex_browser","type":"song","albumart":"https://avatars.yandex.net/get-music-content/14651289/3292203c.a.35929144-1/200x200","artist":"Leader Beats, Deep House","album":null,"name":"Egyptian Vibe","title":"Egyptian Vibe"} Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::startPlaybackTimer Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:14 ft1905-febf volumio[22021]: info: [1750752734551] ControllerYandexPlugin::clearAddPlayTrack Jun 24 16:12:14 ft1905-febf volumio[22021]: info: clearAddPlayTrack track: {"uri":"yandex/track/137473592","service":"yandex_browser","type":"song","albumart":"https://avatars.yandex.net/get-music-content/14651289/3292203c.a.35929144-1/200x200","artist":"Leader Beats, Deep House","album":null,"name":"Egyptian Vibe","title":"Egyptian Vibe"} Jun 24 16:12:14 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 16:12:14 ft1905-febf volumio[22021]: sendCommand: Command { name: 'stop', args: [] } Jun 24 16:12:14 ft1905-febf socketio[2451]: socket send Jun 24 16:12:14 ft1905-febf socketio[2451]: socket send Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CoreStateMachine::updateTrackBlock Jun 24 16:12:14 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrackBlock Jun 24 16:12:14 ft1905-febf volumio[22021]: info: sendMpdCommand stop took 19 milliseconds Jun 24 16:12:14 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand clear Jun 24 16:12:14 ft1905-febf volumio[22021]: sendCommand: Command { name: 'clear', args: [] } Jun 24 16:12:14 ft1905-febf volumio[22021]: info: Jun 24 16:12:14 ft1905-febf volumio[22021]: ---------------------------- MPD announces system playlist update Jun 24 16:12:14 ft1905-febf volumio[22021]: info: Ignoring MPD Status Update Jun 24 16:12:14 ft1905-febf volumio[22021]: info: sendMpdCommand clear took 6 milliseconds Jun 24 16:12:14 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:12:14 ft1905-febf volumio[22021]: info: Jun 24 16:12:14 ft1905-febf volumio[22021]: ---------------------------- MPD announces system playlist update Jun 24 16:12:14 ft1905-febf volumio[22021]: info: Ignoring MPD Status Update Jun 24 16:12:14 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:12:14 ft1905-febf volumio[22021]: error: updateQueue error: null Jun 24 16:12:14 ft1905-febf volumio[22021]: error: updateQueue error: null Jun 24 16:12:14 ft1905-febf volumio[22021]: info: ------------------------------ 29ms Jun 24 16:12:14 ft1905-febf volumio[22021]: info: ------------------------------ 17ms Jun 24 16:12:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:12:16+08:00" level=trace msg="sent dealer ping" Jun 24 16:12:16 ft1905-febf go-librespot[22206]: time="2025-06-24T16:12:16+08:00" level=trace msg="received dealer pong" Jun 24 16:12:17 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand load "https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45" Jun 24 16:12:17 ft1905-febf volumio[22021]: sendCommand: Command { Jun 24 16:12:17 ft1905-febf volumio[22021]: name: Jun 24 16:12:17 ft1905-febf volumio[22021]: 'load "https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45"', Jun 24 16:12:17 ft1905-febf volumio[22021]: args: [] } Jun 24 16:12:18 ft1905-febf volumio[22021]: error: clearAddPlayTrack error: Error: [50@0] {load} No such playlist Jun 24 16:12:18 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand add "https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45" Jun 24 16:12:18 ft1905-febf volumio[22021]: sendCommand: Command { Jun 24 16:12:18 ft1905-febf volumio[22021]: name: Jun 24 16:12:18 ft1905-febf volumio[22021]: 'add "https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45"', Jun 24 16:12:18 ft1905-febf volumio[22021]: args: [] } Jun 24 16:12:18 ft1905-febf volumio[22021]: info: sendMpdCommand add "https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45" took 8 milliseconds Jun 24 16:12:18 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:12:18 ft1905-febf volumio[22021]: !! !! Jun 24 16:12:18 ft1905-febf volumio[22021]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 24 16:12:18 ft1905-febf volumio[22021]: !! !! Jun 24 16:12:18 ft1905-febf volumio[22021]: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! Jun 24 16:12:18 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand play Jun 24 16:12:18 ft1905-febf volumio[22021]: sendCommand: Command { name: 'play', args: [] } Jun 24 16:12:18 ft1905-febf volumio[22021]: info: Jun 24 16:12:18 ft1905-febf volumio[22021]: ---------------------------- MPD announces system playlist update Jun 24 16:12:18 ft1905-febf volumio[22021]: info: Ignoring MPD Status Update Jun 24 16:12:18 ft1905-febf volumio[22021]: info: sendMpdCommand play took 21 milliseconds Jun 24 16:12:18 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:12:18 ft1905-febf volumio[22021]: info: Jun 24 16:12:18 ft1905-febf volumio[22021]: ---------------------------- MPD announces system playlist update Jun 24 16:12:18 ft1905-febf volumio[22021]: info: Ignoring MPD Status Update Jun 24 16:12:18 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [] } Jun 24 16:12:18 ft1905-febf volumio[22021]: info: ------------------------------ 20ms Jun 24 16:12:18 ft1905-febf volumio[22021]: info: ------------------------------ 16ms Jun 24 16:12:19 ft1905-febf volumio[22021]: info: Jun 24 16:12:19 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:12:19 ft1905-febf kernel: sunxi-spdif 2036000.spdif: active: 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:12:19 ft1905-febf volumio[22021]: info: Jun 24 16:12:19 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:12:19 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:12:19 ft1905-febf volumio[22021]: info: Jun 24 16:12:19 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:12:19 ft1905-febf volumio[22021]: info: sendMpdCommand status took 31 milliseconds Jun 24 16:12:19 ft1905-febf volumio[22021]: info: sendMpdCommand status took 16 milliseconds Jun 24 16:12:19 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:12:19 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:12:19 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:12:19 ft1905-febf volumio[22021]: info: Jun 24 16:12:19 ft1905-febf volumio[22021]: ---------------------------- MPD announces state update: player Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ControllerMpd::getState Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand status Jun 24 16:12:19 ft1905-febf volumio[22021]: sendCommand: Command { name: 'status', args: [] } Jun 24 16:12:19 ft1905-febf volumio[22021]: info: sendMpdCommand status took 22 milliseconds Jun 24 16:12:19 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 24 16:12:19 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 24 16:12:19 ft1905-febf volumio[22021]: info: sendMpdCommand status took 7 milliseconds Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseState Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 16:12:19 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: play Jun 24 16:12:19 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:12:19 ft1905-febf volumio[22021]: set volatileService undefined Jun 24 16:12:19 ft1905-febf volumio[22021]: info: volatileService: undefined Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":120,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45","artist":null,"album":null,"uri":"https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45","trackType":"","service":"mpd"} Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService play Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus stop Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: play Jun 24 16:12:19 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:12:19 ft1905-febf volumio[22021]: set volatileService undefined Jun 24 16:12:19 ft1905-febf volumio[22021]: info: volatileService: undefined Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":120,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45","artist":null,"album":null,"uri":"https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45","trackType":"","service":"mpd"} Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService play Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus play Jun 24 16:12:19 ft1905-febf volumio[22021]: info: Received an update from plugin. extracting info from payload Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: sendCommand: Command { name: 'playlistinfo', args: [ 0 ] } Jun 24 16:12:19 ft1905-febf socketio[2451]: socket send Jun 24 16:12:19 ft1905-febf socketio[2451]: socket send Jun 24 16:12:19 ft1905-febf socketio[2451]: socket send Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ------------------------------ 137ms Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ------------------------------ 129ms Jun 24 16:12:19 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 85 milliseconds Jun 24 16:12:19 ft1905-febf volumio[22021]: info: sendMpdCommand playlistinfo took 87 milliseconds Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: ControllerMpd::parseTrackInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: play Jun 24 16:12:19 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:12:19 ft1905-febf volumio[22021]: set volatileService undefined Jun 24 16:12:19 ft1905-febf volumio[22021]: info: volatileService: undefined Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":120,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45","artist":null,"album":null,"uri":"https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45","trackType":"","service":"mpd"} Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService play Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus play Jun 24 16:12:19 ft1905-febf volumio[22021]: info: Received an update from plugin. extracting info from payload Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ControllerMpd::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: this.isVolatile: false, stateService.status: play Jun 24 16:12:19 ft1905-febf volumio[22021]: this.volatileState: {} Jun 24 16:12:19 ft1905-febf volumio[22021]: set volatileService undefined Jun 24 16:12:19 ft1905-febf volumio[22021]: info: volatileService: undefined Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":120,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45","artist":null,"album":null,"uri":"https://s496vla.storage.yandex.net/get-mp3/48450a086328d909454f406ff6350129/0006384db98c56ad/rmusic/U2FsdGVkX18fUEfEBEN2a4kXejp56gfR45BEBjiRoUmuz_THgoitvU32739A2oNdcj10Oq7YS-hfwJQhj9ihbyp9l7_Gww3z8S7wMs2wuCg/4534e16d1b07f5155a4b9901a24b64355b9c20c3b14a10f11768faf34f722d45","trackType":"","service":"mpd"} Jun 24 16:12:19 ft1905-febf volumio[22021]: verbose: CURRENT POSITION 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState stateService play Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::syncState currentStatus play Jun 24 16:12:19 ft1905-febf volumio[22021]: info: Received an update from plugin. extracting info from payload Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreStateMachine::pushState Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CorePlayQueue::getTrack 1 Jun 24 16:12:19 ft1905-febf volumio[22021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 16:12:19 ft1905-febf socketio[2451]: socket send Jun 24 16:12:19 ft1905-febf socketio[2451]: socket send Jun 24 16:12:19 ft1905-febf socketio[2451]: socket send Jun 24 16:12:19 ft1905-febf socketio[2451]: socket send Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ------------------------------ 271ms Jun 24 16:12:19 ft1905-febf volumio[22021]: info: ------------------------------ 249ms Jun 24 16:12:36 ft1905-febf volumio[22021]: Device response: { 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:12:36 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:12:36 GMT', Jun 24 16:12:36 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:12:36 ft1905-febf volumio[22021]: LOCATION: 'http://192.168.2.1:4044/dev.xml', Jun 24 16:12:36 ft1905-febf volumio[22021]: SERVER: 'eXtensible UPnP agent', Jun 24 16:12:36 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:36 ft1905-febf volumio[22021]: USN: Jun 24 16:12:36 ft1905-febf volumio[22021]: 'uuid:60bd2fb3-dabe-cb14-c766-0e319b54c29a::urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:12:36 ft1905-febf volumio[22021]: Device IP: 192.168.2.1 Jun 24 16:12:36 ft1905-febf volumio[22021]: Device response: { 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:12:36 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:12:36 GMT', Jun 24 16:12:36 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:12:36 ft1905-febf volumio[22021]: LOCATION: 'http://192.168.2.1:4044/dev.xml', Jun 24 16:12:36 ft1905-febf volumio[22021]: SERVER: 'eXtensible UPnP agent', Jun 24 16:12:36 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:36 ft1905-febf volumio[22021]: USN: Jun 24 16:12:36 ft1905-febf volumio[22021]: 'uuid:60bd2fb3-dabe-cb14-c766-0e319b54c29a::urn:schemas-upnp-org:device:MediaServer:1' } Jun 24 16:12:36 ft1905-febf volumio[22021]: Device IP: 192.168.2.1 Jun 24 16:12:37 ft1905-febf volumio[22021]: Device response: { EXT: '', Jun 24 16:12:37 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:37 ft1905-febf volumio[22021]: SERVER: Jun 24 16:12:37 ft1905-febf volumio[22021]: 'Linux/5.4.259-qgki-g6f25851aad0d UPnP/1.0 BubbleUPnP/4.4.13', Jun 24 16:12:37 ft1905-febf volumio[22021]: USN: Jun 24 16:12:37 ft1905-febf volumio[22021]: 'uuid:da1e268e-e6e8-4a0f-ac9a-688b73f80eac::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:37 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:12:37 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:12:37 ft1905-febf volumio[22021]: 'http://192.168.2.175:58645/dev/da1e268e-e6e8-4a0f-ac9a-688b73f80eac/desc.xml' } Jun 24 16:12:37 ft1905-febf volumio[22021]: Device IP: 192.168.2.175 Jun 24 16:12:37 ft1905-febf volumio[22021]: Device response: { EXT: '', Jun 24 16:12:37 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:37 ft1905-febf volumio[22021]: SERVER: Jun 24 16:12:37 ft1905-febf volumio[22021]: 'Linux/5.4.259-qgki-g6f25851aad0d UPnP/1.0 BubbleUPnP/4.4.13', Jun 24 16:12:37 ft1905-febf volumio[22021]: USN: Jun 24 16:12:37 ft1905-febf volumio[22021]: 'uuid:da1e268e-e6e8-4a0f-ac9a-688b73f80eac::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:37 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800', Jun 24 16:12:37 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:12:37 ft1905-febf volumio[22021]: 'http://192.168.2.175:58645/dev/da1e268e-e6e8-4a0f-ac9a-688b73f80eac/desc.xml' } Jun 24 16:12:37 ft1905-febf volumio[22021]: Device IP: 192.168.2.175 Jun 24 16:12:38 ft1905-febf volumio[22021]: Device response: { LOCATION: Jun 24 16:12:38 ft1905-febf volumio[22021]: 'http://192.168.2.143:9365/MediaServer/DeviceDescription.xml', Jun 24 16:12:38 ft1905-febf volumio[22021]: SERVER: Jun 24 16:12:38 ft1905-febf volumio[22021]: 'Mac-OS-X/13.7.4 UPnP/1.1 DLNADOC/1.5 Cyaneous-FireStream/2.0', Jun 24 16:12:38 ft1905-febf volumio[22021]: 'CONFIGID.UPNP.ORG': '0', Jun 24 16:12:38 ft1905-febf volumio[22021]: USN: Jun 24 16:12:38 ft1905-febf volumio[22021]: 'uuid:3fdad695-204c-65d4-4e83-c8f2cf400401::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:38 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:12:38 ft1905-febf volumio[22021]: 'BOOTID.UPNP.ORG': '1750147265', Jun 24 16:12:38 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:12:36 GMT', Jun 24 16:12:38 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:38 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800' } Jun 24 16:12:38 ft1905-febf volumio[22021]: Device IP: 192.168.2.143 Jun 24 16:12:38 ft1905-febf volumio[22021]: Device response: { 'BOOTID.UPNP.ORG': '1750147265', Jun 24 16:12:38 ft1905-febf volumio[22021]: 'CONFIGID.UPNP.ORG': '0', Jun 24 16:12:38 ft1905-febf volumio[22021]: SERVER: Jun 24 16:12:38 ft1905-febf volumio[22021]: 'Mac-OS-X/13.7.4 UPnP/1.1 DLNADOC/1.5 Cyaneous-FireStream/2.0', Jun 24 16:12:38 ft1905-febf volumio[22021]: LOCATION: Jun 24 16:12:38 ft1905-febf volumio[22021]: 'http://192.168.2.143:9365/MediaServer/DeviceDescription.xml', Jun 24 16:12:38 ft1905-febf volumio[22021]: EXT: '', Jun 24 16:12:38 ft1905-febf volumio[22021]: USN: Jun 24 16:12:38 ft1905-febf volumio[22021]: 'uuid:3fdad695-204c-65d4-4e83-c8f2cf400401::urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:38 ft1905-febf volumio[22021]: DATE: 'Tue, 24 Jun 2025 08:12:36 GMT', Jun 24 16:12:38 ft1905-febf volumio[22021]: ST: 'urn:schemas-upnp-org:device:MediaServer:1', Jun 24 16:12:38 ft1905-febf volumio[22021]: 'CACHE-CONTROL': 'max-age=1800' } Jun 24 16:12:38 ft1905-febf volumio[22021]: Device IP: 192.168.2.143 Jun 24 16:12:39 ft1905-febf volumio[22021]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 16:12:39 ft1905-febf volumio[22021]: TypeError: Cannot read property 'remoteAddress' of undefined Jun 24 16:12:39 ft1905-febf volumio[22021]: at Socket.eval (webpack://Volumio2/./app/plugins/user_interface/websocket/index.js?:211:78) Jun 24 16:12:39 ft1905-febf volumio[22021]: at Socket.emit (events.js:198:13) Jun 24 16:12:39 ft1905-febf volumio[22021]: at eval (webpack://Volumio2/./node_modules/socket.io/lib/socket.js?:503:12) Jun 24 16:12:39 ft1905-febf volumio[22021]: at process._tickCallback (internal/process/next_tick.js:61:11) Jun 24 16:12:39 ft1905-febf volumio[22021]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 16:12:41 ft1905-febf sudo[22781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-24 16:11 Jun 24 16:12:41 ft1905-febf sudo[22781]: pam_unix(sudo:session): session opened for user root by (uid=0) NAME="Ubuntu" VERSION="20.04.5 LTS (Focal Fossa)" ID=ubuntu ID_LIKE=debian PRETTY_NAME="Ubuntu 20.04.5 LTS" VERSION_ID="20.04" HOME_URL="https://www.ubuntu.com/" SUPPORT_URL="https://help.ubuntu.com/" BUG_REPORT_URL="https://bugs.launchpad.net/ubuntu/" PRIVACY_POLICY_URL="https://www.ubuntu.com/legal/terms-and-policies/privacy-policy" VERSION_CODENAME=focal UBUNTU_CODENAME=focal VOLUMIO_BUILD_VERSION="" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VERSION=1.4.1.157 VOLUMIO_BUILD_DATE=2025-06-17 19:19:17 VOLUMIO_VARIANT=volumio VOLUMIO_HARDWARE=Generic DT based system