-- Logs begin at Sat 2024-07-13 10:40:11 UTC, end at Sat 2024-07-13 11:01:28 UTC. -- Jul 13 11:00:02 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:06 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:10 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:14 volumio volumio[908]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 13 11:00:14 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:16 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Jul 13 11:00:16 volumio volumio[908]: info: Adding a new share Jul 13 11:00:16 volumio volumio[908]: info: Checking key NasMounts.f6ac4e07-f9ad-4021-b854-c9f5682bf8bb Jul 13 11:00:16 volumio volumio[908]: info: No correspondence found in configuration for share nas on IP 192.168.10.150 Jul 13 11:00:16 volumio sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=taka,password=taka,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.150/nas\Music /mnt/NAS/nas Jul 13 11:00:16 volumio sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/module/ccm", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/module/ccm", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1214", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "9970445" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/module/cifs", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/module/cifs", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1215", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "401" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:16 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching Jul 13 11:00:16 volumio kernel: Key type cifs.spnego registered Jul 13 11:00:16 volumio kernel: Key type cifs.idmap registered Jul 13 11:00:16 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/kernel/slab/cifs_inode_cache", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/kernel/slab/cifs_inode_cache", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1216", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "slab", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "652" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/kernel/slab/cifs_request", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/kernel/slab/cifs_request", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1217", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "slab", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "1291" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/kernel/slab/cifs_small_rq", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/kernel/slab/cifs_small_rq", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1218", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "slab", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "101749" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/module/nls_utf8", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/module/nls_utf8", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1219", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "5762" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/module/hmac", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/module/hmac", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1220", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "3752" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/module/cmac", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/module/cmac", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1221", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "5722" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:16 volumio volumio[908]: info: added device { Jul 13 11:00:16 volumio volumio[908]: "syspath": "/sys/module/sha512_generic", Jul 13 11:00:16 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:16 volumio volumio[908]: "DEVPATH": "/module/sha512_generic", Jul 13 11:00:16 volumio volumio[908]: "SEQNUM": "1222", Jul 13 11:00:16 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:16 volumio volumio[908]: "USEC_INITIALIZED": "3976" Jul 13 11:00:16 volumio volumio[908]: } Jul 13 11:00:17 volumio volumio[908]: info: added device { Jul 13 11:00:17 volumio volumio[908]: "syspath": "/sys/module/md5", Jul 13 11:00:17 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:17 volumio volumio[908]: "DEVPATH": "/module/md5", Jul 13 11:00:17 volumio volumio[908]: "SEQNUM": "1223", Jul 13 11:00:17 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:17 volumio volumio[908]: "USEC_INITIALIZED": "8652" Jul 13 11:00:17 volumio volumio[908]: } Jul 13 11:00:17 volumio volumio[908]: info: added device { Jul 13 11:00:17 volumio volumio[908]: "syspath": "/sys/module/md4", Jul 13 11:00:17 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:17 volumio volumio[908]: "DEVPATH": "/module/md4", Jul 13 11:00:17 volumio volumio[908]: "SEQNUM": "1224", Jul 13 11:00:17 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:17 volumio volumio[908]: "USEC_INITIALIZED": "1437" Jul 13 11:00:17 volumio volumio[908]: } Jul 13 11:00:17 volumio volumio[908]: info: added device { Jul 13 11:00:17 volumio volumio[908]: "syspath": "/sys/module/ecb", Jul 13 11:00:17 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:17 volumio volumio[908]: "DEVPATH": "/module/ecb", Jul 13 11:00:17 volumio volumio[908]: "SEQNUM": "1225", Jul 13 11:00:17 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:17 volumio volumio[908]: "USEC_INITIALIZED": "2364" Jul 13 11:00:17 volumio volumio[908]: } Jul 13 11:00:17 volumio volumio[908]: info: added device { Jul 13 11:00:17 volumio volumio[908]: "syspath": "/sys/module/arc4", Jul 13 11:00:17 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:17 volumio volumio[908]: "DEVPATH": "/module/arc4", Jul 13 11:00:17 volumio volumio[908]: "SEQNUM": "1226", Jul 13 11:00:17 volumio volumio[908]: "SUBSYSTEM": "module", Jul 13 11:00:17 volumio volumio[908]: "USEC_INITIALIZED": "9429" Jul 13 11:00:17 volumio volumio[908]: } Jul 13 11:00:17 volumio volumio[908]: info: added device { Jul 13 11:00:17 volumio volumio[908]: "syspath": "/sys/devices/virtual/bdi/cifs-1", Jul 13 11:00:17 volumio volumio[908]: "ACTION": "add", Jul 13 11:00:17 volumio volumio[908]: "DEVPATH": "/devices/virtual/bdi/cifs-1", Jul 13 11:00:17 volumio volumio[908]: "SEQNUM": "1227", Jul 13 11:00:17 volumio volumio[908]: "SUBSYSTEM": "bdi", Jul 13 11:00:17 volumio volumio[908]: "USEC_INITIALIZED": "48071" Jul 13 11:00:17 volumio volumio[908]: } Jul 13 11:00:17 volumio sudo[1755]: pam_unix(sudo:session): session closed for user root Jul 13 11:00:18 volumio volumio[908]: info: [1720868418001] Database scan error: Error: Command failed: /usr/bin/mpc update Jul 13 11:00:18 volumio volumio[908]: error: Cannot assign requested address Jul 13 11:00:18 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:18 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 13 11:00:22 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:26 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:27 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 13 11:00:27 volumio sudo[1815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/nas Jul 13 11:00:27 volumio sudo[1815]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 11:00:27 volumio volumio[908]: info: AVRCP: removed device { Jul 13 11:00:27 volumio volumio[908]: "syspath": "/sys/devices/virtual/bdi/cifs-1", Jul 13 11:00:27 volumio volumio[908]: "ACTION": "remove", Jul 13 11:00:27 volumio volumio[908]: "DEVPATH": "/devices/virtual/bdi/cifs-1", Jul 13 11:00:27 volumio volumio[908]: "SEQNUM": "1228", Jul 13 11:00:27 volumio volumio[908]: "SUBSYSTEM": "bdi", Jul 13 11:00:27 volumio volumio[908]: "USEC_INITIALIZED": "1058871" Jul 13 11:00:27 volumio volumio[908]: } Jul 13 11:00:27 volumio sudo[1815]: pam_unix(sudo:session): session closed for user root Jul 13 11:00:27 volumio volumio[908]: info: Share nas successfully unmounted Jul 13 11:00:28 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 13 11:00:30 volumio volumio[908]: info: [1720868430510] Database scan error: Error: Command failed: /usr/bin/mpc update Jul 13 11:00:30 volumio volumio[908]: error: Cannot assign requested address Jul 13 11:00:30 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:33 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 13 11:00:34 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 13 11:00:36 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 13 11:00:36 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:38 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:42 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:46 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:54 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:58 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:00:59 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Jul 13 11:00:59 volumio volumio[908]: info: Adding a new share Jul 13 11:00:59 volumio volumio[908]: info: No correspondence found in configuration for share nas on IP 192.168.10.150 Jul 13 11:00:59 volumio sudo[1837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=taka,password=taka,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.150/nas\Music /mnt/NAS/nas Jul 13 11:00:59 volumio sudo[1837]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 11:01:00 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 13 11:01:00 volumio volumio[908]: info: added device { Jul 13 11:01:00 volumio volumio[908]: "syspath": "/sys/devices/virtual/bdi/cifs-2", Jul 13 11:01:00 volumio volumio[908]: "ACTION": "add", Jul 13 11:01:00 volumio volumio[908]: "DEVPATH": "/devices/virtual/bdi/cifs-2", Jul 13 11:01:00 volumio volumio[908]: "SEQNUM": "1229", Jul 13 11:01:00 volumio volumio[908]: "SUBSYSTEM": "bdi", Jul 13 11:01:00 volumio volumio[908]: "USEC_INITIALIZED": "3666317" Jul 13 11:01:00 volumio volumio[908]: } Jul 13 11:01:00 volumio sudo[1837]: pam_unix(sudo:session): session closed for user root Jul 13 11:01:00 volumio volumio[908]: info: [1720868460391] Database scan error: Error: Command failed: /usr/bin/mpc update Jul 13 11:01:00 volumio volumio[908]: error: Cannot assign requested address Jul 13 11:01:00 volumio volumio[908]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 13 11:01:01 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 13 11:01:02 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:01:06 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 13 11:01:07 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 13 11:01:16 volumio volumio[908]: info: CoreCommandRouter::volumioGetVisibleSources Jul 13 11:01:16 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 13 11:01:16 volumio volumio[908]: info: CoreCommandRouter::volumioGetQueue Jul 13 11:01:16 volumio volumio[908]: info: CoreStateMachine::getQueue Jul 13 11:01:16 volumio volumio[908]: info: CorePlayQueue::getQueue Jul 13 11:01:18 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 13 11:01:18 volumio volumio[908]: info: CURURI: artists:// Jul 13 11:01:18 volumio volumio[908]: error: Failed to execute browseSource: TypeError: Cannot read property 'sendCommand' of undefined Jul 13 11:01:22 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 13 11:01:22 volumio volumio[908]: info: CURURI: music-library Jul 13 11:01:22 volumio volumio[908]: error: Failed to execute browseSource: TypeError: Cannot read property 'then' of undefined Jul 13 11:01:23 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 13 11:01:23 volumio volumio[908]: info: CURURI: playlists Jul 13 11:01:23 volumio volumio[908]: info: Listing playlists Jul 13 11:01:25 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 13 11:01:25 volumio volumio[908]: info: CURURI: albums:// Jul 13 11:01:25 volumio volumio[908]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 13 11:01:25 volumio volumio[908]: TypeError: Cannot read property 'sendCommand' of undefined Jul 13 11:01:25 volumio volumio[908]: at /volumio/app/plugins/music_service/mpd/index.js:2938:22 Jul 13 11:01:25 volumio volumio[908]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jul 13 11:01:25 volumio volumio[908]: at process._tickCallback (internal/process/next_tick.js:180:9) Jul 13 11:01:25 volumio volumio[908]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 13 11:01:28 volumio sudo[1882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-13 11:00 Jul 13 11:01:28 volumio sudo[1882]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"