-- Logs begin at Sun 2024-07-07 13:18:36 UTC, end at Sun 2024-07-07 13:22:09 UTC. --
Jul 07 13:21:04 musical-fidelity volumio[2423]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: CoreCommandRouter::Close All Modals sent
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: CoreCommandRouter::Close All Modals sent
Jul 07 13:21:04 musical-fidelity volumio[2423]: Express server listening on port 3000
Jul 07 13:21:04 musical-fidelity volumio[2423]: [Metrics] WebUI: 14s 589.35ms
Jul 07 13:21:04 musical-fidelity volumio[2423]: Volumio Calling Home
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: CoreStateMachine::resetVolumioState
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: CoreStateMachine::getcurrentVolume
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioRetrievevolume
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Stopping AccessToken refresher cron for QOBUZ
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: AccessToken refresher cron started for QOBUZ
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:04 musical-fidelity sudo[2655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Jul 07 13:21:04 musical-fidelity sudo[2655]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:04 musical-fidelity sudo[2655]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:04 musical-fidelity sudo[2663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 07 13:21:04 musical-fidelity sudo[2663]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:04 musical-fidelity sudo[2663]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:04 musical-fidelity sudo[2669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 07 13:21:04 musical-fidelity sudo[2669]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:04 musical-fidelity sudo[2669]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Serial port opened successfully
Jul 07 13:21:04 musical-fidelity sudo[2694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart leddaemon.service
Jul 07 13:21:04 musical-fidelity sudo[2694]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:04 musical-fidelity systemd[1]: Stopping LED Daemon Service...
Jul 07 13:21:04 musical-fidelity systemd[1]: Starting LED Daemon Service...
Jul 07 13:21:04 musical-fidelity systemd[1]: Started LED Daemon Service.
Jul 07 13:21:04 musical-fidelity sudo[2694]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:04 musical-fidelity led-daemon[2700]: Starting Network LED Daemon
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Setting Device type: Raspberry PI
Jul 07 13:21:04 musical-fidelity volumio[2423]: [SpotifyConnect] Vollibrespot Daemon service started!
Jul 07 13:21:04 musical-fidelity volumio[2423]: [Metrics] SpotifyConnect: 6s 170.92ms
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Bluetooth name changed to musical-fidelity
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: Shairport-Sync Stopped
Jul 07 13:21:04 musical-fidelity volumio[2423]: info: MPD running with PID747
Jul 07 13:21:04 musical-fidelity volumio[2423]: ,establishing connection
Jul 07 13:21:04 musical-fidelity sudo[2710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Jul 07 13:21:04 musical-fidelity sudo[2710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:04 musical-fidelity sudo[2710]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: VolumeController:: Volume=100 Mute =false
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreStateMachine::pushState
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreStateMachine::updateTrackBlock
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrackBlock
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioRetrievevolume
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 07 13:21:05 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:05 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:05 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:05 musical-fidelity volumio[2423]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified
Jul 07 13:21:05 musical-fidelity volumio[2423]: xcb_connection_has_error() returned true
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1
Jul 07 13:21:05 musical-fidelity volumio[2423]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Jul 07 13:21:05 musical-fidelity sudo[2721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Jul 07 13:21:05 musical-fidelity sudo[2721]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:05 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:05] [connect] Successful connection
Jul 07 13:21:05 musical-fidelity sudo[2721]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:05 musical-fidelity volumio[2423]: No protocol specified
Jul 07 13:21:05 musical-fidelity volumio[2423]: xcb_connection_has_error() returned true
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: Reloading queue from file
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: Received Push USB{"activeRoute":"0","powerShutdown":"0"}
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: inputs , setPCInputReturn
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: inputs , disablePCInput
Jul 07 13:21:05 musical-fidelity sudo[2733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Jul 07 13:21:05 musical-fidelity sudo[2733]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:05 musical-fidelity systemd[1]: Stopping RAAT DAEMON...
Jul 07 13:21:05 musical-fidelity systemd[1]: Starting RAAT DAEMON...
Jul 07 13:21:05 musical-fidelity systemd[1]: Started RAAT DAEMON.
Jul 07 13:21:05 musical-fidelity sudo[2733]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:05 musical-fidelity pulseaudio[2738]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 07 13:21:05 musical-fidelity pulseaudio[2738]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 07 13:21:05 musical-fidelity pulseaudio[2738]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist
Jul 07 13:21:05 musical-fidelity bluetoothd[695]: Endpoint registered: sender=:1.37 path=/MediaEndpoint/A2DPSource
Jul 07 13:21:05 musical-fidelity bluetoothd[695]: Endpoint registered: sender=:1.37 path=/MediaEndpoint/A2DPSink
Jul 07 13:21:05 musical-fidelity volumio[2423]: error: updateQueue error: null
Jul 07 13:21:05 musical-fidelity volumio[2423]: error: Failed LSINFO: Error: [50@0] {} No such directory
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 07 13:21:05 musical-fidelity volumio[2423]: No protocol specified
Jul 07 13:21:05 musical-fidelity volumio[2423]: xcb_connection_has_error() returned true
Jul 07 13:21:05 musical-fidelity volumio[2423]: error: Failed to fix hosts file for Spotify: Error: EACCES: permission denied, open '/etc/hosts'
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreStateMachine::setRepeat false single undefined
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreStateMachine::pushState
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreStateMachine::setRandom null
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreStateMachine::pushState
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:05 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: Raat Daemon started successfully
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: VolumeController:: Volume=undefined Mute =false
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreStateMachine::pushState
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:06 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1720358465 101
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: Executing endpoint restartRAATSocket
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jul 07 13:21:06 musical-fidelity sudo[2769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 07 13:21:06 musical-fidelity sudo[2769]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:06 musical-fidelity systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 07 13:21:06 musical-fidelity sudo[2769]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: Volumio called home
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:06 musical-fidelity volumio[2423]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: Updating push state because input changed
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumiosetSourceActivempd
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: Upmpdcli Daemon Started
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 07 13:21:06 musical-fidelity volumio[2423]: Discovery: adding 35083494-0616-445b-90e6-c13a91a1ac91
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: mDNS: Found device musical-fidelity
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:06 musical-fidelity volumio[2423]: Discovery: this is already registered, 35083494-0616-445b-90e6-c13a91a1ac91
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: mDNS: Found device musical-fidelity
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetQueue
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreStateMachine::getQueue
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CorePlayQueue::getQueue
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: Listing playlists
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 07 13:21:06 musical-fidelity volumio[2423]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: Access Token successfully retrieved
Jul 07 13:21:07 musical-fidelity volumio-streaming-daemon[2603]: Checking variant in static cache
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: Fetching Streaming Services browse cache
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: Setting Additional System Software info: Hardware Firmware Version: 117 Hardware Revision: 1
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetQueue
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CoreStateMachine::getQueue
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CorePlayQueue::getQueue
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: Listing playlists
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 07 13:21:07 musical-fidelity volumio[2423]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: Successfully retrieved User Session From TIDAL
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: Successfully retrieved User Subscription From TIDAL
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: Adding TIDAL to Browse Sources
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: [1720358468667] CoreMusicLibrary::Adding element TIDAL
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: Stopping AccessToken refresher cron
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: AccessToken refresher cron started
Jul 07 13:21:08 musical-fidelity volumio[2423]: info: Checking Spotify Web API
Jul 07 13:21:09 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:09 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:09 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:09 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:09 musical-fidelity volumio[2423]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:09 musical-fidelity volumio[2423]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Jul 07 13:21:09 musical-fidelity sudo[2801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Ds
Jul 07 13:21:09 musical-fidelity sudo[2801]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:09 musical-fidelity sudo[2801]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:09 musical-fidelity volumio[2423]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 07 13:21:09 musical-fidelity volumio[2423]: { Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/Ds'
Jul 07 13:21:09 musical-fidelity volumio[2423]: at Object.fs.rmdirSync (fs.js:846:18)
Jul 07 13:21:09 musical-fidelity volumio[2423]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12
Jul 07 13:21:09 musical-fidelity volumio[2423]: at ChildProcess.exithandler (child_process.js:267:7)
Jul 07 13:21:09 musical-fidelity volumio[2423]: at emitTwo (events.js:126:13)
Jul 07 13:21:09 musical-fidelity volumio[2423]: at ChildProcess.emit (events.js:214:7)
Jul 07 13:21:09 musical-fidelity volumio[2423]: at maybeClose (internal/child_process.js:925:16)
Jul 07 13:21:09 musical-fidelity volumio[2423]: at Process.ChildProcess._handle.onexit (internal/child_process.js:209:5)
Jul 07 13:21:09 musical-fidelity volumio[2423]: errno: -16,
Jul 07 13:21:09 musical-fidelity volumio[2423]: code: 'EBUSY',
Jul 07 13:21:09 musical-fidelity volumio[2423]: syscall: 'rmdir',
Jul 07 13:21:09 musical-fidelity volumio[2423]: path: '/mnt/NAS/Ds' }
Jul 07 13:21:09 musical-fidelity volumio[2423]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 07 13:21:10 musical-fidelity sudo[2819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-07 13:20
Jul 07 13:21:10 musical-fidelity sudo[2819]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:10 musical-fidelity sudo[2819]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:10 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:10] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jul 07 13:21:10 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:10] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jul 07 13:21:10 musical-fidelity systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Jul 07 13:21:10 musical-fidelity bluetoothd[695]: Endpoint unregistered: sender=:1.37 path=/MediaEndpoint/A2DPSource
Jul 07 13:21:10 musical-fidelity bluetoothd[695]: Endpoint unregistered: sender=:1.37 path=/MediaEndpoint/A2DPSink
Jul 07 13:21:10 musical-fidelity systemd[1]: Unit volumio.service entered failed state.
Jul 07 13:21:10 musical-fidelity systemd[1]: Starting dynamicswap service...
Jul 07 13:21:10 musical-fidelity systemd[1]: Started dynamicswap service.
Jul 07 13:21:11 musical-fidelity systemd[1]: volumio.service holdoff time over, scheduling restart.
Jul 07 13:21:11 musical-fidelity systemd[1]: Starting dynamicswap service...
Jul 07 13:21:11 musical-fidelity systemd[1]: Started dynamicswap service.
Jul 07 13:21:11 musical-fidelity systemd[1]: Stopping Volumio Backend Module...
Jul 07 13:21:11 musical-fidelity systemd[1]: Starting Volumio Backend Module...
Jul 07 13:21:11 musical-fidelity systemd[1]: Started Volumio Backend Module.
Jul 07 13:21:12 musical-fidelity volumio[2843]: info: -------------------------------------------
Jul 07 13:21:12 musical-fidelity volumio[2843]: info: ----- Volumio2 ----
Jul 07 13:21:12 musical-fidelity volumio[2843]: info: -------------------------------------------
Jul 07 13:21:12 musical-fidelity volumio[2843]: info: ----- System startup ----
Jul 07 13:21:12 musical-fidelity volumio[2843]: info: -------------------------------------------
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Plugin folders cleanup
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Scanning into folder /volumio/app/plugins/
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Scanning category audio_interface
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Scanning category miscellanea
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Scanning category music_service
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Scanning category plugins.json
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Scanning category system_controller
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Scanning category user_interface
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Scanning into folder /data/plugins/
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Plugin folders cleanup completed
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: -------------------------------------------
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: ----- Core plugins startup ----
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: -------------------------------------------
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Loading plugins from folder /volumio/app/plugins/
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Adding plugin upnp to MyMusic Plugins
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Adding plugin metavolumio to MyMusic Plugins
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Adding plugin cd_controller to MyMusic Plugins
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Adding plugin raat to MyMusic Plugins
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Loading plugins from folder /data/plugins/
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Loading plugin "system"...
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Applying required configuration parameters for plugin system
Jul 07 13:21:13 musical-fidelity volumio[2843]: info: Loading plugin "appearance"...
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "network"...
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Refreshing Cached IP Addresses
Jul 07 13:21:15 musical-fidelity sudo[2884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "services"...
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "alsa_controller"...
Jul 07 13:21:15 musical-fidelity sudo[2884]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:15 musical-fidelity sudo[2887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 07 13:21:15 musical-fidelity sudo[2884]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:15 musical-fidelity sudo[2887]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Applying required configuration parameters for plugin alsa_controller
Jul 07 13:21:15 musical-fidelity sudo[2887]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "wizard"...
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "volumio_command_line_client"...
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "upnp"...
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: [1720358475256] Starting Upmpd Daemon
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "my_music"...
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "mpd"...
Jul 07 13:21:15 musical-fidelity volumio[2843]: info: Loading plugin "upnp_browser"...
Jul 07 13:21:15 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:15] [connect] Successful connection
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "networkfs"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "bluetooth"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: [1720358476312] Starting BluetoothController
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "multiroom"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "alarm-clock"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "metavolumio"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "airplay_emulation"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Starting Shairport Sync
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "cd_controller"...
Jul 07 13:21:16 musical-fidelity sudo[2915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync
Jul 07 13:21:16 musical-fidelity sudo[2915]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Plugin last_100 is not enabled
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "raat"...
Jul 07 13:21:16 musical-fidelity systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 07 13:21:16 musical-fidelity sudo[2915]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: RAAT Plugin loaded
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Adding restartRAATSocket REST API Endpoint
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "streaming_services"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "webradio"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "i2s_dacs"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: I2S DAC not set, start Auto-detection
Jul 07 13:21:16 musical-fidelity volumio[2843]: info: Loading plugin "volumiodiscovery"...
Jul 07 13:21:16 musical-fidelity volumio[2843]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 07 13:21:16 musical-fidelity node[2843]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 07 13:21:16 musical-fidelity node[2843]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 07 13:21:16 musical-fidelity node[2843]: *** WARNING *** For more information see
Jul 07 13:21:16 musical-fidelity node[2843]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 07 13:21:16 musical-fidelity node[2843]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 07 13:21:16 musical-fidelity node[2843]: *** WARNING *** For more information see
Jul 07 13:21:17 musical-fidelity volumio[2843]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 07 13:21:17 musical-fidelity volumio[2843]: *** WARNING *** For more information see
Jul 07 13:21:17 musical-fidelity volumio[2843]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 07 13:21:17 musical-fidelity volumio[2843]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 07 13:21:17 musical-fidelity volumio[2843]: *** WARNING *** For more information see
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 07 13:21:17 musical-fidelity volumio[2843]: Discovery: StartAdv! undefined
Jul 07 13:21:17 musical-fidelity volumio[2843]: Discovery: Started advertising... musical-fidelity - undefined
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Plugin outputs is not enabled
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Loading plugin "albumart"...
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Plugin example_plugin is not enabled
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Loading plugin "hi_res_audio"...
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Applying required configuration parameters for plugin hi_res_audio
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Loading plugin "inputs"...
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Adding inputs REST Endpoints
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/inputs
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Scanning Audio Inputs
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Checking against Known Cards name
Jul 07 13:21:17 musical-fidelity volumio[2843]: info: Loading plugin "qobuz"...
Jul 07 13:21:17 musical-fidelity volumio[2843]: Forking 3 albumart workers
Jul 07 13:21:18 musical-fidelity volumio[2843]: Starting albumart workers
Jul 07 13:21:18 musical-fidelity volumio[2843]: Starting albumart workers
Jul 07 13:21:18 musical-fidelity volumio[2843]: Starting albumart workers
Jul 07 13:21:19 musical-fidelity volumio[2843]: info: Loading plugin "spop"...
Jul 07 13:21:19 musical-fidelity volumio[2843]: info: Loading plugin "tidal"...
Jul 07 13:21:20 musical-fidelity volumio[2843]: info: Loading plugin "gpios"...
Jul 07 13:21:20 musical-fidelity volumio[2843]: error: ATTENTION!!!: Plugin gpios does not return adequate promise from onVolumioStart: please update!
Jul 07 13:21:20 musical-fidelity volumio[2843]: info: Loading plugin "updater_comm"...
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Plugin mpdemulation is not enabled
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Loading plugin "rest_api"...
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Loading plugin "websocket"...
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: ___________ START PLUGINS ___________
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Adding METAVOLUMIO REST API Endpoints
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: [1720358481202] CoreMusicLibrary::Adding element Shairport-Sync
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:21 musical-fidelity sudo[2997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name musical-fidelity
Jul 07 13:21:21 musical-fidelity sudo[2997]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Preparing CD Folders
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Adding CD REST API Endpoints
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Detecting CD presence with Flag file
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Starting RAAT Plugin
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections
Jul 07 13:21:21 musical-fidelity sudo[2997]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Additional UI Settings Added for plugin music_service/raat
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Not Reporting Auto name since its the default one
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Streaming services startup
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Starting Streaming Daemon
Jul 07 13:21:21 musical-fidelity sudo[3011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 07 13:21:21 musical-fidelity sudo[3011]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:21 musical-fidelity systemd[1]: Stopping Volumio Streaming Daemon...
Jul 07 13:21:21 musical-fidelity systemd[1]: Starting Volumio Streaming Daemon...
Jul 07 13:21:21 musical-fidelity systemd[1]: Started Volumio Streaming Daemon.
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 07 13:21:21 musical-fidelity sudo[3011]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: [1720358481352] CoreMusicLibrary::Adding element Webradio
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 07 13:21:21 musical-fidelity volumio-streaming-daemon[3022]: ############################
Jul 07 13:21:21 musical-fidelity volumio-streaming-daemon[3022]: # Volumio Streaming Daemon #
Jul 07 13:21:21 musical-fidelity volumio-streaming-daemon[3022]: # Running on port 7777 #
Jul 07 13:21:21 musical-fidelity volumio-streaming-daemon[3022]: ############################
Jul 07 13:21:21 musical-fidelity volumio-streaming-daemon[3022]: Checking variant in static cache
Jul 07 13:21:21 musical-fidelity volumio-streaming-daemon[3022]: Enabled services:
Jul 07 13:21:21 musical-fidelity volumio-streaming-daemon[3022]: 1) tidal
Jul 07 13:21:21 musical-fidelity volumio-streaming-daemon[3022]: 2) qobuz
Jul 07 13:21:21 musical-fidelity volumio[2843]: error: Hi Res Audio Failed Login: Missing Login Data
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:21 musical-fidelity volumio[2843]: [SpotifyConnect] Creating VLS config file
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: [SpotifyConnect] Starting metadata listener
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Refreshing TIDAL token
Jul 07 13:21:21 musical-fidelity sudo[3033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service
Jul 07 13:21:21 musical-fidelity sudo[3033]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:21 musical-fidelity volumio[2843]: error: Plugin gpios does not return adequate promise from onStart: please update!
Jul 07 13:21:21 musical-fidelity systemd[1]: Started Volspotconnect2 Daemon.
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: Loading i18n strings for locale zh
Jul 07 13:21:21 musical-fidelity sudo[3033]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:21 musical-fidelity volumio[2843]: Updating browse sources language
Jul 07 13:21:21 musical-fidelity volumio[2843]: Cannot find translation for sourceBluetooth
Jul 07 13:21:21 musical-fidelity volumio[2843]: Cannot find translation for sourceUSB/PC
Jul 07 13:21:21 musical-fidelity volumio[2843]: Cannot find translation for sourceShairport-Sync
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::initPlayerControls
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: BOOT COMPLETED
Jul 07 13:21:21 musical-fidelity volumio[2843]: [Metrics] CommandRouter: 8s 634.46ms
Jul 07 13:21:21 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 13:21:26 musical-fidelity volumio[2843]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Jul 07 13:21:26 musical-fidelity volumio[2843]: info: CoreCommandRouter::Close All Modals sent
Jul 07 13:21:26 musical-fidelity volumio[2843]: info: CoreCommandRouter::Close All Modals sent
Jul 07 13:21:26 musical-fidelity volumio[2843]: Express server listening on port 3000
Jul 07 13:21:26 musical-fidelity volumio[2843]: [Metrics] WebUI: 14s 465.30ms
Jul 07 13:21:26 musical-fidelity volumio[2843]: Volumio Calling Home
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreStateMachine::resetVolumioState
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreStateMachine::getcurrentVolume
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioRetrievevolume
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Stopping AccessToken refresher cron for QOBUZ
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: AccessToken refresher cron started for QOBUZ
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:27 musical-fidelity sudo[3097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Jul 07 13:21:27 musical-fidelity sudo[3097]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:27 musical-fidelity sudo[3097]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:27 musical-fidelity sudo[3106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 07 13:21:27 musical-fidelity sudo[3106]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:27 musical-fidelity sudo[3110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 07 13:21:27 musical-fidelity sudo[3106]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:27 musical-fidelity sudo[3110]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Serial port opened successfully
Jul 07 13:21:27 musical-fidelity sudo[3110]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:27 musical-fidelity sudo[3134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart leddaemon.service
Jul 07 13:21:27 musical-fidelity sudo[3134]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:27 musical-fidelity systemd[1]: Stopping LED Daemon Service...
Jul 07 13:21:27 musical-fidelity systemd[1]: Starting LED Daemon Service...
Jul 07 13:21:27 musical-fidelity systemd[1]: Started LED Daemon Service.
Jul 07 13:21:27 musical-fidelity sudo[3134]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:27 musical-fidelity led-daemon[3140]: Starting Network LED Daemon
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Setting Device type: Raspberry PI
Jul 07 13:21:27 musical-fidelity volumio[2843]: [SpotifyConnect] Vollibrespot Daemon service started!
Jul 07 13:21:27 musical-fidelity volumio[2843]: [Metrics] SpotifyConnect: 6s 164.66ms
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Bluetooth name changed to musical-fidelity
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: Shairport-Sync Stopped
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: MPD running with PID747
Jul 07 13:21:27 musical-fidelity volumio[2843]: ,establishing connection
Jul 07 13:21:27 musical-fidelity sudo[3150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Jul 07 13:21:27 musical-fidelity sudo[3150]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:27 musical-fidelity sudo[3150]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: VolumeController:: Volume=100 Mute =false
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreStateMachine::pushState
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreStateMachine::updateTrackBlock
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrackBlock
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioRetrievevolume
Jul 07 13:21:27 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 07 13:21:27 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:27 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:27 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:28 musical-fidelity sudo[3160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Jul 07 13:21:28 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:28] [connect] Successful connection
Jul 07 13:21:28 musical-fidelity sudo[3160]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:28 musical-fidelity volumio[2843]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified
Jul 07 13:21:28 musical-fidelity volumio[2843]: xcb_connection_has_error() returned true
Jul 07 13:21:28 musical-fidelity sudo[3160]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: Volumio called home
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1
Jul 07 13:21:28 musical-fidelity volumio[2843]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Jul 07 13:21:28 musical-fidelity volumio[2843]: No protocol specified
Jul 07 13:21:28 musical-fidelity volumio[2843]: xcb_connection_has_error() returned true
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: Reloading queue from file
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: Received Push USB{"activeRoute":"0","powerShutdown":"0"}
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: inputs , setPCInputReturn
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: inputs , disablePCInput
Jul 07 13:21:28 musical-fidelity sudo[3176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Jul 07 13:21:28 musical-fidelity sudo[3176]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:28 musical-fidelity pulseaudio[3173]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 07 13:21:28 musical-fidelity pulseaudio[3173]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 07 13:21:28 musical-fidelity pulseaudio[3173]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist
Jul 07 13:21:28 musical-fidelity bluetoothd[695]: Endpoint registered: sender=:1.46 path=/MediaEndpoint/A2DPSource
Jul 07 13:21:28 musical-fidelity bluetoothd[695]: Endpoint registered: sender=:1.46 path=/MediaEndpoint/A2DPSink
Jul 07 13:21:28 musical-fidelity systemd[1]: Stopping RAAT DAEMON...
Jul 07 13:21:28 musical-fidelity systemd[1]: Starting RAAT DAEMON...
Jul 07 13:21:28 musical-fidelity systemd[1]: Started RAAT DAEMON.
Jul 07 13:21:28 musical-fidelity sudo[3176]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:28 musical-fidelity volumio[2843]: error: updateQueue error: null
Jul 07 13:21:28 musical-fidelity volumio[2843]: error: Failed LSINFO: Error: [50@0] {} No such directory
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 07 13:21:28 musical-fidelity volumio[2843]: No protocol specified
Jul 07 13:21:28 musical-fidelity volumio[2843]: xcb_connection_has_error() returned true
Jul 07 13:21:28 musical-fidelity volumio[2843]: error: Failed to fix hosts file for Spotify: Error: EACCES: permission denied, open '/etc/hosts'
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreStateMachine::setRepeat false single undefined
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreStateMachine::pushState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreStateMachine::setRandom null
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreStateMachine::pushState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:28 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:28 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:28 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:28 musical-fidelity volumio[2843]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:28 musical-fidelity volumio[2843]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:28 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:28 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:28 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1720358488 101
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: Raat Daemon started successfully
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: VolumeController:: Volume=undefined Mute =false
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreStateMachine::pushState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:28 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:29 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:29 musical-fidelity volumio[2843]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: Executing endpoint restartRAATSocket
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jul 07 13:21:29 musical-fidelity sudo[3209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 07 13:21:29 musical-fidelity sudo[3209]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:29 musical-fidelity systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 07 13:21:29 musical-fidelity sudo[3209]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: Updating push state because input changed
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumiosetSourceActivempd
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:29 musical-fidelity volumio[2843]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:29 musical-fidelity volumio[2843]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: Upmpdcli Daemon Started
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 07 13:21:29 musical-fidelity volumio[2843]: Discovery: adding 35083494-0616-445b-90e6-c13a91a1ac91
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: mDNS: Found device musical-fidelity
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:29 musical-fidelity volumio[2843]: Discovery: this is already registered, 35083494-0616-445b-90e6-c13a91a1ac91
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: mDNS: Found device musical-fidelity
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetQueue
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreStateMachine::getQueue
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CorePlayQueue::getQueue
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: Listing playlists
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetQueue
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreStateMachine::getQueue
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CorePlayQueue::getQueue
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: Listing playlists
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 07 13:21:29 musical-fidelity volumio[2843]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 07 13:21:30 musical-fidelity volumio-streaming-daemon[3022]: Checking variant in static cache
Jul 07 13:21:30 musical-fidelity volumio[2843]: info: Fetching Streaming Services browse cache
Jul 07 13:21:30 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo
Jul 07 13:21:30 musical-fidelity volumio[2843]: info: Setting Additional System Software info: Hardware Firmware Version: 117 Hardware Revision: 1
Jul 07 13:21:30 musical-fidelity volumio[2843]: info: Access Token successfully retrieved
Jul 07 13:21:31 musical-fidelity volumio[2843]: info: Successfully retrieved User Session From TIDAL
Jul 07 13:21:31 musical-fidelity volumio[2843]: info: Checking Spotify Web API
Jul 07 13:21:31 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 07 13:21:31 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:31 musical-fidelity volumio[2843]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: Successfully retrieved User Subscription From TIDAL
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: Adding TIDAL to Browse Sources
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: [1720358492067] CoreMusicLibrary::Adding element TIDAL
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: Stopping AccessToken refresher cron
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: AccessToken refresher cron started
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:32 musical-fidelity volumio[2843]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:35 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Jul 07 13:21:35 musical-fidelity sudo[3260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Ds
Jul 07 13:21:35 musical-fidelity sudo[3260]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:35 musical-fidelity volumio[2843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 07 13:21:35 musical-fidelity sudo[3260]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:35 musical-fidelity volumio[2843]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 07 13:21:35 musical-fidelity volumio[2843]: { Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/Ds'
Jul 07 13:21:35 musical-fidelity volumio[2843]: at Object.fs.rmdirSync (fs.js:846:18)
Jul 07 13:21:35 musical-fidelity volumio[2843]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12
Jul 07 13:21:35 musical-fidelity volumio[2843]: at ChildProcess.exithandler (child_process.js:267:7)
Jul 07 13:21:35 musical-fidelity volumio[2843]: at emitTwo (events.js:126:13)
Jul 07 13:21:35 musical-fidelity volumio[2843]: at ChildProcess.emit (events.js:214:7)
Jul 07 13:21:35 musical-fidelity volumio[2843]: at maybeClose (internal/child_process.js:925:16)
Jul 07 13:21:35 musical-fidelity volumio[2843]: at Process.ChildProcess._handle.onexit (internal/child_process.js:209:5)
Jul 07 13:21:35 musical-fidelity volumio[2843]: errno: -16,
Jul 07 13:21:35 musical-fidelity volumio[2843]: code: 'EBUSY',
Jul 07 13:21:35 musical-fidelity volumio[2843]: syscall: 'rmdir',
Jul 07 13:21:35 musical-fidelity volumio[2843]: path: '/mnt/NAS/Ds' }
Jul 07 13:21:35 musical-fidelity volumio[2843]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 07 13:21:36 musical-fidelity sudo[3282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-07 13:20
Jul 07 13:21:36 musical-fidelity sudo[3282]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:36 musical-fidelity sudo[3282]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:36 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:36] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jul 07 13:21:36 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:36] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jul 07 13:21:36 musical-fidelity systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Jul 07 13:21:36 musical-fidelity bluetoothd[695]: Endpoint unregistered: sender=:1.46 path=/MediaEndpoint/A2DPSource
Jul 07 13:21:36 musical-fidelity bluetoothd[695]: Endpoint unregistered: sender=:1.46 path=/MediaEndpoint/A2DPSink
Jul 07 13:21:36 musical-fidelity systemd[1]: Unit volumio.service entered failed state.
Jul 07 13:21:36 musical-fidelity systemd[1]: Starting dynamicswap service...
Jul 07 13:21:36 musical-fidelity systemd[1]: Started dynamicswap service.
Jul 07 13:21:37 musical-fidelity systemd[1]: volumio.service holdoff time over, scheduling restart.
Jul 07 13:21:37 musical-fidelity systemd[1]: Starting dynamicswap service...
Jul 07 13:21:37 musical-fidelity systemd[1]: Started dynamicswap service.
Jul 07 13:21:37 musical-fidelity systemd[1]: Stopping Volumio Backend Module...
Jul 07 13:21:37 musical-fidelity systemd[1]: Starting Volumio Backend Module...
Jul 07 13:21:37 musical-fidelity systemd[1]: Started Volumio Backend Module.
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: -------------------------------------------
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: ----- Volumio2 ----
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: -------------------------------------------
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: ----- System startup ----
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: -------------------------------------------
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Plugin folders cleanup
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Scanning into folder /volumio/app/plugins/
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Scanning category audio_interface
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Scanning category miscellanea
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Scanning category music_service
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Scanning category plugins.json
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Scanning category system_controller
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Scanning category user_interface
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Scanning into folder /data/plugins/
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Plugin folders cleanup completed
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: -------------------------------------------
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: ----- Core plugins startup ----
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: -------------------------------------------
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Loading plugins from folder /volumio/app/plugins/
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Adding plugin upnp to MyMusic Plugins
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Adding plugin metavolumio to MyMusic Plugins
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Adding plugin cd_controller to MyMusic Plugins
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Adding plugin raat to MyMusic Plugins
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Loading plugins from folder /data/plugins/
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Loading plugin "system"...
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Applying required configuration parameters for plugin system
Jul 07 13:21:39 musical-fidelity volumio[3307]: info: Loading plugin "appearance"...
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "network"...
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Refreshing Cached IP Addresses
Jul 07 13:21:41 musical-fidelity sudo[3348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "services"...
Jul 07 13:21:41 musical-fidelity sudo[3348]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "alsa_controller"...
Jul 07 13:21:41 musical-fidelity sudo[3348]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:41 musical-fidelity sudo[3352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 07 13:21:41 musical-fidelity sudo[3352]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:41 musical-fidelity sudo[3352]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Applying required configuration parameters for plugin alsa_controller
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "wizard"...
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "volumio_command_line_client"...
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "upnp"...
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: [1720358501356] Starting Upmpd Daemon
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "my_music"...
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "mpd"...
Jul 07 13:21:41 musical-fidelity volumio[3307]: info: Loading plugin "upnp_browser"...
Jul 07 13:21:41 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:41] [connect] Successful connection
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "networkfs"...
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 1 ,retrying in 5 seconds
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "bluetooth"...
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: [1720358502430] Starting BluetoothController
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "multiroom"...
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "alarm-clock"...
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "metavolumio"...
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "airplay_emulation"...
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Starting Shairport Sync
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "cd_controller"...
Jul 07 13:21:42 musical-fidelity sudo[3381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync
Jul 07 13:21:42 musical-fidelity sudo[3381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Plugin last_100 is not enabled
Jul 07 13:21:42 musical-fidelity systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "raat"...
Jul 07 13:21:42 musical-fidelity sudo[3381]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: RAAT Plugin loaded
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Adding restartRAATSocket REST API Endpoint
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "streaming_services"...
Jul 07 13:21:42 musical-fidelity volumio[3307]: info: Loading plugin "webradio"...
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Loading plugin "i2s_dacs"...
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: I2S DAC not set, start Auto-detection
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Loading plugin "volumiodiscovery"...
Jul 07 13:21:43 musical-fidelity volumio[3307]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 07 13:21:43 musical-fidelity node[3307]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 07 13:21:43 musical-fidelity node[3307]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 07 13:21:43 musical-fidelity node[3307]: *** WARNING *** For more information see
Jul 07 13:21:43 musical-fidelity node[3307]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 07 13:21:43 musical-fidelity node[3307]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 07 13:21:43 musical-fidelity node[3307]: *** WARNING *** For more information see
Jul 07 13:21:43 musical-fidelity volumio[3307]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 07 13:21:43 musical-fidelity volumio[3307]: *** WARNING *** For more information see
Jul 07 13:21:43 musical-fidelity volumio[3307]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 07 13:21:43 musical-fidelity volumio[3307]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 07 13:21:43 musical-fidelity volumio[3307]: *** WARNING *** For more information see
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 07 13:21:43 musical-fidelity volumio[3307]: Discovery: StartAdv! undefined
Jul 07 13:21:43 musical-fidelity volumio[3307]: Discovery: Started advertising... musical-fidelity - undefined
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Plugin outputs is not enabled
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Loading plugin "albumart"...
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Plugin example_plugin is not enabled
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Loading plugin "hi_res_audio"...
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Applying required configuration parameters for plugin hi_res_audio
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Loading plugin "inputs"...
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Adding inputs REST Endpoints
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/inputs
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Scanning Audio Inputs
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Checking against Known Cards name
Jul 07 13:21:43 musical-fidelity volumio[3307]: info: Loading plugin "qobuz"...
Jul 07 13:21:43 musical-fidelity volumio[3307]: Forking 3 albumart workers
Jul 07 13:21:44 musical-fidelity volumio[3307]: Starting albumart workers
Jul 07 13:21:44 musical-fidelity volumio[3307]: Starting albumart workers
Jul 07 13:21:44 musical-fidelity volumio[3307]: Starting albumart workers
Jul 07 13:21:45 musical-fidelity volumio[3307]: info: Loading plugin "spop"...
Jul 07 13:21:45 musical-fidelity volumio[3307]: info: Loading plugin "tidal"...
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Loading plugin "gpios"...
Jul 07 13:21:47 musical-fidelity volumio[3307]: error: ATTENTION!!!: Plugin gpios does not return adequate promise from onVolumioStart: please update!
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Loading plugin "updater_comm"...
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Plugin mpdemulation is not enabled
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Loading plugin "rest_api"...
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Loading plugin "websocket"...
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: ___________ START PLUGINS ___________
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Adding METAVOLUMIO REST API Endpoints
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: [1720358507597] CoreMusicLibrary::Adding element Shairport-Sync
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:47 musical-fidelity sudo[3461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name musical-fidelity
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Preparing CD Folders
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Adding CD REST API Endpoints
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Detecting CD presence with Flag file
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Starting RAAT Plugin
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Additional UI Settings Added for plugin music_service/raat
Jul 07 13:21:47 musical-fidelity sudo[3461]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:47 musical-fidelity sudo[3461]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Not Reporting Auto name since its the default one
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Streaming services startup
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Starting Streaming Daemon
Jul 07 13:21:47 musical-fidelity sudo[3474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 07 13:21:47 musical-fidelity sudo[3474]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:47 musical-fidelity systemd[1]: Stopping Volumio Streaming Daemon...
Jul 07 13:21:47 musical-fidelity systemd[1]: Starting Volumio Streaming Daemon...
Jul 07 13:21:47 musical-fidelity systemd[1]: Started Volumio Streaming Daemon.
Jul 07 13:21:47 musical-fidelity sudo[3474]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: [1720358507745] CoreMusicLibrary::Adding element Webradio
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:47 musical-fidelity volumio-streaming-daemon[3487]: ############################
Jul 07 13:21:47 musical-fidelity volumio-streaming-daemon[3487]: # Volumio Streaming Daemon #
Jul 07 13:21:47 musical-fidelity volumio-streaming-daemon[3487]: # Running on port 7777 #
Jul 07 13:21:47 musical-fidelity volumio-streaming-daemon[3487]: ############################
Jul 07 13:21:47 musical-fidelity volumio-streaming-daemon[3487]: Checking variant in static cache
Jul 07 13:21:47 musical-fidelity volumio-streaming-daemon[3487]: Enabled services:
Jul 07 13:21:47 musical-fidelity volumio-streaming-daemon[3487]: 1) tidal
Jul 07 13:21:47 musical-fidelity volumio-streaming-daemon[3487]: 2) qobuz
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 07 13:21:47 musical-fidelity volumio[3307]: error: Hi Res Audio Failed Login: Missing Login Data
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 07 13:21:47 musical-fidelity volumio[3307]: [SpotifyConnect] Creating VLS config file
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: [SpotifyConnect] Starting metadata listener
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Refreshing TIDAL token
Jul 07 13:21:47 musical-fidelity sudo[3498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service
Jul 07 13:21:47 musical-fidelity sudo[3498]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:47 musical-fidelity systemd[1]: Started Volspotconnect2 Daemon.
Jul 07 13:21:47 musical-fidelity volumio[3307]: error: Plugin gpios does not return adequate promise from onStart: please update!
Jul 07 13:21:47 musical-fidelity sudo[3498]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: Loading i18n strings for locale zh
Jul 07 13:21:47 musical-fidelity volumio[3307]: Updating browse sources language
Jul 07 13:21:47 musical-fidelity volumio[3307]: Cannot find translation for sourceBluetooth
Jul 07 13:21:47 musical-fidelity volumio[3307]: Cannot find translation for sourceUSB/PC
Jul 07 13:21:47 musical-fidelity volumio[3307]: Cannot find translation for sourceShairport-Sync
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::initPlayerControls
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: BOOT COMPLETED
Jul 07 13:21:47 musical-fidelity volumio[3307]: [Metrics] CommandRouter: 8s 980.80ms
Jul 07 13:21:47 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 13:21:53 musical-fidelity volumio[3307]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: CoreCommandRouter::Close All Modals sent
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: CoreCommandRouter::Close All Modals sent
Jul 07 13:21:53 musical-fidelity volumio[3307]: Express server listening on port 3000
Jul 07 13:21:53 musical-fidelity volumio[3307]: [Metrics] WebUI: 14s 804.72ms
Jul 07 13:21:53 musical-fidelity volumio[3307]: Volumio Calling Home
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: CoreStateMachine::resetVolumioState
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: CoreStateMachine::getcurrentVolume
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioRetrievevolume
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: Stopping AccessToken refresher cron for QOBUZ
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: AccessToken refresher cron started for QOBUZ
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 2 ,retrying in 5 seconds
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 07 13:21:53 musical-fidelity sudo[3541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Jul 07 13:21:53 musical-fidelity sudo[3541]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:53 musical-fidelity sudo[3541]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:53 musical-fidelity sudo[3551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 07 13:21:53 musical-fidelity sudo[3551]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:53 musical-fidelity sudo[3551]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:53 musical-fidelity sudo[3554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 07 13:21:53 musical-fidelity sudo[3554]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:53 musical-fidelity sudo[3554]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:53 musical-fidelity volumio[3307]: info: Serial port opened successfully
Jul 07 13:21:53 musical-fidelity sudo[3581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart leddaemon.service
Jul 07 13:21:53 musical-fidelity sudo[3581]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:53 musical-fidelity systemd[1]: Stopping LED Daemon Service...
Jul 07 13:21:53 musical-fidelity systemd[1]: Starting LED Daemon Service...
Jul 07 13:21:53 musical-fidelity systemd[1]: Started LED Daemon Service.
Jul 07 13:21:53 musical-fidelity sudo[3581]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:53 musical-fidelity led-daemon[3587]: Starting Network LED Daemon
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: Setting Device type: Raspberry PI
Jul 07 13:21:54 musical-fidelity volumio[3307]: [SpotifyConnect] Vollibrespot Daemon service started!
Jul 07 13:21:54 musical-fidelity volumio[3307]: [Metrics] SpotifyConnect: 6s 223.00ms
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: Bluetooth name changed to musical-fidelity
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: Shairport-Sync Stopped
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: MPD running with PID747
Jul 07 13:21:54 musical-fidelity volumio[3307]: ,establishing connection
Jul 07 13:21:54 musical-fidelity sudo[3598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Jul 07 13:21:54 musical-fidelity sudo[3598]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:54 musical-fidelity sudo[3598]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: VolumeController:: Volume=100 Mute =false
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreStateMachine::updateTrackBlock
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrackBlock
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioRetrievevolume
Jul 07 13:21:54 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:54] [connect] Successful connection
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: Volumio called home
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 07 13:21:54 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:54 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:54 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:54 musical-fidelity sudo[3608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Jul 07 13:21:54 musical-fidelity sudo[3608]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:54 musical-fidelity sudo[3608]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:54 musical-fidelity volumio[3307]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified
Jul 07 13:21:54 musical-fidelity volumio[3307]: xcb_connection_has_error() returned true
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1
Jul 07 13:21:54 musical-fidelity volumio[3307]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Jul 07 13:21:54 musical-fidelity volumio[3307]: No protocol specified
Jul 07 13:21:54 musical-fidelity volumio[3307]: xcb_connection_has_error() returned true
Jul 07 13:21:54 musical-fidelity pulseaudio[3620]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 07 13:21:54 musical-fidelity pulseaudio[3620]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 07 13:21:54 musical-fidelity pulseaudio[3620]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist
Jul 07 13:21:54 musical-fidelity bluetoothd[695]: Endpoint registered: sender=:1.56 path=/MediaEndpoint/A2DPSource
Jul 07 13:21:54 musical-fidelity bluetoothd[695]: Endpoint registered: sender=:1.56 path=/MediaEndpoint/A2DPSink
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: Reloading queue from file
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: Received Push USB{"activeRoute":"0","powerShutdown":"0"}
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: inputs , setPCInputReturn
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus
Jul 07 13:21:54 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: inputs , disablePCInput
Jul 07 13:21:54 musical-fidelity sudo[3624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Jul 07 13:21:54 musical-fidelity sudo[3624]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:54 musical-fidelity systemd[1]: Stopping RAAT DAEMON...
Jul 07 13:21:54 musical-fidelity systemd[1]: Starting RAAT DAEMON...
Jul 07 13:21:54 musical-fidelity systemd[1]: Started RAAT DAEMON.
Jul 07 13:21:54 musical-fidelity sudo[3624]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:54 musical-fidelity volumio[3307]: error: updateQueue error: null
Jul 07 13:21:54 musical-fidelity volumio[3307]: error: Failed LSINFO: Error: [50@0] {} No such directory
Jul 07 13:21:55 musical-fidelity volumio-remote-updater[707]: [2024-07-07 13:21:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1720358514 101
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 07 13:21:55 musical-fidelity volumio[3307]: No protocol specified
Jul 07 13:21:55 musical-fidelity volumio[3307]: xcb_connection_has_error() returned true
Jul 07 13:21:55 musical-fidelity volumio[3307]: error: Failed to fix hosts file for Spotify: Error: EACCES: permission denied, open '/etc/hosts'
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreStateMachine::setRepeat false single undefined
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreStateMachine::setRandom null
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:55 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:55 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:55 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:55 musical-fidelity volumio[3307]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:55 musical-fidelity volumio[3307]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:55 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:55 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: Raat Daemon started successfully
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: VolumeController:: Volume=undefined Mute =false
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: Executing endpoint restartRAATSocket
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jul 07 13:21:55 musical-fidelity volumio[3307]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 07 13:21:55 musical-fidelity sudo[3657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 07 13:21:55 musical-fidelity sudo[3657]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:55 musical-fidelity systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 07 13:21:55 musical-fidelity sudo[3657]: pam_unix(sudo:session): session closed for user root
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: Updating push state because input changed
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumiosetSourceActivempd
Jul 07 13:21:55 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:56 musical-fidelity volumio[3307]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:56 musical-fidelity volumio[3307]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: Upmpdcli Daemon Started
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetQueue
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreStateMachine::getQueue
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CorePlayQueue::getQueue
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: Listing playlists
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 07 13:21:56 musical-fidelity volumio[3307]: Discovery: adding 35083494-0616-445b-90e6-c13a91a1ac91
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: mDNS: Found device musical-fidelity
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:56 musical-fidelity volumio[3307]: Discovery: this is already registered, 35083494-0616-445b-90e6-c13a91a1ac91
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: mDNS: Found device musical-fidelity
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetState
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioGetQueue
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreStateMachine::getQueue
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CorePlayQueue::getQueue
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: Listing playlists
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 07 13:21:56 musical-fidelity volumio-streaming-daemon[3487]: Checking variant in static cache
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: Fetching Streaming Services browse cache
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo
Jul 07 13:21:56 musical-fidelity volumio[3307]: info: Setting Additional System Software info: Hardware Firmware Version: 117 Hardware Revision: 1
Jul 07 13:21:57 musical-fidelity volumio[3307]: info: Access Token successfully retrieved
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Checking Spotify Web API
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Successfully retrieved User Session From TIDAL
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 3 ,retrying in 5 seconds
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Successfully retrieved User Subscription From TIDAL
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Adding TIDAL to Browse Sources
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: [1720358518860] CoreMusicLibrary::Adding element TIDAL
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: Stopping AccessToken refresher cron
Jul 07 13:21:58 musical-fidelity volumio[3307]: info: AccessToken refresher cron started
Jul 07 13:21:59 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 07 13:22:03 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 4 ,retrying in 5 seconds
Jul 07 13:22:03 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 4 ,retrying in 5 seconds
Jul 07 13:22:03 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 4 ,retrying in 5 seconds
Jul 07 13:22:03 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 4 ,retrying in 5 seconds
Jul 07 13:22:03 musical-fidelity volumio[3307]: info: Cannot mount NAS Ds at system boot, trial number 4 ,retrying in 5 seconds
Jul 07 13:22:03 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 07 13:22:04 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Jul 07 13:22:04 musical-fidelity sudo[3722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Ds
Jul 07 13:22:04 musical-fidelity sudo[3722]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:22:04 musical-fidelity sudo[3722]: pam_unix(sudo:session): session closed for user root
Jul 07 13:22:04 musical-fidelity volumio[3307]: info: Share Ds successfully unmounted
Jul 07 13:22:05 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 13:22:07 musical-fidelity volumio[3307]: info:
Jul 07 13:22:07 musical-fidelity volumio[3307]: ---------------------------- MPD announces state update: update
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ControllerMpd::getState
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: sendMpdCommand status took 8 milliseconds
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: sendMpdCommand status took 4 milliseconds
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::parseState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: Command Router : Notfying DB Updatetrue
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::parseState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ControllerMpd::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::servicePushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: CURRENT POSITION 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::syncState stateService stop
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::syncState currentStatus stop
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: No code
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ------------------------------ 134ms
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: [1720358527795] Database update started
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: MPD Database updated - AlbumList cache refreshed
Jul 07 13:22:07 musical-fidelity volumio[3307]: info:
Jul 07 13:22:07 musical-fidelity volumio[3307]: ---------------------------- MPD announces state update: database
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 13:22:07 musical-fidelity volumio[3307]: info:
Jul 07 13:22:07 musical-fidelity volumio[3307]: ---------------------------- MPD announces state update: update
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ControllerMpd::getState
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ControllerMpd::getState
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::sendMpdCommand status
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: sendMpdCommand status took 20 milliseconds
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: sendMpdCommand status took 19 milliseconds
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: sendMpdCommand status took 18 milliseconds
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::parseState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: Command Router : Notfying DB Updatefalse
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::Close All Modals sent
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::parseState
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: ControllerMpd::parseState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ControllerMpd::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::servicePushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: 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}
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: CURRENT POSITION 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::syncState stateService stop
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::syncState currentStatus stop
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: No code
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ControllerMpd::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::servicePushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: 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}
Jul 07 13:22:07 musical-fidelity volumio[3307]: verbose: CURRENT POSITION 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::syncState stateService stop
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::syncState currentStatus stop
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: No code
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreStateMachine::pushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CorePlayQueue::getTrack 0
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::volumioPushState
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ------------------------------ 108ms
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: ------------------------------ 108ms
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:07 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:08 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:08 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:08 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:08 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:08 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:08 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:08 musical-fidelity volumio[3307]: info: Updating RAAT Signal Path
Jul 07 13:22:08 musical-fidelity volumio[3307]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 07 13:22:08 musical-fidelity volumio[3307]: TypeError: Cannot read property 'replace' of undefined
Jul 07 13:22:08 musical-fidelity volumio[3307]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:198:28)
Jul 07 13:22:08 musical-fidelity volumio[3307]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:251:20)
Jul 07 13:22:08 musical-fidelity volumio[3307]: at ontimeout (timers.js:482:11)
Jul 07 13:22:08 musical-fidelity volumio[3307]: at tryOnTimeout (timers.js:317:5)
Jul 07 13:22:08 musical-fidelity volumio[3307]: at Timer.listOnTimeout (timers.js:277:5)
Jul 07 13:22:08 musical-fidelity sudo[3780]: 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.3.30/Music /mnt/NAS/Ds
Jul 07 13:22:08 musical-fidelity volumio[3307]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 07 13:22:08 musical-fidelity sudo[3780]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 07 13:22:08 musical-fidelity sudo[3780]: pam_unix(sudo:session): session closed for user root
Jul 07 13:22:09 musical-fidelity sudo[3803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-07 13:21
Jul 07 13:22:09 musical-fidelity sudo[3803]: 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="6d9442f761618503268d0366db805a252514dec1"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="mf"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022"
VOLUMIO_VERSION="1.079"
VOLUMIO_HARDWARE="pi"
VOLUMIO_VENDOR="Musical Fidelity"
VOLUMIO_MODEL="MX-Stream"
VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream"
VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"