-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Wed 2025-06-18 14:04:34 JST. -- Jun 18 14:03:01 volumio volumio[12581]: info: JP_Radio::JpRadio.#pgupdate: complete. ### 1947ms ### Jun 18 14:03:02 volumio volumio[12581]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 18 14:03:06 volumio volumio[12581]: info: Adding plugin bluetooth to MyMusic Plugins Jun 18 14:03:06 volumio volumio[12581]: info: Adding plugin multiroom to MyMusic Plugins Jun 18 14:03:06 volumio volumio[12581]: info: Adding plugin metavolumio to MyMusic Plugins Jun 18 14:03:06 volumio volumio[12581]: info: Adding plugin cd_controller to MyMusic Plugins Jun 18 14:03:06 volumio volumio[12581]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 18 14:03:06 volumio volumio[12581]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 18 14:03:06 volumio volumio[12581]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 18 14:03:06 volumio volumio[12581]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 18 14:03:08 volumio volumio[12581]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 18 14:03:08 volumio volumio[12581]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 18 14:03:08 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:08 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:08 volumio volumio[12581]: info: Starting MyVolumio Remote Streaming Endpoints Jun 18 14:03:08 volumio volumio[12581]: info: MyVolumio login type: Token Jun 18 14:03:08 volumio volumio[12581]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 18 14:03:08 volumio volumio[12581]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 18 14:03:09 volumio volumio[12581]: info: Starting Streaming Service Transparent Proxy Jun 18 14:03:09 volumio volumio[12581]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 18 14:03:09 volumio volumio[12581]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 18 14:03:09 volumio volumio[12581]: info: Streaming services startup Jun 18 14:03:09 volumio volumio[12581]: info: Starting Streaming Daemon Jun 18 14:03:09 volumio sudo[12881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 18 14:03:09 volumio sudo[12881]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 14:03:09 volumio sudo[12881]: pam_unix(sudo:session): session closed for user root Jun 18 14:03:09 volumio volumio[12581]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 18 14:03:09 volumio volumio[12581]: error: Cannot start Volumio Streaming Daemon Jun 18 14:03:09 volumio volumio[12581]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 18 14:03:09 volumio volumio[12581]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 18 14:03:10 volumio volumio[12581]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 18 14:03:10 volumio volumio[12581]: STREAMING PROXY: Starting server on port 3245 Jun 18 14:03:10 volumio volumio[12581]: Node JS runtime: 14 Jun 18 14:03:11 volumio volumio[12581]: info: MyVolumio token set successfully Jun 18 14:03:11 volumio volumio[12581]: info: MYVOLUMIO: Adding device Jun 18 14:03:11 volumio volumio[12581]: info: MYVOLUMIO: Evaluating Server Jun 18 14:03:11 volumio volumio[12581]: info: MyVolumio status changed Jun 18 14:03:11 volumio volumio[12581]: info: Streaming services startup Jun 18 14:03:11 volumio volumio[12581]: info: Starting Streaming Daemon Jun 18 14:03:11 volumio volumio[12581]: info: Removing browser output: myVolumio user plan is not superstar Jun 18 14:03:11 volumio volumio[12581]: info: Removing audio output: Jun 18 14:03:11 volumio volumio[12581]: info: Stoppping Tunnel 1 Jun 18 14:03:11 volumio sudo[12906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 18 14:03:11 volumio sudo[12906]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 14:03:11 volumio sudo[12906]: pam_unix(sudo:session): session closed for user root Jun 18 14:03:11 volumio sudo[12909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jun 18 14:03:11 volumio sudo[12909]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 14:03:11 volumio volumio[12581]: error: Cannot start Volumio Streaming Daemon Jun 18 14:03:11 volumio volumio[12581]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 18 14:03:11 volumio volumio[12581]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 18 14:03:11 volumio sudo[12909]: pam_unix(sudo:session): session closed for user root Jun 18 14:03:11 volumio volumio[12581]: info: Remote SSH Stopped Jun 18 14:03:12 volumio volumio[12581]: info: Setting Geolocation for MyVolumio to as1 Jun 18 14:03:12 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:12 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:13 volumio volumio[12581]: info: Updating MyVolumio device info Jun 18 14:03:13 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:13 volumio volumio[12581]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jun 18 14:03:14 volumio volumio[12581]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jun 18 14:03:17 volumio volumio[12581]: info: MYVOLUMIO: Adding device Jun 18 14:03:17 volumio volumio[12581]: info: MYVOLUMIO: Evaluating Server Jun 18 14:03:18 volumio volumio[12581]: info: Setting Geolocation for MyVolumio to as1 Jun 18 14:03:18 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:18 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:18 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:19 volumio volumio[12581]: info: Updating MyVolumio device info Jun 18 14:03:19 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:20 volumio volumio[12581]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jun 18 14:03:20 volumio volumio[12581]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jun 18 14:03:23 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 18 14:03:23 volumio volumio[12581]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 18 14:03:23 volumio volumio[12581]: info: CoreCommandRouter::volumioGetState Jun 18 14:03:23 volumio volumio[12581]: info: CorePlayQueue::getTrack 0 Jun 18 14:03:24 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 18 14:03:24 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:24 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 18 14:03:24 volumio volumio-remote-updater[523]: Test mode enabled Jun 18 14:03:24 volumio volumio-remote-updater[523]: No alpha test mode Jun 18 14:03:24 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 18 14:03:25 volumio volumio[12581]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES



 

