-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2024-10-17 18:52:48 CEST. -- Oct 17 18:51:00 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:05 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:08 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:17 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:21 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:24 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:28 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:32 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:36 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:40 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:44 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:48 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:52 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:56 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:51:56 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Oct 17 18:51:56 volumio volumio[894]: info: Adding a new share Oct 17 18:51:56 volumio volumio[894]: info: No correspondence found in configuration for share SERVER on IP 192.168.100.134 Oct 17 18:51:57 volumio sudo[2131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=sebok,password=EDKOlilinkainka4059,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.134/HUDBA /mnt/NAS/SERVER Oct 17 18:51:57 volumio sudo[2131]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 18:51:57 volumio kernel: Key type cifs.spnego registered Oct 17 18:51:57 volumio kernel: Key type cifs.idmap registered Oct 17 18:51:57 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 17 18:51:57 volumio kernel: CIFS: Attempting to mount \\192.168.100.134\HUDBA Oct 17 18:51:57 volumio sudo[2131]: pam_unix(sudo:session): session closed for user root Oct 17 18:51:57 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status Oct 17 18:51:57 volumio volumio[894]: info: Oct 17 18:51:57 volumio volumio[894]: ---------------------------- MPD announces state update: update Oct 17 18:51:57 volumio volumio[894]: info: ControllerMpd::getState Oct 17 18:51:57 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status Oct 17 18:51:57 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status Oct 17 18:51:57 volumio volumio[894]: info: Oct 17 18:51:57 volumio volumio[894]: ---------------------------- MPD announces state update: update Oct 17 18:51:57 volumio volumio[894]: info: ControllerMpd::getState Oct 17 18:51:57 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status Oct 17 18:51:57 volumio volumio[894]: info: sendMpdCommand status took 8 milliseconds Oct 17 18:51:57 volumio volumio[894]: info: sendMpdCommand status took 5 milliseconds Oct 17 18:51:57 volumio volumio[894]: info: sendMpdCommand status took 5 milliseconds Oct 17 18:51:57 volumio volumio[894]: info: sendMpdCommand status took 3 milliseconds Oct 17 18:51:57 volumio volumio[894]: verbose: ControllerMpd::parseState Oct 17 18:51:57 volumio volumio[894]: info: Command Router : Notfying DB Updatetrue Oct 17 18:51:57 volumio volumio[894]: verbose: ControllerMpd::parseState Oct 17 18:51:57 volumio volumio[894]: verbose: ControllerMpd::parseState Oct 17 18:51:57 volumio volumio[894]: info: Command Router : Notfying DB Updatetrue Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::Close All Modals sent Oct 17 18:51:57 volumio volumio[894]: verbose: ControllerMpd::parseState Oct 17 18:51:57 volumio volumio[894]: info: ControllerMpd::pushState Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::servicePushState Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::pushState Oct 17 18:51:57 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::volumioPushState Oct 17 18:51:57 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:51:57 volumio volumio[894]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 18:51:57 volumio volumio[894]: verbose: CURRENT POSITION 0 Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::syncState stateService stop Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::syncState currentStatus stop Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::pushState Oct 17 18:51:57 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::volumioPushState Oct 17 18:51:57 volumio volumio[894]: info: No code Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::pushState Oct 17 18:51:57 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::volumioPushState Oct 17 18:51:57 volumio volumio[894]: info: ControllerMpd::pushState Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::servicePushState Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::pushState Oct 17 18:51:57 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::volumioPushState Oct 17 18:51:57 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:51:57 volumio volumio[894]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 18:51:57 volumio volumio[894]: verbose: CURRENT POSITION 0 Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::syncState stateService stop Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::syncState currentStatus stop Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::pushState Oct 17 18:51:57 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::volumioPushState Oct 17 18:51:57 volumio volumio[894]: info: No code Oct 17 18:51:57 volumio volumio[894]: info: CoreStateMachine::pushState Oct 17 18:51:57 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:51:57 volumio volumio[894]: info: CoreCommandRouter::volumioPushState Oct 17 18:51:57 volumio volumio[894]: info: ------------------------------ 99ms Oct 17 18:51:57 volumio volumio[894]: info: ------------------------------ 96ms Oct 17 18:51:57 volumio volumio[894]: info: [1729183917896] Database update started Oct 17 18:51:58 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 17 18:52:00 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:52:04 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:52:08 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:52:12 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 18:52:17 volumio volumio[894]: info: CoreCommandRouter::volumioGetState Oct 17 18:52:17 volumio volumio[894]: info: CorePlayQueue::getTrack 0 Oct 17 18:52:22 volumio volumio[894]: info: CoreCommandRouter::volumioGetQueue Oct 17 18:52:22 volumio volumio[894]: info: CoreStateMachine::getQueue Oct 17 18:52:22 volumio volumio[894]: info: CorePlayQueue::getQueue Oct 17 18:52:27 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:27 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:29 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:29 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:30 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:30 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:35 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:36 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:38 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:38 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:40 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:40 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:41 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:41 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:43 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:43 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:45 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:45 volumio volumio[894]: info: Preload queue cleared Oct 17 18:52:47 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 17 18:52:47 volumio volumio[894]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 18:52:47 volumio volumio[894]: TypeError: Cannot read property 'length' of undefined Oct 17 18:52:47 volumio volumio[894]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 17 18:52:47 volumio volumio[894]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 17 18:52:47 volumio volumio[894]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 17 18:52:47 volumio volumio[894]: at Parser.emit (events.js:315:20) Oct 17 18:52:47 volumio volumio[894]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 17 18:52:47 volumio volumio[894]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 17 18:52:47 volumio volumio[894]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 17 18:52:47 volumio volumio[894]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 17 18:52:47 volumio volumio[894]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 17 18:52:47 volumio volumio[894]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 17 18:52:47 volumio volumio[894]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 17 18:52:47 volumio volumio[894]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 17 18:52:47 volumio volumio[894]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 17 18:52:47 volumio volumio[894]: at IncomingMessage.emit (events.js:327:22) Oct 17 18:52:47 volumio volumio[894]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 17 18:52:47 volumio volumio[894]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 17 18:52:47 volumio volumio[894]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 18:52:48 volumio sudo[2242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-17 18:51 Oct 17 18:52:48 volumio sudo[2242]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"