-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2024-05-01 15:12:55 CEST. -- May 01 15:11:00 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:00 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:00 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:00 volumio-salon volumio[929]: STREAMING PROXY: Client dropped request, destroying May 01 15:11:04 volumio-salon volumio[929]: info: CoreCommandRouter::volumioSeek May 01 15:11:04 volumio-salon volumio[929]: info: CoreStateMachine::seek May 01 15:11:04 volumio-salon volumio[929]: info: CorePlayQueue::getTrack 11 May 01 15:11:04 volumio-salon volumio[929]: info: TRACKBLOCK {"uri":"tidal://song/17078373","service":"tidal","name":"Moments of Joy","title":"Moments of Joy","album":"Universe of Light","type":"track","tracknumber":12,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/97a13076/e402/415e/b2df/3f0cca054451/640x640.jpg","duration":387,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Lichtmond","artistUri":"tidal://artist/3765457","albumUri":"tidal://album/17078361","audioQuality":"LOSSLESS"} May 01 15:11:04 volumio-salon volumio[929]: info: CoreStateMachine::startPlaybackTimer May 01 15:11:04 volumio-salon volumio[929]: info: CorePlayQueue::getTrack 11 May 01 15:11:04 volumio-salon volumio[929]: info: [1714569064090] ControllerTidal::seek May 01 15:11:04 volumio-salon volumio[929]: info: CoreStateMachine::setConsumeUpdateService mpd May 01 15:11:04 volumio-salon volumio[929]: info: ControllerMpd::seek May 01 15:11:04 volumio-salon volumio[929]: info: CoreStateMachine::pushState May 01 15:11:04 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 15:11:04 volumio-salon volumio[929]: info: CoreCommandRouter::volumioPushState May 01 15:11:04 volumio-salon volumio[929]: info: MRS: Pushing multiroomSync output update for this device May 01 15:11:04 volumio-salon volumio[929]: info: MRS: Pushing multiroomSync output May 01 15:11:04 volumio-salon volumio[929]: error: null May 01 15:11:04 volumio-salon volumio[929]: info: May 01 15:11:04 volumio-salon volumio[929]: ---------------------------- MPD announces state update: player May 01 15:11:04 volumio-salon volumio[929]: info: ControllerMpd::getState May 01 15:11:04 volumio-salon volumio[929]: verbose: ControllerMpd::sendMpdCommand status May 01 15:11:04 volumio-salon volumio[929]: info: sendMpdCommand status took 6 milliseconds May 01 15:11:04 volumio-salon volumio[929]: verbose: ControllerMpd::parseState May 01 15:11:04 volumio-salon volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 15:11:04 volumio-salon volumio[929]: info: sendMpdCommand playlistinfo took 2 milliseconds May 01 15:11:04 volumio-salon volumio[929]: verbose: ControllerMpd::parseTrackInfo May 01 15:11:04 volumio-salon volumio[929]: info: ControllerMpd::pushState May 01 15:11:04 volumio-salon volumio[929]: info: CoreCommandRouter::servicePushState May 01 15:11:04 volumio-salon volumio[929]: info: CorePlayQueue::getTrack 11 May 01 15:11:04 volumio-salon volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71960,"duration":387,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"912 Kbps","isStreaming":false,"title":"17078373&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/17078373&soundQuality=LOSSLESS","trackType":"tidal"} May 01 15:11:04 volumio-salon volumio[929]: verbose: CURRENT POSITION 11 May 01 15:11:04 volumio-salon volumio[929]: info: CoreStateMachine::syncState stateService play May 01 15:11:04 volumio-salon volumio[929]: info: CoreStateMachine::syncState currentStatus play May 01 15:11:04 volumio-salon volumio[929]: info: Received an update from plugin. extracting info from payload May 01 15:11:04 volumio-salon volumio[929]: info: CoreStateMachine::pushState May 01 15:11:04 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 15:11:04 volumio-salon volumio[929]: info: CoreCommandRouter::volumioPushState May 01 15:11:04 volumio-salon volumio[929]: info: MRS: Pushing multiroomSync output update for this device May 01 15:11:04 volumio-salon volumio[929]: info: MRS: Pushing multiroomSync output May 01 15:11:04 volumio-salon volumio[929]: info: CoreStateMachine::pushState May 01 15:11:04 volumio-salon volumio[929]: info: CoreCommandRouter::volumioPushState May 01 15:11:04 volumio-salon volumio[929]: info: MRS: Pushing multiroomSync output update for this device May 01 15:11:04 volumio-salon volumio[929]: info: MRS: Pushing multiroomSync output May 01 15:11:04 volumio-salon volumio[929]: info: ------------------------------ 27ms May 01 15:11:06 volumio-salon volumio[929]: info: VolumeController::SetAlsaVolume62 May 01 15:11:06 volumio-salon volumio[929]: info: CoreStateMachine::pushState May 01 15:11:06 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 15:11:06 volumio-salon volumio[929]: info: CoreCommandRouter::volumioPushState May 01 15:11:06 volumio-salon volumio[929]: info: MRS: Pushing multiroomSync output update for this device May 01 15:11:06 volumio-salon volumio[929]: info: MRS: Pushing multiroomSync output May 01 15:11:09 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:10 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 15:11:13 volumio-salon volumio[929]: info: Retrieving Cloud Streaming UI May 01 15:11:13 volumio-salon volumio[929]: info: Getting Tidal Cloud Configuration May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 15:11:13 volumio-salon volumio[929]: info: Getting Qobuz Cloud Configuration May 01 15:11:13 volumio-salon volumio[929]: info: Asking plugin for UI Config May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 15:11:13 volumio-salon volumio[929]: info: Getting Spotify Cloud Configuration May 01 15:11:13 volumio-salon volumio[929]: info: Asking plugin for UI Config May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 15:11:13 volumio-salon volumio[929]: info: Saving Spotify Acccount May 01 15:11:13 volumio-salon volumio[929]: info: Got it May 01 15:11:13 volumio-salon volumio[929]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 01 15:11:13 volumio-salon volumio[929]: info: Got Tidal Cloud Configuration May 01 15:11:13 volumio-salon volumio[929]: info: Got it May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 15:11:13 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 01 15:11:18 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:19 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:19 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:19 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:20 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:20 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:20 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:20 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:11:20 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:11:20 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:11:20 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:11:20 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:11:20 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:11:22 volumio-salon volumio[929]: error: Failed request for metavolumio API May 01 15:11:29 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:30 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:30 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 15:11:30 volumio-salon volumio[929]: info: CURURI: music-library May 01 15:11:30 volumio-salon volumio[929]: error: Failed LSINFO: null May 01 15:11:30 volumio-salon volumio[929]: info: Preload queue cleared May 01 15:11:36 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:37 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 15:11:37 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 01 15:11:38 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:11:38 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:11:38 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:11:38 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:11:38 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:11:38 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:11:39 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:39 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:39 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:40 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:40 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:40 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:45 volumio-salon volumio[929]: error: Failed request for metavolumio API May 01 15:11:48 volumio-salon volumio[929]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/minidlna/volumio/buster/armhf May 01 15:11:49 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:50 volumio-salon volumio[929]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/minidlna/volumio/buster/armhf May 01 15:11:50 volumio-salon volumio[929]: info: Folder /tmp/plugins removed May 01 15:11:50 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:50 volumio-salon volumio[929]: info: Check plugin dependencies May 01 15:11:50 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 15:11:50 volumio-salon volumio[929]: info: Checking if plugin already exists May 01 15:11:50 volumio-salon volumio[929]: info: Rename folder May 01 15:11:50 volumio-salon volumio[929]: info: Folder /tmp/downloaded_plugin.zip removed May 01 15:11:50 volumio-salon volumio[929]: info: Move to category May 01 15:11:50 volumio-salon volumio[929]: info: Checking if install.sh is present May 01 15:11:50 volumio-salon volumio[929]: info: Executing install.sh May 01 15:11:50 volumio-salon sudo[30329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/minidlna/install.sh May 01 15:11:50 volumio-salon sudo[30329]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 15:11:50 volumio-salon volumio[929]: info: Completing "UIConfig.json" May 01 15:11:50 volumio-salon volumio[929]: info: Installing MiniDLNA May 01 15:11:50 volumio-salon volumio[929]: info: Get:1 http://archive.raspberrypi.org/debian buster InRelease [32.6 kB] May 01 15:11:50 volumio-salon volumio[929]: info: Get:2 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] May 01 15:11:51 volumio-salon volumio[929]: info: Get:3 https://deb.nodesource.com/node_14.x buster InRelease [4584 B] May 01 15:11:51 volumio-salon volumio[929]: info: Get:4 http://raspbian.raspberrypi.org/raspbian buster/main armhf Packages [13.0 MB] May 01 15:11:51 volumio-salon volumio[929]: info: Get:5 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] May 01 15:11:52 volumio-salon volumio[929]: info: Get:6 https://deb.nodesource.com/node_14.x buster/main armhf Packages [786 B] May 01 15:11:52 volumio-salon volumio[929]: info: Get:7 http://raspbian.raspberrypi.org/raspbian buster/contrib armhf Packages [58.8 kB] May 01 15:11:52 volumio-salon volumio[929]: info: Get:8 http://raspbian.raspberrypi.org/raspbian buster/non-free armhf Packages [110 kB] May 01 15:11:52 volumio-salon volumio[929]: info: Get:9 http://raspbian.raspberrypi.org/raspbian buster/rpi armhf Packages [1360 B] May 01 15:11:56 volumio-salon volumio[929]: info: Fetched 13.6 MB in 6s (2342 kB/s) May 01 15:11:59 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:11:59 volumio-salon volumio[929]: info: Listing playlists May 01 15:11:59 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:00 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:00 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:00 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:01 volumio-salon volumio[929]: info: Reading package lists... May 01 15:12:04 volumio-salon volumio[929]: info: Reading package lists... May 01 15:12:04 volumio-salon volumio[929]: info: Building dependency tree... May 01 15:12:04 volumio-salon volumio[929]: info: Reading state information... May 01 15:12:05 volumio-salon volumio[929]: info: The following additional packages will be installed: May 01 15:12:05 volumio-salon volumio[929]: info: libexif12 May 01 15:12:05 volumio-salon volumio[929]: info: The following NEW packages will be installed: May 01 15:12:05 volumio-salon volumio[929]: info: libexif12 minidlna May 01 15:12:06 volumio-salon volumio[929]: info: 0 upgraded, 2 newly installed, 0 to remove and 29 not upgraded. May 01 15:12:06 volumio-salon volumio[929]: info: Need to get 446 kB of archives. May 01 15:12:06 volumio-salon volumio[929]: info: After this operation, 2329 kB of additional disk space will be used. May 01 15:12:06 volumio-salon volumio[929]: info: Get:1 http://ftp.icm.edu.pl/pub/Linux/distributions/raspbian/raspbian buster/main armhf libexif12 armhf 0.6.21-5.1+deb10u5 [313 kB] May 01 15:12:06 volumio-salon volumio[929]: info: Get:2 http://ftp.icm.edu.pl/pub/Linux/distributions/raspbian/raspbian buster/main armhf minidlna armhf 1.2.1+dfsg-2+deb10u4 [132 kB] May 01 15:12:07 volumio-salon volumio[929]: info: Fetched 446 kB in 1s (457 kB/s) May 01 15:12:07 volumio-salon volumio[929]: info: Selecting previously unselected package libexif12:armhf. May 01 15:12:08 volumio-salon volumio[929]: [620B blob data] May 01 15:12:08 volumio-salon volumio[929]: info: Preparing to unpack .../libexif12_0.6.21-5.1+deb10u5_armhf.deb ... May 01 15:12:08 volumio-salon volumio[929]: info: Unpacking libexif12:armhf (0.6.21-5.1+deb10u5) ... May 01 15:12:09 volumio-salon volumio[929]: info: Selecting previously unselected package minidlna. May 01 15:12:09 volumio-salon volumio[929]: info: Preparing to unpack .../minidlna_1.2.1+dfsg-2+deb10u4_armhf.deb ... May 01 15:12:09 volumio-salon volumio[929]: info: Unpacking minidlna (1.2.1+dfsg-2+deb10u4) ... May 01 15:12:09 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:10 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:10 volumio-salon volumio[929]: info: Setting up libexif12:armhf (0.6.21-5.1+deb10u5) ... May 01 15:12:11 volumio-salon volumio[929]: info: Setting up minidlna (1.2.1+dfsg-2+deb10u4) ... May 01 15:12:11 volumio-salon groupadd[30678]: group added to /etc/group: name=minidlna, GID=123 May 01 15:12:11 volumio-salon groupadd[30678]: group added to /etc/gshadow: name=minidlna May 01 15:12:11 volumio-salon groupadd[30678]: new group: name=minidlna, GID=123 May 01 15:12:11 volumio-salon useradd[30682]: new user: name=minidlna, UID=118, GID=123, home=/var/lib/minidlna, shell=/usr/sbin/nologin May 01 15:12:11 volumio-salon usermod[30690]: change user 'minidlna' password May 01 15:12:11 volumio-salon chage[30695]: changed password expiry for minidlna May 01 15:12:11 volumio-salon chfn[30698]: changed user 'minidlna' information May 01 15:12:11 volumio-salon systemd[1]: Reloading. May 01 15:12:11 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:12 volumio-salon systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. May 01 15:12:12 volumio-salon systemd[1]: Reloading. May 01 15:12:12 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:13 volumio-salon systemd[1]: Reloading. May 01 15:12:13 volumio-salon volumio[929]: info: Created symlink /etc/systemd/system/multi-user.target.wants/minidlna.service → /lib/systemd/system/minidlna.service. May 01 15:12:13 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:13 volumio-salon systemd[1]: Reloading. May 01 15:12:14 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:14 volumio-salon systemd[1]: Starting MiniDLNA lightweight DLNA/UPnP-AV server... May 01 15:12:14 volumio-salon volumio[929]: ------------------------------------ BT MESSAGE: BT STATUS: running May 01 15:12:14 volumio-salon systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. May 01 15:12:14 volumio-salon volumio[929]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... May 01 15:12:15 volumio-salon volumio[929]: info: Processing triggers for systemd (241-7~deb10u9+rpi1) ... May 01 15:12:15 volumio-salon systemd[1]: Reloading. May 01 15:12:15 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:16 volumio-salon systemd[1]: Reloading. May 01 15:12:17 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:17 volumio-salon systemd[1]: Reloading. May 01 15:12:17 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:18 volumio-salon systemd[1]: Reloading. May 01 15:12:18 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:18 volumio-salon systemd[1]: Stopping MiniDLNA lightweight DLNA/UPnP-AV server... May 01 15:12:18 volumio-salon volumio[929]: ------------------------------------ BT MESSAGE: BT STATUS: running May 01 15:12:18 volumio-salon systemd[1]: minidlna.service: Succeeded. May 01 15:12:18 volumio-salon systemd[1]: Stopped MiniDLNA lightweight DLNA/UPnP-AV server. May 01 15:12:18 volumio-salon volumio[929]: info: Creating systemd unit /etc/systemd/system/minidlna.service May 01 15:12:18 volumio-salon systemd[1]: Reloading. May 01 15:12:19 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 01 15:12:19 volumio-salon volumio[929]: info: Setting values for "network_interface" and "model_number" in /data/plugins/music_service/minidlna/config.json May 01 15:12:19 volumio-salon volumio[929]: info: Setting permissions to MiniDLNA folders May 01 15:12:19 volumio-salon volumio[929]: Plugin install end detected on script May 01 15:12:19 volumio-salon sudo[30329]: pam_unix(sudo:session): session closed for user root May 01 15:12:19 volumio-salon volumio[929]: info: Install script completed May 01 15:12:19 volumio-salon volumio[929]: info: Adding reference to registry May 01 15:12:19 volumio-salon volumio[929]: info: Done installing plugin. May 01 15:12:19 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 15:12:19 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 01 15:12:19 volumio-salon volumio[929]: info: Folder /tmp/plugins removed May 01 15:12:19 volumio-salon volumio[929]: info: Folder /tmp/downloaded_plugin.zip removed May 01 15:12:19 volumio-salon volumio[929]: info: Folder /data/temp removed May 01 15:12:19 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:19 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:19 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:20 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:20 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:20 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:22 volumio-salon volumio[929]: info: Enabling plugin minidlna May 01 15:12:22 volumio-salon volumio[929]: info: Loading plugin "minidlna"... May 01 15:12:22 volumio-salon volumio[929]: info: PLUGIN START: minidlna May 01 15:12:22 volumio-salon volumio[929]: info: Loading i18n strings for locale pl May 01 15:12:22 volumio-salon volumio[929]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. May 01 15:12:22 volumio-salon volumio[929]: info: minidlna: Found miniDLNA version 1.2.1 May 01 15:12:22 volumio-salon volumio[929]: info: minidlna: /data/minidlna.conf written May 01 15:12:22 volumio-salon volumio[929]: info: minidlna: Starting minidlna.service May 01 15:12:22 volumio-salon sudo[30931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service May 01 15:12:22 volumio-salon sudo[30931]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 15:12:22 volumio-salon systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. May 01 15:12:22 volumio-salon sudo[30931]: pam_unix(sudo:session): session closed for user root May 01 15:12:22 volumio-salon volumio[929]: info: minidlna: systemctl start minidlna.service succeeded. May 01 15:12:22 volumio-salon volumio[929]: info: Done. May 01 15:12:28 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:29 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 15:12:29 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 01 15:12:29 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:30 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:30 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:12:30 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:12:30 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:12:30 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:12:30 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:12:30 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:12:31 volumio-salon volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 15:12:39 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:39 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:39 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:40 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:40 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:40 volumio-salon volumio[929]: info: Listing playlists May 01 15:12:40 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:42 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:12:42 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:12:42 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:12:42 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:12:42 volumio-salon volumio[929]: info: Executing endpoint metavolumio May 01 15:12:42 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 01 15:12:42 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 15:12:42 volumio-salon volumio[929]: info: Preload queue cleared May 01 15:12:44 volumio-salon volumio[929]: error: Failed request for metavolumio API May 01 15:12:47 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 15:12:47 volumio-salon volumio[929]: info: Preload queue cleared May 01 15:12:48 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 15:12:49 volumio-salon volumio[929]: info: Preload queue cleared May 01 15:12:49 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:50 volumio-salon volumio[929]: info: CoreCommandRouter::volumioGetState May 01 15:12:55 volumio-salon volumio[929]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 15:12:55 volumio-salon volumio[929]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 15:12:55 volumio-salon volumio[929]: TypeError: Cannot read property 'length' of undefined May 01 15:12:55 volumio-salon volumio[929]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 01 15:12:55 volumio-salon volumio[929]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 01 15:12:55 volumio-salon volumio[929]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 01 15:12:55 volumio-salon volumio[929]: at Parser.emit (events.js:315:20) May 01 15:12:55 volumio-salon volumio[929]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 01 15:12:55 volumio-salon volumio[929]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 01 15:12:55 volumio-salon volumio[929]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 01 15:12:55 volumio-salon volumio[929]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 01 15:12:55 volumio-salon volumio[929]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 01 15:12:55 volumio-salon volumio[929]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 01 15:12:55 volumio-salon volumio[929]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 01 15:12:55 volumio-salon volumio[929]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 01 15:12:55 volumio-salon volumio[929]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 01 15:12:55 volumio-salon volumio[929]: at IncomingMessage.emit (events.js:327:22) May 01 15:12:55 volumio-salon volumio[929]: at endReadableNT (internal/streams/readable.js:1327:12) May 01 15:12:55 volumio-salon volumio[929]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 01 15:12:55 volumio-salon volumio[929]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 15:12:55 volumio-salon sudo[31108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 15:11 May 01 15:12:55 volumio-salon sudo[31108]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"