-- Logs begin at Thu 2019-02-14 19:11:58 KST, end at Wed 2025-06-04 13:50:24 KST. -- Jun 04 13:49:24 volumio-usb volumiologrotate[564]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 04 13:49:24 volumio-usb volumiologrotate[564]: ls: cannot access 'USB': No such file or directory Jun 04 13:49:43 volumio-usb kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1 Jun 04 13:49:43 volumio-usb kernel: xhci_hcd 0000:01:00.0: @0000000429522ee0 00000000 00000000 0e000000 02028001 Jun 04 13:49:43 volumio-usb volumio[956]: info: Jun 04 13:49:43 volumio-usb volumio[956]: ---------------------------- MPD announces state update: player Jun 04 13:49:43 volumio-usb volumio[956]: info: ControllerMpd::getState Jun 04 13:49:43 volumio-usb volumio[956]: verbose: ControllerMpd::sendMpdCommand status Jun 04 13:49:43 volumio-usb volumio[956]: info: sendMpdCommand status took 1 milliseconds Jun 04 13:49:43 volumio-usb volumio[956]: verbose: ControllerMpd::parseState Jun 04 13:49:43 volumio-usb volumio[956]: info: ControllerMpd::pushState Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreCommandRouter::servicePushState Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreStateMachine::pushState Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreCommandRouter::volumioPushState Jun 04 13:49:43 volumio-usb volumio[956]: info: MRS: Pushing multiroomSync output update for this device Jun 04 13:49:43 volumio-usb volumio[956]: info: MRS: Pushing multiroomSync output Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:49:43 volumio-usb volumio[956]: info: CorePlayQueue::getTrack 0 Jun 04 13:49:43 volumio-usb volumio[956]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 04 13:49:43 volumio-usb volumio[956]: verbose: CURRENT POSITION 0 Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreStateMachine::syncState stateService stop Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreStateMachine::syncState currentStatus play Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreCommandRouter::volumioPushState Jun 04 13:49:43 volumio-usb volumio[956]: info: MRS: Pushing multiroomSync output update for this device Jun 04 13:49:43 volumio-usb volumio[956]: info: MRS: Pushing multiroomSync output Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreStateMachine::stPlaybackTimer Jun 04 13:49:43 volumio-usb volumio[956]: info: ------------------------------ 14ms Jun 04 13:49:43 volumio-usb volumio[956]: info: [ASDebug] CurState: play PrevState: play Jun 04 13:49:43 volumio-usb volumio[956]: info: [ASDebug] CurState: stop PrevState: play Jun 04 13:49:43 volumio-usb volumio[956]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetQueue Jun 04 13:49:43 volumio-usb volumio[956]: info: CoreStateMachine::getQueue Jun 04 13:49:43 volumio-usb volumio[956]: info: CorePlayQueue::getQueue Jun 04 13:49:44 volumio-usb volumio[956]: info: [ASDebug] Togle GPIO: OFF Jun 04 13:49:48 volumio-usb nmbd[730]: [2025/06/04 13:49:48.800021, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jun 04 13:49:48 volumio-usb nmbd[730]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.39 for name WORKGROUP<1d>. Jun 04 13:49:48 volumio-usb nmbd[730]: This response was from IP 192.168.0.32, reporting an IP address of 192.168.0.32. Jun 04 13:50:08 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 04 13:50:08 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 04 13:50:08 volumio-usb volumio[956]: info: Discovery: Getting this device information Jun 04 13:50:08 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:50:08 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 04 13:50:09 volumio-usb volumio[956]: verbose: New Socket.io Connection to 192.168.0.39 from 192.168.0.4 UA: okhttp/3.12.12 Engine version: 3 Transport: websocket Total Clients: 7 Jun 04 13:50:09 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:50:09 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 04 13:50:09 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 04 13:50:11 volumio-usb sudo[13885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 13:50:11 volumio-usb sudo[13885]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 13:50:11 volumio-usb sudo[13885]: pam_unix(sudo:session): session closed for user root Jun 04 13:50:11 volumio-usb sudo[13888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 13:50:11 volumio-usb sudo[13888]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 13:50:11 volumio-usb sudo[13888]: pam_unix(sudo:session): session closed for user root Jun 04 13:50:11 volumio-usb volumio[956]: verbose: New Socket.io Connection to 192.168.0.39 from 192.168.0.4 UA: okhttp/3.12.12 Engine version: 3 Transport: polling Total Clients: 8 Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetVisibleSources Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 04 13:50:11 volumio-usb volumio[956]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 04 13:50:11 volumio-usb volumio[956]: info: Received Get System Info Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 04 13:50:11 volumio-usb volumio[956]: info: Discovery: Getting this device information Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:50:11 volumio-usb volumio[956]: info: Listing playlists Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 04 13:50:11 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 04 13:50:13 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 04 13:50:13 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 04 13:50:13 volumio-usb volumio[956]: info: Received Get System Info Jun 04 13:50:13 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 04 13:50:13 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 04 13:50:13 volumio-usb volumio[956]: info: Discovery: Getting this device information Jun 04 13:50:13 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:50:13 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 04 13:50:13 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetQueue Jun 04 13:50:13 volumio-usb volumio[956]: info: CoreStateMachine::getQueue Jun 04 13:50:13 volumio-usb volumio[956]: info: CorePlayQueue::getQueue Jun 04 13:50:14 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 04 13:50:14 volumio-usb volumio[956]: info: Received Get System Info Jun 04 13:50:14 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 04 13:50:14 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 04 13:50:14 volumio-usb volumio[956]: info: Discovery: Getting this device information Jun 04 13:50:14 volumio-usb volumio[956]: info: CoreCommandRouter::volumioGetState Jun 04 13:50:14 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 04 13:50:16 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 04 13:50:16 volumio-usb volumio[956]: info: Preload queue cleared Jun 04 13:50:19 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 04 13:50:19 volumio-usb volumio[956]: info: Preload queue cleared Jun 04 13:50:21 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 04 13:50:24 volumio-usb volumio[956]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 04 13:50:24 volumio-usb volumio[956]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 04 13:50:24 volumio-usb volumio[956]: TypeError: Cannot read property 'length' of undefined Jun 04 13:50:24 volumio-usb volumio[956]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jun 04 13:50:24 volumio-usb volumio[956]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jun 04 13:50:24 volumio-usb volumio[956]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jun 04 13:50:24 volumio-usb volumio[956]: at Parser.emit (events.js:315:20) Jun 04 13:50:24 volumio-usb volumio[956]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jun 04 13:50:24 volumio-usb volumio[956]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jun 04 13:50:24 volumio-usb volumio[956]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jun 04 13:50:24 volumio-usb volumio[956]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jun 04 13:50:24 volumio-usb volumio[956]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jun 04 13:50:24 volumio-usb volumio[956]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jun 04 13:50:24 volumio-usb volumio[956]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jun 04 13:50:24 volumio-usb volumio[956]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jun 04 13:50:24 volumio-usb volumio[956]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jun 04 13:50:24 volumio-usb volumio[956]: at IncomingMessage.emit (events.js:327:22) Jun 04 13:50:24 volumio-usb volumio[956]: at endReadableNT (internal/streams/readable.js:1327:12) Jun 04 13:50:24 volumio-usb volumio[956]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 04 13:50:24 volumio-usb volumio[956]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 04 13:50:24 volumio-usb volumiologrotate[564]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 04 13:50:24 volumio-usb volumiologrotate[564]: ls: cannot access 'USB': No such file or directory Jun 04 13:50:24 volumio-usb sudo[13989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-04 13:49 Jun 04 13:50:24 volumio-usb sudo[13989]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"