-- Logs begin at Sat 2024-05-18 02:12:49 UTC, end at Sun 2025-05-11 23:17:35 UTC. --
May 11 23:17:14 omvolume systemd[1]: Time has been changed
May 11 23:17:14 omvolume volumio[790]: info: -------------------------------------------
May 11 23:17:15 omvolume volumio[790]: info: ----- Volumio2 ----
May 11 23:17:15 omvolume volumio[790]: info: -------------------------------------------
May 11 23:17:15 omvolume volumio[790]: info: ----- System startup ----
May 11 23:17:15 omvolume volumio[790]: info: -------------------------------------------
May 11 23:17:15 omvolume volumio[790]: info: MYVOLUMIO Environment detected
May 11 23:17:17 omvolume volumio[790]: info: Plugin folders cleanup
May 11 23:17:17 omvolume volumio[790]: info: Scanning into folder /volumio/app/plugins/
May 11 23:17:17 omvolume volumio[790]: info: Scanning category audio_interface
May 11 23:17:17 omvolume volumio[790]: info: Scanning category miscellanea
May 11 23:17:17 omvolume volumio[790]: info: Scanning category music_service
May 11 23:17:17 omvolume volumio[790]: info: Scanning category plugins.json
May 11 23:17:17 omvolume volumio[790]: info: Scanning category system_controller
May 11 23:17:17 omvolume volumio[790]: info: Scanning category user_interface
May 11 23:17:17 omvolume volumio[790]: info: Scanning into folder /data/plugins/
May 11 23:17:17 omvolume volumio[790]: info: Scanning category music_service
May 11 23:17:17 omvolume volumio[790]: info: Plugin folders cleanup completed
May 11 23:17:17 omvolume volumio[790]: info: -------------------------------------------
May 11 23:17:17 omvolume volumio[790]: info: ----- Core plugins startup ----
May 11 23:17:17 omvolume volumio[790]: info: -------------------------------------------
May 11 23:17:17 omvolume volumio[790]: info: Loading plugins from folder /volumio/app/plugins/
May 11 23:17:17 omvolume volumio[790]: info: Adding plugin upnp to MyMusic Plugins
May 11 23:17:17 omvolume volumio[790]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 11 23:17:17 omvolume volumio[790]: info: Adding plugin upnp_browser to MyMusic Plugins
May 11 23:17:17 omvolume volumio[790]: info: Loading plugins from folder /data/plugins/
May 11 23:17:17 omvolume volumio[790]: info: Loading plugin "system"...
May 11 23:17:17 omvolume volumio[790]: info: Loading plugin "appearance"...
May 11 23:17:18 omvolume volumio-remote-updater[601]: [2025-05-11 23:17:18] [connect] Successful connection
May 11 23:17:19 omvolume volumio[790]: info: Loading plugin "network"...
May 11 23:17:20 omvolume volumio[790]: info: Loading plugin "services"...
May 11 23:17:20 omvolume volumio[790]: info: Loading plugin "alsa_controller"...
May 11 23:17:20 omvolume volumio[790]: info: Loading plugin "wizard"...
May 11 23:17:20 omvolume volumio[790]: info: Loading plugin "volumio_command_line_client"...
May 11 23:17:20 omvolume volumio[790]: info: Loading plugin "upnp"...
May 11 23:17:20 omvolume volumio[790]: info: [1747005440618] Starting Upmpd Daemon
May 11 23:17:20 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 11 23:17:20 omvolume volumio[790]: info: Loading plugin "my_music"...
May 11 23:17:20 omvolume volumio[790]: info: Loading plugin "mpd"...
May 11 23:17:21 omvolume sudo[864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 11 23:17:21 omvolume volumio[790]: info: Loading plugin "upnp_browser"...
May 11 23:17:21 omvolume sudo[864]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 23:17:21 omvolume sudo[864]: pam_unix(sudo:session): session closed for user root
May 11 23:17:21 omvolume sudo[867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 11 23:17:21 omvolume sudo[867]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 23:17:21 omvolume systemd[1]: Stopping Music Player Daemon...
May 11 23:17:21 omvolume systemd[1]: Starting Music Player Daemon...
May 11 23:17:22 omvolume systemd[1]: Started Music Player Daemon.
May 11 23:17:22 omvolume sudo[867]: pam_unix(sudo:session): session closed for user root
May 11 23:17:22 omvolume volumio[790]: info: Loading plugin "networkfs"...
May 11 23:17:23 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 11 23:17:23 omvolume volumio[790]: info: Loading plugin "alarm-clock"...
May 11 23:17:23 omvolume sudo[888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=devin,password=2420N0Va,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.184/music /mnt/NAS/music
May 11 23:17:23 omvolume sudo[890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Devin,password=2420N0Va,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.253/Music/ /mnt/NAS/Raspberrypiomv
May 11 23:17:23 omvolume sudo[890]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 23:17:23 omvolume sudo[888]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 23:17:23 omvolume kernel: FS-Cache: Netfs 'cifs' registered for caching
May 11 23:17:23 omvolume kernel: Key type cifs.spnego registered
May 11 23:17:23 omvolume kernel: Key type cifs.idmap registered
May 11 23:17:23 omvolume 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.
May 11 23:17:23 omvolume 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.
May 11 23:17:23 omvolume sudo[888]: pam_unix(sudo:session): session closed for user root
May 11 23:17:23 omvolume kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 11 23:17:23 omvolume kernel: CIFS VFS: cifs_mount failed w/return code = -111
May 11 23:17:23 omvolume volumio[790]: info: Loading plugin "airplay_emulation"...
May 11 23:17:23 omvolume volumio[790]: info: Starting Shairport Sync
May 11 23:17:23 omvolume volumio[790]: info: Loading plugin "last_100"...
May 11 23:17:23 omvolume volumio[790]: info: Loading plugin "webradio"...
May 11 23:17:23 omvolume volumio[790]: info: Loading plugin "i2s_dacs"...
May 11 23:17:23 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 11 23:17:23 omvolume volumio[790]: info: Loading plugin "volumiodiscovery"...
May 11 23:17:24 omvolume volumio[790]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 11 23:17:24 omvolume node[790]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 11 23:17:24 omvolume node[790]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 11 23:17:24 omvolume node[790]: *** WARNING *** For more information see
May 11 23:17:24 omvolume node[790]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 11 23:17:24 omvolume node[790]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 11 23:17:24 omvolume node[790]: *** WARNING *** For more information see
May 11 23:17:24 omvolume volumio[790]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 11 23:17:24 omvolume volumio[790]: *** WARNING *** For more information see
May 11 23:17:24 omvolume volumio[790]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 11 23:17:24 omvolume volumio[790]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 11 23:17:24 omvolume volumio[790]: *** WARNING *** For more information see
May 11 23:17:24 omvolume volumio[790]: info: Applying required configuration parameters for plugin volumiodiscovery
May 11 23:17:24 omvolume volumio[790]: Discovery: StartAdv! undefined
May 11 23:17:24 omvolume volumio[790]: Discovery: Started advertising... omvolume - undefined
May 11 23:17:24 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 11 23:17:24 omvolume volumio[790]: info: Loading plugin "jellyfin"...
May 11 23:17:25 omvolume volumio[790]: info: Loading plugin "outputs"...
May 11 23:17:25 omvolume volumio[790]: info: Loading plugin "albumart"...
May 11 23:17:25 omvolume volumio[790]: info: Plugin example_plugin is not enabled
May 11 23:17:25 omvolume volumio[790]: info: Loading plugin "inputs"...
May 11 23:17:25 omvolume volumio[790]: info: Loading plugin "updater_comm"...
May 11 23:17:25 omvolume volumio[790]: info: Plugin mpdemulation is not enabled
May 11 23:17:25 omvolume volumio[790]: info: Loading plugin "rest_api"...
May 11 23:17:25 omvolume volumio[790]: info: Loading plugin "websocket"...
May 11 23:17:25 omvolume volumio[790]: info: ___________ START PLUGINS ___________
May 11 23:17:25 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 11 23:17:25 omvolume volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 11 23:17:25 omvolume volumio[790]: info: [1747005445858] CoreMusicLibrary::Adding element Media Servers
May 11 23:17:25 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 11 23:17:25 omvolume volumio[790]: Forking 3 albumart workers
May 11 23:17:26 omvolume volumio[790]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 11 23:17:26 omvolume volumio[790]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 11 23:17:26 omvolume volumio[790]: info: [1747005446115] CoreMusicLibrary::Adding element Last_100
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 11 23:17:26 omvolume volumio[790]: info: [1747005446124] CoreMusicLibrary::Adding element Webradio
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 11 23:17:26 omvolume volumio[790]: Begin ConnectionManager constructor
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 11 23:17:26 omvolume volumio[790]: info: [1747005446180] CoreMusicLibrary::Adding element Jellyfin
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 11 23:17:26 omvolume volumio[790]: info: [jellyfin-poller-worker] start(): Started polling...
May 11 23:17:26 omvolume volumio[790]: info: -------------------------------------------
May 11 23:17:26 omvolume volumio[790]: info: ----- MyVolumio plugins startup ----
May 11 23:17:26 omvolume volumio[790]: info: -------------------------------------------
May 11 23:17:26 omvolume volumio[790]: info: [MyVolumio PluginManager] Fetching plans data....
May 11 23:17:26 omvolume volumio[790]: info: Loading i18n strings for locale en
May 11 23:17:26 omvolume volumio[790]: Updating browse sources language
May 11 23:17:26 omvolume volumio[790]: Cannot find translation for sourceMedia Servers
May 11 23:17:26 omvolume volumio[790]: Cannot find translation for sourceJellyfin
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::initPlayerControls
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 11 23:17:26 omvolume volumio[790]: info: BOOT COMPLETED
May 11 23:17:26 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 11 23:17:27 omvolume volumio[790]: Starting albumart workers
May 11 23:17:27 omvolume volumio[790]: Starting albumart workers
May 11 23:17:27 omvolume volumio[790]: Starting albumart workers
May 11 23:17:29 omvolume sudo[890]: pam_unix(sudo:session): session closed for user root
May 11 23:17:29 omvolume kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 11 23:17:29 omvolume kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 11 23:17:31 omvolume volumio[790]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
May 11 23:17:31 omvolume volumio[790]: info: CoreCommandRouter::Close All Modals sent
May 11 23:17:31 omvolume volumio[790]: info: CoreCommandRouter::Close All Modals sent
May 11 23:17:31 omvolume volumio[790]: Express server listening on port 3000
May 11 23:17:31 omvolume volumio[790]: Volumio Calling Home
May 11 23:17:32 omvolume volumio[790]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms.
May 11 23:17:32 omvolume volumio[790]: info: CoreStateMachine::resetVolumioState
May 11 23:17:32 omvolume volumio[790]: info: CoreStateMachine::getcurrentVolume
May 11 23:17:32 omvolume volumio[790]: info: CoreCommandRouter::volumioRetrievevolume
May 11 23:17:32 omvolume sudo[979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 11 23:17:32 omvolume sudo[979]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 23:17:32 omvolume sudo[979]: pam_unix(sudo:session): session closed for user root
May 11 23:17:32 omvolume volumio[790]: info: Setting Device type: Raspberry PI
May 11 23:17:32 omvolume volumio[790]: info: Cannot mount NAS Raspberrypiomv at system boot, trial number 1 ,retrying in 5 seconds
May 11 23:17:32 omvolume volumio[790]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds
May 11 23:17:32 omvolume volumio[790]: info: MPD Permissions set
May 11 23:17:32 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 11 23:17:33 omvolume volumio-remote-updater[601]: [2025-05-11 23:17:33] [connect] Successful connection
May 11 23:17:33 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 11 23:17:33 omvolume volumio[790]: info: MPD running with PID879 ,establishing connection
May 11 23:17:33 omvolume volumio[790]: info: VolumeController:: Volume=70 Mute =false
May 11 23:17:33 omvolume volumio[790]: info: CoreStateMachine::pushState
May 11 23:17:33 omvolume volumio[790]: info: CoreStateMachine::getState
May 11 23:17:33 omvolume volumio[790]: info: CorePlayQueue::getTrack 0
May 11 23:17:33 omvolume volumio[790]: info: CoreCommandRouter::volumioPushState
May 11 23:17:33 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 23:17:33 omvolume volumio[790]: info: CoreStateMachine::updateTrackBlock
May 11 23:17:33 omvolume volumio[790]: info: CorePlayQueue::getTrackBlock
May 11 23:17:33 omvolume volumio[790]: info: CoreCommandRouter::volumioRetrievevolume
May 11 23:17:33 omvolume volumio[790]: info:
May 11 23:17:33 omvolume volumio[790]: ---------------------------- Client requests Volume 25
May 11 23:17:33 omvolume volumio[790]: info: VolumeController::SetAlsaVolume25
May 11 23:17:33 omvolume volumio[790]: info: CoreStateMachine::pushState
May 11 23:17:33 omvolume volumio[790]: info: CoreStateMachine::getState
May 11 23:17:33 omvolume volumio[790]: info: CorePlayQueue::getTrack 0
May 11 23:17:33 omvolume volumio[790]: info: CoreCommandRouter::volumioPushState
May 11 23:17:33 omvolume volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 23:17:33 omvolume volumio[790]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 11 23:17:33 omvolume volumio[790]: { AssertionError [ERR_ASSERTION]: false == true
May 11 23:17:33 omvolume volumio[790]: at MpdClient.sendCommand (/volumio/app/plugins/music_service/mpd/lib/mpd.js:92:9)
May 11 23:17:33 omvolume volumio[790]: at /volumio/app/plugins/music_service/mpd/index.js:3118:28
May 11 23:17:33 omvolume volumio[790]: at _combinedTickCallback (internal/process/next_tick.js:131:7)
May 11 23:17:33 omvolume volumio[790]: at process._tickCallback (internal/process/next_tick.js:180:9)
May 11 23:17:33 omvolume volumio[790]: generatedMessage: true,
May 11 23:17:33 omvolume volumio[790]: name: 'AssertionError [ERR_ASSERTION]',
May 11 23:17:33 omvolume volumio[790]: code: 'ERR_ASSERTION',
May 11 23:17:33 omvolume volumio[790]: actual: false,
May 11 23:17:33 omvolume volumio[790]: expected: true,
May 11 23:17:33 omvolume volumio[790]: operator: '==' }
May 11 23:17:33 omvolume volumio[790]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 11 23:17:35 omvolume sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-11 23:16
May 11 23:17:35 omvolume sudo[1006]: 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="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d"
VOLUMIO_FE_VERSION=""
VOLUMIO_BE_VERSION="a5d5fb6aa4e4c71be85580a005adf6b2009366a5"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Jan 16 20:23:20 CET 2020"
VOLUMIO_VERSION="2.698"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="3dcbb012a2043e1c4181cb54ce618cae"