-- Logs begin at Sat 2025-02-15 08:58:52 -05, end at Sat 2025-02-15 10:06:09 -05. --
Feb 15 10:05:00 volumio go-librespot[3485]: time="2025-02-15T10:05:00-05:00" level=trace msg="sent dealer ping"
Feb 15 10:05:01 volumio go-librespot[3485]: time="2025-02-15T10:05:00-05:00" level=trace msg="received dealer pong"
Feb 15 10:05:01 volumio volumio[2971]: info: Setting values for "network_interface" and "model_number" in /data/plugins/music_service/minidlna/config.json
Feb 15 10:05:03 volumio volumio[2971]: info: Setting permissions to MiniDLNA folders
Feb 15 10:05:04 volumio volumio[2971]: Plugin install end detected on script
Feb 15 10:05:04 volumio sudo[9810]: pam_unix(sudo:session): session closed for user root
Feb 15 10:05:04 volumio volumio[2971]: info: Install script completed
Feb 15 10:05:04 volumio volumio[2971]: info: Adding reference to registry
Feb 15 10:05:04 volumio volumio[2971]: info: Done installing plugin.
Feb 15 10:05:04 volumio volumio[2971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 15 10:05:04 volumio volumio[2971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 15 10:05:06 volumio volumio[2971]: info: Folder /tmp/plugins removed
Feb 15 10:05:06 volumio volumio[2971]: info: Folder /tmp/downloaded_plugin.zip removed
Feb 15 10:05:06 volumio volumio[2971]: info: Folder /data/temp removed
Feb 15 10:05:08 volumio volumio[2971]: error: Failed to check for new versions for plugin YouTube Music: Error: Invalid argument not valid semver ('' received)
Feb 15 10:05:08 volumio volumio[2971]: info: Enabling plugin minidlna
Feb 15 10:05:08 volumio volumio[2971]: info: Loading plugin "minidlna"...
Feb 15 10:05:10 volumio volumio[2971]: info: PLUGIN START: minidlna
Feb 15 10:05:10 volumio volumio[2971]: info: Loading i18n strings for locale en
Feb 15 10:05:11 volumio volumio[2971]: info: Enabling plugin minidlna
Feb 15 10:05:11 volumio volumio[2971]: info: Loading plugin "minidlna"...
Feb 15 10:05:11 volumio volumio[2971]: info: Applying required configuration parameters for plugin minidlna
Feb 15 10:05:11 volumio volumio[2971]: info: PLUGIN START: minidlna
Feb 15 10:05:11 volumio volumio[2971]: info: Loading i18n strings for locale en
Feb 15 10:05:12 volumio volumio[2971]: info: minidlna: Found miniDLNA version 1.2.1
Feb 15 10:05:13 volumio volumio[2971]: info: minidlna: /data/minidlna.conf written
Feb 15 10:05:13 volumio volumio[2971]: info: minidlna: Starting minidlna.service
Feb 15 10:05:14 volumio sudo[10886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service
Feb 15 10:05:14 volumio sudo[10886]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 10:05:14 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server.
Feb 15 10:05:14 volumio volumio[2971]: info: minidlna: Found miniDLNA version 1.2.1
Feb 15 10:05:14 volumio sudo[10886]: pam_unix(sudo:session): session closed for user root
Feb 15 10:05:14 volumio volumio[2971]: info: minidlna: Starting minidlna.service
Feb 15 10:05:14 volumio volumio[2971]: info: minidlna: systemctl start minidlna.service succeeded.
Feb 15 10:05:14 volumio volumio[2971]: info: Done.
Feb 15 10:05:15 volumio sudo[10890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service
Feb 15 10:05:15 volumio sudo[10890]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 10:05:15 volumio sudo[10890]: pam_unix(sudo:session): session closed for user root
Feb 15 10:05:15 volumio volumio[2971]: info: minidlna: systemctl start minidlna.service succeeded.
Feb 15 10:05:15 volumio volumio[2971]: info: Done.
Feb 15 10:05:30 volumio go-librespot[3485]: time="2025-02-15T10:05:30-05:00" level=trace msg="received accesspoint ping"
Feb 15 10:05:30 volumio go-librespot[3485]: time="2025-02-15T10:05:30-05:00" level=trace msg="received accesspoint pong ack"
Feb 15 10:05:30 volumio go-librespot[3485]: time="2025-02-15T10:05:30-05:00" level=trace msg="sent dealer ping"
Feb 15 10:05:30 volumio go-librespot[3485]: time="2025-02-15T10:05:30-05:00" level=trace msg="received dealer pong"
Feb 15 10:05:37 volumio nmbd[546]: [2025/02/15 10:05:37.398523, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Feb 15 10:05:37 volumio nmbd[546]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.7 for name WORKGROUP<1d>.
Feb 15 10:05:37 volumio nmbd[546]: This response was from IP 192.168.1.60, reporting an IP address of 192.168.1.60.
Feb 15 10:05:52 volumio volumio[2971]: info: CoreCommandRouter::volumioGetState
Feb 15 10:05:52 volumio volumio[2971]: info: CorePlayQueue::getTrack 0
Feb 15 10:05:55 volumio volumio[2971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 15 10:05:55 volumio volumio[2971]: info: Preload queue cleared
Feb 15 10:05:59 volumio volumio[2971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 15 10:06:00 volumio volumio[2971]: info: Preload queue cleared
Feb 15 10:06:00 volumio go-librespot[3485]: time="2025-02-15T10:06:00-05:00" level=trace msg="sent dealer ping"
Feb 15 10:06:01 volumio go-librespot[3485]: time="2025-02-15T10:06:01-05:00" level=trace msg="received dealer pong"
Feb 15 10:06:01 volumio volumio[2971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 15 10:06:02 volumio volumio[2971]: info: Preload queue cleared
Feb 15 10:06:03 volumio volumio[2971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 15 10:06:03 volumio volumio[2971]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 15 10:06:03 volumio volumio[2971]: TypeError: Cannot read property 'length' of undefined
Feb 15 10:06:03 volumio volumio[2971]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Feb 15 10:06:03 volumio volumio[2971]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Feb 15 10:06:03 volumio volumio[2971]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Feb 15 10:06:03 volumio volumio[2971]: at Parser.emit (events.js:315:20)
Feb 15 10:06:03 volumio volumio[2971]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Feb 15 10:06:03 volumio volumio[2971]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Feb 15 10:06:03 volumio volumio[2971]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Feb 15 10:06:03 volumio volumio[2971]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Feb 15 10:06:03 volumio volumio[2971]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Feb 15 10:06:03 volumio volumio[2971]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Feb 15 10:06:03 volumio volumio[2971]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Feb 15 10:06:03 volumio volumio[2971]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Feb 15 10:06:03 volumio volumio[2971]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Feb 15 10:06:03 volumio volumio[2971]: at IncomingMessage.emit (events.js:327:22)
Feb 15 10:06:03 volumio volumio[2971]: at endReadableNT (internal/streams/readable.js:1327:12)
Feb 15 10:06:03 volumio volumio[2971]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Feb 15 10:06:03 volumio volumio[2971]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 15 10:06:09 volumio sudo[11072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 10:05
Feb 15 10:06:09 volumio sudo[11072]: 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="f6610a1100d2380eef33bd3004af43153c786f96"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET"
VOLUMIO_VERSION="3.785"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"