-- Logs begin at Sat 2025-06-28 05:51:39 EEST, end at Sat 2025-06-28 12:41:43 EEST. -- Jun 28 12:40:23 volumio go-librespot[1921]: time="2025-06-28T12:40:23+03:00" level=trace msg="sent dealer ping" Jun 28 12:40:24 volumio go-librespot[1921]: time="2025-06-28T12:40:24+03:00" level=trace msg="received dealer pong" Jun 28 12:40:53 volumio go-librespot[1921]: time="2025-06-28T12:40:53+03:00" level=trace msg="sent dealer ping" Jun 28 12:40:54 volumio go-librespot[1921]: time="2025-06-28T12:40:54+03:00" level=trace msg="received dealer pong" Jun 28 12:41:12 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.1.21 from 192.168.1.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 28 12:41:12 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState Jun 28 12:41:12 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:12 volumio volumio[1020]: info: CoreCommandRouter::volumioGetQueue Jun 28 12:41:12 volumio volumio[1020]: info: CoreStateMachine::getQueue Jun 28 12:41:12 volumio volumio[1020]: info: CorePlayQueue::getQueue Jun 28 12:41:12 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Jun 28 12:41:12 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Jun 28 12:41:12 volumio volumio[1020]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Jun 28 12:41:12 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Jun 28 12:41:12 volumio volumio[1020]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Jun 28 12:41:12 volumio volumio[1020]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Jun 28 12:41:12 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Jun 28 12:41:15 volumio volumio[1020]: info: CALLMETHOD: system_controller system setTestPlugins true Jun 28 12:41:15 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jun 28 12:41:15 volumio volumio[1020]: info: Plugins store is now in test mode Jun 28 12:41:16 volumio volumio[1020]: info: CALLMETHOD: system_controller system enableSSH true Jun 28 12:41:16 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , enableSSH Jun 28 12:41:16 volumio sudo[27425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ssh.service Jun 28 12:41:16 volumio sudo[27425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 12:41:16 volumio sudo[27425]: pam_unix(sudo:session): session closed for user root Jun 28 12:41:16 volumio sudo[27427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable ssh.service Jun 28 12:41:16 volumio sudo[27427]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 12:41:16 volumio systemd[1]: Reloading. Jun 28 12:41:16 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 28 12:41:16 volumio systemd[1]: Reloading. Jun 28 12:41:16 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 28 12:41:17 volumio systemd[1]: Reloading. Jun 28 12:41:17 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 28 12:41:17 volumio sudo[27427]: pam_unix(sudo:session): session closed for user root Jun 28 12:41:17 volumio volumio[1020]: info: enable SSH service success Jun 28 12:41:23 volumio go-librespot[1921]: time="2025-06-28T12:41:23+03:00" level=trace msg="sent dealer ping" Jun 28 12:41:24 volumio go-librespot[1921]: time="2025-06-28T12:41:24+03:00" level=trace msg="received dealer pong" Jun 28 12:41:27 volumio sudo[27511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 28 12:41:27 volumio sudo[27511]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 12:41:27 volumio sudo[27511]: pam_unix(sudo:session): session closed for user root Jun 28 12:41:27 volumio sudo[27514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 12:41:27 volumio sudo[27514]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 12:41:27 volumio sudo[27514]: pam_unix(sudo:session): session closed for user root Jun 28 12:41:27 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.1.21 from 192.168.1.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState Jun 28 12:41:27 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 28 12:41:27 volumio sudo[27517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 28 12:41:27 volumio sudo[27517]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 12:41:27 volumio sudo[27517]: pam_unix(sudo:session): session closed for user root Jun 28 12:41:27 volumio sudo[27520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 12:41:27 volumio sudo[27520]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 12:41:27 volumio sudo[27520]: pam_unix(sudo:session): session closed for user root Jun 28 12:41:27 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.1.21 from 192.168.1.120 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState Jun 28 12:41:27 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 28 12:41:27 volumio volumio[1020]: info: Listing playlists Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 28 12:41:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 28 12:41:29 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 28 12:41:29 volumio volumio[1020]: info: Received Get System Info Jun 28 12:41:29 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 12:41:29 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 12:41:29 volumio volumio[1020]: info: Discovery: Getting this device information Jun 28 12:41:29 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState Jun 28 12:41:29 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:29 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 12:41:29 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 28 12:41:31 volumio volumio[1020]: info: CoreCommandRouter::volumioPlay Jun 28 12:41:31 volumio volumio[1020]: info: CoreStateMachine::play index undefined Jun 28 12:41:31 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 12:41:31 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:31 volumio volumio[1020]: info: CoreStateMachine::startPlaybackTimer Jun 28 12:41:31 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:31 volumio volumio[1020]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22IO9Cocq9eak%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Eyes%20of%20the%20Abyss%20-%20Dark%20Oceanic%20Music%20for%20the%20Soul%22%2C%22artist%22%3A%22Dark%20Rise%20Temple%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FIO9Cocq9eak%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCPY-B028BGq8SCYciKH48vlyN67g%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22IO9Cocq9eak%22%7D%7D%7D Jun 28 12:41:31 volumio volumio[1020]: error: [youtube2] Error in VideoModel.getInfo(IO9Cocq9eak): No valid URL to decipher Error: No valid URL to decipher Jun 28 12:41:31 volumio volumio[1020]: at _Player.decipher (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:34251:13) Jun 28 12:41:31 volumio volumio[1020]: at _Format.decipher (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:23105:19) Jun 28 12:41:31 volumio volumio[1020]: at VideoModel._VideoModel_chooseFormat (/data/plugins/music_service/youtube2/dist/lib/model/VideoModel.js:86:39) Jun 28 12:41:31 volumio volumio[1020]: at VideoModel.getPlaybackInfo (/data/plugins/music_service/youtube2/dist/lib/model/VideoModel.js:69:116) Jun 28 12:41:31 volumio volumio[1020]: at runMicrotasks () Jun 28 12:41:31 volumio volumio[1020]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jun 28 12:41:31 volumio volumio[1020]: at async Function.getPlaybackInfoFromUri (/data/plugins/music_service/youtube2/dist/lib/controller/play/PlayController.js:167:19) Jun 28 12:41:31 volumio volumio[1020]: at async PlayController.clearAddPlayTrack (/data/plugins/music_service/youtube2/dist/lib/controller/play/PlayController.js:89:49) Jun 28 12:41:33 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 28 12:41:33 volumio volumio[1020]: info: Received Get System Info Jun 28 12:41:33 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 12:41:33 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 12:41:33 volumio volumio[1020]: info: Discovery: Getting this device information Jun 28 12:41:33 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState Jun 28 12:41:33 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:33 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 12:41:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Jun 28 12:41:36 volumio volumio[1020]: info: [1751103696385] [80s80s] handleBrowseUri curUri: 80s80s Jun 28 12:41:36 volumio volumio[1020]: info: CoreCommandRouter::volumioGetQueue Jun 28 12:41:36 volumio volumio[1020]: info: CoreStateMachine::getQueue Jun 28 12:41:36 volumio volumio[1020]: info: CorePlayQueue::getQueue Jun 28 12:41:36 volumio volumio[1020]: info: Preload queue cleared Jun 28 12:41:38 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Jun 28 12:41:38 volumio volumio[1020]: info: [1751103698650] [80s80s] handleBrowseUri curUri: 80s80s/nineties Jun 28 12:41:38 volumio volumio[1020]: info: [1751103698650] [80s80s] getRadioContent url: nineties Jun 28 12:41:38 volumio volumio[1020]: info: Preload queue cleared Jun 28 12:41:41 volumio volumio[1020]: info: Preload queue cleared Jun 28 12:41:41 volumio volumio[1020]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::ClearQueue Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::stop Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::clearPlayQueue Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::saveQueue Jun 28 12:41:41 volumio volumio[1020]: info: CoreCommandRouter::volumioPushQueue Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::addQueueItems Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::addQueueItems Jun 28 12:41:41 volumio volumio[1020]: info: Preload queue cleared Jun 28 12:41:41 volumio volumio[1020]: info: Adding Item to queue: webnineties/4 Jun 28 12:41:41 volumio volumio[1020]: info: Exploding uri webnineties/4 in service 80s80s Jun 28 12:41:41 volumio volumio[1020]: info: [1751103701494] [80s80s] explodeUri: webnineties/4 Jun 28 12:41:41 volumio volumio[1020]: info: CoreCommandRouter::volumioPushQueue Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::saveQueue Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::updateTrackBlock Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrackBlock Jun 28 12:41:41 volumio volumio[1020]: info: CoreCommandRouter::volumioPlay Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::play index 0 Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::stop Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::play index undefined Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::startPlaybackTimer Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:41 volumio volumio[1020]: info: [1751103701497] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/techno/mp3-192/volumio Jun 28 12:41:41 volumio volumio[1020]: info: [1751103701497] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=261&count=2 Jun 28 12:41:41 volumio volumio[1020]: info: [1751103701801] [80s80s] received new event containing 2 songs. Jun 28 12:41:41 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 12:41:41 volumio volumio[1020]: info: sendMpdCommand stop took 1 milliseconds Jun 28 12:41:41 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand clear Jun 28 12:41:41 volumio volumio[1020]: info: Jun 28 12:41:41 volumio volumio[1020]: ---------------------------- MPD announces system playlist update Jun 28 12:41:41 volumio volumio[1020]: info: Ignoring MPD Status Update Jun 28 12:41:41 volumio volumio[1020]: info: sendMpdCommand clear took 1 milliseconds Jun 28 12:41:41 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand consume 1 Jun 28 12:41:41 volumio volumio[1020]: error: updateQueue error: null Jun 28 12:41:41 volumio volumio[1020]: info: Jun 28 12:41:41 volumio volumio[1020]: ---------------------------- MPD announces state update: options Jun 28 12:41:41 volumio volumio[1020]: info: ------------------------------ 1ms Jun 28 12:41:41 volumio volumio[1020]: info: sendMpdCommand consume 1 took 1 milliseconds Jun 28 12:41:41 volumio volumio[1020]: info: ControllerMpd::getState Jun 28 12:41:41 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand status Jun 28 12:41:41 volumio volumio[1020]: info: [1751103701806] [80s80s] adding url: http://streams.90s90s.de/techno/mp3-192/volumio Jun 28 12:41:41 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/techno/mp3-192/volumio" Jun 28 12:41:41 volumio volumio[1020]: info: Jun 28 12:41:41 volumio volumio[1020]: ---------------------------- MPD announces system playlist update Jun 28 12:41:41 volumio volumio[1020]: info: Ignoring MPD Status Update Jun 28 12:41:41 volumio volumio[1020]: info: sendMpdCommand status took 1 milliseconds Jun 28 12:41:41 volumio volumio[1020]: info: sendMpdCommand add "http://streams.90s90s.de/techno/mp3-192/volumio" took 1 milliseconds Jun 28 12:41:41 volumio volumio[1020]: verbose: ControllerMpd::parseState Jun 28 12:41:41 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand play Jun 28 12:41:41 volumio volumio[1020]: info: ControllerMpd::pushState Jun 28 12:41:41 volumio volumio[1020]: info: CoreCommandRouter::servicePushState Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::pushState Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:41 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 12:41:41 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:41 volumio volumio[1020]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jun 28 12:41:41 volumio volumio[1020]: info: ------------------------------ 7ms Jun 28 12:41:41 volumio volumio[1020]: error: Upnp client error: Error: This socket has been ended by the other party Jun 28 12:41:41 volumio volumio[1020]: info: ------------------------------ 8ms Jun 28 12:41:41 volumio volumio[1020]: info: sendMpdCommand play took 6 milliseconds Jun 28 12:41:41 volumio volumio[1020]: info: [1751103701815] [80s80s] Pushing the next song state: Elektrochemie LK - Strip (Oliver Huntemann Version) Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:41 volumio volumio[1020]: info: CoreCommandRouter::servicePushState Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:41 volumio volumio[1020]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"/albumart?sourceicon=music_service/80s80s/images/90s90s-techno-cover.png","name":"Elektrochemie LK - Strip (Oliver Huntemann Version)","title":"Strip (Oliver Huntemann Version)","artist":"90s90s Techno","album":"","streaming":true,"disableUiControls":true,"duration":"382","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jun 28 12:41:41 volumio volumio[1020]: verbose: CURRENT POSITION 0 Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::syncState stateService play Jun 28 12:41:41 volumio volumio[1020]: info: CoreStateMachine::syncState currentStatus stop Jun 28 12:41:41 volumio volumio[1020]: info: [1751103701816] [80s80s] PlayNextTrack API delay: 30 Jun 28 12:41:41 volumio volumio[1020]: info: [1751103701823] [80s80s] Setting timer to: 23184 milliseconds. Jun 28 12:41:41 volumio volumio[1020]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:41 volumio volumio[1020]: info: CorePlayQueue::getTrack 1 Jun 28 12:41:43 volumio volumio[1020]: info: Preload queue cleared Jun 28 12:41:43 volumio volumio[1020]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 28 12:41:43 volumio volumio[1020]: info: CoreStateMachine::ClearQueue Jun 28 12:41:43 volumio volumio[1020]: info: CoreStateMachine::stop Jun 28 12:41:43 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 12:41:43 volumio volumio[1020]: info: CoreStateMachine::stPlaybackTimer Jun 28 12:41:43 volumio volumio[1020]: info: CoreStateMachine::updateTrackBlock Jun 28 12:41:43 volumio volumio[1020]: info: CorePlayQueue::getTrackBlock Jun 28 12:41:43 volumio volumio[1020]: info: CoreStateMachine::pushState Jun 28 12:41:43 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 Jun 28 12:41:43 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 12:41:43 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState Jun 28 12:41:43 volumio volumio[1020]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 12:41:43 volumio volumio[1020]: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Jun 28 12:41:43 volumio volumio[1020]: at FerrumStreamingControlTechnology.updateStateOnPlayer (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:72:12) Jun 28 12:41:43 volumio volumio[1020]: at FerrumStreamingControlTechnology.pushState (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:183:10) Jun 28 12:41:43 volumio volumio[1020]: at /volumio/app/index.js:326:81 Jun 28 12:41:43 volumio volumio[1020]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jun 28 12:41:43 volumio volumio[1020]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jun 28 12:41:43 volumio volumio[1020]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) Jun 28 12:41:43 volumio volumio[1020]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:530:22) Jun 28 12:41:43 volumio volumio[1020]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1243:12) Jun 28 12:41:43 volumio volumio[1020]: at CoreStateMachine.clearQueue (/volumio/app/statemachine.js:273:8) Jun 28 12:41:43 volumio volumio[1020]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:494:21) Jun 28 12:41:43 volumio volumio[1020]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Jun 28 12:41:43 volumio volumio[1020]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Jun 28 12:41:43 volumio volumio[1020]: at Socket.emit (events.js:315:20) Jun 28 12:41:43 volumio volumio[1020]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jun 28 12:41:43 volumio volumio[1020]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jun 28 12:41:43 volumio volumio[1020]: code: 'NumberExpected' Jun 28 12:41:43 volumio volumio[1020]: } Jun 28 12:41:43 volumio volumio[1020]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 12:41:43 volumio sudo[27556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-28 12:40 Jun 28 12:41:43 volumio sudo[27556]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"