-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-01-12 10:32:23 CET. -- Jan 12 10:31:02 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 10:31:02 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 10:31:02 volumio-pi volumio[1203]: info: Discovery: Getting this device information Jan 12 10:31:02 volumio-pi volumio[1203]: info: CoreCommandRouter::volumioGetState Jan 12 10:31:02 volumio-pi volumio[1203]: info: CorePlayQueue::getTrack 0 Jan 12 10:31:02 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 10:31:03 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 10:31:03 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 10:31:03 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 10:31:04 volumio-pi volumio-remote-updater[666]: No test mode Jan 12 10:31:04 volumio-pi volumio-remote-updater[666]: No alpha test mode Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 12 10:31:04 volumio-pi volumio[1203]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::volumioGetBrowseSources Jan 12 10:31:04 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 10:31:05 volumio-pi volumio[1203]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jan 12 10:31:05 volumio-pi volumio[1203]: info: Completed starting MyVolumio Plugin Jan 12 10:31:05 volumio-pi volumio[1203]: [Metrics] CommandRouter: 36s 132.46ms Jan 12 10:31:05 volumio-pi volumio[1203]: info: CoreCommandRouter::volumiosetStartupVolume Jan 12 10:31:05 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 10:31:05 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 10:31:05 volumio-pi volumio[1203]: info: CoreCommandRouter::Close All Modals sent Jan 12 10:31:05 volumio-pi volumio[1203]: info: CoreCommandRouter::Close All Modals sent Jan 12 10:31:06 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 12 10:31:06 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 12 10:31:06 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 12 10:31:08 volumio-pi volumiologrotate[650]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jan 12 10:31:08 volumio-pi volumiologrotate[650]: ls: cannot access 'PI': No such file or directory Jan 12 10:31:12 volumio-pi volumio[1203]: info: BOOT COMPLETED Jan 12 10:31:15 volumio-pi ntpd[783]: Soliciting pool server 144.91.126.59 Jan 12 10:31:16 volumio-pi ntpd[783]: Soliciting pool server 128.127.67.142 Jan 12 10:31:16 volumio-pi ntpd[783]: Soliciting pool server 185.13.148.71 Jan 12 10:31:17 volumio-pi ntpd[783]: Soliciting pool server 129.70.132.32 Jan 12 10:31:17 volumio-pi ntpd[783]: Soliciting pool server 116.203.244.102 Jan 12 10:31:17 volumio-pi ntpd[783]: Soliciting pool server 131.188.3.221 Jan 12 10:31:18 volumio-pi ntpd[783]: Soliciting pool server 62.75.236.38 Jan 12 10:31:18 volumio-pi ntpd[783]: Soliciting pool server 185.233.107.180 Jan 12 10:31:18 volumio-pi ntpd[783]: Soliciting pool server 46.4.54.78 Jan 12 10:31:18 volumio-pi ntpd[783]: Soliciting pool server 213.172.105.106 Jan 12 10:31:19 volumio-pi ntpd[783]: Soliciting pool server 62.169.23.198 Jan 12 10:31:19 volumio-pi ntpd[783]: Soliciting pool server 78.47.93.191 Jan 12 10:31:19 volumio-pi ntpd[783]: Soliciting pool server 131.188.3.220 Jan 12 10:31:20 volumio-pi ntpd[783]: Soliciting pool server 94.130.23.46 Jan 12 10:31:20 volumio-pi ntpd[783]: Soliciting pool server 94.130.184.193 Jan 12 10:31:21 volumio-pi ntpd[783]: Soliciting pool server 78.47.56.71 Jan 12 10:31:21 volumio-pi ntpd[783]: Soliciting pool server 2a01:4f8:c013:4b98::1 Jan 12 10:31:23 volumio-pi ntpd[783]: receive: Unexpected origin timestamp 0xeb2e0a6b.0d78b705 does not match aorg 0000000000.00000000 from server@94.130.184.193 xmt 0xeb2e0a6b.aa546fff Jan 12 10:31:23 volumio-pi ntpd[783]: receive: Unexpected origin timestamp 0xeb2e0a6b.0d7d7b8c does not match aorg 0000000000.00000000 from server@185.233.107.180 xmt 0xeb2e0a6b.aaf7e6f8 Jan 12 10:31:23 volumio-pi ntpd[783]: receive: Unexpected origin timestamp 0xeb2e0a6b.0d7acd22 does not match aorg 0000000000.00000000 from server@131.188.3.220 xmt 0xeb2e0a6b.aa7d89b3 Jan 12 10:31:23 volumio-pi ntpd[783]: receive: Unexpected origin timestamp 0xeb2e0a6b.0d7627ab does not match aorg 0000000000.00000000 from server@78.47.56.71 xmt 0xeb2e0a6b.aa6022d0 Jan 12 10:31:23 volumio-pi ntpd[783]: receive: Unexpected origin timestamp 0xeb2e0a6b.0d7c9944 does not match aorg 0000000000.00000000 from server@46.4.54.78 xmt 0xeb2e0a6b.aa9298ea Jan 12 10:31:23 volumio-pi ntpd[783]: receive: Unexpected origin timestamp 0xeb2e0a6b.0d7e5d4e does not match aorg 0000000000.00000000 from server@185.13.148.71 xmt 0xeb2e0a6b.ab42fc74 Jan 12 10:31:23 volumio-pi ntpd[783]: receive: Unexpected origin timestamp 0xeb2e0a6b.0d79d7e8 does not match aorg 0000000000.00000000 from server@62.169.23.198 xmt 0xeb2e0a6b.aa9aa566 Jan 12 10:31:32 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 10:31:32 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 10:31:32 volumio-pi volumio[1203]: info: Discovery: Getting this device information Jan 12 10:31:32 volumio-pi volumio[1203]: info: CoreCommandRouter::volumioGetState Jan 12 10:31:32 volumio-pi volumio[1203]: info: CorePlayQueue::getTrack 0 Jan 12 10:31:32 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 10:31:46 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Jan 12 10:31:49 volumio-pi volumio[1203]: info: CoreCommandRouter::volumioGetQueue Jan 12 10:31:49 volumio-pi volumio[1203]: info: CoreStateMachine::getQueue Jan 12 10:31:49 volumio-pi volumio[1203]: info: CorePlayQueue::getQueue Jan 12 10:31:52 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 12 10:31:52 volumio-pi volumio[1203]: info: CURURI: music-library Jan 12 10:31:52 volumio-pi volumio[1203]: error: Failed LSINFO: null Jan 12 10:31:52 volumio-pi volumio[1203]: info: Preload queue cleared Jan 12 10:32:02 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 10:32:02 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 10:32:02 volumio-pi volumio[1203]: info: Discovery: Getting this device information Jan 12 10:32:02 volumio-pi volumio[1203]: info: CoreCommandRouter::volumioGetState Jan 12 10:32:02 volumio-pi volumio[1203]: info: CorePlayQueue::getTrack 0 Jan 12 10:32:02 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 10:32:03 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 12 10:32:03 volumio-pi volumio[1203]: info: CURURI: albums:// Jan 12 10:32:03 volumio-pi volumio[1203]: info: listAlbums - loading Albums from cache Jan 12 10:32:03 volumio-pi volumio[1203]: info: Preload queue cleared Jan 12 10:32:08 volumio-pi volumiologrotate[650]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jan 12 10:32:08 volumio-pi volumiologrotate[650]: ls: cannot access 'PI': No such file or directory Jan 12 10:32:12 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 10:32:12 volumio-pi volumio[1203]: info: Preload queue cleared Jan 12 10:32:18 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 10:32:18 volumio-pi volumio[1203]: info: Preload queue cleared Jan 12 10:32:21 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 10:32:21 volumio-pi volumio[1203]: info: Preload queue cleared Jan 12 10:32:22 volumio-pi volumio[1203]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 10:32:22 volumio-pi volumio[1203]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 10:32:22 volumio-pi volumio[1203]: TypeError: Cannot read property 'length' of undefined Jan 12 10:32:22 volumio-pi volumio[1203]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jan 12 10:32:22 volumio-pi volumio[1203]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jan 12 10:32:22 volumio-pi volumio[1203]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jan 12 10:32:22 volumio-pi volumio[1203]: at Parser.emit (events.js:315:20) Jan 12 10:32:22 volumio-pi volumio[1203]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jan 12 10:32:22 volumio-pi volumio[1203]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jan 12 10:32:22 volumio-pi volumio[1203]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jan 12 10:32:22 volumio-pi volumio[1203]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jan 12 10:32:22 volumio-pi volumio[1203]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jan 12 10:32:22 volumio-pi volumio[1203]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jan 12 10:32:22 volumio-pi volumio[1203]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jan 12 10:32:22 volumio-pi volumio[1203]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jan 12 10:32:22 volumio-pi volumio[1203]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jan 12 10:32:22 volumio-pi volumio[1203]: at IncomingMessage.emit (events.js:327:22) Jan 12 10:32:22 volumio-pi volumio[1203]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 12 10:32:22 volumio-pi volumio[1203]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 12 10:32:22 volumio-pi volumio[1203]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 10:32:23 volumio-pi sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-12 10:31 Jan 12 10:32:23 volumio-pi sudo[1782]: 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"