","title":"Update v3.816","updateavailable":true} Jun 18 14:03:25 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 18 14:03:28 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 18 14:03:28 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 18 14:03:28 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 18 14:03:28 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 18 14:03:28 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 18 14:03:28 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 18 14:03:28 volumio volumio[12581]: info: CoreCommandRouter::volumioGetBrowseSources Jun 18 14:03:28 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 18 14:03:29 volumio volumio[12581]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jun 18 14:03:29 volumio volumio[12581]: info: Completed starting MyVolumio Plugin Jun 18 14:03:29 volumio volumio[12581]: [Metrics] CommandRouter: 53s 618.15ms Jun 18 14:03:29 volumio volumio[12581]: info: CoreCommandRouter::volumiosetStartupVolume Jun 18 14:03:29 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 18 14:03:29 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 18 14:03:29 volumio volumio[12581]: info: CoreCommandRouter::Close All Modals sent Jun 18 14:03:29 volumio volumio[12581]: info: CoreCommandRouter::Close All Modals sent Jun 18 14:03:30 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 18 14:03:30 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 18 14:03:30 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 18 14:03:36 volumio volumio[12581]: info: BOOT COMPLETED Jun 18 14:04:20 volumio volumio[12581]: info: CALLMETHOD: system_controller system enableLiveLog true Jun 18 14:04:20 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog Jun 18 14:04:20 volumio volumio[12581]: info: Launching a new LiveLog session Jun 18 14:04:26 volumio volumio[12581]: info: CoreCommandRouter::executeOnPlugin: jp_radio , handleBrowseUri Jun 18 14:04:26 volumio volumio[12581]: info: JP_Radio::JpRadio.radioStations Jun 18 14:04:27 volumio volumio[12581]: info: Preload queue cleared Jun 18 14:04:27 volumio volumio[12581]: info: Preloading song: http://localhost:9000/radiko/play/KRY/%E3%81%8A%E6%98%BC%E3%81%AF%EF%BC%BA%EF%BC%A5%EF%BC%B4%EF%BC%B4%EF%BC%A1%EF%BC%A9%E3%83%A9%E3%82%B8%EF%BC%B4%EF%BC%A9%EF%BC%AD%EF%BC%A5%EF%BC%88%EF%BC%92%EF%BC%89/%EF%BC%AB%EF%BC%B2%EF%BC%B9%E5%B1%B1%E5%8F%A3%E6%94%BE%E9%80%81%2014%3A00-16%3A00/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fa0b77f85-cca2-448b-ae55-bd79f9608e8f.jpeg Jun 18 14:04:27 volumio volumio[12581]: info: Preloading song: http://localhost:9000/radiko/play/FMY/%E3%83%AC%E3%82%B3%E3%83%AC%E3%83%BC%E3%83%AB/%E3%82%A8%E3%83%95%E3%82%A8%E3%83%A0%E5%B1%B1%E5%8F%A3%2013%3A30-14%3A30/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fmo0d3e7p0c.jpg Jun 18 14:04:27 volumio volumio[12581]: info: Preloading song: http://localhost:9000/radiko/play/JOFK/%E3%83%8B%E3%83%A5%E3%83%BC%E3%82%B9/NHK%E3%83%A9%E3%82%B8%E3%82%AA%E7%AC%AC1%EF%BC%88%E5%BA%83%E5%B3%B6%EF%BC%89%2014%3A00-14%3A05/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fd3e92ac3-843e-4309-8ddc-69879f352ffd.png Jun 18 14:04:27 volumio volumio[12581]: info: Preload queue cleared Jun 18 14:04:27 volumio volumio[12581]: info: Preloading song: http://localhost:9000/radiko/play/RN1/%E3%83%9E%E3%83%BC%E3%82%B1%E3%83%83%E3%83%88%E3%83%97%E3%83%AC%E3%82%B9%E3%80%80%E5%BE%8C%E5%A0%B4/%E3%83%A9%E3%82%B8%E3%82%AANIKKEI%E7%AC%AC1%2013%3A00-14%3A30/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fj1ukn0x1xa.png Jun 18 14:04:27 volumio volumio[12581]: info: Preloading song: http://localhost:9000/radiko/play/RN2/RaNi%20Music%E2%99%AADay/%E3%83%A9%E3%82%B8%E3%82%AANIKKEI%E7%AC%AC2%2012%3A00-15%3A00/https%3A%2F%2Fprogram-static.cf.radiko.jp%2F0145ad41-d166-4ad3-b6bb-496132a605c6.png Jun 18 14:04:27 volumio volumio[12581]: info: Preloading song: http://localhost:9000/radiko/play/JOAK-FM/%E3%82%AF%E3%83%A9%E3%82%B7%E3%83%83%E3%82%AF%E3%81%AE%E5%BA%AD%E3%80%80%E9%81%B8%E3%80%80%E3%83%A9%E3%83%B4%E3%82%A7%E3%83%AB%E3%81%AE%E3%80%8C%E4%BA%A1%E3%81%8D%E7%8E%8B%E5%A5%B3%E3%81%AE%E3%81%9F%E3%82%81%E3%81%AE%E3%83%91%E3%83%B4%E3%82%A1%E3%83%BC%E3%83%8C%E3%80%8D/NHK-FM%EF%BC%88%E6%9D%B1%E4%BA%AC%EF%BC%89%2014%3A00-15%3A50/https%3A%2F%2Fprogram-static.cf.radiko.jp%2F57fmaomcn7.jpg Jun 18 14:04:27 volumio volumio[12581]: info: Exploding uri http://localhost:9000/radiko/play/RN1/%E3%83%9E%E3%83%BC%E3%82%B1%E3%83%83%E3%83%88%E3%83%97%E3%83%AC%E3%82%B9%E3%80%80%E5%BE%8C%E5%A0%B4/%E3%83%A9%E3%82%B8%E3%82%AANIKKEI%E7%AC%AC1%2013%3A00-14%3A30/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fj1ukn0x1xa.png in service jp_radio Jun 18 14:04:27 volumio volumio[12581]: info: Exploding uri http://localhost:9000/radiko/play/RN2/RaNi%20Music%E2%99%AADay/%E3%83%A9%E3%82%B8%E3%82%AANIKKEI%E7%AC%AC2%2012%3A00-15%3A00/https%3A%2F%2Fprogram-static.cf.radiko.jp%2F0145ad41-d166-4ad3-b6bb-496132a605c6.png in service jp_radio Jun 18 14:04:27 volumio volumio[12581]: info: Exploding uri http://localhost:9000/radiko/play/JOAK-FM/%E3%82%AF%E3%83%A9%E3%82%B7%E3%83%83%E3%82%AF%E3%81%AE%E5%BA%AD%E3%80%80%E9%81%B8%E3%80%80%E3%83%A9%E3%83%B4%E3%82%A7%E3%83%AB%E3%81%AE%E3%80%8C%E4%BA%A1%E3%81%8D%E7%8E%8B%E5%A5%B3%E3%81%AE%E3%81%9F%E3%82%81%E3%81%AE%E3%83%91%E3%83%B4%E3%82%A1%E3%83%BC%E3%83%8C%E3%80%8D/NHK-FM%EF%BC%88%E6%9D%B1%E4%BA%AC%EF%BC%89%2014%3A00-15%3A50/https%3A%2F%2Fprogram-static.cf.radiko.jp%2F57fmaomcn7.jpg in service jp_radio Jun 18 14:04:29 volumio volumio[12581]: info: Preload queue cleared Jun 18 14:04:29 volumio volumio[12581]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::ClearQueue Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::stop Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::clearPlayQueue Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::saveQueue Jun 18 14:04:29 volumio volumio[12581]: info: CoreCommandRouter::volumioPushQueue Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::addQueueItems Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::addQueueItems Jun 18 14:04:29 volumio volumio[12581]: info: Preload queue cleared Jun 18 14:04:29 volumio volumio[12581]: info: Adding Item to queue: http://localhost:9000/radiko/play/KRY/%E3%81%8A%E6%98%BC%E3%81%AF%EF%BC%BA%EF%BC%A5%EF%BC%B4%EF%BC%B4%EF%BC%A1%EF%BC%A9%E3%83%A9%E3%82%B8%EF%BC%B4%EF%BC%A9%EF%BC%AD%EF%BC%A5%EF%BC%88%EF%BC%92%EF%BC%89/%EF%BC%AB%EF%BC%B2%EF%BC%B9%E5%B1%B1%E5%8F%A3%E6%94%BE%E9%80%81%2014%3A00-16%3A00/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fa0b77f85-cca2-448b-ae55-bd79f9608e8f.jpeg Jun 18 14:04:29 volumio volumio[12581]: info: Exploding uri http://localhost:9000/radiko/play/KRY/%E3%81%8A%E6%98%BC%E3%81%AF%EF%BC%BA%EF%BC%A5%EF%BC%B4%EF%BC%B4%EF%BC%A1%EF%BC%A9%E3%83%A9%E3%82%B8%EF%BC%B4%EF%BC%A9%EF%BC%AD%EF%BC%A5%EF%BC%88%EF%BC%92%EF%BC%89/%EF%BC%AB%EF%BC%B2%EF%BC%B9%E5%B1%B1%E5%8F%A3%E6%94%BE%E9%80%81%2014%3A00-16%3A00/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fa0b77f85-cca2-448b-ae55-bd79f9608e8f.jpeg in service jp_radio Jun 18 14:04:29 volumio volumio[12581]: info: Adding Item to queue: http://localhost:9000/radiko/play/FMY/%E3%83%AC%E3%82%B3%E3%83%AC%E3%83%BC%E3%83%AB/%E3%82%A8%E3%83%95%E3%82%A8%E3%83%A0%E5%B1%B1%E5%8F%A3%2013%3A30-14%3A30/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fmo0d3e7p0c.jpg Jun 18 14:04:29 volumio volumio[12581]: info: Exploding uri http://localhost:9000/radiko/play/FMY/%E3%83%AC%E3%82%B3%E3%83%AC%E3%83%BC%E3%83%AB/%E3%82%A8%E3%83%95%E3%82%A8%E3%83%A0%E5%B1%B1%E5%8F%A3%2013%3A30-14%3A30/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fmo0d3e7p0c.jpg in service jp_radio Jun 18 14:04:29 volumio volumio[12581]: info: CoreCommandRouter::volumioPushQueue Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::saveQueue Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::updateTrackBlock Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::getTrackBlock Jun 18 14:04:29 volumio volumio[12581]: info: CoreCommandRouter::volumioPlay Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::play index 1 Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::addQueueItems Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::addQueueItems Jun 18 14:04:29 volumio volumio[12581]: info: Preload queue cleared Jun 18 14:04:29 volumio volumio[12581]: info: Adding Item to queue: http://localhost:9000/radiko/play/JOFK/%E3%83%8B%E3%83%A5%E3%83%BC%E3%82%B9/NHK%E3%83%A9%E3%82%B8%E3%82%AA%E7%AC%AC1%EF%BC%88%E5%BA%83%E5%B3%B6%EF%BC%89%2014%3A00-14%3A05/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fd3e92ac3-843e-4309-8ddc-69879f352ffd.png Jun 18 14:04:29 volumio volumio[12581]: info: Exploding uri http://localhost:9000/radiko/play/JOFK/%E3%83%8B%E3%83%A5%E3%83%BC%E3%82%B9/NHK%E3%83%A9%E3%82%B8%E3%82%AA%E7%AC%AC1%EF%BC%88%E5%BA%83%E5%B3%B6%EF%BC%89%2014%3A00-14%3A05/https%3A%2F%2Fprogram-static.cf.radiko.jp%2Fd3e92ac3-843e-4309-8ddc-69879f352ffd.png in service jp_radio Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::stop Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::play index undefined Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::startPlaybackTimer Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:29 volumio volumio[12581]: info: JP_Radio::clearAddPlayTrack: uri=http://localhost:9000/radiko/play/FMY Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::clearPlayQueue Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::saveQueue Jun 18 14:04:29 volumio volumio[12581]: info: CoreCommandRouter::volumioPushQueue Jun 18 14:04:29 volumio volumio[12581]: info: JP_Radio:: track=service,jp_radio,type,song,title,レコレール,name,レコレール,artist,エフエム山口 13:30-14:30,albumart,https://program-static.cf.radiko.jp/mo0d3e7p0c.jpg,uri,http://localhost:9000/radiko/play/FMY,samplerate,,bitdepth,0,channels,0 Jun 18 14:04:29 volumio volumio[12581]: info: JP_Radio:: state=status,stop,position,1,title,レコレール,artist,エフエム山口 13:30-14:30,album,,albumart,https://program-static.cf.radiko.jp/mo0d3e7p0c.jpg,uri,http://localhost:9000/radiko/play/FMY,trackType,,codec,,seek,0,duration,,samplerate,,bitdepth,0,channels,0,random,,repeat,false,repeatSingle,false,consume,false,volume,100,dbVolume,,disableVolumeControl,true,mute,false,stream,,updatedb,false,volatile,false,service,jp_radio Jun 18 14:04:29 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 14:04:29 volumio volumio[12581]: info: CoreCommandRouter::volumioPushQueue Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::saveQueue Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::updateTrackBlock Jun 18 14:04:29 volumio volumio[12581]: info: CorePlayQueue::getTrackBlock Jun 18 14:04:29 volumio volumio[12581]: info: sendMpdCommand stop took 21 milliseconds Jun 18 14:04:29 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand clear Jun 18 14:04:29 volumio volumio[12581]: info: sendMpdCommand clear took 2 milliseconds Jun 18 14:04:29 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand add "http://localhost:9000/radiko/play/FMY" Jun 18 14:04:29 volumio volumio[12581]: info: Jun 18 14:04:29 volumio volumio[12581]: ---------------------------- MPD announces system playlist update Jun 18 14:04:29 volumio volumio[12581]: info: Ignoring MPD Status Update Jun 18 14:04:29 volumio volumio[12581]: info: Jun 18 14:04:29 volumio volumio[12581]: ---------------------------- MPD announces system playlist update Jun 18 14:04:29 volumio volumio[12581]: info: Ignoring MPD Status Update Jun 18 14:04:29 volumio volumio[12581]: info: Jun 18 14:04:29 volumio volumio[12581]: ---------------------------- MPD announces system playlist update Jun 18 14:04:29 volumio volumio[12581]: info: Ignoring MPD Status Update Jun 18 14:04:29 volumio volumio[12581]: info: Jun 18 14:04:29 volumio volumio[12581]: ---------------------------- MPD announces system playlist update Jun 18 14:04:29 volumio volumio[12581]: info: Ignoring MPD Status Update Jun 18 14:04:29 volumio volumio[12581]: info: sendMpdCommand add "http://localhost:9000/radiko/play/FMY" took 11 milliseconds Jun 18 14:04:29 volumio volumio[12581]: info: ------------------------------ 11ms Jun 18 14:04:29 volumio volumio[12581]: info: ------------------------------ 8ms Jun 18 14:04:29 volumio volumio[12581]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 18 14:04:29 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand play Jun 18 14:04:29 volumio volumio[12581]: info: Jun 18 14:04:29 volumio volumio[12581]: ---------------------------- MPD announces system playlist update Jun 18 14:04:29 volumio volumio[12581]: info: Ignoring MPD Status Update Jun 18 14:04:29 volumio volumio[12581]: info: Jun 18 14:04:29 volumio volumio[12581]: ---------------------------- MPD announces system playlist update Jun 18 14:04:29 volumio volumio[12581]: info: Ignoring MPD Status Update Jun 18 14:04:29 volumio volumio[12581]: info: ------------------------------ 14ms Jun 18 14:04:29 volumio volumio[12581]: info: ------------------------------ 13ms Jun 18 14:04:29 volumio volumio[12581]: info: sendMpdCommand play took 7 milliseconds Jun 18 14:04:29 volumio volumio[12581]: info: ------------------------------ 7ms Jun 18 14:04:29 volumio volumio[12581]: info: ------------------------------ 5ms Jun 18 14:04:30 volumio volumio[12581]: info: JP_Radio::JpRadio.#setupRoutes.get=> req.originalUrl=/radiko/play/FMY Jun 18 14:04:30 volumio volumio[12581]: info: JP_Radio::JpRadio.#startStream Jun 18 14:04:30 volumio volumio[12581]: info: JP_Radio::Radiko.play station=>FMY Jun 18 14:04:30 volumio volumio[12581]: info: JP_Radio::Radiko.play: ffmpeg -y,-headers,X-Radiko-Authtoken:iNgQf-FYCQCKWaJQX105hQ,-i,https://f-radiko.smartstream.ne.jp/FMY/_definst_/simul-stream.stream/chunklist_w1010818655.m3u8,-acodec,copy,-f,adts,-loglevel,error,pipe:1 Jun 18 14:04:30 volumio volumio[12581]: info: JP_Radio::JpRadio.#startStream: ffmpeg=13149 Jun 18 14:04:30 volumio volumio[12581]: info: JP_Radio::JpRadio.#startStream: Streaming started Jun 18 14:04:32 volumio volumio[12581]: info: Jun 18 14:04:32 volumio volumio[12581]: ---------------------------- MPD announces state update: player Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::getState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand status Jun 18 14:04:32 volumio volumio[12581]: info: Jun 18 14:04:32 volumio volumio[12581]: ---------------------------- MPD announces state update: player Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::getState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand status Jun 18 14:04:32 volumio volumio[12581]: info: Jun 18 14:04:32 volumio volumio[12581]: ---------------------------- MPD announces state update: player Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::getState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand status Jun 18 14:04:32 volumio volumio[12581]: info: Jun 18 14:04:32 volumio volumio[12581]: ---------------------------- MPD announces state update: player Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand status took 31 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::getState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand status Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand status took 26 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand status took 20 milliseconds Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 14:04:32 volumio volumio[12581]: info: Jun 18 14:04:32 volumio volumio[12581]: ---------------------------- MPD announces state update: player Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::getState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand status Jun 18 14:04:32 volumio volumio[12581]: info: Jun 18 14:04:32 volumio volumio[12581]: ---------------------------- MPD announces state update: player Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::getState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand status Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand status took 18 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand playlistinfo took 13 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand status took 9 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand status took 6 milliseconds Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseTrackInfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseTrackInfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseTrackInfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseState Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CoreCommandRouter::servicePushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"47 Kbps","isStreaming":false,"title":"FMY","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/FMY","trackType":""} Jun 18 14:04:32 volumio volumio[12581]: verbose: CURRENT POSITION 1 Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState stateService play Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState currentStatus stop Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CoreCommandRouter::servicePushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: verbose: STATE SERVICE {"status":"play","position":0,"seek":272,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"47 Kbps","isStreaming":false,"title":"FMY","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/FMY","trackType":""} Jun 18 14:04:32 volumio volumio[12581]: verbose: CURRENT POSITION 1 Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState stateService play Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState currentStatus play Jun 18 14:04:32 volumio volumio[12581]: info: Received an update from plugin. extracting info from payload Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CoreCommandRouter::servicePushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: verbose: STATE SERVICE {"status":"play","position":0,"seek":409,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"47 Kbps","isStreaming":false,"title":"FMY","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/FMY","trackType":""} Jun 18 14:04:32 volumio volumio[12581]: verbose: CURRENT POSITION 1 Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState stateService play Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState currentStatus play Jun 18 14:04:32 volumio volumio[12581]: info: Received an update from plugin. extracting info from payload Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: info: ------------------------------ 92ms Jun 18 14:04:32 volumio volumio[12581]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jun 18 14:04:32 volumio volumio[12581]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jun 18 14:04:32 volumio volumio[12581]: info: ------------------------------ 84ms Jun 18 14:04:32 volumio volumio[12581]: info: ------------------------------ 79ms Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand playlistinfo took 37 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand playlistinfo took 32 milliseconds Jun 18 14:04:32 volumio volumio[12581]: info: sendMpdCommand playlistinfo took 30 milliseconds Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseTrackInfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseTrackInfo Jun 18 14:04:32 volumio volumio[12581]: verbose: ControllerMpd::parseTrackInfo Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CoreCommandRouter::servicePushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"47 Kbps","isStreaming":false,"title":"FMY","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/FMY","trackType":""} Jun 18 14:04:32 volumio volumio[12581]: verbose: CURRENT POSITION 1 Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState stateService play Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState currentStatus play Jun 18 14:04:32 volumio volumio[12581]: info: Received an update from plugin. extracting info from payload Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CoreCommandRouter::servicePushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"47 Kbps","isStreaming":false,"title":"FMY","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/FMY","trackType":""} Jun 18 14:04:32 volumio volumio[12581]: verbose: CURRENT POSITION 1 Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState stateService play Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState currentStatus play Jun 18 14:04:32 volumio volumio[12581]: info: Received an update from plugin. extracting info from payload Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: info: ControllerMpd::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CoreCommandRouter::servicePushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"47 Kbps","isStreaming":false,"title":"FMY","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/FMY","trackType":""} Jun 18 14:04:32 volumio volumio[12581]: verbose: CURRENT POSITION 1 Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState stateService play Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::syncState currentStatus play Jun 18 14:04:32 volumio volumio[12581]: info: Received an update from plugin. extracting info from payload Jun 18 14:04:32 volumio volumio[12581]: info: CoreStateMachine::pushState Jun 18 14:04:32 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:32 volumio volumio[12581]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jun 18 14:04:32 volumio volumio[12581]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jun 18 14:04:32 volumio volumio[12581]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jun 18 14:04:32 volumio volumio[12581]: info: ------------------------------ 89ms Jun 18 14:04:32 volumio volumio[12581]: info: ------------------------------ 74ms Jun 18 14:04:32 volumio volumio[12581]: info: ------------------------------ 71ms Jun 18 14:04:33 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:33 volumio volumio[12581]: (node:12581) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'name' of undefined Jun 18 14:04:33 volumio volumio[12581]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 18 14:04:33 volumio volumio[12581]: at JpRadio._JpRadio_pushSongState (/data/plugins/music_service/jp_radio/dist/lib/radio.js:270:51) Jun 18 14:04:33 volumio volumio[12581]: at listOnTimeout (internal/timers.js:554:17) Jun 18 14:04:33 volumio volumio[12581]: at processTimers (internal/timers.js:497:7) Jun 18 14:04:33 volumio volumio[12581]: (Use `node --trace-warnings ...` to show where the warning was created) Jun 18 14:04:33 volumio volumio[12581]: (node:12581) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1) Jun 18 14:04:33 volumio volumio[12581]: (node:12581) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Jun 18 14:04:34 volumio volumio[12581]: info: CoreCommandRouter::volumioGetState Jun 18 14:04:34 volumio volumio[12581]: info: CorePlayQueue::getTrack 1 Jun 18 14:04:34 volumio volumio[12581]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 18 14:04:34 volumio volumio[12581]: TypeError: Cannot read property 'name' of undefined Jun 18 14:04:34 volumio volumio[12581]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 18 14:04:34 volumio volumio[12581]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 18 14:04:34 volumio volumio[12581]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:58:38) Jun 18 14:04:34 volumio volumio[12581]: at Socket.emit (events.js:315:20) Jun 18 14:04:34 volumio volumio[12581]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jun 18 14:04:34 volumio volumio[12581]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jun 18 14:04:34 volumio volumio[12581]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 18 14:04:34 volumio sudo[13165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-18 14:03 Jun 18 14:04:34 volumio sudo[13165]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"