-- Logs begin at Sat 2025-07-05 11:36:31 WEST, end at Sat 2025-07-05 12:40:05 WEST. -- Jul 05 12:39:00 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:00 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:00 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:00 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:00 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri Jul 05 12:39:00 volumio volumio[886]: info: [ytmusic-browse] browseUri: ytmusic/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEmusic_home%22%7D%7D Jul 05 12:39:00 volumio volumio[886]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Jul 05 12:39:00 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:00 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:00 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:00 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:00 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:00 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:00 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:00 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:01 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:01 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:01 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:01 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:01 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri Jul 05 12:39:01 volumio volumio[886]: info: [ytmusic-browse] browseUri: ytmusic/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEmusic_explore%22%7D%7D Jul 05 12:39:01 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:01 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:01 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:01 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:02 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:02 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:02 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:02 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:02 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:02 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:02 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:02 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:03 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:03 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:03 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri Jul 05 12:39:03 volumio volumio[886]: info: [ytmusic-browse] browseUri: ytmusic/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEmusic_library_landing%22%7D%7D Jul 05 12:39:03 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:03 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:03 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:03 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:03 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:03 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:04 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:04 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:04 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:04 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:04 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:04 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:04 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:04 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:05 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:05 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:05 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:05 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:05 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:05 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:06 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:06 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:06 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:06 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:06 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:06 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:06 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:06 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Jul 05 12:39:07 volumio volumio[886]: info: [1751715547216] [80s80s] handleBrowseUri curUri: 80s80s Jul 05 12:39:07 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:07 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:07 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:07 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:07 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:08 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:08 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:08 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:08 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:08 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Jul 05 12:39:08 volumio volumio[886]: info: [1751715548829] [80s80s] handleBrowseUri curUri: 80s80s/nineties Jul 05 12:39:08 volumio volumio[886]: info: [1751715548831] [80s80s] getRadioContent url: nineties Jul 05 12:39:08 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:08 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:08 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:08 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:08 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:14 volumio volumio-remote-updater[534]: [2025-07-05 12:39:14] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jul 05 12:39:18 volumio kernel: hwmon hwmon1: Voltage normalised Jul 05 12:39:19 volumio volumio-remote-updater[534]: [2025-07-05 12:39:19] [connect] Successful connection Jul 05 12:39:22 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 05 12:39:29 volumio go-librespot[1425]: time="2025-07-05T12:39:29+01:00" level=trace msg="sent dealer ping" Jul 05 12:39:29 volumio go-librespot[1425]: time="2025-07-05T12:39:29+01:00" level=trace msg="received dealer pong" Jul 05 12:39:30 volumio go-librespot[1425]: time="2025-07-05T12:39:30+01:00" level=trace msg="received accesspoint ping" Jul 05 12:39:30 volumio go-librespot[1425]: time="2025-07-05T12:39:30+01:00" level=trace msg="received accesspoint pong ack" Jul 05 12:39:31 volumio kernel: hwmon hwmon1: Voltage normalised Jul 05 12:39:31 volumio volumio[886]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Jul 05 12:39:31 volumio volumio[886]: info: [ytmusic] InnertubeLoader: obtaining po_token by visitorData... Jul 05 12:39:31 volumio volumio-remote-updater[534]: [2025-07-05 12:39:31] [connect] Successful connection Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::ClearQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::updateTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stPlaybackTimer Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::pushState Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::serviceStop Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 9 Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::serviceStop Jul 05 12:39:32 volumio volumio[886]: info: Spotify Stop Jul 05 12:39:32 volumio volumio[886]: SPOTIFY: SPOTIFY STOP Jul 05 12:39:32 volumio volumio[886]: SPOTIFY: {"status":"pause","position":9,"title":"Milionário","artist":"Matias Damásio","album":"Milionário","albumart":"https://i.scdn.co/image/ab67616d0000b2739649092580313c9d2d5adece","uri":"spotify:track:2SkgTFL4pSfG5N5ub9frhb","trackType":"spotify","codec":"ogg","seek":99160,"duration":241,"samplerate":"320 kbps","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":87,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Jul 05 12:39:32 volumio volumio[886]: info: Sending Spotify command to local API: /player/pause Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::clearPlayQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: Adding Item to queue: webnineties/6 Jul 05 12:39:32 volumio volumio[886]: info: Exploding uri webnineties/6 in service 80s80s Jul 05 12:39:32 volumio volumio[886]: info: [1751715572216] [80s80s] explodeUri: webnineties/6 Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::ClearQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::clearPlayQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: Adding Item to queue: webnineties/6 Jul 05 12:39:32 volumio volumio[886]: info: Exploding uri webnineties/6 in service 80s80s Jul 05 12:39:32 volumio volumio[886]: info: [1751715572223] [80s80s] explodeUri: webnineties/6 Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::ClearQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::clearPlayQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: Adding Item to queue: webnineties/6 Jul 05 12:39:32 volumio volumio[886]: info: Exploding uri webnineties/6 in service 80s80s Jul 05 12:39:32 volumio volumio[886]: info: [1751715572230] [80s80s] explodeUri: webnineties/6 Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::ClearQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::clearPlayQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: Adding Item to queue: webnineties/7 Jul 05 12:39:32 volumio volumio[886]: info: Exploding uri webnineties/7 in service 80s80s Jul 05 12:39:32 volumio volumio[886]: info: [1751715572236] [80s80s] explodeUri: webnineties/7 Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::ClearQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::clearPlayQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::addQueueItems Jul 05 12:39:32 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:32 volumio volumio[886]: info: Adding Item to queue: webnineties/7 Jul 05 12:39:32 volumio volumio[886]: info: Exploding uri webnineties/7 in service 80s80s Jul 05 12:39:32 volumio volumio[886]: info: [1751715572241] [80s80s] explodeUri: webnineties/7 Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::saveQueue Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::updateTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::updateTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::updateTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::updateTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::updateTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrackBlock Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPlay Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index 0 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPlay Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index 0 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPlay Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index 0 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPlay Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index 0 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioPlay Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index 1 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::stop Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::play index undefined Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: [1751715572316] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:32 volumio volumio[886]: info: [1751715572320] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=265&count=2 Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: [1751715572335] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:32 volumio volumio[886]: info: [1751715572336] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=265&count=2 Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: [1751715572342] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:32 volumio volumio[886]: info: [1751715572343] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=265&count=2 Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: [1751715572350] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:32 volumio volumio[886]: info: [1751715572350] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=265&count=2 Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio volumio[886]: info: [1751715572356] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:32 volumio volumio[886]: info: [1751715572357] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=265&count=2 Jul 05 12:39:32 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jul 05 12:39:32 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.1.86 from 192.168.1.178 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 05 12:39:32 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.1.86 from 192.168.1.178 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 05 12:39:32 volumio volumio-remote-updater[534]: [2025-07-05 12:39:32] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751715571 101 Jul 05 12:39:32 volumio volumio[886]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 Jul 05 12:39:32 volumio go-librespot[1425]: time="2025-07-05T12:39:32+01:00" level=debug msg="pause track at 98892ms" Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:32 volumio go-librespot[1425]: time="2025-07-05T12:39:32+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jul 05 12:39:32 volumio go-librespot[1425]: time="2025-07-05T12:39:32+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jul 05 12:39:32 volumio go-librespot[1425]: time="2025-07-05T12:39:32+01:00" level=trace msg="emitting websocket event: paused" Jul 05 12:39:32 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:32 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:2SkgTFL4pSfG5N5ub9frhb","play_origin":"go-librespot"}} Jul 05 12:39:33 volumio volumio[886]: SPOTIFY: PUSH STATE SPOTIFY Jul 05 12:39:33 volumio volumio[886]: SPOTIFY: {"status":"pause","service":"spop","title":"Milionário","artist":"Matias Damásio","album":"Milionário","albumart":"https://i.scdn.co/image/ab67616d00001e029649092580313c9d2d5adece","uri":"spotify:track:2SkgTFL4pSfG5N5ub9frhb","trackType":"spotify","seek":98000,"duration":241,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 05 12:39:33 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received spop Jul 05 12:39:33 volumio volumio[886]: info: [1751715573099] [80s80s] received new event containing 2 songs. Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:39:33 volumio volumio[886]: info: [1751715573110] [80s80s] received new event containing 2 songs. Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand stop took 35 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand stop took 29 milliseconds Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:39:33 volumio volumio[886]: info: Jul 05 12:39:33 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:33 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:33 volumio volumio[886]: info: Jul 05 12:39:33 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:33 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand clear took 15 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand clear took 18 milliseconds Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 05 12:39:33 volumio volumio[886]: error: updateQueue error: null Jul 05 12:39:33 volumio volumio[886]: error: updateQueue error: null Jul 05 12:39:33 volumio volumio[886]: info: ------------------------------ 26ms Jul 05 12:39:33 volumio volumio[886]: info: ------------------------------ 21ms Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand consume 1 took 17 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand consume 1 took 16 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: [1751715573181] [80s80s] adding url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" Jul 05 12:39:33 volumio volumio[886]: info: [1751715573182] [80s80s] adding url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" Jul 05 12:39:33 volumio volumio[886]: info: Jul 05 12:39:33 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:33 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:33 volumio volumio[886]: info: Jul 05 12:39:33 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:33 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" took 10 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" took 10 milliseconds Jul 05 12:39:33 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:39:33 volumio volumio[886]: info: ------------------------------ 32ms Jul 05 12:39:33 volumio volumio[886]: info: ------------------------------ 31ms Jul 05 12:39:33 volumio volumio[886]: info: [1751715573225] [80s80s] received new event containing 2 songs. Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:39:33 volumio volumio[886]: info: [1751715573237] [80s80s] received new event containing 2 songs. Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:39:33 volumio volumio[886]: info: [1751715573243] [80s80s] received new event containing 2 songs. Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand play took 49 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand play took 45 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: [1751715573256] [80s80s] Pushing the next song state: The Notorious B.I.G. - Juicy Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music124/v4/3b/c5/ef/3bc5ef56-64b7-9175-5f88-50eca6fa7ce3/source/600x600bb.jpg","name":"The Notorious B.I.G. - Juicy","title":"Juicy","artist":"90s90s HipHop & Rap","album":"","streaming":true,"disableUiControls":true,"duration":"287","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 05 12:39:33 volumio volumio[886]: verbose: CURRENT POSITION 1 Jul 05 12:39:33 volumio volumio[886]: info: CoreStateMachine::syncState stateService play Jul 05 12:39:33 volumio volumio[886]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:39:33 volumio volumio[886]: info: [1751715573263] [80s80s] Pushing the next song state: The Notorious B.I.G. - Juicy Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music124/v4/3b/c5/ef/3bc5ef56-64b7-9175-5f88-50eca6fa7ce3/source/600x600bb.jpg","name":"The Notorious B.I.G. - Juicy","title":"Juicy","artist":"90s90s HipHop & Rap","album":"","streaming":true,"disableUiControls":true,"duration":"287","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 05 12:39:33 volumio volumio[886]: verbose: CURRENT POSITION 1 Jul 05 12:39:33 volumio volumio[886]: info: CoreStateMachine::syncState stateService play Jul 05 12:39:33 volumio volumio[886]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:39:33 volumio volumio[886]: info: Received an update from plugin. extracting info from payload Jul 05 12:39:33 volumio volumio[886]: info: CoreStateMachine::pushState Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:39:33 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Jul 05 12:39:33 volumio volumio[886]: info: [1751715573279] [80s80s] PlayNextTrack API delay: 30 Jul 05 12:39:33 volumio volumio[886]: info: [1751715573388] [80s80s] Setting timer to: 287000 milliseconds. Jul 05 12:39:33 volumio volumio[886]: info: Jul 05 12:39:33 volumio volumio[886]: ---------------------------- MPD announces state update: player Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand stop took 290 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: ControllerMpd::getState Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand stop took 284 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand stop took 274 milliseconds Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 2 Jul 05 12:39:33 volumio volumio[886]: info: Jul 05 12:39:33 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:33 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand status took 20 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand clear took 20 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand clear took 19 milliseconds Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::parseState Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 05 12:39:33 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: error: updateQueue error: null Jul 05 12:39:33 volumio volumio[886]: info: ------------------------------ 134ms Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand playlistinfo took 124 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand consume 1 took 124 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand consume 1 took 124 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand consume 1 took 124 milliseconds Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:39:33 volumio volumio[886]: info: [1751715573686] [80s80s] adding url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" Jul 05 12:39:33 volumio volumio[886]: info: [1751715573688] [80s80s] adding url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" Jul 05 12:39:33 volumio volumio[886]: info: [1751715573689] [80s80s] adding url: http://streams.90s90s.de/hiphop/mp3-192/volumio Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" Jul 05 12:39:33 volumio volumio[886]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 12:39:33 volumio volumio[886]: info: ------------------------------ 183ms Jul 05 12:39:33 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 05 12:39:33 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:33 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:33 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:33 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:33 volumio volumio[886]: info: Jul 05 12:39:33 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:33 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:33 volumio volumio[886]: info: Jul 05 12:39:33 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:33 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" took 104 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" took 103 milliseconds Jul 05 12:39:33 volumio volumio[886]: info: sendMpdCommand add "http://streams.90s90s.de/hiphop/mp3-192/volumio" took 103 milliseconds Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:39:33 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:39:34 volumio volumio[886]: info: ------------------------------ 218ms Jul 05 12:39:34 volumio volumio[886]: info: ------------------------------ 219ms Jul 05 12:39:34 volumio volumio[886]: info: sendMpdCommand play took 211 milliseconds Jul 05 12:39:34 volumio volumio[886]: info: sendMpdCommand play took 209 milliseconds Jul 05 12:39:34 volumio volumio[886]: info: sendMpdCommand play took 207 milliseconds Jul 05 12:39:34 volumio volumio[886]: info: [1751715574012] [80s80s] Pushing the next song state: The Notorious B.I.G. - Juicy Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music124/v4/3b/c5/ef/3bc5ef56-64b7-9175-5f88-50eca6fa7ce3/source/600x600bb.jpg","name":"The Notorious B.I.G. - Juicy","title":"Juicy","artist":"90s90s HipHop & Rap","album":"","streaming":true,"disableUiControls":true,"duration":"287","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 05 12:39:34 volumio volumio[886]: verbose: CURRENT POSITION 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::syncState stateService play Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:39:34 volumio volumio[886]: info: Received an update from plugin. extracting info from payload Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::pushState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Jul 05 12:39:34 volumio volumio[886]: info: [1751715574030] [80s80s] Pushing the next song state: The Notorious B.I.G. - Juicy Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music124/v4/3b/c5/ef/3bc5ef56-64b7-9175-5f88-50eca6fa7ce3/source/600x600bb.jpg","name":"The Notorious B.I.G. - Juicy","title":"Juicy","artist":"90s90s HipHop & Rap","album":"","streaming":true,"disableUiControls":true,"duration":"287","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 05 12:39:34 volumio volumio[886]: verbose: CURRENT POSITION 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::syncState stateService play Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:39:34 volumio volumio[886]: info: Received an update from plugin. extracting info from payload Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::pushState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Jul 05 12:39:34 volumio volumio[886]: info: [1751715574039] [80s80s] Pushing the next song state: The Notorious B.I.G. - Juicy Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music124/v4/3b/c5/ef/3bc5ef56-64b7-9175-5f88-50eca6fa7ce3/source/600x600bb.jpg","name":"The Notorious B.I.G. - Juicy","title":"Juicy","artist":"90s90s HipHop & Rap","album":"","streaming":true,"disableUiControls":true,"duration":"287","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 05 12:39:34 volumio volumio[886]: verbose: CURRENT POSITION 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::syncState stateService play Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:39:34 volumio volumio[886]: info: Received an update from plugin. extracting info from payload Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::pushState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Jul 05 12:39:34 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jul 05 12:39:34 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 05 12:39:34 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 2 Jul 05 12:39:34 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jul 05 12:39:34 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.1.86 from 192.168.1.178 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jul 05 12:39:34 volumio volumio[886]: info: [GPIO_Control] Status changed: play Jul 05 12:39:34 volumio volumio[886]: info: [GPIO_Control] Handling event: musicPlay Jul 05 12:39:34 volumio volumio[886]: info: [GPIO_Control] Status changed: play Jul 05 12:39:34 volumio volumio[886]: info: [GPIO_Control] Status changed: play Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:34 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:34 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jul 05 12:39:34 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Jul 05 12:39:34 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:34 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 12:39:35 volumio volumio[886]: info: Received Get System Info Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:39:35 volumio volumio[886]: info: Discovery: Getting this device information Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: Listing playlists Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:35 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:35 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:35 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:35 volumio volumio[886]: SPOTIFY: RECEIVED VOLUMIO VOLUME 87 Jul 05 12:39:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 05 12:39:35 volumio volumio[886]: info: FusionDsp - no preset used Jul 05 12:39:36 volumio volumio[886]: info: FusionDsp - no preset used Jul 05 12:39:37 volumio volumio[886]: info: Preload queue cleared Jul 05 12:39:37 volumio volumio[886]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,bobs.json Jul 05 12:39:37 volumio volumio[886]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,bobs.json Jul 05 12:39:37 volumio volumio[886]: info: Jul 05 12:39:37 volumio volumio[886]: ---------------------------- MPD announces state update: player Jul 05 12:39:37 volumio volumio[886]: info: ControllerMpd::getState Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:39:37 volumio volumio[886]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 05 12:39:37 volumio volumio[886]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 05 12:39:37 volumio volumio[886]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 05 12:39:37 volumio volumio[886]: info: FusionDsp - Effects disabled Jul 05 12:39:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:37 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:37 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:37 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:37 volumio volumio[886]: info: Jul 05 12:39:37 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:37 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:37 volumio volumio[886]: info: Jul 05 12:39:37 volumio volumio[886]: ---------------------------- MPD announces state update: player Jul 05 12:39:37 volumio volumio[886]: info: Jul 05 12:39:37 volumio volumio[886]: ---------------------------- MPD announces system playlist update Jul 05 12:39:37 volumio volumio[886]: info: Ignoring MPD Status Update Jul 05 12:39:37 volumio volumio[886]: info: Jul 05 12:39:37 volumio volumio[886]: ---------------------------- MPD announces state update: player Jul 05 12:39:37 volumio volumio[886]: info: ControllerMpd::getState Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:39:37 volumio volumio[886]: info: sendMpdCommand status took 91 milliseconds Jul 05 12:39:37 volumio volumio[886]: info: ControllerMpd::getState Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::parseState Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:39:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:37 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:37 volumio volumio[886]: info: ------------------------------ 98ms Jul 05 12:39:37 volumio volumio[886]: info: sendMpdCommand status took 92 milliseconds Jul 05 12:39:37 volumio volumio[886]: info: ------------------------------ 107ms Jul 05 12:39:37 volumio volumio[886]: info: sendMpdCommand status took 89 milliseconds Jul 05 12:39:37 volumio volumio[886]: info: sendMpdCommand playlistinfo took 87 milliseconds Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::parseState Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::parseState Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:39:37 volumio volumio[886]: info: ControllerMpd::pushState Jul 05 12:39:37 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:37 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:37 volumio volumio[886]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jul 05 12:39:37 volumio volumio[886]: info: ------------------------------ 223ms Jul 05 12:39:37 volumio volumio[886]: info: sendMpdCommand playlistinfo took 62 milliseconds Jul 05 12:39:37 volumio volumio[886]: info: sendMpdCommand playlistinfo took 51 milliseconds Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:39:37 volumio volumio[886]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:39:37 volumio volumio[886]: info: ControllerMpd::pushState Jul 05 12:39:37 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:37 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:37 volumio volumio[886]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jul 05 12:39:37 volumio volumio[886]: info: ControllerMpd::pushState Jul 05 12:39:37 volumio volumio[886]: info: CoreCommandRouter::servicePushState Jul 05 12:39:37 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:37 volumio volumio[886]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jul 05 12:39:37 volumio volumio[886]: info: ------------------------------ 185ms Jul 05 12:39:37 volumio volumio[886]: info: ------------------------------ 182ms Jul 05 12:39:38 volumio volumio[886]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 05 12:39:38 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:38 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:42 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:42 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:42 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:42 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:42 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:42 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:42 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:42 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:42 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:42 volumio volumio[886]: info: [ytmusic] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jul 05 12:39:42 volumio volumio[886]: info: [ytmusic] InnertubeLoader: re-create Innertube instance with po_token Jul 05 12:39:42 volumio volumio[886]: info: [ytmusic] InnertubeLoader: creating Innertube instance with po_token... Jul 05 12:39:42 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:42 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:42 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:42 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:42 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:42 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:42 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:42 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:42 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:43 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:43 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:43 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:43 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:43 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:43 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:43 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:43 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:43 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:43 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:43 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:43 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:43 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:44 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:44 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:44 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:44 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:44 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:44 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:44 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:44 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:44 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:39:44 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:39:44 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:39:44 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:39:44 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:39:59 volumio go-librespot[1425]: time="2025-07-05T12:39:59+01:00" level=trace msg="sent dealer ping" Jul 05 12:39:59 volumio go-librespot[1425]: time="2025-07-05T12:39:59+01:00" level=trace msg="received dealer pong" Jul 05 12:40:02 volumio volumio-remote-updater[534]: [2025-07-05 12:40:02] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jul 05 12:40:02 volumio volumio[886]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Jul 05 12:40:03 volumio volumio[886]: info: [ytmusic] InnertubeLoader: going to refresh po_token in 43100 seconds Jul 05 12:40:03 volumio volumio[886]: error: You need to be signed in to access this content. You can do this in the plugin settings. Error: You need to be signed in to access this content. You can do this in the plugin settings. Jul 05 12:40:03 volumio volumio[886]: at GenericViewHandler.browse (/data/plugins/music_service/ytmusic/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:30:19) Jul 05 12:40:03 volumio volumio[886]: at runMicrotasks () Jul 05 12:40:03 volumio volumio[886]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jul 05 12:40:03 volumio volumio[886]: at async BrowseController.browseUri (/data/plugins/music_service/ytmusic/dist/lib/controller/browse/BrowseController.js:30:20) Jul 05 12:40:03 volumio volumio[886]: error: Failed to execute browseSource: Error: You need to be signed in to access this content. You can do this in the plugin settings. Jul 05 12:40:03 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Jul 05 12:40:03 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:40:03 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:40:03 volumio volumio[886]: info: CoreStateMachine::getQueue Jul 05 12:40:03 volumio volumio[886]: info: CorePlayQueue::getQueue Jul 05 12:40:03 volumio volumio[886]: info: CoreCommandRouter::volumioSeek Jul 05 12:40:03 volumio volumio[886]: info: CoreStateMachine::seek Jul 05 12:40:03 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:40:03 volumio volumio[886]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"nineties","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music124/v4/3b/c5/ef/3bc5ef56-64b7-9175-5f88-50eca6fa7ce3/source/600x600bb.jpg","uri":"http://streams.90s90s.de/hiphop/mp3-192/volumio","name":"The Notorious B.I.G. - Juicy","duration":"287","artist":"90s90s HipHop & Rap","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 05 12:40:03 volumio volumio[886]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:40:03 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:40:03 volumio volumio[886]: info: [1751715603260] [80s80s] seek to 59000 Jul 05 12:40:03 volumio volumio[886]: info: CoreStateMachine::pushState Jul 05 12:40:03 volumio volumio[886]: info: CorePlayQueue::getTrack 1 Jul 05 12:40:03 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:40:03 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Jul 05 12:40:03 volumio volumio[886]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 12:40:03 volumio volumio[886]: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Jul 05 12:40:03 volumio volumio[886]: at FerrumStreamingControlTechnology.updateStateOnPlayer (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:72:12) Jul 05 12:40:03 volumio volumio[886]: at FerrumStreamingControlTechnology.pushState (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:183:10) Jul 05 12:40:03 volumio volumio[886]: at /volumio/app/index.js:326:81 Jul 05 12:40:03 volumio volumio[886]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jul 05 12:40:03 volumio volumio[886]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jul 05 12:40:03 volumio volumio[886]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) Jul 05 12:40:03 volumio volumio[886]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:530:22) Jul 05 12:40:03 volumio volumio[886]: at CoreStateMachine.seek (/volumio/app/statemachine.js:1143:14) Jul 05 12:40:03 volumio volumio[886]: at CoreCommandRouter.volumioSeek (/volumio/app/index.js:1446:28) Jul 05 12:40:03 volumio volumio[886]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:177:33) Jul 05 12:40:03 volumio volumio[886]: at Socket.emit (events.js:315:20) Jul 05 12:40:03 volumio volumio[886]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 05 12:40:03 volumio volumio[886]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jul 05 12:40:03 volumio volumio[886]: code: 'NumberExpected' Jul 05 12:40:03 volumio volumio[886]: } Jul 05 12:40:03 volumio volumio[886]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 12:40:05 volumio sudo[26587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-05 12:39 Jul 05 12:40:05 volumio sudo[26587]: 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"