-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2024-04-21 22:04:24 CST. --
Apr 21 22:03:00 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Apr 21 22:03:00 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Apr 21 22:03:02 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:06 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:10 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:14 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:18 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare
Apr 21 22:03:18 alex volumio[926]: info: Adding a new share
Apr 21 22:03:18 alex volumio[926]: info: No correspondence found in configuration for share alex on IP 192.168.8.102
Apr 21 22:03:18 alex sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.8.102/\\\\Laptop-85g4t9g5\\g /mnt/NAS/alex
Apr 21 22:03:18 alex sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 22:03:18 alex kernel: Key type cifs.spnego registered
Apr 21 22:03:18 alex kernel: Key type cifs.idmap registered
Apr 21 22:03:18 alex 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.
Apr 21 22:03:18 alex kernel: CIFS: Attempting to mount \\192.168.8.102\
Apr 21 22:03:18 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:18 alex sudo[1309]: pam_unix(sudo:session): session closed for user root
Apr 21 22:03:18 alex kernel: CIFS: Status code returned 0xc0000022 STATUS_ACCESS_DENIED
Apr 21 22:03:18 alex kernel: CIFS: VFS: \\192.168.8.102 Send error in SessSetup = -13
Apr 21 22:03:18 alex kernel: CIFS: VFS: cifs_mount failed w/return code = -13
Apr 21 22:03:18 alex volumio[926]: info: Permission denied for alex on IP 192.168.8.102
Apr 21 22:03:19 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 21 22:03:22 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:26 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:30 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:30 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare
Apr 21 22:03:30 alex volumio[926]: info: Share alex successfully unmounted
Apr 21 22:03:30 alex sudo[1339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=alex,password=a25494369,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.8.102/\\\\Laptop-85g4t9g5\\g /mnt/NAS/alex
Apr 21 22:03:30 alex sudo[1339]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 22:03:30 alex kernel: CIFS: Attempting to mount \\192.168.8.102\
Apr 21 22:03:30 alex sudo[1339]: pam_unix(sudo:session): session closed for user root
Apr 21 22:03:30 alex kernel: CIFS: VFS: cifs_mount failed w/return code = -22
Apr 21 22:03:30 alex volumio[926]: info: An error occurred mounting the new share. Rolling back configuration
Apr 21 22:03:31 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 21 22:03:34 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:38 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 22:03:40 alex volumio[926]: info: CoreCommandRouter::volumioGetState
Apr 21 22:03:40 alex volumio[926]: info: CorePlayQueue::getTrack 0
Apr 21 22:03:53 alex volumio[926]: info: CoreCommandRouter::volumioGetQueue
Apr 21 22:03:53 alex volumio[926]: info: CoreStateMachine::getQueue
Apr 21 22:03:53 alex volumio[926]: info: CorePlayQueue::getQueue
Apr 21 22:03:58 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 21 22:03:58 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:05 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 21 22:04:05 alex volumio[926]: info: CURURI: music-library
Apr 21 22:04:05 alex volumio[926]: error: Failed LSINFO: null
Apr 21 22:04:05 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:10 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 21 22:04:10 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:13 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 21 22:04:13 alex volumio[926]: info: TuneIn handleBrowseUri: tunein/location
Apr 21 22:04:14 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:15 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 21 22:04:15 alex volumio[926]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101216
Apr 21 22:04:15 alex volumio[926]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101216
Apr 21 22:04:16 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:18 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 21 22:04:18 alex volumio[926]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101302
Apr 21 22:04:18 alex volumio[926]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101302
Apr 21 22:04:18 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:18 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:19 alex sudo[971]: pam_unix(sudo:session): session closed for user root
Apr 21 22:04:19 alex volumio[926]: info: Cannot mount NAS ALEX at system boot, trial number 1 ,retrying in 5 seconds
Apr 21 22:04:21 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:21 alex volumio[926]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 21 22:04:21 alex volumio[926]: info: CoreStateMachine::ClearQueue
Apr 21 22:04:21 alex volumio[926]: info: CoreStateMachine::stop
Apr 21 22:04:21 alex volumio[926]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 22:04:21 alex volumio[926]: info: CorePlayQueue::clearPlayQueue
Apr 21 22:04:21 alex volumio[926]: info: CorePlayQueue::saveQueue
Apr 21 22:04:21 alex volumio[926]: info: CoreCommandRouter::volumioPushQueue
Apr 21 22:04:21 alex volumio[926]: info: CoreStateMachine::addQueueItems
Apr 21 22:04:21 alex volumio[926]: info: CorePlayQueue::addQueueItems
Apr 21 22:04:21 alex volumio[926]: info: Preload queue cleared
Apr 21 22:04:21 alex volumio[926]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s112541
Apr 21 22:04:21 alex volumio[926]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 21 22:04:22 alex volumio[926]: info: CoreCommandRouter::volumioPushQueue
Apr 21 22:04:22 alex volumio[926]: info: CorePlayQueue::saveQueue
Apr 21 22:04:22 alex volumio[926]: info: CoreStateMachine::updateTrackBlock
Apr 21 22:04:22 alex volumio[926]: info: CorePlayQueue::getTrackBlock
Apr 21 22:04:22 alex volumio[926]: info: CoreCommandRouter::volumioPlay
Apr 21 22:04:22 alex volumio[926]: info: CoreStateMachine::play index 0
Apr 21 22:04:22 alex volumio[926]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 22:04:22 alex volumio[926]: info: CoreStateMachine::stop
Apr 21 22:04:22 alex volumio[926]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 22:04:22 alex volumio[926]: info: CoreStateMachine::play index undefined
Apr 21 22:04:22 alex volumio[926]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 22:04:22 alex volumio[926]: info: CorePlayQueue::getTrack 0
Apr 21 22:04:22 alex volumio[926]: info: CoreStateMachine::startPlaybackTimer
Apr 21 22:04:22 alex volumio[926]: info: CorePlayQueue::getTrack 0
Apr 21 22:04:22 alex volumio[926]: info: [1713708262050] ControllerWebradio::clearAddPlayTrack
Apr 21 22:04:22 alex volumio[926]: verbose: ControllerMpd::sendMpdCommand stop
Apr 21 22:04:22 alex volumio[926]: info: sendMpdCommand stop took 3 milliseconds
Apr 21 22:04:22 alex volumio[926]: verbose: ControllerMpd::sendMpdCommand clear
Apr 21 22:04:22 alex volumio[926]: info:
Apr 21 22:04:22 alex volumio[926]: ---------------------------- MPD announces system playlist update
Apr 21 22:04:22 alex volumio[926]: info: Ignoring MPD Status Update
Apr 21 22:04:22 alex volumio[926]: info: sendMpdCommand clear took 2 milliseconds
Apr 21 22:04:22 alex volumio[926]: verbose: ControllerMpd::sendMpdCommand load "mms://59.120.150.141:11882/"
Apr 21 22:04:22 alex volumio[926]: info:
Apr 21 22:04:22 alex volumio[926]: ---------------------------- MPD announces system playlist update
Apr 21 22:04:22 alex volumio[926]: info: Ignoring MPD Status Update
Apr 21 22:04:22 alex volumio[926]: info:
Apr 21 22:04:22 alex volumio[926]: ---------------------------- MPD announces system playlist update
Apr 21 22:04:22 alex volumio[926]: info: Ignoring MPD Status Update
Apr 21 22:04:22 alex volumio[926]: error: updateQueue error: null
Apr 21 22:04:22 alex volumio[926]: info: ------------------------------ 5ms
Apr 21 22:04:22 alex volumio[926]: error: Upnp client error: Error: This socket has been ended by the other party
Apr 21 22:04:23 alex volumio[926]: verbose: ControllerMpd::sendMpdCommand add "mms://59.120.150.141:11882/"
Apr 21 22:04:23 alex volumio[926]: error: updateQueue error: null
Apr 21 22:04:23 alex volumio[926]: error: updateQueue error: null
Apr 21 22:04:23 alex volumio[926]: info:
Apr 21 22:04:23 alex volumio[926]: ---------------------------- MPD announces system playlist update
Apr 21 22:04:23 alex volumio[926]: info: Ignoring MPD Status Update
Apr 21 22:04:23 alex volumio[926]: info: ------------------------------ 1651ms
Apr 21 22:04:23 alex volumio[926]: info: ------------------------------ 1651ms
Apr 21 22:04:23 alex volumio[926]: info: sendMpdCommand add "mms://59.120.150.141:11882/" took 2 milliseconds
Apr 21 22:04:23 alex volumio[926]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 21 22:04:23 alex volumio[926]: verbose: ControllerMpd::sendMpdCommand play
Apr 21 22:04:23 alex volumio[926]: info:
Apr 21 22:04:23 alex volumio[926]: ---------------------------- MPD announces system playlist update
Apr 21 22:04:23 alex volumio[926]: info: Ignoring MPD Status Update
Apr 21 22:04:23 alex volumio[926]: info:
Apr 21 22:04:23 alex volumio[926]: ---------------------------- MPD announces system playlist update
Apr 21 22:04:23 alex volumio[926]: info: Ignoring MPD Status Update
Apr 21 22:04:23 alex volumio[926]: info: ------------------------------ 5ms
Apr 21 22:04:23 alex volumio[926]: info: sendMpdCommand play took 4 milliseconds
Apr 21 22:04:23 alex volumio[926]: info: ------------------------------ 4ms
Apr 21 22:04:23 alex volumio[926]: info: ------------------------------ 3ms
Apr 21 22:04:24 alex volumio[926]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 22:04:24 alex volumio[926]: TypeError: Cannot read property 'replace' of undefined
Apr 21 22:04:24 alex volumio[926]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28)
Apr 21 22:04:24 alex volumio[926]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20)
Apr 21 22:04:24 alex volumio[926]: at listOnTimeout (internal/timers.js:554:17)
Apr 21 22:04:24 alex volumio[926]: at processTimers (internal/timers.js:497:7)
Apr 21 22:04:24 alex volumio[926]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 22:04:24 alex sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 22:03
Apr 21 22:04:24 alex sudo[1405]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"