-- Logs begin at Thu 2019-02-14 05:12:00 EST, end at Mon 2024-11-25 15:40:15 EST. --
Nov 25 15:40:00 volumio systemd-timedated[1127]: Changed local time to Mon Nov 25 20:40:00 2024
Nov 25 15:40:00 volumio sudo[1125]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:00 volumio volumio-time-update[611]: volumio-time-update-util: System time updated successfully.
Nov 25 15:40:00 volumio systemd[1]: Starting Daily apt download activities...
Nov 25 15:40:00 volumio systemd[1]: Started Volumio Time Update Utility.
Nov 25 15:40:00 volumio systemd[1]: Reached target Multi-User System.
Nov 25 15:40:00 volumio systemd[1]: Reached target Graphical Interface.
Nov 25 15:40:00 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Nov 25 15:40:00 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Nov 25 15:40:00 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Nov 25 15:40:01 volumio volumio[922]: info: File /data/configuration/plugins.json does not exist. Copying from Volumio
Nov 25 15:40:01 volumio volumio[922]: info: MYVOLUMIO Environment detected
Nov 25 15:40:01 volumio systemd[1]: apt-daily.service: Succeeded.
Nov 25 15:40:01 volumio systemd[1]: Started Daily apt download activities.
Nov 25 15:40:01 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Nov 25 15:40:01 volumio volumio[922]: info: Plugin folders cleanup
Nov 25 15:40:01 volumio volumio[922]: info: Scanning into folder /volumio/app/plugins/
Nov 25 15:40:01 volumio volumio[922]: info: Scanning category audio_interface
Nov 25 15:40:01 volumio volumio[922]: info: Scanning category miscellanea
Nov 25 15:40:01 volumio volumio[922]: info: Scanning category music_service
Nov 25 15:40:01 volumio volumio[922]: info: Scanning category plugins.json
Nov 25 15:40:01 volumio volumio[922]: info: Scanning category system_controller
Nov 25 15:40:01 volumio volumio[922]: info: Scanning category user_interface
Nov 25 15:40:01 volumio volumio[922]: info: Scanning into folder /data/plugins/
Nov 25 15:40:01 volumio volumio[922]: info: Plugin folders cleanup completed
Nov 25 15:40:01 volumio volumio[922]: info: -------------------------------------------
Nov 25 15:40:01 volumio volumio[922]: info: ----- Core plugins startup ----
Nov 25 15:40:01 volumio volumio[922]: info: -------------------------------------------
Nov 25 15:40:01 volumio volumio[922]: info: Loading plugins from folder /volumio/app/plugins/
Nov 25 15:40:01 volumio volumio[922]: info: Adding plugin upnp to MyMusic Plugins
Nov 25 15:40:01 volumio volumio[922]: info: Adding plugin airplay_emulation to MyMusic Plugins
Nov 25 15:40:01 volumio volumio[922]: info: Adding plugin upnp_browser to MyMusic Plugins
Nov 25 15:40:01 volumio volumio[922]: info: Loading plugins from folder /data/plugins/
Nov 25 15:40:01 volumio volumio[922]: info: Loading plugin "system"...
Nov 25 15:40:01 volumio volumio[922]: info: No id defined. Creating one
Nov 25 15:40:01 volumio volumio[922]: info: Loading plugin "appearance"...
Nov 25 15:40:01 volumio volumio-remote-updater[608]: [2024-11-25 20:40:01] [connect] Successful connection
Nov 25 15:40:02 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
Nov 25 15:40:02 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Nov 25 15:40:02 volumio systemd[1]: Startup finished in 1min 2.297s (kernel) + 21.998s (userspace) = 1min 24.295s.
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "network"...
Nov 25 15:40:03 volumio volumio[922]: info: Refreshing Cached IP Addresses
Nov 25 15:40:03 volumio sudo[1245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 25 15:40:03 volumio sudo[1245]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:03 volumio sudo[1245]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:03 volumio sudo[1247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 25 15:40:03 volumio sudo[1247]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:03 volumio sudo[1247]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "services"...
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "alsa_controller"...
Nov 25 15:40:03 volumio sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Nov 25 15:40:03 volumio sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:03 volumio volumio[922]: warn: The ALSA output card is not set, defaulting to card [object Object]
Nov 25 15:40:03 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Nov 25 15:40:03 volumio volumio[922]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out
Nov 25 15:40:03 volumio volumio[922]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Nov 25 15:40:03 volumio volumio[922]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Nov 25 15:40:03 volumio volumio[922]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Nov 25 15:40:03 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "wizard"...
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "networkfs"...
Nov 25 15:40:03 volumio volumio[922]: info: Starting Udev Watcher for removable devices
Nov 25 15:40:03 volumio volumio[922]: info: Ignoring mount for partition: boot
Nov 25 15:40:03 volumio volumio[922]: info: Ignoring mount for partition: volumio
Nov 25 15:40:03 volumio volumio[922]: info: Ignoring mount for partition: volumio_data
Nov 25 15:40:03 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "volumio_command_line_client"...
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "upnp"...
Nov 25 15:40:03 volumio volumio[922]: info: [1732567203819] Starting Upmpd Daemon
Nov 25 15:40:03 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "my_music"...
Nov 25 15:40:03 volumio volumio[922]: info: Loading plugin "mpd"...
Nov 25 15:40:04 volumio sudo[1256]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:04 volumio volumio[922]: info: Loading plugin "upnp_browser"...
Nov 25 15:40:04 volumio volumio[922]: info: Loading plugin "alarm-clock"...
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "airplay_emulation"...
Nov 25 15:40:05 volumio volumio[922]: info: Starting Shairport Sync
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "last_100"...
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "webradio"...
Nov 25 15:40:05 volumio firststart.sh[923]: Creating SSH2 RSA key; this may take some time ...
Nov 25 15:40:05 volumio firststart.sh[923]: 2048 SHA256:hUCIh7UWM4FSVM1Ej/izgy8Aq1oRC4nMaV4VoZjSnHk root@volumio (RSA)
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "i2s_dacs"...
Nov 25 15:40:05 volumio volumio[922]: info: I2S DAC not set, start Auto-detection
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "volumiodiscovery"...
Nov 25 15:40:05 volumio volumio[922]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 25 15:40:05 volumio volumio[922]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 25 15:40:05 volumio volumio[922]: *** WARNING *** For more information see
Nov 25 15:40:05 volumio volumio[922]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 25 15:40:05 volumio volumio[922]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 25 15:40:05 volumio volumio[922]: *** WARNING *** For more information see
Nov 25 15:40:05 volumio node[922]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 25 15:40:05 volumio node[922]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 25 15:40:05 volumio node[922]: *** WARNING *** For more information see
Nov 25 15:40:05 volumio node[922]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 25 15:40:05 volumio node[922]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 25 15:40:05 volumio node[922]: *** WARNING *** For more information see
Nov 25 15:40:05 volumio volumio[922]: info: Discovery: Started advertising with name: Volumio
Nov 25 15:40:05 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "outputs"...
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "albumart"...
Nov 25 15:40:05 volumio volumio[922]: info: Plugin example_plugin is not enabled
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "inputs"...
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "updater_comm"...
Nov 25 15:40:05 volumio volumio[922]: info: Plugin mpdemulation is not enabled
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "rest_api"...
Nov 25 15:40:05 volumio volumio[922]: info: Loading plugin "websocket"...
Nov 25 15:40:05 volumio volumio[922]: info: Starting Socket.io Server version 2.3.0
Nov 25 15:40:05 volumio volumio[922]: info: Loading i18n strings for locale en
Nov 25 15:40:05 volumio volumio[922]: Updating browse sources language
Nov 25 15:40:05 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 25 15:40:05 volumio volumio[922]: Forking 3 albumart workers
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::initPlayerControls
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: Express server listening on port 3000
Nov 25 15:40:06 volumio volumio[922]: [Metrics] WebUI: 7s 672.73ms
Nov 25 15:40:06 volumio volumio[922]: info: CoreStateMachine::resetVolumioState
Nov 25 15:40:06 volumio volumio[922]: info: CoreStateMachine::getcurrentVolume
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::volumioRetrievevolume
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 25 15:40:06 volumio volumio[922]: info: Cannot read play queue from file
Nov 25 15:40:06 volumio volumio[922]: info: Volumio Network Manager: Network status updated: 1
Nov 25 15:40:06 volumio volumio-remote-updater[608]: [2024-11-25 20:40:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732567201 101
Nov 25 15:40:06 volumio volumio[922]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 25 15:40:06 volumio volumio[922]: info: Discovery: Getting this device information
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 25 15:40:06 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 25 15:40:06 volumio volumio[922]: info: VolumeController:: Volume=86 Mute =false
Nov 25 15:40:06 volumio volumio[922]: info: CoreStateMachine::pushState
Nov 25 15:40:06 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 25 15:40:06 volumio volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 25 15:40:06 volumio volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 25 15:40:06 volumio volumio[922]: info: CoreCommandRouter::volumioRetrievevolume
Nov 25 15:40:06 volumio firststart.sh[923]: Creating SSH2 DSA key; this may take some time ...
Nov 25 15:40:06 volumio volumio[922]: info: Setting Device type: Raspberry PI
Nov 25 15:40:06 volumio volumio[922]: Starting albumart workers
Nov 25 15:40:06 volumio firststart.sh[923]: 1024 SHA256:E2ZqaUk0NjwoVCXtbeQLEK6bSA2RdKggFkcHMf6lIjI root@volumio (DSA)
Nov 25 15:40:06 volumio volumio[922]: verbose: New Socket.io Connection to 192.168.1.223:3000 from 192.168.1.228 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2
Nov 25 15:40:06 volumio firststart.sh[923]: Creating SSH2 ECDSA key; this may take some time ...
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 25 15:40:07 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:07 volumio firststart.sh[923]: 256 SHA256:Pv+QWiBzulME2QXvNQD7GqOZqxeRfEcSpeKk0Fd4lAc root@volumio (ECDSA)
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Nov 25 15:40:07 volumio volumio[922]: info: Discovery: adding b54efa3d-0e5f-4f5f-bc77-3bf6c0b895cc
Nov 25 15:40:07 volumio volumio[922]: info: Discovery: Found device Volumio
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 25 15:40:07 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:07 volumio volumio-remote-updater[608]: No test mode
Nov 25 15:40:07 volumio volumio-remote-updater[608]: No alpha test mode
Nov 25 15:40:07 volumio volumio[922]: info: Discovery: this is already registered, b54efa3d-0e5f-4f5f-bc77-3bf6c0b895cc
Nov 25 15:40:07 volumio volumio[922]: info: Discovery: Found device Volumio
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 25 15:40:07 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:07 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:07 volumio volumio[922]: info: VolumeController:: Volume=86 Mute =false
Nov 25 15:40:07 volumio volumio[922]: info: CoreStateMachine::pushState
Nov 25 15:40:07 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 25 15:40:07 volumio volumio[922]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Nov 25 15:40:07 volumio volumio[922]: info: Completed loading Core Plugins
Nov 25 15:40:07 volumio volumio[922]: info: Preparing to generate the ALSA configuration file
Nov 25 15:40:07 volumio volumio[922]: Starting albumart workers
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Nov 25 15:40:07 volumio volumio[922]: info: CoreStateMachine::getcurrentVolume
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::volumioRetrievevolume
Nov 25 15:40:07 volumio volumio[922]: Starting albumart workers
Nov 25 15:40:07 volumio volumio[922]: info: Asound.conf file written
Nov 25 15:40:07 volumio sudo[1352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Nov 25 15:40:07 volumio sudo[1352]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:07 volumio sudo[1352]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:07 volumio volumio[922]: No state is present for card b1
Nov 25 15:40:07 volumio volumio[922]: /usr/share/alsa/init/bcm2835:14: control element not found
Nov 25 15:40:07 volumio volumio[922]: No state is present for card b1
Nov 25 15:40:07 volumio volumio[922]: No state is present for card Headphones
Nov 25 15:40:07 volumio volumio[922]: /usr/share/alsa/init/bcm2835:20: control element not found
Nov 25 15:40:07 volumio volumio[922]: No state is present for card Headphones
Nov 25 15:40:07 volumio volumio[922]: info: Output device has changed, restarting MPD
Nov 25 15:40:07 volumio sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 25 15:40:07 volumio sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:07 volumio volumio[922]: info: Output device has changed, restarting Shairport Sync
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 25 15:40:07 volumio sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 25 15:40:07 volumio sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:07 volumio sudo[1357]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:07 volumio systemd[1]: Stopping Music Player Daemon...
Nov 25 15:40:07 volumio volumio[922]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 25 15:40:07 volumio volumio[922]: info: ___________ START PLUGINS ___________
Nov 25 15:40:07 volumio volumio[922]: info: Setting Hotspot Unique name on first start: Volumio-149BA
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam
Nov 25 15:40:07 volumio volumio[922]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings
Nov 25 15:40:07 volumio volumio[922]: info: CoreCommandRouter::Reload Ui
Nov 25 15:40:07 volumio volumio[922]: info: ControllerMpd::onStart: Initializing MPD
Nov 25 15:40:07 volumio volumio[922]: info: Creating MPD Configuration file
Nov 25 15:40:08 volumio systemd[1]: mpd.service: Succeeded.
Nov 25 15:40:08 volumio systemd[1]: Stopped Music Player Daemon.
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 25 15:40:08 volumio volumio[922]: info: [1732567208096] CoreMusicLibrary::Adding element Media Servers
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 25 15:40:08 volumio sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 25 15:40:08 volumio sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:08 volumio sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 25 15:40:08 volumio sudo[1367]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:08 volumio sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:08 volumio systemd[1]: Starting Music Player Daemon...
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 25 15:40:08 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Nov 25 15:40:08 volumio systemd[1]: mpd.service: Succeeded.
Nov 25 15:40:08 volumio systemd[1]: Stopped Music Player Daemon.
Nov 25 15:40:08 volumio systemd[1]: Starting Music Player Daemon...
Nov 25 15:40:08 volumio volumio[922]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 25 15:40:08 volumio volumio[922]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 25 15:40:08 volumio volumio[922]: info: [1732567208312] CoreMusicLibrary::Adding element Last_100
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 25 15:40:08 volumio volumio[922]: info: [1732567208317] CoreMusicLibrary::Adding element Webradio
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 25 15:40:08 volumio volumio[922]: info: Initializing BBC Radios
Nov 25 15:40:08 volumio sudo[1376]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Nov 25 15:40:08 volumio sudo[1376]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:08 volumio sudo[1376]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 25 15:40:08 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 25 15:40:08 volumio volumio[922]: info: Volumio Calling Home
Nov 25 15:40:09 volumio volumio[922]: info: MPD Permissions set
Nov 25 15:40:09 volumio volumio[922]: info: MPD Permissions set
Nov 25 15:40:09 volumio sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf
Nov 25 15:40:09 volumio sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 25 15:40:09 volumio volumio[922]: info: Discovery: Getting this device information
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 25 15:40:09 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 25 15:40:09 volumio sudo[1415]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:09 volumio volumio[922]: info: Volumio called home
Nov 25 15:40:09 volumio systemd[1]: Reloading.
Nov 25 15:40:09 volumio volumio[922]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Nov 25 15:40:09 volumio volumio[922]: info: Permissions for /etc/hostapd/hostapd.conf
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Nov 25 15:40:09 volumio volumio[922]: info: Discovery: Restarting Advertising due to device name change
Nov 25 15:40:09 volumio volumio[922]: info: VolumeController:: Volume=86 Mute =false
Nov 25 15:40:09 volumio volumio[922]: info: CoreStateMachine::pushState
Nov 25 15:40:09 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 25 15:40:09 volumio volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 25 15:40:09 volumio volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::volumioRetrievevolume
Nov 25 15:40:09 volumio sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
Nov 25 15:40:09 volumio sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 25 15:40:09 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 25 15:40:10 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Nov 25 15:40:10 volumio volumio[922]: info: Starting Shairport Sync
Nov 25 15:40:10 volumio volumio[922]: info: Starting Shairport Sync
Nov 25 15:40:10 volumio volumio[922]: info: Starting Shairport Sync
Nov 25 15:40:10 volumio sudo[1455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 25 15:40:10 volumio sudo[1455]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:10 volumio sudo[1457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 25 15:40:10 volumio sudo[1457]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:10 volumio sudo[1460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 25 15:40:10 volumio sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:10 volumio volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 25 15:40:10 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:10 volumio volumio[922]: info: VolumeController:: Volume=86 Mute =false
Nov 25 15:40:10 volumio volumio[922]: info: CoreStateMachine::pushState
Nov 25 15:40:10 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:10 volumio volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 25 15:40:10 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Nov 25 15:40:10 volumio mpd[1392]: Nov 25 20:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 25 15:40:10 volumio systemd[1]: Started Music Player Daemon.
Nov 25 15:40:10 volumio volumio[922]: info: Discovery: A device disappeared from network
Nov 25 15:40:10 volumio volumio[922]: info: Discovery: Device volumio disappeared from network
Nov 25 15:40:10 volumio sudo[1359]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:10 volumio volumio[922]: info: Discovery: A device disappeared from network
Nov 25 15:40:10 volumio sudo[1370]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:10 volumio volumio[922]: info: Completed starting Core Plugins
Nov 25 15:40:10 volumio volumio[922]: info: -------------------------------------------
Nov 25 15:40:10 volumio volumio[922]: info: ----- MyVolumio plugins startup ----
Nov 25 15:40:10 volumio volumio[922]: info: -------------------------------------------
Nov 25 15:40:10 volumio volumio[922]: info: [MyVolumio PluginManager] Fetching plans data....
Nov 25 15:40:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 25 15:40:10 volumio volumio[922]: error: MPD error: The expression evaluated to a falsy value:
Nov 25 15:40:10 volumio volumio[922]: assert.ok(self.idling)
Nov 25 15:40:10 volumio volumio[922]: error: The expression evaluated to a falsy value:
Nov 25 15:40:10 volumio volumio[922]: assert.ok(self.idling)
Nov 25 15:40:10 volumio volumio[922]: info: MPD running with PID1392
Nov 25 15:40:10 volumio volumio[922]: ,establishing connection
Nov 25 15:40:10 volumio volumio[922]: error: updateQueue error: null
Nov 25 15:40:10 volumio systemd[1]: Starting Wireless Services...
Nov 25 15:40:10 volumio systemd[1]: shairport-sync.service: Succeeded.
Nov 25 15:40:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 25 15:40:10 volumio volumio[922]: error: updateQueue error: null
Nov 25 15:40:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 25 15:40:10 volumio sudo[1460]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:10 volumio volumio[922]: info: Shairport-Sync Started
Nov 25 15:40:10 volumio sudo[1457]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:10 volumio sudo[1455]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:10 volumio firststart.sh[923]: rescue-ssh.target is a disabled or a static unit, not starting it.
Nov 25 15:40:10 volumio volumio[922]: Error adding Membership: Error: addMembership EINVAL
Nov 25 15:40:10 volumio volumio[922]: info: Shairport-Sync Started
Nov 25 15:40:11 volumio firststart.sh[923]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5).
Nov 25 15:40:11 volumio firststart.sh[923]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty).
Nov 25 15:40:11 volumio systemd[1]: Reloading.
Nov 25 15:40:11 volumio wireless.js[1472]: Cleaning previous...
Nov 25 15:40:11 volumio sudo[1504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 25 15:40:11 volumio sudo[1504]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:11 volumio sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 25 15:40:11 volumio sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:11 volumio sudo[1504]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:11 volumio sudo[1503]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:11 volumio volumio[922]: verbose: New Socket.io Connection to 192.168.1.223 from 192.168.1.228 UA: Mozilla/5.0 (Linux; Android 14; SM-F936U Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Nov 25 15:40:11 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Nov 25 15:40:11 volumio volumio[922]: info: Received Get System Info
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 25 15:40:11 volumio volumio[922]: info: Discovery: Getting this device information
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 25 15:40:11 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 25 15:40:11 volumio volumio-remote-updater[608]: No test mode
Nov 25 15:40:11 volumio volumio-remote-updater[608]: No alpha test mode
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Nov 25 15:40:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 25 15:40:12 volumio volumio[922]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Nov 25 15:40:12 volumio sudo[1524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 25 15:40:12 volumio sudo[1524]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:12 volumio sudo[1524]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:12 volumio sudo[1526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 25 15:40:12 volumio sudo[1526]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:12 volumio sudo[1526]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:12 volumio volumio[922]: verbose: New Socket.io Connection to 192.168.1.223 from 192.168.1.38 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Edg/131.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Nov 25 15:40:12 volumio volumio[922]: info: Received Get System Info
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 25 15:40:12 volumio volumio[922]: info: Discovery: Getting this device information
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 25 15:40:12 volumio volumio[922]: info: CorePlayQueue::getTrack 0
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 25 15:40:12 volumio volumio-remote-updater[608]: No test mode
Nov 25 15:40:12 volumio volumio-remote-updater[608]: No alpha test mode
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Nov 25 15:40:12 volumio systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator...
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 25 15:40:12 volumio volumio[922]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Nov 25 15:40:12 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Nov 25 15:40:12 volumio firststart.sh[923]: Enabling SSH for first boot
Nov 25 15:40:12 volumio systemd[1]: Starting OpenBSD Secure Shell server...
Nov 25 15:40:13 volumio sshd[1539]: Server listening on 0.0.0.0 port 22.
Nov 25 15:40:13 volumio sshd[1539]: Server listening on :: port 22.
Nov 25 15:40:13 volumio systemd[1]: Started OpenBSD Secure Shell server.
Nov 25 15:40:13 volumio firststart.sh[923]: Disabling firststart service
Nov 25 15:40:13 volumio firststart.sh[923]: Removed /etc/systemd/system/multi-user.target.wants/firststart.service.
Nov 25 15:40:13 volumio systemd[1]: Reloading.
Nov 25 15:40:13 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Nov 25 15:40:13 volumio volumio[922]: info: Loading i18n strings for locale en
Nov 25 15:40:13 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Nov 25 15:40:13 volumio volumio[922]: info: Setting timezone to America/New_York
Nov 25 15:40:13 volumio sudo[1542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Nov 25 15:40:13 volumio sudo[1542]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio sudo[1542]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime
Nov 25 15:40:13 volumio sudo[1552]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio sudo[1552]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Nov 25 15:40:13 volumio sudo[1561]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio sudo[1561]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York
Nov 25 15:40:13 volumio sudo[1564]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio systemd-timedated[1127]: Failed to set time zone: Permission denied
Nov 25 15:40:13 volumio sudo[1564]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio volumio[922]: Failed to set time zone: Access denied
Nov 25 15:40:13 volumio volumio[922]: info: Could not set timezone, retrying
Nov 25 15:40:13 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Nov 25 15:40:13 volumio volumio[922]: Updating browse sources language
Nov 25 15:40:13 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 25 15:40:13 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Nov 25 15:40:13 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Nov 25 15:40:13 volumio volumio[922]: info: Loading i18n strings for locale en
Nov 25 15:40:13 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Nov 25 15:40:13 volumio volumio[922]: info: Setting timezone to America/New_York
Nov 25 15:40:13 volumio sudo[1581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Nov 25 15:40:13 volumio sudo[1581]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio sudo[1581]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime
Nov 25 15:40:13 volumio sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio sudo[1584]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Nov 25 15:40:13 volumio sudo[1587]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio sudo[1587]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York
Nov 25 15:40:13 volumio sudo[1590]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio sudo[1590]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 25 15:40:13 volumio sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio sudo[1593]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 25 15:40:13 volumio sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio volumio[922]: Updating browse sources language
Nov 25 15:40:13 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 25 15:40:13 volumio sudo[1595]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:13 volumio sudo[1599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Nov 25 15:40:13 volumio sudo[1599]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:13 volumio systemd[1]: hostapd.service: Succeeded.
Nov 25 15:40:13 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator.
Nov 25 15:40:13 volumio firststart.sh[923]: Finalizing
Nov 25 15:40:14 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Nov 25 15:40:14 volumio sudo[1604]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Nov 25 15:40:14 volumio sudo[1604]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:14 volumio avahi-daemon[620]: Withdrawing address record for 192.168.211.1 on wlan0.
Nov 25 15:40:14 volumio avahi-daemon[620]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1.
Nov 25 15:40:14 volumio sudo[1599]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:14 volumio avahi-daemon[620]: Interface wlan0.IPv4 no longer relevant for mDNS.
Nov 25 15:40:14 volumio sudo[1604]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:14 volumio volumio[922]: info: Upmpdcli Daemon Started
Nov 25 15:40:14 volumio sudo[1606]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Nov 25 15:40:14 volumio sudo[1606]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:14 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Nov 25 15:40:14 volumio systemd[1]: firststart.service: Succeeded.
Nov 25 15:40:14 volumio sudo[1606]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:14 volumio sudo[1614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York
Nov 25 15:40:14 volumio sudo[1614]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:14 volumio sudo[1614]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:14 volumio volumio[922]: Terminated
Nov 25 15:40:14 volumio volumio[922]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 25 15:40:14 volumio volumio[922]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'America/New_York'
Nov 25 15:40:14 volumio volumio[922]: Terminated
Nov 25 15:40:14 volumio volumio[922]: at checkExecSyncError (child_process.js:616:11)
Nov 25 15:40:14 volumio volumio[922]: at execSync (child_process.js:652:15)
Nov 25 15:40:14 volumio volumio[922]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9)
Nov 25 15:40:14 volumio volumio[922]: at listOnTimeout (internal/timers.js:554:17)
Nov 25 15:40:14 volumio volumio[922]: at processTimers (internal/timers.js:497:7) {
Nov 25 15:40:14 volumio volumio[922]: status: 143,
Nov 25 15:40:14 volumio volumio[922]: signal: null,
Nov 25 15:40:14 volumio volumio[922]: output: [ null, '', 'Terminated\n' ],
Nov 25 15:40:14 volumio volumio[922]: pid: 1613,
Nov 25 15:40:14 volumio volumio[922]: stdout: '',
Nov 25 15:40:14 volumio volumio[922]: stderr: 'Terminated\n'
Nov 25 15:40:14 volumio volumio[922]: }
Nov 25 15:40:14 volumio volumio[922]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 25 15:40:14 volumio wireless.js[1472]: Stopped aP
Nov 25 15:40:14 volumio volumio[1602]: Generating RSA private key, 4096 bit long modulus (2 primes)
Nov 25 15:40:14 volumio sudo[1633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Nov 25 15:40:14 volumio sudo[1633]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:14 volumio sudo[1633]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:14 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Nov 25 15:40:14 volumio sudo[1640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Nov 25 15:40:14 volumio sudo[1640]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:14 volumio sudo[1640]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:14 volumio sudo[1648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Nov 25 15:40:14 volumio sudo[1648]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:14 volumio sudo[1648]: pam_unix(sudo:session): session closed for user root
Nov 25 15:40:14 volumio sudo[1650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Nov 25 15:40:14 volumio sudo[1650]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:15 volumio sudo[1655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 15:39
Nov 25 15:40:15 volumio sudo[1655]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 25 15:40:15 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Nov 25 15:40:15 volumio sudo[1650]: pam_unix(sudo:session): session closed for user root
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"