-- Logs begin at Thu 2019-02-14 04:12:00 CST, end at Fri 2024-07-12 15:27:14 CDT. -- Jul 12 15:26:10 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 12 15:26:10 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 12 15:26:15 volumioexternalamp volumio[950]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 15:26:24 volumioexternalamp volumio[950]: info: CALLMETHOD: music_service minidlna forceRescan R Jul 12 15:26:24 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: minidlna , forceRescan Jul 12 15:26:24 volumioexternalamp sudo[1889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e s/^Environment=DAEMON_OPTS=$/Environment=DAEMON_OPTS=-R/ /etc/systemd/system/minidlna.service Jul 12 15:26:24 volumioexternalamp sudo[1889]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 15:26:24 volumioexternalamp sudo[1889]: pam_unix(sudo:session): session closed for user root Jul 12 15:26:24 volumioexternalamp sudo[1892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 12 15:26:24 volumioexternalamp sudo[1892]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 15:26:24 volumioexternalamp systemd[1]: Reloading. Jul 12 15:26:24 volumioexternalamp 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. Jul 12 15:26:24 volumioexternalamp systemd[1]: /data/plugins/music_service/lms/unit/logitechmediaserver.service:7: PIDFile= references path below legacy directory /var/run/, updating /var/run/logitechmediaserver.pid → /run/logitechmediaserver.pid; please update the unit file accordingly. Jul 12 15:26:24 volumioexternalamp sudo[1892]: pam_unix(sudo:session): session closed for user root Jul 12 15:26:24 volumioexternalamp volumio[950]: info: minidlna: systemctl daemon-reload succeeded. Jul 12 15:26:24 volumioexternalamp sudo[1909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart minidlna.service Jul 12 15:26:24 volumioexternalamp sudo[1909]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 15:26:24 volumioexternalamp systemd[1]: Stopping MiniDLNA lightweight DLNA/UPnP-AV server... Jul 12 15:26:24 volumioexternalamp volumio[950]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 12 15:26:24 volumioexternalamp systemd[1]: minidlna.service: Succeeded. Jul 12 15:26:24 volumioexternalamp systemd[1]: Stopped MiniDLNA lightweight DLNA/UPnP-AV server. Jul 12 15:26:24 volumioexternalamp volumio[950]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 12 15:26:24 volumioexternalamp systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Jul 12 15:26:24 volumioexternalamp sudo[1909]: pam_unix(sudo:session): session closed for user root Jul 12 15:26:24 volumioexternalamp volumio[950]: info: minidlna: systemctl restart minidlna.service succeeded. Jul 12 15:26:24 volumioexternalamp volumio[950]: info: minidlna: Rescanning the media directories. Jul 12 15:26:25 volumioexternalamp sudo[1915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e s/^Environment=DAEMON_OPTS=-R$/Environment=DAEMON_OPTS=/ /etc/systemd/system/minidlna.service Jul 12 15:26:25 volumioexternalamp sudo[1915]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 15:26:25 volumioexternalamp sudo[1915]: pam_unix(sudo:session): session closed for user root Jul 12 15:26:25 volumioexternalamp sudo[1918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 12 15:26:25 volumioexternalamp sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 15:26:25 volumioexternalamp systemd[1]: Reloading. Jul 12 15:26:25 volumioexternalamp 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. Jul 12 15:26:25 volumioexternalamp systemd[1]: /data/plugins/music_service/lms/unit/logitechmediaserver.service:7: PIDFile= references path below legacy directory /var/run/, updating /var/run/logitechmediaserver.pid → /run/logitechmediaserver.pid; please update the unit file accordingly. Jul 12 15:26:25 volumioexternalamp sudo[1918]: pam_unix(sudo:session): session closed for user root Jul 12 15:26:25 volumioexternalamp volumio[950]: info: minidlna: systemctl daemon-reload succeeded. Jul 12 15:26:40 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 12 15:26:40 volumioexternalamp volumio[950]: info: CURURI: music-library Jul 12 15:26:40 volumioexternalamp volumio[950]: info: CoreCommandRouter::volumioGetQueue Jul 12 15:26:40 volumioexternalamp volumio[950]: info: CoreStateMachine::getQueue Jul 12 15:26:40 volumioexternalamp volumio[950]: info: CorePlayQueue::getQueue Jul 12 15:26:40 volumioexternalamp volumio[950]: info: Listing playlists Jul 12 15:26:40 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:43 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 12 15:26:43 volumioexternalamp volumio[950]: info: CURURI: music-library/NAS Jul 12 15:26:43 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:45 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 12 15:26:45 volumioexternalamp volumio[950]: info: CURURI: music-library Jul 12 15:26:45 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:46 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 12 15:26:46 volumioexternalamp volumio[950]: info: CURURI: music-library/INTERNAL Jul 12 15:26:46 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:47 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 12 15:26:47 volumioexternalamp volumio[950]: info: CURURI: music-library/INTERNAL/FusionDsp Jul 12 15:26:47 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:49 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 12 15:26:49 volumioexternalamp volumio[950]: info: CURURI: music-library/INTERNAL/FusionDsp/tools Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Preloading song: music-library/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_L_refL.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Preloading song: music-library/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_LR_refL.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Preloading song: music-library/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_R_refL.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Preloading song: music-library/INTERNAL/FusionDsp/tools/HouseCurveTestSignal.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Preloading song: music-library/INTERNAL/FusionDsp/tools/PinkNoise_44k_BOTH.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Preloading song: music-library/INTERNAL/FusionDsp/tools/PinkNoise_44k_L.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Preloading song: music-library/INTERNAL/FusionDsp/tools/PinkNoise_44k_R.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Exploding uri music-library/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_L_refL.wav in service mpd Jul 12 15:26:49 volumioexternalamp volumio[950]: info: ALBUMART /albumart?cacheid=870&web=FusionDsp/Test%20Signal/extralarge&path=%2Fmnt%2FINTERNAL%2FFusionDsp%2Ftools%2F512kMeasSweep_30_to_20000_44k_PCM16_L_refL.wav&metadata=false Jul 12 15:26:49 volumioexternalamp volumio[950]: info: URI /mnt/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_L_refL.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Exploding uri music-library/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_LR_refL.wav in service mpd Jul 12 15:26:49 volumioexternalamp volumio[950]: info: ALBUMART /albumart?cacheid=870&web=FusionDsp/Test%20Signal/extralarge&path=%2Fmnt%2FINTERNAL%2FFusionDsp%2Ftools%2F512kMeasSweep_30_to_20000_44k_PCM16_LR_refL.wav&metadata=false Jul 12 15:26:49 volumioexternalamp volumio[950]: info: URI /mnt/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_LR_refL.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Exploding uri music-library/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_R_refL.wav in service mpd Jul 12 15:26:49 volumioexternalamp volumio[950]: info: ALBUMART /albumart?cacheid=870&web=FusionDsp/Test%20Signal/extralarge&path=%2Fmnt%2FINTERNAL%2FFusionDsp%2Ftools%2F512kMeasSweep_30_to_20000_44k_PCM16_R_refL.wav&metadata=false Jul 12 15:26:49 volumioexternalamp volumio[950]: info: URI /mnt/INTERNAL/FusionDsp/tools/512kMeasSweep_30_to_20000_44k_PCM16_R_refL.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Exploding uri music-library/INTERNAL/FusionDsp/tools/HouseCurveTestSignal.wav in service mpd Jul 12 15:26:49 volumioexternalamp volumio[950]: info: ALBUMART /albumart?cacheid=870&web=FusionDsp/Test%20Signal/extralarge&path=%2Fmnt%2FINTERNAL%2FFusionDsp%2Ftools%2FHouseCurveTestSignal.wav&metadata=false Jul 12 15:26:49 volumioexternalamp volumio[950]: info: URI /mnt/INTERNAL/FusionDsp/tools/HouseCurveTestSignal.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Exploding uri music-library/INTERNAL/FusionDsp/tools/PinkNoise_44k_BOTH.wav in service mpd Jul 12 15:26:49 volumioexternalamp volumio[950]: info: ALBUMART /albumart?cacheid=870&web=FusionDsp/Test%20Signal/extralarge&path=%2Fmnt%2FINTERNAL%2FFusionDsp%2Ftools%2FPinkNoise_44k_BOTH.wav&metadata=false Jul 12 15:26:49 volumioexternalamp volumio[950]: info: URI /mnt/INTERNAL/FusionDsp/tools/PinkNoise_44k_BOTH.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Exploding uri music-library/INTERNAL/FusionDsp/tools/PinkNoise_44k_L.wav in service mpd Jul 12 15:26:49 volumioexternalamp volumio[950]: info: ALBUMART /albumart?cacheid=870&web=FusionDsp/Test%20Signal/extralarge&path=%2Fmnt%2FINTERNAL%2FFusionDsp%2Ftools%2FPinkNoise_44k_L.wav&metadata=false Jul 12 15:26:49 volumioexternalamp volumio[950]: info: URI /mnt/INTERNAL/FusionDsp/tools/PinkNoise_44k_L.wav Jul 12 15:26:49 volumioexternalamp volumio[950]: info: Exploding uri music-library/INTERNAL/FusionDsp/tools/PinkNoise_44k_R.wav in service mpd Jul 12 15:26:49 volumioexternalamp volumio[950]: info: ALBUMART /albumart?cacheid=870&web=FusionDsp/Test%20Signal/extralarge&path=%2Fmnt%2FINTERNAL%2FFusionDsp%2Ftools%2FPinkNoise_44k_R.wav&metadata=false Jul 12 15:26:49 volumioexternalamp volumio[950]: info: URI /mnt/INTERNAL/FusionDsp/tools/PinkNoise_44k_R.wav Jul 12 15:26:51 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 12 15:26:51 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:53 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 12 15:26:53 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:54 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 12 15:26:54 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:26:57 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 12 15:26:57 volumioexternalamp volumio[950]: info: Preload queue cleared Jul 12 15:27:14 volumioexternalamp volumio[950]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 12 15:27:14 volumioexternalamp volumio[950]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 12 15:27:14 volumioexternalamp volumio[950]: TypeError: Cannot read property 'length' of undefined Jul 12 15:27:14 volumioexternalamp volumio[950]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jul 12 15:27:14 volumioexternalamp volumio[950]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jul 12 15:27:14 volumioexternalamp volumio[950]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jul 12 15:27:14 volumioexternalamp volumio[950]: at Parser.emit (events.js:315:20) Jul 12 15:27:14 volumioexternalamp volumio[950]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jul 12 15:27:14 volumioexternalamp volumio[950]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jul 12 15:27:14 volumioexternalamp volumio[950]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jul 12 15:27:14 volumioexternalamp volumio[950]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jul 12 15:27:14 volumioexternalamp volumio[950]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jul 12 15:27:14 volumioexternalamp volumio[950]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jul 12 15:27:14 volumioexternalamp volumio[950]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jul 12 15:27:14 volumioexternalamp volumio[950]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jul 12 15:27:14 volumioexternalamp volumio[950]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jul 12 15:27:14 volumioexternalamp volumio[950]: at IncomingMessage.emit (events.js:327:22) Jul 12 15:27:14 volumioexternalamp volumio[950]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 12 15:27:14 volumioexternalamp volumio[950]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 12 15:27:14 volumioexternalamp volumio[950]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 12 15:27:14 volumioexternalamp sudo[2009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-12 15:26 Jul 12 15:27:14 volumioexternalamp sudo[2009]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"