-- Logs begin at Tue 2025-10-14 22:31:06 UTC, end at Wed 2025-10-15 22:11:05 UTC. -- Oct 15 22:10:01 volumio volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:10:01 volumio volumio[1124]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:10:01 volumio volumio[1124]: info: Discovery: Getting this device information Oct 15 22:10:01 volumio volumio[1124]: info: CoreCommandRouter::volumioGetState Oct 15 22:10:01 volumio volumio[1124]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 15 22:10:01 volumio volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 15 22:10:01 volumio volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 15 22:10:22 volumio volumio[1124]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 22:10:22 volumio volumio[1124]: TypeError: Cannot read property 'title' of undefined Oct 15 22:10:22 volumio volumio[1124]: at /data/plugins/music_service/podcast/index.js:421:51 Oct 15 22:10:22 volumio volumio[1124]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/podcast/node_modules/rss-parser/lib/utils.js:63:29) Oct 15 22:10:22 volumio volumio[1124]: at ontimeout (timers.js:482:11) Oct 15 22:10:22 volumio volumio[1124]: at tryOnTimeout (timers.js:317:5) Oct 15 22:10:22 volumio volumio[1124]: at Timer.listOnTimeout (timers.js:277:5) Oct 15 22:10:22 volumio volumio[1124]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 22:10:23 volumio sudo[9933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 22:09 Oct 15 22:10:23 volumio sudo[9933]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:23 volumio sudo[9933]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:24 volumio volumio-remote-updater[613]: [2025-10-15 22:10:24] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 22:10:24 volumio volumio-remote-updater[613]: [2025-10-15 22:10:24] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 22:10:24 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Oct 15 22:10:24 volumio systemd[1]: Unit volumio.service entered failed state. Oct 15 22:10:24 volumio systemd[1]: Starting dynamicswap service... Oct 15 22:10:24 volumio systemd[1]: Started dynamicswap service. Oct 15 22:10:24 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Oct 15 22:10:24 volumio systemd[1]: Starting dynamicswap service... Oct 15 22:10:24 volumio systemd[1]: Started dynamicswap service. Oct 15 22:10:24 volumio systemd[1]: Stopping Volumio Backend Module... Oct 15 22:10:24 volumio systemd[1]: Starting Volumio Backend Module... Oct 15 22:10:24 volumio systemd[1]: Started Volumio Backend Module. Oct 15 22:10:26 volumio volumio[9957]: info: ------------------------------------------- Oct 15 22:10:26 volumio volumio[9957]: info: ----- Volumio2 ---- Oct 15 22:10:26 volumio volumio[9957]: info: ------------------------------------------- Oct 15 22:10:26 volumio volumio[9957]: info: ----- System startup ---- Oct 15 22:10:26 volumio volumio[9957]: info: ------------------------------------------- Oct 15 22:10:27 volumio volumio[9957]: info: MYVOLUMIO Environment detected Oct 15 22:10:27 volumio volumio[9957]: info: Plugin folders cleanup Oct 15 22:10:27 volumio volumio[9957]: info: Scanning into folder /volumio/app/plugins/ Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category audio_interface Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category miscellanea Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category music_service Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category plugins.json Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category system_controller Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category user_interface Oct 15 22:10:27 volumio volumio[9957]: info: Scanning into folder /data/plugins/ Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category miscellanea Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category music_service Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category system_controller Oct 15 22:10:27 volumio volumio[9957]: info: Scanning category user_interface Oct 15 22:10:27 volumio volumio[9957]: info: Plugin folders cleanup completed Oct 15 22:10:27 volumio volumio[9957]: info: ------------------------------------------- Oct 15 22:10:27 volumio volumio[9957]: info: ----- Core plugins startup ---- Oct 15 22:10:27 volumio volumio[9957]: info: ------------------------------------------- Oct 15 22:10:27 volumio volumio[9957]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 22:10:27 volumio volumio[9957]: info: Adding plugin upnp to MyMusic Plugins Oct 15 22:10:27 volumio volumio[9957]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 22:10:27 volumio volumio[9957]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 22:10:27 volumio volumio[9957]: info: Loading plugins from folder /data/plugins/ Oct 15 22:10:27 volumio volumio[9957]: info: Loading plugin "system"... Oct 15 22:10:27 volumio volumio[9957]: info: Loading plugin "appearance"... Oct 15 22:10:29 volumio volumio-remote-updater[613]: [2025-10-15 22:10:29] [connect] Successful connection Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "network"... Oct 15 22:10:30 volumio volumio[9957]: info: Refreshing Cached IP Addresses Oct 15 22:10:30 volumio sudo[9983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "touch_display"... Oct 15 22:10:30 volumio sudo[9983]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:30 volumio sudo[9983]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:30 volumio sudo[9986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 22:10:30 volumio sudo[9986]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:30 volumio sudo[9986]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:30 volumio volumio[9957]: info: Applying required configuration parameters for plugin touch_display Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "services"... Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "alsa_controller"... Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "wizard"... Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "volumio_command_line_client"... Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "upnp"... Oct 15 22:10:30 volumio volumio[9957]: info: [1760566230863] Starting Upmpd Daemon Oct 15 22:10:30 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "my_music"... Oct 15 22:10:30 volumio volumio[9957]: info: Loading plugin "mpd"... Oct 15 22:10:31 volumio volumio[9957]: info: Loading plugin "upnp_browser"... Oct 15 22:10:31 volumio volumio[9957]: info: Loading plugin "networkfs"... Oct 15 22:10:31 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 22:10:31 volumio volumio[9957]: info: Loading plugin "alarm-clock"... Oct 15 22:10:32 volumio volumio[9957]: info: Loading plugin "airplay_emulation"... Oct 15 22:10:32 volumio volumio[9957]: info: Starting Shairport Sync Oct 15 22:10:32 volumio volumio[9957]: info: Loading plugin "last_100"... Oct 15 22:10:32 volumio volumio[9957]: info: Loading plugin "webradio"... Oct 15 22:10:32 volumio volumio[9957]: info: Loading plugin "i2s_dacs"... Oct 15 22:10:32 volumio volumio[9957]: info: I2S DAC not set, start Auto-detection Oct 15 22:10:32 volumio volumio[9957]: info: Loading plugin "volumiodiscovery"... Oct 15 22:10:32 volumio volumio[9957]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 22:10:32 volumio node[9957]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 22:10:32 volumio node[9957]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 22:10:32 volumio node[9957]: *** WARNING *** For more information see Oct 15 22:10:32 volumio node[9957]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 22:10:32 volumio node[9957]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 22:10:32 volumio node[9957]: *** WARNING *** For more information see Oct 15 22:10:32 volumio volumio[9957]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 22:10:32 volumio volumio[9957]: *** WARNING *** For more information see Oct 15 22:10:32 volumio volumio[9957]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 22:10:32 volumio volumio[9957]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 22:10:32 volumio volumio[9957]: *** WARNING *** For more information see Oct 15 22:10:32 volumio volumio[9957]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 22:10:32 volumio volumio[9957]: Discovery: StartAdv! undefined Oct 15 22:10:32 volumio volumio[9957]: Discovery: Started advertising... Volumio - undefined Oct 15 22:10:32 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 22:10:32 volumio volumio[9957]: info: Loading plugin "autostart"... Oct 15 22:10:32 volumio volumio[9957]: info: Applying required configuration parameters for plugin autostart Oct 15 22:10:32 volumio volumio[9957]: info: Loading plugin "now_playing"... Oct 15 22:10:33 volumio volumio[9957]: info: Loading plugin "gpio-buttons"... Oct 15 22:10:33 volumio volumio[9957]: info: GPIO-Buttons initialized Oct 15 22:10:33 volumio volumio[9957]: info: Loading plugin "outputs"... Oct 15 22:10:33 volumio volumio[9957]: info: Loading plugin "albumart"... Oct 15 22:10:33 volumio volumio[9957]: info: Plugin example_plugin is not enabled Oct 15 22:10:33 volumio volumio[9957]: info: Loading plugin "inputs"... Oct 15 22:10:33 volumio volumio[9957]: info: Loading plugin "updater_comm"... Oct 15 22:10:33 volumio volumio[9957]: info: Plugin mpdemulation is not enabled Oct 15 22:10:33 volumio volumio[9957]: info: Loading plugin "rest_api"... Oct 15 22:10:33 volumio volumio[9957]: info: Loading plugin "websocket"... Oct 15 22:10:33 volumio volumio[9957]: info: Loading plugin "podcast"... Oct 15 22:10:34 volumio volumio[9957]: Forking 3 albumart workers Oct 15 22:10:35 volumio volumio[9957]: Starting albumart workers Oct 15 22:10:35 volumio volumio[9957]: Starting albumart workers Oct 15 22:10:35 volumio volumio[9957]: Starting albumart workers Oct 15 22:10:37 volumio volumio[9957]: info: ControllerPodcast::constructor Oct 15 22:10:37 volumio volumio[9957]: info: Loading plugin "radio_paradise"... Oct 15 22:10:37 volumio volumio[9957]: info: Applying required configuration parameters for plugin radio_paradise Oct 15 22:10:37 volumio volumio[9957]: info: [1760566237382] [RadioParadise] API delay: 0 Oct 15 22:10:37 volumio volumio[9957]: info: Loading plugin "gpio_radio_buttons"... Oct 15 22:10:37 volumio volumio[9957]: info: Applying required configuration parameters for plugin gpio_radio_buttons Oct 15 22:10:37 volumio volumio[9957]: info: GPIO Radio Buttons: config file: /data/configuration/system_controller/gpio_radio_buttons/config.json Oct 15 22:10:37 volumio volumio[9957]: info: GPIO Radio Buttons: initialized Oct 15 22:10:37 volumio volumio[9957]: info: Loading plugin "gpiorandom"... Oct 15 22:10:38 volumio volumio[9957]: info: Applying required configuration parameters for plugin gpiorandom Oct 15 22:10:38 volumio volumio[9957]: info: Loading plugin "rotaryencoder"... Oct 15 22:10:38 volumio volumio[9957]: info: Applying required configuration parameters for plugin rotaryencoder Oct 15 22:10:38 volumio volumio[9957]: info: ___________ START PLUGINS ___________ Oct 15 22:10:38 volumio volumio[9957]: info: Loading i18n strings for locale en Oct 15 22:10:38 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 22:10:38 volumio volumio[9957]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:10:38 volumio volumio[9957]: info: [1760566238885] CoreMusicLibrary::Adding element Media Servers Oct 15 22:10:38 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:10:38 volumio sudo[10066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 15 22:10:38 volumio sudo[10066]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:38 volumio systemd[1]: Reloading. Oct 15 22:10:39 volumio volumio[9957]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 22:10:39 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Oct 15 22:10:39 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Oct 15 22:10:39 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Oct 15 22:10:39 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Oct 15 22:10:39 volumio volumio[9957]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:10:39 volumio volumio[9957]: info: [1760566239072] CoreMusicLibrary::Adding element Last_100 Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:10:39 volumio volumio[9957]: info: [1760566239076] CoreMusicLibrary::Adding element Webradio Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 22:10:39 volumio volumio[9957]: info: GPIO-Buttons: Reading config and creating triggers... Oct 15 22:10:39 volumio volumio[9957]: info: GPIO-Buttons: playPause on pin 17 Oct 15 22:10:39 volumio volumio[9957]: info: GPIO-Buttons: volumeUp on pin 19 Oct 15 22:10:39 volumio volumio[9957]: info: GPIO-Buttons: shutdown on pin 26 Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:10:39 volumio volumio[9957]: info: [1760566239122] CoreMusicLibrary::Adding element Podcast Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:10:39 volumio sudo[10066]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:10:39 volumio volumio[9957]: info: [1760566239140] CoreMusicLibrary::Adding element Radio Paradise Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:10:39 volumio volumio[9957]: info: GPIO Radio Buttons: Using gpio pins from config file: [4,5,6,12,13,16,17,18,19,20,21,22,23,24,25,26,27] Oct 15 22:10:39 volumio volumio[9957]: info: GPIO Radio Buttons: Reading config and creating triggers... Oct 15 22:10:39 volumio volumio[9957]: info: GPIO Radio Buttons: button1 on pin 4 tunes to BBC 4 using uri http://lsn.lv/bbcradio.m3u8?station=bbc_radio_fourfm&bitrate=320000 Oct 15 22:10:39 volumio volumio[9957]: info: GPIO Radio Buttons: button2 on pin 5 tunes to BBC 1 using uri http://lsn.lv/bbcradio.m3u8?station=bbc_radio_one&bitrate=320000 Oct 15 22:10:39 volumio volumio[9957]: info: GPIO Radio Buttons: button3 on pin 6 tunes to BBC 6 using uri http://lsn.lv/bbcradio.m3u8?station=bbc_6music&bitrate=320000 Oct 15 22:10:39 volumio volumio[9957]: info: GPIO Radio Buttons: button4 on pin 12 tunes to BBC Scotland using uri http://lsn.lv/bbcradio.m3u8?station=bbc_radio_scotland_fm&bitrate=320000&uk=1 Oct 15 22:10:39 volumio volumio[9957]: info: GPIO Radio Buttons: button5 on pin 25 tunes to Radio Paradise using uri http://stream-dc1.radioparadise.com/rp_192m.ogg Oct 15 22:10:39 volumio volumio[9957]: info: gpioRandom : init GPIO, edge = rising debounceTimeout = 5 activeLow = false Oct 15 22:10:39 volumio volumio[9957]: info: ------------------------------------------- Oct 15 22:10:39 volumio volumio[9957]: info: ----- MyVolumio plugins startup ---- Oct 15 22:10:39 volumio volumio[9957]: info: ------------------------------------------- Oct 15 22:10:39 volumio volumio[9957]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 15 22:10:39 volumio volumio[9957]: info: Loading i18n strings for locale en Oct 15 22:10:39 volumio volumio[9957]: Updating browse sources language Oct 15 22:10:39 volumio volumio[9957]: Cannot find translation for sourceMedia Servers Oct 15 22:10:39 volumio volumio[9957]: Cannot find translation for sourcePodcast Oct 15 22:10:39 volumio volumio[9957]: Cannot find translation for sourceRadio Paradise Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::initPlayerControls Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 22:10:39 volumio volumio[9957]: info: BOOT COMPLETED Oct 15 22:10:39 volumio volumio[9957]: [Metrics] CommandRouter: 12s 750.88ms Oct 15 22:10:39 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:10:41 volumio volumio-remote-updater[613]: [2025-10-15 22:10:41] [connect] Successful connection Oct 15 22:10:44 volumio volumio[9957]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 15 22:10:44 volumio volumio[9957]: info: CoreCommandRouter::Close All Modals sent Oct 15 22:10:44 volumio volumio[9957]: info: CoreCommandRouter::Close All Modals sent Oct 15 22:10:44 volumio volumio[9957]: Express server listening on port 3000 Oct 15 22:10:44 volumio volumio[9957]: [Metrics] WebUI: 18s 635.79ms Oct 15 22:10:44 volumio volumio[9957]: Volumio Calling Home Oct 15 22:10:44 volumio volumio[9957]: (node:9957) Warning: N-API is an experimental feature and could change at any time. Oct 15 22:10:44 volumio volumio[9957]: info: [now-playing-app] App is listening on port 4004. Oct 15 22:10:44 volumio volumio[9957]: info: GPIO-Buttons started Oct 15 22:10:44 volumio volumio[9957]: info: GPIO Radio Buttons: Triggers installed Oct 15 22:10:44 volumio volumio[9957]: info: CoreStateMachine::resetVolumioState Oct 15 22:10:44 volumio volumio[9957]: info: CoreStateMachine::getcurrentVolume Oct 15 22:10:44 volumio volumio[9957]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 22:10:44 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:10:44 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:10:44 volumio sudo[10106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 22:10:44 volumio sudo[10106]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:44 volumio sudo[10109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 22:10:44 volumio sudo[10106]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:44 volumio sudo[10109]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:44 volumio sudo[10109]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:45 volumio volumio[9957]: info: Setting Device type: Raspberry PI Oct 15 22:10:45 volumio volumio[9957]: info: touch_display: systemctl daemon-reload succeeded. Oct 15 22:10:45 volumio sudo[10125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Oct 15 22:10:45 volumio volumio[9957]: info: MPD running with PID681 Oct 15 22:10:45 volumio volumio[9957]: ,establishing connection Oct 15 22:10:45 volumio sudo[10125]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:45 volumio sudo[10130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Oct 15 22:10:45 volumio systemd[1]: Started Volumio Kiosk. Oct 15 22:10:45 volumio sudo[10125]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:45 volumio sudo[10130]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:45 volumio sudo[10130]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:45 volumio volumio-remote-updater[613]: [2025-10-15 22:10:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1760566241 101 Oct 15 22:10:45 volumio volumio[9957]: info: VolumeController:: Volume=100 Mute =false Oct 15 22:10:45 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:45 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:45 volumio volumio[9957]: info: CoreStateMachine::updateTrackBlock Oct 15 22:10:45 volumio volumio[9957]: info: CorePlayQueue::getTrackBlock Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 22:10:45 volumio volumio[9957]: info: Volumio called home Oct 15 22:10:45 volumio volumio[9957]: info: Oct 15 22:10:45 volumio volumio[9957]: ---------------------------- Client requests Volume 100 Oct 15 22:10:45 volumio volumio[9957]: info: VolumeController::SetAlsaVolume100 Oct 15 22:10:45 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:45 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:10:45 volumio volumio[9957]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Oct 15 22:10:45 volumio volumio[9957]: info: touch_display: Volumio Kiosk started Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::volumioGetState Oct 15 22:10:45 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:45 volumio volumio[9957]: info: Reloading queue from file Oct 15 22:10:45 volumio volumio[9957]: info: CoreCommandRouter::volumioGetState Oct 15 22:10:45 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:46 volumio volumio[9957]: info: Setting volume on startup at 100 Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 15 22:10:46 volumio volumio[9957]: info: CoreStateMachine::setRepeat true single undefined Oct 15 22:10:46 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:46 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:46 volumio volumio[9957]: info: CoreStateMachine::setRandom false Oct 15 22:10:46 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:46 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:46 volumio volumio[9957]: info: VolumeController:: Volume=100 Mute =false Oct 15 22:10:46 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:46 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:46 volumio volumio[9957]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 15 22:10:46 volumio volumio[9957]: info: CoreCommandRouter::volumioGetState Oct 15 22:10:46 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:46 volumio volumio[9957]: info: Starting Shairport Sync Oct 15 22:10:46 volumio volumio[9957]: info: Starting Shairport Sync Oct 15 22:10:46 volumio sudo[10156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 22:10:46 volumio sudo[10156]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:46 volumio sudo[10159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 22:10:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 22:10:46 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 15 22:10:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 22:10:46 volumio sudo[10156]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:46 volumio sudo[10165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 15 22:10:46 volumio sudo[10159]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:46 volumio sudo[10165]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 22:10:46 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 15 22:10:46 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 15 22:10:46 volumio sudo[10165]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 22:10:46 volumio sudo[10159]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:47 volumio volumio[9957]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 15 22:10:47 volumio volumio[9957]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Oct 15 22:10:47 volumio sudo[10208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Oct 15 22:10:47 volumio sudo[10208]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:47 volumio sudo[10208]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:47 volumio volumio[9957]: info: Upmpdcli Daemon Started Oct 15 22:10:47 volumio volumio[9957]: info: Shairport-Sync Started Oct 15 22:10:47 volumio volumio[9957]: Error adding Membership: Error: addMembership EINVAL Oct 15 22:10:47 volumio volumio[9957]: info: Shairport-Sync Started Oct 15 22:10:47 volumio volumio[9957]: Discovery: adding 1b41bda5-9324-4127-8254-a82c04377bc4 Oct 15 22:10:47 volumio volumio[9957]: info: mDNS: Found device Volumio Oct 15 22:10:47 volumio volumio[9957]: info: CoreCommandRouter::volumioGetState Oct 15 22:10:47 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:47 volumio volumio[9957]: info: CALLMETHOD: miscellanea now_playing broadcastPluginInfo undefined Oct 15 22:10:47 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: now_playing , broadcastPluginInfo Oct 15 22:10:47 volumio volumio[9957]: info: touch_display: Touchscreen transformation matrix removed. Oct 15 22:10:47 volumio volumio[9957]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 15 22:10:47 volumio volumio[9957]: info: CoreCommandRouter::volumioGetState Oct 15 22:10:47 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:47 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 15 22:10:47 volumio volumio[9957]: info: CoreCommandRouter::volumioGetState Oct 15 22:10:47 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:48 volumio volumio[9957]: info: gpioRandom : loadRadiosList - list done - unregister browseLibrary event Oct 15 22:10:50 volumio volumio[9957]: info: CoreCommandRouter::volumioGetState Oct 15 22:10:50 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 15 22:10:51 volumio volumio[9957]: info: Adding plugin bluetooth to MyMusic Plugins Oct 15 22:10:51 volumio volumio[9957]: info: Adding plugin cd_controller to MyMusic Plugins Oct 15 22:10:51 volumio volumio[9957]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 15 22:10:51 volumio volumio[9957]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 15 22:10:51 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:10:51 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:10:51 volumio volumio[9957]: info: Starting MyVolumio Remote Streaming Endpoints Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 15 22:10:51 volumio volumio[9957]: info: Streaming services startup Oct 15 22:10:51 volumio volumio[9957]: info: Starting Streaming Daemon Oct 15 22:10:51 volumio sudo[10226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 15 22:10:51 volumio sudo[10226]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:10:51 volumio systemd[1]: Stopping Volumio Streaming Daemon... Oct 15 22:10:51 volumio systemd[1]: Starting Volumio Streaming Daemon... Oct 15 22:10:51 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 15 22:10:51 volumio sudo[10226]: pam_unix(sudo:session): session closed for user root Oct 15 22:10:51 volumio volumio-streaming-daemon[10235]: ############################ Oct 15 22:10:51 volumio volumio-streaming-daemon[10235]: # Volumio Streaming Daemon # Oct 15 22:10:51 volumio volumio-streaming-daemon[10235]: # Running on port 7777 # Oct 15 22:10:51 volumio volumio-streaming-daemon[10235]: ############################ Oct 15 22:10:51 volumio volumio-streaming-daemon[10235]: Environment: production Oct 15 22:10:51 volumio volumio[9957]: info: MyVolumio login type: Token Oct 15 22:10:51 volumio volumio[9957]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 15 22:10:52 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 22:10:52 volumio volumio[9957]: info: Listing playlists Oct 15 22:10:52 volumio volumio[9957]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 22:10:52 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:10:52 volumio volumio[9957]: info: CoreCommandRouter::volumioGetQueue Oct 15 22:10:52 volumio volumio[9957]: info: CoreStateMachine::getQueue Oct 15 22:10:52 volumio volumio[9957]: info: CorePlayQueue::getQueue Oct 15 22:10:52 volumio volumio[9957]: info: AutoStart - getting queue Oct 15 22:10:52 volumio volumio[9957]: info: CoreCommandRouter::volumioGetQueue Oct 15 22:10:52 volumio volumio[9957]: info: CoreStateMachine::getQueue Oct 15 22:10:52 volumio volumio[9957]: info: CorePlayQueue::getQueue Oct 15 22:10:52 volumio volumio[9957]: info: AutoStart - start playing -> queue is not empty Oct 15 22:10:52 volumio volumio[9957]: info: CoreCommandRouter::volumioPlay Oct 15 22:10:52 volumio volumio[9957]: verbose: UNSET VOLATILE Oct 15 22:10:52 volumio volumio[9957]: info: CoreStateMachine::play index undefined Oct 15 22:10:52 volumio volumio[9957]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 22:10:52 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:52 volumio volumio[9957]: info: CoreStateMachine::startPlaybackTimer Oct 15 22:10:52 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:52 volumio volumio[9957]: info: [1760566252535] ControllerWebradio::clearAddPlayTrack Oct 15 22:10:52 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 22:10:53 volumio volumio[9957]: info: sendMpdCommand stop took 753 milliseconds Oct 15 22:10:53 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 22:10:53 volumio volumio[9957]: info: Oct 15 22:10:53 volumio volumio[9957]: ---------------------------- MPD announces state update: player Oct 15 22:10:53 volumio volumio[9957]: info: Oct 15 22:10:53 volumio volumio[9957]: ---------------------------- MPD announces system playlist update Oct 15 22:10:53 volumio volumio[9957]: info: Ignoring MPD Status Update Oct 15 22:10:53 volumio volumio[9957]: info: ControllerMpd::getState Oct 15 22:10:53 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand status Oct 15 22:10:53 volumio volumio[9957]: info: sendMpdCommand clear took 6 milliseconds Oct 15 22:10:53 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand load "http://lsn.lv/bbcradio.m3u8?station=bbc_radio_fourfm&bitrate=320000" Oct 15 22:10:53 volumio volumio[9957]: error: updateQueue error: null Oct 15 22:10:53 volumio volumio[9957]: info: sendMpdCommand status took 7 milliseconds Oct 15 22:10:53 volumio volumio[9957]: info: ------------------------------ 12ms Oct 15 22:10:53 volumio volumio[9957]: verbose: ControllerMpd::parseState Oct 15 22:10:53 volumio volumio[9957]: info: ControllerMpd::pushState Oct 15 22:10:53 volumio volumio[9957]: info: CoreCommandRouter::servicePushState Oct 15 22:10:53 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:53 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:53 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:53 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:53 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:53 volumio volumio[9957]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 15 22:10:53 volumio volumio[9957]: info: ------------------------------ 42ms Oct 15 22:10:54 volumio volumio-streaming-daemon[10235]: Environment: production Oct 15 22:10:54 volumio volumio[9957]: info: Fetching Streaming Services browse cache Oct 15 22:10:58 volumio volumio[9957]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 15 22:10:58 volumio volumio[9957]: info: MYVOLUMIO: Adding device Oct 15 22:10:58 volumio volumio[9957]: info: MYVOLUMIO: Evaluating Server Oct 15 22:10:58 volumio volumio[9957]: info: sendMpdCommand load "http://lsn.lv/bbcradio.m3u8?station=bbc_radio_fourfm&bitrate=320000" took 5463 milliseconds Oct 15 22:10:58 volumio volumio[9957]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 15 22:10:58 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand play Oct 15 22:10:58 volumio volumio[9957]: info: Oct 15 22:10:58 volumio volumio[9957]: ---------------------------- MPD announces system playlist update Oct 15 22:10:58 volumio volumio[9957]: info: Ignoring MPD Status Update Oct 15 22:10:58 volumio volumio[9957]: info: sendMpdCommand play took 3 milliseconds Oct 15 22:10:58 volumio volumio[9957]: info: ------------------------------ 3ms Oct 15 22:10:59 volumio volumio[9957]: info: Oct 15 22:10:59 volumio volumio[9957]: ---------------------------- MPD announces state update: player Oct 15 22:10:59 volumio volumio[9957]: info: ControllerMpd::getState Oct 15 22:10:59 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand status Oct 15 22:10:59 volumio volumio[9957]: info: Oct 15 22:10:59 volumio volumio[9957]: ---------------------------- MPD announces state update: player Oct 15 22:10:59 volumio volumio[9957]: info: ControllerMpd::getState Oct 15 22:10:59 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand status Oct 15 22:10:59 volumio volumio[9957]: info: sendMpdCommand status took 3 milliseconds Oct 15 22:10:59 volumio volumio[9957]: verbose: ControllerMpd::parseState Oct 15 22:10:59 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 22:10:59 volumio volumio[9957]: info: sendMpdCommand status took 4 milliseconds Oct 15 22:10:59 volumio volumio[9957]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 15 22:10:59 volumio volumio[9957]: verbose: ControllerMpd::parseState Oct 15 22:10:59 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 22:10:59 volumio volumio[9957]: verbose: ControllerMpd::parseTrackInfo Oct 15 22:10:59 volumio volumio[9957]: info: ControllerMpd::pushState Oct 15 22:10:59 volumio volumio[9957]: info: CoreCommandRouter::servicePushState Oct 15 22:10:59 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:59 volumio volumio[9957]: verbose: STATE SERVICE {"status":"play","position":0,"seek":426,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"316 Kbps","isStreaming":false,"title":"bbc_radio_fourfm-audio%3d320000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_55057080/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d320000.norewind.m3u8","trackType":"m3u8"} Oct 15 22:10:59 volumio volumio[9957]: verbose: CURRENT POSITION 0 Oct 15 22:10:59 volumio volumio[9957]: info: CoreStateMachine::syncState stateService play Oct 15 22:10:59 volumio volumio[9957]: info: CoreStateMachine::syncState currentStatus stop Oct 15 22:10:59 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:59 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:59 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:59 volumio volumio[9957]: info: ------------------------------ 35ms Oct 15 22:10:59 volumio volumio[9957]: info: sendMpdCommand playlistinfo took 28 milliseconds Oct 15 22:10:59 volumio volumio[9957]: verbose: ControllerMpd::parseTrackInfo Oct 15 22:10:59 volumio volumio[9957]: info: ControllerMpd::pushState Oct 15 22:10:59 volumio volumio[9957]: info: CoreCommandRouter::servicePushState Oct 15 22:10:59 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:10:59 volumio volumio[9957]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"316 Kbps","isStreaming":false,"title":"bbc_radio_fourfm-audio%3d320000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_55057080/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d320000.norewind.m3u8","trackType":"m3u8"} Oct 15 22:10:59 volumio volumio[9957]: verbose: CURRENT POSITION 0 Oct 15 22:10:59 volumio volumio[9957]: info: CoreStateMachine::syncState stateService play Oct 15 22:10:59 volumio volumio[9957]: info: CoreStateMachine::syncState currentStatus play Oct 15 22:10:59 volumio volumio[9957]: info: Received an update from plugin. extracting info from payload Oct 15 22:10:59 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:59 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:59 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:59 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:10:59 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:10:59 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:10:59 volumio volumio[9957]: info: ------------------------------ 92ms Oct 15 22:10:59 volumio volumio[9957]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 15 22:11:03 volumio volumio[9957]: info: MyVolumio status changed Oct 15 22:11:03 volumio volumio[9957]: info: Streaming services startup Oct 15 22:11:03 volumio volumio[9957]: info: Re-Starting Streaming Daemon Oct 15 22:11:03 volumio volumio[9957]: info: Removing browser output: myVolumio user plan is not superstar Oct 15 22:11:03 volumio volumio[9957]: info: Removing audio output: Oct 15 22:11:03 volumio volumio[9957]: info: Stoppping Tunnel 1 Oct 15 22:11:03 volumio volumio-streaming-daemon[10235]: Restarting daemon Oct 15 22:11:03 volumio sudo[10285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 15 22:11:03 volumio sudo[10285]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 22:11:03 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Oct 15 22:11:03 volumio sudo[10285]: pam_unix(sudo:session): session closed for user root Oct 15 22:11:03 volumio volumio[9957]: info: Remote SSH Stopped Oct 15 22:11:04 volumio volumio[9957]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 22:11:04 volumio volumio[9957]: info: CoreStateMachine::ClearQueue Oct 15 22:11:04 volumio volumio[9957]: info: CoreStateMachine::stop Oct 15 22:11:04 volumio volumio[9957]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 22:11:04 volumio volumio[9957]: verbose: UNSET VOLATILE Oct 15 22:11:04 volumio volumio[9957]: info: CoreStateMachine::stPlaybackTimer Oct 15 22:11:04 volumio volumio[9957]: info: CoreStateMachine::updateTrackBlock Oct 15 22:11:04 volumio volumio[9957]: info: CorePlayQueue::getTrackBlock Oct 15 22:11:04 volumio volumio[9957]: info: CoreStateMachine::pushState Oct 15 22:11:04 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:11:04 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:11:04 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:11:04 volumio volumio[9957]: info: CoreStateMachine::serviceStop Oct 15 22:11:04 volumio volumio[9957]: info: CorePlayQueue::getTrack 0 Oct 15 22:11:04 volumio volumio[9957]: info: CoreCommandRouter::serviceStop Oct 15 22:11:04 volumio volumio[9957]: info: [1760566264562] ControllerWebradio::stop Oct 15 22:11:04 volumio volumio[9957]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 22:11:04 volumio volumio[9957]: info: CorePlayQueue::clearPlayQueue Oct 15 22:11:04 volumio volumio[9957]: info: CorePlayQueue::saveQueue Oct 15 22:11:04 volumio volumio[9957]: info: CoreCommandRouter::volumioPushState Oct 15 22:11:04 volumio volumio[9957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:11:04 volumio volumio[9957]: info: CoreCommandRouter::volumioPushQueue Oct 15 22:11:04 volumio volumio[9957]: info: CoreStateMachine::addQueueItems Oct 15 22:11:04 volumio volumio[9957]: info: CorePlayQueue::addQueueItems Oct 15 22:11:04 volumio volumio[9957]: info: Adding Item to queue: podcast/6/0 Oct 15 22:11:04 volumio volumio[9957]: info: Exploding uri podcast/6/0 in service podcast Oct 15 22:11:04 volumio volumio[9957]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 22:11:04 volumio volumio[9957]: TypeError: Cannot read property 'url' of undefined Oct 15 22:11:04 volumio volumio[9957]: at ControllerPodcast.explodeUri (/data/plugins/music_service/podcast/index.js:665:22) Oct 15 22:11:04 volumio volumio[9957]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1283:16) Oct 15 22:11:04 volumio volumio[9957]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:144:48) Oct 15 22:11:04 volumio volumio[9957]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:238:25) Oct 15 22:11:04 volumio volumio[9957]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:476:23) Oct 15 22:11:04 volumio volumio[9957]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:452:17) Oct 15 22:11:04 volumio volumio[9957]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:106:35) Oct 15 22:11:04 volumio volumio[9957]: at emitTwo (events.js:126:13) Oct 15 22:11:04 volumio volumio[9957]: at Socket.emit (events.js:214:7) Oct 15 22:11:04 volumio volumio[9957]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 15 22:11:04 volumio volumio[9957]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Oct 15 22:11:04 volumio volumio[9957]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 15 22:11:04 volumio volumio[9957]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 22:11:05 volumio sudo[10323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 22:10 Oct 15 22:11:05 volumio sudo[10323]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"