Feb 18 11:10:00 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:00 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:00 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:00 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:01 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:01 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:01 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:01 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:02 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:02 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:02 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:02 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:03 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:03 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:03 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:03 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:04 living-room volumio[1294]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/lastfm/volumio/bookworm/armhf Feb 18 11:10:04 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:04.168+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:04 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:04 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:04 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:04 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:05 living-room volumio[1294]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/lastfm/volumio/bookworm/armhf Feb 18 11:10:05 living-room volumio[1294]: info: Folder /tmp/plugins removed Feb 18 11:10:05 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:05.736+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:05 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:05.819+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:05 living-room volumio[1294]: info: Check plugin dependencies Feb 18 11:10:05 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 11:10:05 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:05.830+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:05 living-room volumio[1294]: info: Checking if plugin already exists Feb 18 11:10:05 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:05.831+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:05 living-room volumio[1294]: info: Rename folder Feb 18 11:10:05 living-room volumio[1294]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 11:10:05 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:05.847+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:05 living-room volumio[1294]: info: Move to category Feb 18 11:10:05 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:05 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:05 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:05 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:06 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:06.825+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:06 living-room volumio[1294]: info: Checking if install.sh is present Feb 18 11:10:06 living-room volumio[1294]: info: Executing install.sh Feb 18 11:10:06 living-room sudo[9368]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/lastfm/install.sh Feb 18 11:10:06 living-room sudo[9368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:10:06 living-room sudo[9368]: pam_unix(sudo:session): session closed for user root Feb 18 11:10:06 living-room volumio[1294]: info: Install script completed Feb 18 11:10:06 living-room volumio[1294]: info: Adding reference to registry Feb 18 11:10:06 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:06.859+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:06 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:06.860+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:06 living-room volumio[1294]: info: Done installing plugin. Feb 18 11:10:06 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 11:10:06 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 11:10:06 living-room volumio[1294]: info: Folder /tmp/plugins removed Feb 18 11:10:06 living-room volumio[1294]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 11:10:06 living-room volumio[1294]: info: Folder /data/temp removed Feb 18 11:10:06 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:06 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:06 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:06 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:07 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:07 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:07 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:07 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:08 living-room volumio[1294]: info: Enabling plugin lastfm Feb 18 11:10:08 living-room volumio[1294]: info: Loading plugin "lastfm"... Feb 18 11:10:08 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:08 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:08 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:08 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:08 living-room volumio[1294]: info: PLUGIN START: lastfm Feb 18 11:10:08 living-room volumio[1294]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 18 11:10:08 living-room volumio[1294]: info: [1771409408967] CoreMusicLibrary::Adding element LastFM Feb 18 11:10:08 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 11:10:08 living-room volumio[1294]: Cannot find translation for source LastFM Feb 18 11:10:08 living-room volumio[1294]: info: [LastFM] scrobbler initiated! Feb 18 11:10:08 living-room volumio[1294]: info: [LastFM] extended logging: false Feb 18 11:10:08 living-room volumio[1294]: info: [LastFM] try scrobble stream/radio plays: true Feb 18 11:10:08 living-room volumio[1294]: info: [LastFM] Configuration parameters missing: "API_KEY" "API_SECRET" "username" "authToken" Feb 18 11:10:08 living-room volumio[1294]: info: [LastFM] Left init routine Feb 18 11:10:08 living-room volumio[1294]: info: [LastFM] Socket already connected: false Feb 18 11:10:08 living-room volumio[1294]: info: [LastFM] finished init with error: Configuration parameters missing: "API_KEY" "API_SECRET" "username" "authToken" Feb 18 11:10:08 living-room volumio[1294]: info: Done. Feb 18 11:10:08 living-room volumio[1294]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 18 11:10:09 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:09 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:09 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:09 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:10 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:10 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:10 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:10 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:11 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:11 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:11 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:11 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:12 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:12 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:12 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:12 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:13 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:13 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:13 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:13 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:14 living-room volumio[1294]: info: Enabling plugin lastfm Feb 18 11:10:14 living-room volumio[1294]: info: Loading plugin "lastfm"... Feb 18 11:10:14 living-room volumio[1294]: info: PLUGIN START: lastfm Feb 18 11:10:14 living-room volumio[1294]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 18 11:10:14 living-room volumio[1294]: info: [1771409414249] CoreMusicLibrary::Adding element LastFM Feb 18 11:10:14 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 11:10:14 living-room volumio[1294]: Cannot find translation for source LastFM Feb 18 11:10:14 living-room volumio[1294]: info: [LastFM] scrobbler initiated! Feb 18 11:10:14 living-room volumio[1294]: info: [LastFM] extended logging: false Feb 18 11:10:14 living-room volumio[1294]: info: [LastFM] try scrobble stream/radio plays: true Feb 18 11:10:14 living-room volumio[1294]: info: [LastFM] Configuration parameters missing: "API_KEY" "API_SECRET" "username" "authToken" Feb 18 11:10:14 living-room volumio[1294]: info: [LastFM] Left init routine Feb 18 11:10:14 living-room volumio[1294]: info: [LastFM] Socket already connected: true Feb 18 11:10:14 living-room volumio[1294]: info: [LastFM] finished init with error: Configuration parameters missing: "API_KEY" "API_SECRET" "username" "authToken" Feb 18 11:10:14 living-room volumio[1294]: info: Done. Feb 18 11:10:14 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:14 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:14 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:14 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:15 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:15 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:15 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:15 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:16 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:16 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:16 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:16 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:17 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:17 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:17 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:17 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:18 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:18 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:18 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:18 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:19 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:19 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:19 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:19 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:20 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:20 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:20 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:20 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:21 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:21 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:21 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:21 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:22 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:22 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:22 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:22 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:23 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:23 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:23 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:23 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:24 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:24 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:24 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:24 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:25 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:25 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:25 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:25 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:26 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:26 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:26 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:26 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:27 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 11:10:27 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 11:10:27 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:27 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:27 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:27 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:28 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:28 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:28 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:28 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:29 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:29 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:29 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:29 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:30 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:30 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:30 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:30 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:31 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:31 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:31 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:31 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:32 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:32 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:32 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:32 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:33 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:33 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:33 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:33 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:34 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:34 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:34 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:34 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:35 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:35 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:35 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:35 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:36 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:36 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:36 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:36 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:37 living-room volumio[1294]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf Feb 18 11:10:37 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:37.548+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:37 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:37 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:37 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:37 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:38 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:38 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:38 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:38 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:39 living-room volumio[1294]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf Feb 18 11:10:39 living-room volumio[1294]: info: Folder /tmp/plugins removed Feb 18 11:10:39 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:39.742+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:39 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:39 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:39 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:39 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:40 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:40.039+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:40 living-room volumio[1294]: info: Check plugin dependencies Feb 18 11:10:40 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 11:10:40 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:40.075+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:40 living-room volumio[1294]: info: Checking if plugin already exists Feb 18 11:10:40 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:40.076+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:40 living-room volumio[1294]: info: Rename folder Feb 18 11:10:40 living-room volumio[1294]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 11:10:40 living-room volumio[1294]: info: Move to category Feb 18 11:10:40 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:40.085+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:40 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:40 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:40 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:40 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:41 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:41 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:41 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:41 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:42 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:42 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:42 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:42 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:43 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:43 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:43 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:43 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:44 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:44 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:44 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:44 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:45 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:45.377+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:45 living-room volumio[1294]: info: Checking if install.sh is present Feb 18 11:10:45 living-room volumio[1294]: info: Executing install.sh Feb 18 11:10:45 living-room sudo[9531]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/now_playing/install.sh Feb 18 11:10:45 living-room sudo[9531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:10:45 living-room volumio[1294]: info: Installing geo-tz node dependency Feb 18 11:10:45 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:45.416+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:45 living-room volumio[1294]: info: Installing geo-tz node dependency Feb 18 11:10:45 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:45.422+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:45 living-room su[9534]: (to volumio) root on none Feb 18 11:10:45 living-room su[9534]: pam_unix(su:session): session opened for user volumio(uid=1000) by (uid=0) Feb 18 11:10:45 living-room systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Feb 18 11:10:45 living-room systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Feb 18 11:10:45 living-room systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Feb 18 11:10:45 living-room systemd[1]: Starting user@1000.service - User Manager for UID 1000... Feb 18 11:10:45 living-room (systemd)[9536]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0) Feb 18 11:10:45 living-room systemd[9536]: Queued start job for default target default.target. Feb 18 11:10:45 living-room systemd[9536]: Created slice app.slice - User Application Slice. Feb 18 11:10:45 living-room systemd[9536]: Reached target paths.target - Paths. Feb 18 11:10:45 living-room systemd[9536]: Reached target timers.target - Timers. Feb 18 11:10:45 living-room systemd[9536]: Starting dbus.socket - D-Bus User Message Bus Socket... Feb 18 11:10:45 living-room systemd[9536]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Feb 18 11:10:45 living-room systemd[9536]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Feb 18 11:10:45 living-room systemd[9536]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Feb 18 11:10:45 living-room systemd[9536]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Feb 18 11:10:45 living-room systemd[9536]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Feb 18 11:10:45 living-room systemd[9536]: Listening on dbus.socket - D-Bus User Message Bus Socket. Feb 18 11:10:45 living-room systemd[9536]: Reached target sockets.target - Sockets. Feb 18 11:10:45 living-room systemd[9536]: Reached target basic.target - Basic System. Feb 18 11:10:45 living-room systemd[1]: Started user@1000.service - User Manager for UID 1000. Feb 18 11:10:45 living-room systemd[1]: Started session-c1.scope - Session c1 of User volumio. Feb 18 11:10:45 living-room systemd[9536]: Started mpris-proxy.service - Bluetooth mpris proxy. Feb 18 11:10:45 living-room systemd[9536]: Reached target default.target - Main User Target. Feb 18 11:10:45 living-room systemd[9536]: Startup finished in 256ms. Feb 18 11:10:45 living-room systemd[9536]: Created slice session.slice - User Core Session Slice. Feb 18 11:10:45 living-room systemd[9536]: Starting dbus.service - D-Bus User Message Bus... Feb 18 11:10:45 living-room systemd[9536]: Started dbus.service - D-Bus User Message Bus. Feb 18 11:10:45 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:45 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:45 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:45 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:46 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:46 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:46 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:46 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:47 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:47 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:47 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:47 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:48 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:48 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:48 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:48 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:49 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:49 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:49 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:49 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:50 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:50 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:50 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:50 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:51 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:51 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:51 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:51 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.236+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: added 27 packages, changed 4 packages, and audited 162 packages in 6s Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.237+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.240+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: added 27 packages, changed 4 packages, and audited 162 packages in 6s Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio[1294]: info: 24 packages are looking for funding Feb 18 11:10:52 living-room volumio[1294]: info: run `npm fund` for details Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.242+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.242+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.242+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.242+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.251+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: 24 packages are looking for funding Feb 18 11:10:52 living-room volumio[1294]: info: run `npm fund` for details Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.253+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.253+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.258+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: 1 low severity vulnerability Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio[1294]: info: To address all issues, run: Feb 18 11:10:52 living-room volumio[1294]: info: npm audit fix Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio[1294]: info: Run `npm audit` for details. Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.260+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.260+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.261+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.261+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.261+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.261+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.265+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: 1 low severity vulnerability Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio[1294]: info: To address all issues, run: Feb 18 11:10:52 living-room volumio[1294]: info: npm audit fix Feb 18 11:10:52 living-room volumio[1294]: info: Feb 18 11:10:52 living-room volumio[1294]: info: Run `npm audit` for details. Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.277+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.277+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.277+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.277+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.277+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.278+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room su[9534]: pam_unix(su:session): session closed for user volumio Feb 18 11:10:52 living-room systemd[1]: session-c1.scope: Deactivated successfully. Feb 18 11:10:52 living-room systemd[1]: session-c1.scope: Consumed 12.124s CPU time. Feb 18 11:10:52 living-room volumio[1294]: info: Creating user directories (if not exist) Feb 18 11:10:52 living-room volumio[1294]: info: Creating user directories (if not exist) Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.364+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.365+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room sudo[9531]: pam_unix(sudo:session): session closed for user root Feb 18 11:10:52 living-room volumio[1294]: info: Now Playing plugin installed Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.372+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: Plugin install end detected on script Feb 18 11:10:52 living-room volumio[1294]: info: Now Playing plugin installed Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.373+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: Plugin install end detected on script Feb 18 11:10:52 living-room volumio[1294]: info: Install script completed Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.376+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: Adding reference to registry Feb 18 11:10:52 living-room volumio5-onboarding[2639]: time=2026-02-18T11:10:52.378+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:10:52 living-room volumio[1294]: info: Done installing plugin. Feb 18 11:10:52 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 11:10:52 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 11:10:52 living-room volumio[1294]: info: Folder /tmp/plugins removed Feb 18 11:10:52 living-room volumio[1294]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 11:10:52 living-room volumio[1294]: info: Folder /data/temp removed Feb 18 11:10:52 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:52 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:52 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:52 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:53 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:53 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:53 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:53 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:54 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:54 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:54 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:54 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:55 living-room volumio[1294]: info: Enabling plugin now_playing Feb 18 11:10:55 living-room volumio[1294]: info: Loading plugin "now_playing"... Feb 18 11:10:55 living-room volumio[1294]: info: PLUGIN START: now_playing Feb 18 11:10:55 living-room volumio[1294]: info: [now-playing] ConfigUpdater: config version unavailable. Either this is the first time the plugin is installed, or the previous version is < 0.3.0). Config will not be updated. Feb 18 11:10:55 living-room volumio[1294]: info: [now-playing] ConfigUpdater: updated config version to 1.0.6 Feb 18 11:10:55 living-room volumio[1294]: info: [now-playing] App is listening on port 4004. Feb 18 11:10:55 living-room volumio[1294]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Feb 18 11:10:55 living-room volumio[1294]: info: Done. Feb 18 11:10:55 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:55 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:55 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:55 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:56 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:56 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:56 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:56 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:57 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:57 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:57 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:57 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:58 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:58 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:58 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:58 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:59 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:59 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:10:59 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:10:59 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:01 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:01 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:01 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:01 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:01 living-room volumio[1294]: info: Enabling plugin now_playing Feb 18 11:11:01 living-room volumio[1294]: info: Loading plugin "now_playing"... Feb 18 11:11:01 living-room volumio[1294]: info: PLUGIN START: now_playing Feb 18 11:11:01 living-room volumio[1294]: info: [now-playing] ConfigUpdater: config is up to date. Feb 18 11:11:01 living-room volumio[1294]: info: [now-playing] App already started Feb 18 11:11:01 living-room volumio[1294]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Feb 18 11:11:01 living-room volumio[1294]: info: Done. Feb 18 11:11:02 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:02 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:02 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:02 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:02 living-room systemd[1]: Stopping user@1000.service - User Manager for UID 1000... Feb 18 11:11:02 living-room systemd[9536]: Activating special unit exit.target... Feb 18 11:11:02 living-room systemd[9536]: Stopped target default.target - Main User Target. Feb 18 11:11:02 living-room systemd[9536]: Stopping mpris-proxy.service - Bluetooth mpris proxy... Feb 18 11:11:02 living-room mpris-proxy[9553]: org.bluez appeared Feb 18 11:11:02 living-room mpris-proxy[9553]: Bluetooth Adapter /org/bluez/hci0 found Feb 18 11:11:02 living-room mpris-proxy[9553]: Bluetooth Player /org/bluez/hci0/dev_74_F6_7A_A8_4B_41/mcp/player0 found Feb 18 11:11:02 living-room mpris-proxy[9553]: Player org.mpris.MediaPlayer2.Galaxy_S24_FE created Feb 18 11:11:02 living-room mpris-proxy[9553]: Bluetooth Adapter /org/bluez/hci0 removed Feb 18 11:11:02 living-room mpris-proxy[9553]: org.bluez disappeared Feb 18 11:11:02 living-room systemd[9536]: Stopped mpris-proxy.service - Bluetooth mpris proxy. Feb 18 11:11:02 living-room systemd[9536]: Stopping dbus.service - D-Bus User Message Bus... Feb 18 11:11:02 living-room systemd[9536]: Stopped dbus.service - D-Bus User Message Bus. Feb 18 11:11:02 living-room systemd[9536]: Removed slice session.slice - User Core Session Slice. Feb 18 11:11:02 living-room systemd[9536]: Stopped target basic.target - Basic System. Feb 18 11:11:02 living-room systemd[9536]: Stopped target paths.target - Paths. Feb 18 11:11:02 living-room systemd[9536]: Stopped target sockets.target - Sockets. Feb 18 11:11:02 living-room systemd[9536]: Stopped target timers.target - Timers. Feb 18 11:11:02 living-room systemd[9536]: Closed dbus.socket - D-Bus User Message Bus Socket. Feb 18 11:11:02 living-room systemd[9536]: Closed dirmngr.socket - GnuPG network certificate management daemon. Feb 18 11:11:02 living-room systemd[9536]: Closed gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Feb 18 11:11:02 living-room systemd[9536]: Closed gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Feb 18 11:11:02 living-room systemd[9536]: Closed gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Feb 18 11:11:02 living-room systemd[9536]: Closed gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Feb 18 11:11:02 living-room systemd[9536]: Removed slice app.slice - User Application Slice. Feb 18 11:11:02 living-room systemd[9536]: Reached target shutdown.target - Shutdown. Feb 18 11:11:02 living-room systemd[9536]: Finished systemd-exit.service - Exit the Session. Feb 18 11:11:02 living-room systemd[9536]: Reached target exit.target - Exit the Session. Feb 18 11:11:02 living-room systemd[1]: user@1000.service: Deactivated successfully. Feb 18 11:11:02 living-room systemd[1]: Stopped user@1000.service - User Manager for UID 1000. Feb 18 11:11:02 living-room systemd[1]: Stopping user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Feb 18 11:11:02 living-room systemd[1]: run-user-1000.mount: Deactivated successfully. Feb 18 11:11:02 living-room systemd[1]: user-runtime-dir@1000.service: Deactivated successfully. Feb 18 11:11:02 living-room systemd[1]: Stopped user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Feb 18 11:11:02 living-room systemd[1]: Removed slice user-1000.slice - User Slice of UID 1000. Feb 18 11:11:02 living-room systemd[1]: user-1000.slice: Consumed 12.421s CPU time. Feb 18 11:11:03 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:03 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:03 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:03 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:04 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:04 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:04 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:04 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:05 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:05 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:05 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:05 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:05 living-room volumio[1294]: info: Enabling plugin now_playing Feb 18 11:11:05 living-room volumio[1294]: info: Loading plugin "now_playing"... Feb 18 11:11:05 living-room volumio[1294]: info: PLUGIN START: now_playing Feb 18 11:11:05 living-room volumio[1294]: info: [now-playing] ConfigUpdater: config is up to date. Feb 18 11:11:05 living-room volumio[1294]: info: [now-playing] App already started Feb 18 11:11:05 living-room volumio[1294]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Feb 18 11:11:05 living-room volumio[1294]: info: Done. Feb 18 11:11:06 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:06 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:06 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:06 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:07 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:07 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:07 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:07 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:08 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:08 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:08 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:08 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:08 living-room volumio[1294]: info: CoreCommandRouter::volumioPlay Feb 18 11:11:08 living-room volumio[1294]: info: CoreStateMachine::play index undefined Feb 18 11:11:08 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:08 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:09 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:09 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:09 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:09 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:10 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:10 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:10 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:10 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:11 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:11 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:11 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:11 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:12 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:12 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:12 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:12 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:13 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:13 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:13 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:13 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:14 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:14 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:14 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:14 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:15 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:15 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:15 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:15 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:15 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 18 11:11:15 living-room volumio[1294]: info: Preload queue cleared Feb 18 11:11:16 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:16 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:16 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:16 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:17 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:17 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:17 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:17 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:18 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:18 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:18 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:18 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:18 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 18 11:11:19 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:19 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:19 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:19 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:19 living-room volumio[1294]: info: Preload queue cleared Feb 18 11:11:20 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:20 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:20 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:20 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:21 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:21 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:21 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:21 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:21 living-room volumio[1294]: info: Preload queue cleared Feb 18 11:11:21 living-room volumio[1294]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::ClearQueue Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::stop Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:21 living-room volumio[1294]: info: CorePlayQueue::clearPlayQueue Feb 18 11:11:21 living-room volumio[1294]: info: CorePlayQueue::saveQueue Feb 18 11:11:21 living-room volumio[1294]: info: CoreCommandRouter::volumioPushQueue Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::addQueueItems Feb 18 11:11:21 living-room volumio[1294]: info: CorePlayQueue::addQueueItems Feb 18 11:11:21 living-room volumio[1294]: info: Preload queue cleared Feb 18 11:11:21 living-room volumio[1294]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Feb 18 11:11:21 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 18 11:11:21 living-room volumio[1294]: info: CoreCommandRouter::volumioPushQueue Feb 18 11:11:21 living-room volumio[1294]: info: CorePlayQueue::saveQueue Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::updateTrackBlock Feb 18 11:11:21 living-room volumio[1294]: info: CorePlayQueue::getTrackBlock Feb 18 11:11:21 living-room volumio[1294]: info: CoreCommandRouter::volumioPlay Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::play index 0 Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::stop Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::play index undefined Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:21 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::startPlaybackTimer Feb 18 11:11:21 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:21 living-room volumio[1294]: info: [1771409481197] ControllerWebradio::clearAddPlayTrack Feb 18 11:11:21 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 11:11:21 living-room volumio[1294]: info: sendMpdCommand stop took 2 milliseconds Feb 18 11:11:21 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand clear Feb 18 11:11:21 living-room volumio[1294]: info: Feb 18 11:11:21 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:21 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:21 living-room volumio[1294]: info: sendMpdCommand clear took 1 milliseconds Feb 18 11:11:21 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Feb 18 11:11:21 living-room volumio[1294]: info: Feb 18 11:11:21 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:21 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:21 living-room volumio[1294]: info: Feb 18 11:11:21 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:21 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:21 living-room volumio[1294]: error: updateQueue error: null Feb 18 11:11:21 living-room volumio[1294]: info: ------------------------------ 2ms Feb 18 11:11:21 living-room volumio[1294]: info: Feb 18 11:11:21 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:21 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:21 living-room volumio[1294]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 237 milliseconds Feb 18 11:11:21 living-room volumio[1294]: info: ------------------------------ 236ms Feb 18 11:11:21 living-room volumio[1294]: info: ------------------------------ 236ms Feb 18 11:11:21 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 18 11:11:21 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand play Feb 18 11:11:21 living-room volumio[1294]: info: Feb 18 11:11:21 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:21 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:21 living-room volumio[1294]: info: Feb 18 11:11:21 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:21 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:21 living-room volumio[1294]: info: ------------------------------ 3ms Feb 18 11:11:21 living-room volumio[1294]: info: sendMpdCommand play took 2 milliseconds Feb 18 11:11:21 living-room volumio[1294]: info: ------------------------------ 1ms Feb 18 11:11:21 living-room volumio[1294]: info: ------------------------------ 1ms Feb 18 11:11:22 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:22 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:22 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:22 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 0 milliseconds Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 3 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 3 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 2 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus stop Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 9ms Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.076+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.076+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.076+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.076+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 12ms Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.084+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.084+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.084+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.084+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.084+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.084+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.084+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.085+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 20ms Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 20ms Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 19ms Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 18ms Feb 18 11:11:22 living-room volumio[1294]: info: [LastFM] Current track has sufficient metadata: title (ANTENNE BAYERN) and artist ((#1 - 5793/500000) ANTENNE BAYERN) passed on explicitly Feb 18 11:11:22 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:22 living-room volumio[1294]: info: [LastFM] Current track has sufficient metadata: title (ANTENNE BAYERN) and artist ((#1 - 5793/500000) ANTENNE BAYERN) passed on explicitly Feb 18 11:11:22 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:22 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:22 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:22 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:22 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 3ms Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 2 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 2ms Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 2 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 2ms Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:22 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:22 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:22 living-room volumio[1294]: info: Feb 18 11:11:22 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 2ms Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 3 milliseconds Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 3ms Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 3 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 3ms Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand status took 3 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.111+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.112+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 18ms Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 18ms Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 18ms Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 17ms Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 12 milliseconds Feb 18 11:11:22 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 12 milliseconds Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:22 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:22 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:22 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:22 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:22 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.120+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.120+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.120+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.120+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.120+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.120+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.120+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:22 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:22.120+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 22ms Feb 18 11:11:22 living-room volumio[1294]: info: ------------------------------ 23ms Feb 18 11:11:22 living-room volumio[1294]: info: [LastFM] Split composite title into artist: Lenny Kravitz and title: Again Feb 18 11:11:22 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:22 living-room volumio[1294]: info: [LastFM] Split composite title into artist: Lenny Kravitz and title: Again Feb 18 11:11:22 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:23 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:23 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:23 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:23 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:23 living-room volumio[1294]: info: Preload queue cleared Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::ClearQueue Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::stop Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::stPlaybackTimer Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::updateTrackBlock Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrackBlock Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::serviceStop Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::serviceStop Feb 18 11:11:23 living-room volumio[1294]: info: [1771409483547] ControllerWebradio::stop Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::clearPlayQueue Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::saveQueue Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::volumioPushQueue Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::addQueueItems Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::addQueueItems Feb 18 11:11:23 living-room volumio[1294]: info: Preload queue cleared Feb 18 11:11:23 living-room volumio[1294]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 18 11:11:23 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:23.548+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_STOPPED positionMs=0 volume=100 Feb 18 11:11:23 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:23.548+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" title="ANTENNE BAYERN" Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::volumioPushQueue Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::saveQueue Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::updateTrackBlock Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrackBlock Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::volumioPlay Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::play index 0 Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::stop Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::play index undefined Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::startPlaybackTimer Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:23 living-room volumio[1294]: info: [1771409483550] ControllerWebradio::clearAddPlayTrack Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand stop took 6 milliseconds Feb 18 11:11:23 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand stop took 2 milliseconds Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand clear Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:23 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:23 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:23 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand status took 2 milliseconds Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand clear took 2 milliseconds Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:23 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:23 living-room volumio[1294]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 18 11:11:23 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:23 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:23 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:23 living-room volumio[1294]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 18 11:11:23 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:23.558+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_STOPPED positionMs=0 volume=100 Feb 18 11:11:23 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:23.558+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" title="ANTENNE BAYERN" Feb 18 11:11:23 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:23.558+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_STOPPED positionMs=0 volume=100 Feb 18 11:11:23 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:23.559+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" title="ANTENNE BAYERN" Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 5ms Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 5ms Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:23 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:23 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:23 living-room volumio[1294]: error: updateQueue error: null Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 17ms Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:23 living-room volumio[1294]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 18ms Feb 18 11:11:23 living-room volumio[1294]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 18 11:11:23 living-room volumio[1294]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:23 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 107 milliseconds Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 102ms Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 102ms Feb 18 11:11:23 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 18 11:11:23 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand play Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:23 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:23 living-room volumio[1294]: info: Feb 18 11:11:23 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:23 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 1ms Feb 18 11:11:23 living-room volumio[1294]: info: sendMpdCommand play took 1 milliseconds Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 1ms Feb 18 11:11:23 living-room volumio[1294]: info: ------------------------------ 0ms Feb 18 11:11:24 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:24 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:24 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:24 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 0 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus stop Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:24 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:24 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 7ms Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.151+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.151+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.151+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.151+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.151+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.151+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.151+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.152+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 8ms Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 9ms Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:24 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:24 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5793/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:24 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.160+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.160+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.160+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.160+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.160+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 15ms Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.160+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.161+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.161+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 15ms Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 16ms Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.161+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.161+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.161+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.161+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="ANTENNE BAYERN" Feb 18 11:11:24 living-room volumio[1294]: info: [LastFM] Current track has sufficient metadata: title (ANTENNE BAYERN) and artist ((#1 - 5793/500000) ANTENNE BAYERN) passed on explicitly Feb 18 11:11:24 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:24 living-room volumio[1294]: info: [LastFM] Current track has sufficient metadata: title (ANTENNE BAYERN) and artist ((#1 - 5793/500000) ANTENNE BAYERN) passed on explicitly Feb 18 11:11:24 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:24 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:24 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:24 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:24 living-room volumio[1294]: info: Feb 18 11:11:24 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 1ms Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 0 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 0ms Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 2ms Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand status took 2 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:24 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.184+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.184+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.184+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.184+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 7ms Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 18 11:11:24 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:24 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:24 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:24 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Lenny Kravitz - Again","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 18 11:11:24 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:24 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:24 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.190+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.190+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.190+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.190+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.190+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.190+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.190+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:24 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:24.191+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=http://stream.antenne.de:80/antenne title="Lenny Kravitz - Again" Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 13ms Feb 18 11:11:24 living-room volumio[1294]: info: ------------------------------ 13ms Feb 18 11:11:24 living-room volumio[1294]: info: [LastFM] Split composite title into artist: Lenny Kravitz and title: Again Feb 18 11:11:24 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:24 living-room volumio[1294]: info: [LastFM] Split composite title into artist: Lenny Kravitz and title: Again Feb 18 11:11:24 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:25 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:25 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:25 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:25 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:26 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:26 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:26 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:26 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:27 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:27 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:27 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:27 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:28 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:28 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:28 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:28 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:29 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:29 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:29 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:29 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:30 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:30 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:30 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:30 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:31 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:31 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:31 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:31 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:32 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:32 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:32 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:32 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:32 living-room volumio[1294]: info: Preload queue cleared Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::ClearQueue Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::stop Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::stPlaybackTimer Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::updateTrackBlock Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrackBlock Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::serviceStop Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::serviceStop Feb 18 11:11:32 living-room volumio[1294]: info: [1771409492403] ControllerWebradio::stop Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::clearPlayQueue Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::saveQueue Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushQueue Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::addQueueItems Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::addQueueItems Feb 18 11:11:32 living-room volumio[1294]: info: Preload queue cleared Feb 18 11:11:32 living-room volumio[1294]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.403+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_STOPPED positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.404+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" title="ANTENNE BAYERN" Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushQueue Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::saveQueue Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::updateTrackBlock Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrackBlock Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPlay Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::play index 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::stop Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::play index undefined Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::startPlaybackTimer Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: [1771409492406] ControllerWebradio::clearAddPlayTrack Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand stop took 6 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand stop took 3 milliseconds Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand clear Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 2 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand clear took 2 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.415+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_STOPPED positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.415+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_STOPPED positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.415+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" title="Dance Wave!" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.415+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" title="Dance Wave!" Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 6ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 5ms Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: error: updateQueue error: null Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 16ms Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 19ms Feb 18 11:11:32 living-room volumio[1294]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 18 11:11:32 living-room volumio[1294]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 101 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 96ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 96ms Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand play Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 2ms Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand play took 1 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 1ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 1ms Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 2 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 3 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 3 milliseconds Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 1 milliseconds Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 4 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 4 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus stop Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 11ms Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.838+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.839+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.839+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.839+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.839+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.839+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.839+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.839+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 13ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 13ms Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 7ms Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 7 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 7ms Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 7 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.846+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.847+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.847+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 19ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 18ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 18ms Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: [LastFM] Current track has sufficient metadata: title (Dance Wave!) and artist (Dance Wave!) passed on explicitly Feb 18 11:11:32 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:32 living-room volumio[1294]: info: [LastFM] Current track has sufficient metadata: title (Dance Wave!) and artist (Dance Wave!) passed on explicitly Feb 18 11:11:32 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:32 living-room volumio[1294]: info: [LastFM] Current track has sufficient metadata: title (Tracklist: https://dancewave.online) and artist (Dance Wave!) passed on explicitly Feb 18 11:11:32 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:32 living-room volumio[1294]: info: [LastFM] Current track has sufficient metadata: title (Tracklist: https://dancewave.online) and artist (Dance Wave!) passed on explicitly Feb 18 11:11:32 living-room volumio[1294]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 14ms Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 13 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 6ms Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 6 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 0ms Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.860+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.860+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.860+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.860+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 27ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 27ms Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces system playlist update Feb 18 11:11:32 living-room volumio[1294]: info: Ignoring MPD Status Update Feb 18 11:11:32 living-room volumio[1294]: info: Feb 18 11:11:32 living-room volumio[1294]: ---------------------------- MPD announces state update: player Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::getState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand status Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.862+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.861+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 8 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 2ms Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand status took 2 milliseconds Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseState Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.863+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.863+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.869+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.869+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.869+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.869+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.869+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 28ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 21ms Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.869+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.870+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=0 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.870+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 18 11:11:32 living-room volumio[1294]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: verbose: ControllerMpd::parseTrackInfo Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: ControllerMpd::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::servicePushState Feb 18 11:11:32 living-room volumio[1294]: info: CorePlayQueue::getTrack 0 Feb 18 11:11:32 living-room volumio[1294]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 18 11:11:32 living-room volumio[1294]: verbose: CURRENT POSITION 0 Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState stateService play Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::syncState currentStatus play Feb 18 11:11:32 living-room volumio[1294]: info: Received an update from plugin. extracting info from payload Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreStateMachine::pushState Feb 18 11:11:32 living-room volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.883+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=182 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.884+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=182 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.883+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=182 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.884+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.884+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.883+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" state=STATUS_PLAYING positionMs=182 volume=100 Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.884+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio5-onboarding[2639]: time=2026-02-18T11:11:32.884+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.30:47472 @ 0x2c00750" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 31ms Feb 18 11:11:32 living-room volumio[1294]: info: ------------------------------ 24ms Feb 18 11:11:33 living-room lircd[3786]: lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:33 living-room lircd[3786]: lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:33 living-room lircd-0.10.1[3786]: Error: could not get file information for /dev/lirc0 Feb 18 11:11:33 living-room lircd-0.10.1[3786]: default_init(): No such file or directory Feb 18 11:11:33 living-room volumio[1294]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 11:11:33 living-room volumio[1294]: TypeError: Cannot read properties of null (reading 'slice') Feb 18 11:11:33 living-room volumio[1294]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Feb 18 11:11:33 living-room volumio[1294]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Feb 18 11:11:33 living-room volumio[1294]: at Object.onceWrapper (node:events:629:26) Feb 18 11:11:33 living-room volumio[1294]: at ClientRequest.emit (node:events:514:28) Feb 18 11:11:33 living-room volumio[1294]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Feb 18 11:11:33 living-room volumio[1294]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Feb 18 11:11:33 living-room volumio[1294]: at TLSSocket.socketOnData (node:_http_client:535:22) Feb 18 11:11:33 living-room volumio[1294]: at TLSSocket.emit (node:events:514:28) Feb 18 11:11:33 living-room volumio[1294]: at addChunk (node:internal/streams/readable:343:12) Feb 18 11:11:33 living-room volumio[1294]: at readableAddChunk (node:internal/streams/readable:316:9) Feb 18 11:11:33 living-room volumio[1294]: at Readable.push (node:internal/streams/readable:253:10) Feb 18 11:11:33 living-room volumio[1294]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Feb 18 11:11:33 living-room volumio[1294]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 11:11:33 living-room sudo[9868]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-18 11:10' Feb 18 11:11:33 living-room sudo[9868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"