-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Tue 2025-07-08 19:50:06 CEST. --
Jul 08 19:49:00 volumio volumio[1116]: info: MYVOLUMIO Environment detected
Jul 08 19:49:00 volumio volumio[1116]: info: Plugin folders cleanup
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning into folder /volumio/app/plugins/
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category audio_interface
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category miscellanea
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category music_service
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category plugins.json
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category system_controller
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category user_interface
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning into folder /data/plugins/
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category audio_interface
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category music_service
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category system_controller
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category system_hardware
Jul 08 19:49:00 volumio volumio[1116]: info: Scanning category user_interface
Jul 08 19:49:00 volumio volumio[1116]: info: Plugin folders cleanup completed
Jul 08 19:49:00 volumio volumio[1116]: info: -------------------------------------------
Jul 08 19:49:00 volumio volumio[1116]: info: ----- Core plugins startup ----
Jul 08 19:49:00 volumio volumio[1116]: info: -------------------------------------------
Jul 08 19:49:00 volumio volumio[1116]: info: Loading plugins from folder /volumio/app/plugins/
Jul 08 19:49:00 volumio volumio[1116]: info: Adding plugin upnp to MyMusic Plugins
Jul 08 19:49:00 volumio volumio[1116]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 08 19:49:00 volumio volumio[1116]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 08 19:49:00 volumio volumio[1116]: info: Loading plugins from folder /data/plugins/
Jul 08 19:49:00 volumio volumio[1116]: info: Loading plugin "system"...
Jul 08 19:49:00 volumio volumio[1116]: info: Loading plugin "ampswitch"...
Jul 08 19:49:00 volumio volumio[1116]: info: Applying required configuration parameters for plugin ampswitch
Jul 08 19:49:00 volumio volumio[1116]: info: Loading plugin "appearance"...
Jul 08 19:49:01 volumio volumio-remote-updater[651]: [2025-07-08 19:49:01] [connect] Successful connection
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "network"...
Jul 08 19:49:01 volumio volumio[1116]: info: Refreshing Cached IP Addresses
Jul 08 19:49:01 volumio sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 08 19:49:01 volumio sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:01 volumio sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 08 19:49:01 volumio sudo[1148]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:01 volumio sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "services"...
Jul 08 19:49:01 volumio sudo[1150]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "alsa_controller"...
Jul 08 19:49:01 volumio sudo[1159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jul 08 19:49:01 volumio sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "wizard"...
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "networkfs"...
Jul 08 19:49:01 volumio volumio[1116]: info: Starting Udev Watcher for removable devices
Jul 08 19:49:01 volumio volumio[1116]: info: Ignoring mount for partition: boot
Jul 08 19:49:01 volumio volumio[1116]: info: Ignoring mount for partition: volumio
Jul 08 19:49:01 volumio volumio[1116]: info: Ignoring mount for partition: volumio_data
Jul 08 19:49:01 volumio volumio[1116]: info: Mounting Device ff908750-8869-49df-8a37-db501cd2d30a
Jul 08 19:49:01 volumio sudo[1179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/ff908750-8869-49df-8a37-db501cd2d30a -o noatime
Jul 08 19:49:01 volumio sudo[1179]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:01 volumio sudo[1179]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:01 volumio kernel: EXT4-fs (sda1): recovery complete
Jul 08 19:49:01 volumio kernel: EXT4-fs (sda1): mounted filesystem ff908750-8869-49df-8a37-db501cd2d30a r/w with ordered data mode. Quota mode: none.
Jul 08 19:49:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "volumio_command_line_client"...
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "upnp"...
Jul 08 19:49:01 volumio volumio[1116]: info: [1751996941917] Starting Upmpd Daemon
Jul 08 19:49:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "my_music"...
Jul 08 19:49:01 volumio volumio[1116]: info: Loading plugin "mpd"...
Jul 08 19:49:02 volumio volumio[1116]: info: Loading plugin "upnp_browser"...
Jul 08 19:49:02 volumio volumio[1116]: info: Loading plugin "alarm-clock"...
Jul 08 19:49:02 volumio volumio[1116]: info: Loading plugin "airplay_emulation"...
Jul 08 19:49:02 volumio volumio[1116]: info: Starting Shairport Sync
Jul 08 19:49:02 volumio volumio[1116]: info: Loading plugin "last_100"...
Jul 08 19:49:02 volumio volumio[1116]: info: Loading plugin "webradio"...
Jul 08 19:49:02 volumio volumio[1116]: info: Loading plugin "i2s_dacs"...
Jul 08 19:49:02 volumio volumio[1116]: info: I2S DAC not set, start Auto-detection
Jul 08 19:49:02 volumio volumio[1116]: info: Loading plugin "volumiodiscovery"...
Jul 08 19:49:02 volumio volumio[1116]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 08 19:49:02 volumio volumio[1116]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 19:49:02 volumio volumio[1116]: *** WARNING *** For more information see
Jul 08 19:49:02 volumio node[1116]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 08 19:49:02 volumio volumio[1116]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 08 19:49:02 volumio volumio[1116]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 19:49:02 volumio volumio[1116]: *** WARNING *** For more information see
Jul 08 19:49:02 volumio node[1116]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 19:49:02 volumio node[1116]: *** WARNING *** For more information see
Jul 08 19:49:02 volumio node[1116]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 08 19:49:02 volumio node[1116]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 08 19:49:02 volumio node[1116]: *** WARNING *** For more information see
Jul 08 19:49:02 volumio volumio[1116]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 08 19:49:02 volumio volumio[1116]: info: Discovery: Started advertising with name: Volumio
Jul 08 19:49:02 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 08 19:49:02 volumio volumio[1116]: info: Loading plugin "spop"...
Jul 08 19:49:03 volumio volumio[1116]: info: Loading plugin "now_playing"...
Jul 08 19:49:05 volumio volumio[1116]: info: Loading plugin "outputs"...
Jul 08 19:49:05 volumio volumio[1116]: info: Loading plugin "albumart"...
Jul 08 19:49:05 volumio volumio[1116]: info: Plugin example_plugin is not enabled
Jul 08 19:49:05 volumio volumio[1116]: info: Loading plugin "inputs"...
Jul 08 19:49:05 volumio volumio[1116]: info: Loading plugin "updater_comm"...
Jul 08 19:49:05 volumio sudo[1159]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:05 volumio volumio[1116]: info: Plugin mpdemulation is not enabled
Jul 08 19:49:05 volumio volumio[1116]: info: Loading plugin "rest_api"...
Jul 08 19:49:05 volumio volumio[1116]: info: Loading plugin "websocket"...
Jul 08 19:49:05 volumio volumio[1116]: info: Starting Socket.io Server version 2.3.0
Jul 08 19:49:05 volumio volumio[1116]: info: Plugin fusiondsp is not enabled
Jul 08 19:49:05 volumio volumio[1116]: info: Plugin mpdoutput is not enabled
Jul 08 19:49:05 volumio volumio[1116]: info: Loading plugin "plexamp"...
Jul 08 19:49:05 volumio volumio[1116]: Forking 3 albumart workers
Jul 08 19:49:05 volumio volumio[1116]: Starting albumart workers
Jul 08 19:49:05 volumio volumio[1116]: Starting albumart workers
Jul 08 19:49:05 volumio volumio[1116]: Starting albumart workers
Jul 08 19:49:06 volumio volumio[1116]: info: Applying required configuration parameters for plugin plexamp
Jul 08 19:49:07 volumio volumio[1116]: info: Loading plugin "podcast"...
Jul 08 19:49:07 volumio volumio[1116]: info: ControllerPodcast::constructor
Jul 08 19:49:07 volumio volumio[1116]: info: Loading plugin "ir_controller"...
Jul 08 19:49:07 volumio volumio[1116]: info: Applying required configuration parameters for plugin ir_controller
Jul 08 19:49:07 volumio volumio[1116]: info: Loading plugin "Systeminfo"...
Jul 08 19:49:07 volumio volumio[1116]: info: Loading plugin "lastfm"...
Jul 08 19:49:08 volumio volumio[1116]: info: Loading plugin "randomizer"...
Jul 08 19:49:08 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Jul 08 19:49:08 volumio volumio[1116]: info: Applying required configuration parameters for plugin randomizer
Jul 08 19:49:08 volumio volumio[1116]: info: Loading plugin "touch_display"...
Jul 08 19:49:08 volumio volumio[1116]: info: Applying required configuration parameters for plugin touch_display
Jul 08 19:49:08 volumio volumio[1116]: info: Loading i18n strings for locale en
Jul 08 19:49:08 volumio volumio[1116]: Updating browse sources language
Jul 08 19:49:08 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::initPlayerControls
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: Express server listening on port 3000
Jul 08 19:49:09 volumio volumio[1116]: [Metrics] WebUI: 10s 149.92ms
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::resetVolumioState
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::getcurrentVolume
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioRetrievevolume
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: Volumio Network Manager: Network status updated: 3
Jul 08 19:49:09 volumio volumio[1116]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Jul 08 19:49:09 volumio volumio[1116]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Jul 08 19:49:09 volumio volumio[1116]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Jul 08 19:49:09 volumio volumio[1116]: info: Reloading queue from file
Jul 08 19:49:09 volumio volumio[1116]: info: VolumeController:: Volume=46 Mute =false
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::pushState
Jul 08 19:49:09 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::updateTrackBlock
Jul 08 19:49:09 volumio volumio[1116]: info: CorePlayQueue::getTrackBlock
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioRetrievevolume
Jul 08 19:49:09 volumio volumio[1116]: info: Setting Device type: Raspberry PI
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::setRepeat false single undefined
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::pushState
Jul 08 19:49:09 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::setRandom false
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::pushState
Jul 08 19:49:09 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState
Jul 08 19:49:09 volumio volumio[1116]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jul 08 19:49:09 volumio volumio[1116]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115
Jul 08 19:49:09 volumio volumio[1116]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jul 08 19:49:09 volumio volumio[1116]: info: VolumeController:: Volume=46 Mute =false
Jul 08 19:49:09 volumio volumio[1116]: info: CoreStateMachine::pushState
Jul 08 19:49:09 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState
Jul 08 19:49:09 volumio volumio[1116]: info: Completed loading Core Plugins
Jul 08 19:49:09 volumio volumio[1116]: info: Preparing to generate the ALSA configuration file
Jul 08 19:49:09 volumio volumio[1116]: info: Asound.conf file written
Jul 08 19:49:09 volumio sudo[1255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jul 08 19:49:09 volumio sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:09 volumio sudo[1255]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:09 volumio volumio[1116]: info: Output device has changed, restarting MPD
Jul 08 19:49:09 volumio sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 08 19:49:09 volumio volumio[1116]: info: Output device has changed, restarting Shairport Sync
Jul 08 19:49:09 volumio sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:09 volumio sudo[1260]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:09 volumio sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 08 19:49:09 volumio sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:09 volumio systemd[1]: Stopping Music Player Daemon...
Jul 08 19:49:09 volumio volumio[1116]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 08 19:49:09 volumio volumio[1116]: info: ___________ START PLUGINS ___________
Jul 08 19:49:09 volumio volumio[1116]: info: ControllerMpd::onStart: Initializing MPD
Jul 08 19:49:09 volumio volumio[1116]: info: Creating MPD Configuration file
Jul 08 19:49:09 volumio sudo[1281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 08 19:49:09 volumio sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 19:49:09 volumio volumio[1116]: info: [1751996949803] CoreMusicLibrary::Adding element Media Servers
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:09 volumio sudo[1281]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:09 volumio sudo[1283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 08 19:49:09 volumio sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:09 volumio volumio[1116]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:09 volumio systemd[1]: mpd.service: Succeeded.
Jul 08 19:49:09 volumio systemd[1]: Stopped Music Player Daemon.
Jul 08 19:49:09 volumio volumio[1116]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 19:49:09 volumio volumio[1116]: info: [1751996949892] CoreMusicLibrary::Adding element Last_100
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 19:49:09 volumio volumio[1116]: info: [1751996949894] CoreMusicLibrary::Adding element Webradio
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 19:49:09 volumio volumio[1116]: info: Initializing BBC Radios
Jul 08 19:49:09 volumio systemd[1]: Starting Music Player Daemon...
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:09 volumio volumio[1116]: info: Creating Spotify config file
Jul 08 19:49:09 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:09 volumio sudo[1292]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 08 19:49:09 volumio sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:09 volumio sudo[1292]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:10 volumio volumio[1116]: info: [now-playing] ConfigUpdater: config is up to date.
Jul 08 19:49:10 volumio volumio[1116]: info: Loading i18n strings for locale en
Jul 08 19:49:10 volumio volumio[1116]: Updating browse sources language
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 19:49:10 volumio volumio[1116]: info: [1751996950085] CoreMusicLibrary::Adding element Podcast
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source Podcast
Jul 08 19:49:10 volumio volumio[1116]: info: Loading i18n strings for locale en
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 19:49:10 volumio volumio[1116]: info: [1751996950098] CoreMusicLibrary::Adding element LastFM
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source Podcast
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source LastFM
Jul 08 19:49:10 volumio volumio[1116]: info: [LastFM] scrobbler initiated!
Jul 08 19:49:10 volumio volumio[1116]: info: [LastFM] extended logging: false
Jul 08 19:49:10 volumio volumio[1116]: info: [LastFM] try scrobble stream/radio plays: true
Jul 08 19:49:10 volumio volumio[1116]: info: [LastFM] Left init routine
Jul 08 19:49:10 volumio volumio[1116]: info: [LastFM] Socket already connected: true
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 19:49:10 volumio volumio[1116]: info: [1751996950120] CoreMusicLibrary::Adding element Randomizer
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source Podcast
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source LastFM
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source Randomizer
Jul 08 19:49:10 volumio volumio[1116]: info: Loading i18n strings for locale en
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 19:49:10 volumio volumio[1116]: info: Volumio Calling Home
Jul 08 19:49:10 volumio volumio[1116]: info: PlexAmp::Plex initialised[object Object]
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 08 19:49:10 volumio volumio[1116]: info: [1751996950192] CoreMusicLibrary::Adding element Plex
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source Podcast
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source LastFM
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source Randomizer
Jul 08 19:49:10 volumio volumio[1116]: Cannot find translation for source Plex
Jul 08 19:49:10 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Jul 08 19:49:10 volumio sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc
Jul 08 19:49:10 volumio sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio sudo[1313]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:10 volumio sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service
Jul 08 19:49:10 volumio sudo[1316]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service
Jul 08 19:49:10 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Jul 08 19:49:10 volumio sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio sudo[1316]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:10 volumio volumio[1116]: info: [now-playing] App is listening on port 4004.
Jul 08 19:49:10 volumio systemd[1]: Reloading.
Jul 08 19:49:10 volumio volumio[1116]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
Jul 08 19:49:10 volumio volumio[1116]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/'
Jul 08 19:49:10 volumio volumio[1116]: info: touch_display: systemctl stop getty@tty1.service succeeded.
Jul 08 19:49:10 volumio volumio[1116]: info: ir_controller: File permissions successfully set on /etc/lirc/*.
Jul 08 19:49:10 volumio volumio[1116]: info: MPD Permissions set
Jul 08 19:49:10 volumio volumio[1116]: info: MPD Permissions set
Jul 08 19:49:10 volumio volumio[1116]: info: Spotify config file written
Jul 08 19:49:10 volumio sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Jul 08 19:49:10 volumio sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:10 volumio volumio[1116]: info: No need to fix Spotify hosts
Jul 08 19:49: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.
Jul 08 19:49:10 volumio volumio[1116]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Jul 08 19:49:10 volumio volumio[1116]: info: Starting Shairport Sync
Jul 08 19:49:10 volumio volumio[1116]: info: Starting Shairport Sync
Jul 08 19:49:10 volumio sudo[1349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf
Jul 08 19:49:10 volumio sudo[1349]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio volumio[1116]: info: Starting Shairport Sync
Jul 08 19:49:10 volumio mpd[1304]: Jul 08 19:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 08 19:49:10 volumio sudo[1349]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:10 volumio sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 08 19:49:10 volumio sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 08 19:49:10 volumio sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio volumio[1116]: info: ir_controller: LIRC correctly updated.
Jul 08 19:49:10 volumio volumio[1116]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver!
Jul 08 19:49:10 volumio sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 08 19:49:10 volumio sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:10 volumio volumio[1116]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set.
Jul 08 19:49:10 volumio volumio[1116]: info: ir_controller: Raspberry Pi revision code: c03115
Jul 08 19:49:10 volumio sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1
Jul 08 19:49:10 volumio sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:11 volumio sudo[1365]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:11 volumio sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up
Jul 08 19:49:11 volumio sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:11 volumio kernel: pinctrl-bcm2835 fe200000.gpio: pin gpio25 already requested by soc:fb; cannot claim for ir-receiver@19
Jul 08 19:49:11 volumio kernel: pinctrl-bcm2835 fe200000.gpio: pin-25 (ir-receiver@19) status -22
Jul 08 19:49:11 volumio kernel: pinctrl-bcm2835 fe200000.gpio: could not request pin 25 (gpio25) from group gpio25 on device pinctrl-bcm2711
Jul 08 19:49:11 volumio kernel: gpio_ir_recv ir-receiver@19: Error applying setting, reverse things back
Jul 08 19:49:11 volumio sudo[1321]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:11 volumio sudo[1372]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:11 volumio volumio[1116]: info: touch_display: systemctl daemon-reload succeeded.
Jul 08 19:49:11 volumio systemd[1]: Reloading.
Jul 08 19:49:11 volumio volumio[1116]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up loaded.
Jul 08 19:49:11 volumio sudo[1382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Jul 08 19:49:11 volumio sudo[1382]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:11 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service
Jul 08 19:49:11 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49: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.
Jul 08 19:49:11 volumio sudo[1318]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:11 volumio volumio[1116]: info: touch_display: systemctl disable getty@tty1.service succeeded.
Jul 08 19:49:11 volumio systemd[1]: Starting lircd(8) initialization helper tool...
Jul 08 19:49:11 volumio systemd[1]: Started Volumio Kiosk.
Jul 08 19:49:11 volumio sudo[1382]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 08 19:49:11 volumio volumio[1116]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Jul 08 19:49:11 volumio volumio[1116]: info: touch_display: Volumio Kiosk started.
Jul 08 19:49:11 volumio systemd[1]: Started go-librespot Daemon.
Jul 08 19:49:11 volumio go-librespot[1416]: go-librespot daemon starting...
Jul 08 19:49:11 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 08 19:49:11 volumio sudo[1338]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 08 19:49:11 volumio volumio[1116]: info: CoreCommandRouter::volumioGetState
Jul 08 19:49:11 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:11 volumio sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service
Jul 08 19:49:11 volumio sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:11 volumio volumio[1116]: info: touch_display: X display number found:
Jul 08 19:49:11 volumio sudo[1434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 08 19:49:11 volumio sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 08 19:49:11 volumio sudo[1434]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio sudo[1351]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio sudo[1354]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio sudo[1437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 08 19:49:12 volumio sudo[1437]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:12 volumio sudo[1357]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio sudo[1437]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio volumio[1116]: info: Shairport-Sync Started
Jul 08 19:49:12 volumio volumio[1116]: Error adding Membership: Error: addMembership EINVAL
Jul 08 19:49:12 volumio volumio[1116]: info: Shairport-Sync Started
Jul 08 19:49:12 volumio volumio[1116]: info: touch_display: X display number found:
Jul 08 19:49:12 volumio sudo[1460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 08 19:49:12 volumio sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:12 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 08 19:49:12 volumio sudo[1460]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio volumio[1116]: info: Upmpdcli Daemon Started
Jul 08 19:49:12 volumio volumio[1116]: info: touch_display: X display number found: 0
Jul 08 19:49:12 volumio systemd[1]: Started Music Player Daemon.
Jul 08 19:49:12 volumio sudo[1283]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio sudo[1262]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio volumio[1116]: info: Completed starting Core Plugins
Jul 08 19:49:12 volumio volumio[1116]: info: -------------------------------------------
Jul 08 19:49:12 volumio volumio[1116]: info: ----- MyVolumio plugins startup ----
Jul 08 19:49:12 volumio volumio[1116]: info: -------------------------------------------
Jul 08 19:49:12 volumio volumio[1116]: info: [MyVolumio PluginManager] Fetching plans data....
Jul 08 19:49:12 volumio startx[1415]: X.Org X Server 1.20.4
Jul 08 19:49:12 volumio startx[1415]: X Protocol Version 11, Revision 0
Jul 08 19:49:12 volumio startx[1415]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian
Jul 08 19:49:12 volumio startx[1415]: Current Operating System: Linux volumio 6.6.62-v7l+ #1816 SMP Mon Nov 18 15:33:33 GMT 2024 armv7l
Jul 08 19:49:12 volumio startx[1415]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=E4:5F:01:9C:4E:9B vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=9515b9c7-cad0-4dff-b5e6-eed02d916a6f imgfile=/volumio_current.sqsh bootpart=UUID=1DB0-740B datapart=UUID=518343f7-6553-4bee-ac69-434763ba11bb uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no
Jul 08 19:49:12 volumio startx[1415]: Build Date: 04 April 2023 07:50:56AM
Jul 08 19:49:12 volumio startx[1415]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support)
Jul 08 19:49:12 volumio startx[1415]: Current version of pixman: 0.36.0
Jul 08 19:49:12 volumio startx[1415]: Before reporting problems, check http://wiki.x.org
Jul 08 19:49:12 volumio startx[1415]: to make sure that you have the latest version.
Jul 08 19:49:12 volumio startx[1415]: Markers: (--) probed, (**) from config file, (==) default setting,
Jul 08 19:49:12 volumio startx[1415]: (++) from command line, (!!) notice, (II) informational,
Jul 08 19:49:12 volumio startx[1415]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Jul 08 19:49:12 volumio startx[1415]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Jul 8 19:49:12 2025
Jul 08 19:49:12 volumio startx[1415]: (==) Using config directory: "/etc/X11/xorg.conf.d"
Jul 08 19:49:12 volumio startx[1415]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Jul 08 19:49:12 volumio volumio[1116]: error: MPD error: The expression evaluated to a falsy value:
Jul 08 19:49:12 volumio volumio[1116]: assert.ok(self.idling)
Jul 08 19:49:12 volumio volumio[1116]: error: The expression evaluated to a falsy value:
Jul 08 19:49:12 volumio volumio[1116]: assert.ok(self.idling)
Jul 08 19:49:12 volumio volumio[1116]: info: MPD running with PID1304
Jul 08 19:49:12 volumio volumio[1116]: ,establishing connection
Jul 08 19:49:12 volumio volumio[1116]: error: MPD error: The expression evaluated to a falsy value:
Jul 08 19:49:12 volumio volumio[1116]: assert.ok(self.idling)
Jul 08 19:49:12 volumio volumio[1116]: error: The expression evaluated to a falsy value:
Jul 08 19:49:12 volumio volumio[1116]: assert.ok(self.idling)
Jul 08 19:49:12 volumio volumio[1116]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Jul 08 19:49:12 volumio volumio[1116]: error: updateQueue error: null
Jul 08 19:49:12 volumio volumio[1116]: info: touch_display: X display number found: 0
Jul 08 19:49:12 volumio volumio[1462]: Generating RSA private key, 4096 bit long modulus (2 primes)
Jul 08 19:49:12 volumio go-librespot[1416]: time="2025-07-08T19:49:12+02:00" level=info msg="running go-librespot 0.2.0"
Jul 08 19:49:12 volumio go-librespot[1416]: time="2025-07-08T19:49:12+02:00" level=debug msg="app state loaded"
Jul 08 19:49:12 volumio go-librespot[1416]: time="2025-07-08T19:49:12+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Jul 08 19:49:12 volumio lircd-setup[1414]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead.
Jul 08 19:49:12 volumio lircd-setup[1414]: parser = configparser.SafeConfigParser()
Jul 08 19:49:12 volumio systemd[1]: lircd-setup.service: Succeeded.
Jul 08 19:49:12 volumio systemd[1]: Started lircd(8) initialization helper tool.
Jul 08 19:49:12 volumio systemd[1]: Starting Flexible IR remote input/output application support...
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Info: lircd: Opening log, level: Info
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Version: lircd 0.10.1
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: System info: Linux volumio 6.6.62-v7l+ #1816 SMP Mon Nov 18 15:33:33 GMT 2024 armv7l GNU/Linux
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Info: Initial device: /dev/lirc0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Warning: Cannot access device: /dev/lirc0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Info: Initial device: /dev/lirc0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Warning: Cannot access device: /dev/lirc0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: driver: default
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Info: lircd: Opening log, level: Info
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Notice: Using systemd fd
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Warning: Running as root
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: output: /var/run/lirc/lircd
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Info: Using remote: lircd.conf.
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Notice: lircd(default) ready, using /var/run/lirc/lircd
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: nodaemon: 1
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins
Jul 08 19:49:12 volumio systemd[1]: Started Flexible IR remote input/output application support.
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: logfile: syslog
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: immediate-init: 0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: permission: 666
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: driver-options:
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: pidfile: /var/run/lirc/lircd.pid
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: listen: 0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: connect: (null)
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: userelease: 0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: effective_user: (null)
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: release_suffix: _EVUP
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: allow_simulate: 0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: repeat_max: 600
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: configfile: /etc/lirc/lircd.conf
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Options: dynamic_codes: (null)
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Current driver: default
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Driver API version: 3
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Driver version: 0.10.0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Info: lircd: Opening log, level: Info
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: Using systemd fd
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Warning: Running as root
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Info: Using remote: lircd.conf.
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: lircd(default) ready, using /var/run/lirc/lircd
Jul 08 19:49:12 volumio sudo[1429]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio sudo[1385]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio volumio[1116]: info: ir_controller: systemctl restart lircd.service succeeded.
Jul 08 19:49:12 volumio volumio[1116]: info: ir_controller: systemctl restart lircd.service succeeded.
Jul 08 19:49:12 volumio sudo[1492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service
Jul 08 19:49:12 volumio sudo[1492]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:12 volumio sudo[1495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service
Jul 08 19:49:12 volumio sudo[1495]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 08 19:49:12 volumio systemd[1]: Started Handle events from IR remotes decoded by lircd(8).
Jul 08 19:49:12 volumio sudo[1492]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Notice: accepted new client on /var/run/lirc/lircd
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: accepted new client on /var/run/lirc/lircd
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Info: Cannot configure the rc device for /dev/lirc0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Info: Cannot configure the rc device for /dev/lirc0
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:12 volumio volumio[1116]: info: ir_controller: systemctl restart irexec.service succeeded.
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Warning: Failed to initialize hardware
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Warning: Failed to initialize hardware
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Info: removed client
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Info: removed client
Jul 08 19:49:12 volumio systemd[1]: Stopping Handle events from IR remotes decoded by lircd(8)...
Jul 08 19:49:12 volumio systemd[1]: irexec.service: Main process exited, code=killed, status=15/TERM
Jul 08 19:49:12 volumio systemd[1]: irexec.service: Succeeded.
Jul 08 19:49:12 volumio systemd[1]: Stopped Handle events from IR remotes decoded by lircd(8).
Jul 08 19:49:12 volumio systemd[1]: Started Handle events from IR remotes decoded by lircd(8).
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Notice: accepted new client on /var/run/lirc/lircd
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Info: Cannot configure the rc device for /dev/lirc0
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:12 volumio lircd[1488]: lircd-0.10.1[1488]: Warning: Failed to initialize hardware
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Notice: accepted new client on /var/run/lirc/lircd
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Info: Cannot configure the rc device for /dev/lirc0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:12 volumio lircd-0.10.1[1488]: Warning: Failed to initialize hardware
Jul 08 19:49:12 volumio sudo[1495]: pam_unix(sudo:session): session closed for user root
Jul 08 19:49:12 volumio volumio[1116]: info: ir_controller: systemctl restart irexec.service succeeded.
Jul 08 19:49:13 volumio volumio[1116]: info: touch_display: Setting screensaver timeout to 60 seconds.
Jul 08 19:49:13 volumio volumio[1462]: ..............++++
Jul 08 19:49:13 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:13 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:13 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:13 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:14 volumio volumio[1462]: ....++++
Jul 08 19:49:14 volumio volumio[1462]: e is 65537 (0x010001)
Jul 08 19:49:14 volumio volumio[1462]: writing RSA key
Jul 08 19:49:14 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:14 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:14 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:14 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:14 volumio volumio[1116]: info: go-librespot daemon successfully initialized
Jul 08 19:49:15 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:15 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:15 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:15 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:16 volumio volumio-remote-updater[651]: [2025-07-08 19:49:16] [connect] Successful connection
Jul 08 19:49:16 volumio volumio-remote-updater[651]: [2025-07-08 19:49:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751996956 101
Jul 08 19:49:16 volumio volumio[1116]: 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: 4
Jul 08 19:49:16 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:16 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:16 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:16 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:17 volumio volumio-time-update[645]: volumio-time-update-util: Date not found in response
Jul 08 19:49:17 volumio volumio-time-update[645]: volumio-time-update-util: Retrying in 5 seconds...
Jul 08 19:49:17 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:17 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:17 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:17 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:17 volumio volumio[1116]: info: Initializing connection to go-librespot Websocket
Jul 08 19:49:18 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:18 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:18 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:18 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:19 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:19 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:19 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:19 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:20 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:20 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:20 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:20 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:21 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:21 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:21 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:21 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:22 volumio volumio-time-update[645]: volumio-time-update-util: Fetching time from Volumio...
Jul 08 19:49:22 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:22 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:22 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:22 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:23 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:23 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:23 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:23 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:24 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:24 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:24 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:24 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:25 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:25 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:25 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:25 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:25 volumio ntpd[1105]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Jul 08 19:49:26 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:26 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:26 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:26 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:27 volumio volumio[1116]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jul 08 19:49:27 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:27 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:27 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:27 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:28 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:28 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:28 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:28 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:29 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:29 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:29 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:29 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:30 volumio volumio[1116]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jul 08 19:49:30 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:30 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:30 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:30 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:30 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::volumioGetState
Jul 08 19:49:31 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 08 19:49:31 volumio volumio[1116]: info: Received Get System Info
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 08 19:49:31 volumio volumio[1116]: info: Discovery: Getting this device information
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::volumioGetState
Jul 08 19:49:31 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::volumioGetState
Jul 08 19:49:31 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:31 volumio volumio[1116]: info: Listing playlists
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 08 19:49:31 volumio volumio[1116]: info: Received Get System Info
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 08 19:49:31 volumio volumio[1116]: info: Discovery: Getting this device information
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::volumioGetState
Jul 08 19:49:31 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:31 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 08 19:49:31 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:31 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:31 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:31 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:32 volumio volumio[1116]: error: MyVolumio Plugin failed to start in a timely fashion
Jul 08 19:49:32 volumio volumio[1116]: [Metrics] CommandRouter: 32s 955.09ms
Jul 08 19:49:32 volumio volumio[1116]: info: CoreCommandRouter::volumiosetStartupVolume
Jul 08 19:49:32 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 08 19:49:32 volumio volumio[1116]: info: VolumeController:: Setting startup Volume 60
Jul 08 19:49:32 volumio volumio[1116]: info: VolumeController::SetAlsaVolume60
Jul 08 19:49:32 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:32 volumio volumio[1116]: info: CoreCommandRouter::Close All Modals sent
Jul 08 19:49:32 volumio volumio[1116]: info: CoreCommandRouter::Close All Modals sent
Jul 08 19:49:32 volumio volumio[1116]: info: CoreStateMachine::pushState
Jul 08 19:49:32 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:32 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 08 19:49:32 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState
Jul 08 19:49:32 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:32 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:32 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:32 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:32 volumio wpa_supplicant[986]: RRM: Ignoring radio measurement request: Not RRM network
Jul 08 19:49:33 volumio wpa_supplicant[986]: RRM: Ignoring radio measurement request: Not RRM network
Jul 08 19:49:33 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 08 19:49:33 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 08 19:49:33 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 08 19:49:33 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:33 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:33 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:33 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:34 volumio wpa_supplicant[986]: RRM: Ignoring radio measurement request: Not RRM network
Jul 08 19:49:34 volumio dhcpcd[730]: wlan0: carrier lost
Jul 08 19:49:34 volumio wpa_supplicant[986]: wlan0: Associated with 9c:c7:a6:c7:f0:78
Jul 08 19:49:34 volumio wpa_supplicant[986]: wlan0: CTRL-EVENT-CONNECTED - Connection to 9c:c7:a6:c7:f0:78 completed [id=0 id_str=]
Jul 08 19:49:34 volumio wpa_supplicant[986]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Jul 08 19:49:34 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:34 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:34 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:34 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:34 volumio avahi-daemon[668]: Withdrawing address record for 192.168.178.84 on wlan0.
Jul 08 19:49:34 volumio avahi-daemon[668]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.84.
Jul 08 19:49:34 volumio dhcpcd[730]: wlan0: deleting route to 192.168.178.0/24
Jul 08 19:49:34 volumio dhcpcd[730]: wlan0: deleting default route via 192.168.178.1
Jul 08 19:49:34 volumio avahi-daemon[668]: Interface wlan0.IPv4 no longer relevant for mDNS.
Jul 08 19:49:35 volumio ntpd[1105]: ntpd exiting on signal 15 (Terminated)
Jul 08 19:49:35 volumio ntpd[1105]: 192.168.178.1 local addr 192.168.178.5 ->
Jul 08 19:49:35 volumio systemd[1]: Stopping Network Time Service...
Jul 08 19:49:35 volumio systemd[1]: ntp.service: Succeeded.
Jul 08 19:49:35 volumio systemd[1]: Stopped Network Time Service.
Jul 08 19:49:35 volumio systemd[1]: Starting Network Time Service...
Jul 08 19:49:35 volumio ntpd[2012]: ntpd 4.2.8p12@1.3728-o (1): Starting
Jul 08 19:49:35 volumio ntpd[2012]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103
Jul 08 19:49:35 volumio systemd[1]: Started Network Time Service.
Jul 08 19:49:35 volumio dhcpcd[730]: wlan0: carrier acquired
Jul 08 19:49:35 volumio ntpd[2018]: proto: precision = 0.833 usec (-20)
Jul 08 19:49:35 volumio ntpd[2018]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Jul 08 19:49:35 volumio ntpd[2018]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Jul 08 19:49:35 volumio ntpd[2018]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 193 days ago
Jul 08 19:49:35 volumio ntpd[2018]: Listen and drop on 0 v6wildcard [::]:123
Jul 08 19:49:35 volumio ntpd[2018]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jul 08 19:49:35 volumio ntpd[2018]: Listen normally on 2 lo 127.0.0.1:123
Jul 08 19:49:35 volumio ntpd[2018]: Listen normally on 3 eth0 192.168.178.5:123
Jul 08 19:49:35 volumio ntpd[2018]: Listening on routing socket on fd #20 for interface updates
Jul 08 19:49:35 volumio ntpd[2018]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 08 19:49:35 volumio ntpd[2018]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 08 19:49:35 volumio dhcpcd[730]: wlan0: IAID 01:9c:4e:9d
Jul 08 19:49:35 volumio dhcpcd[730]: wlan0: rebinding lease of 192.168.178.84
Jul 08 19:49:35 volumio dhcpcd[730]: wlan0: probing address 192.168.178.84/24
Jul 08 19:49:35 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:35 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:35 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:35 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:36 volumio dhcpcd[730]: wlan0: soliciting an IPv6 router
Jul 08 19:49:36 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:36 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:36 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:36 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:37 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 3 ep 1
Jul 08 19:49:37 volumio kernel: xhci_hcd 0000:01:00.0: @00000004295148c0 00000000 00000000 0e000000 03028001
Jul 08 19:49:37 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:37 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:37 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:37 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:38 volumio volumio[1116]: info: Discovery: adding 3e5059e9-b0dd-4bfe-8ec1-f6ffabf693ab
Jul 08 19:49:38 volumio volumio[1116]: info: Discovery: Found device Volumio
Jul 08 19:49:38 volumio volumio[1116]: info: CoreCommandRouter::volumioGetState
Jul 08 19:49:38 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:38 volumio volumio[1116]: info: Discovery: this is already registered, 3e5059e9-b0dd-4bfe-8ec1-f6ffabf693ab
Jul 08 19:49:38 volumio volumio[1116]: info: Discovery: Found device Volumio
Jul 08 19:49:38 volumio volumio[1116]: info: CoreCommandRouter::volumioGetState
Jul 08 19:49:38 volumio volumio[1116]: info: CorePlayQueue::getTrack 0
Jul 08 19:49:38 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jul 08 19:49:38 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:38 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:38 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:38 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:39 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:39 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:39 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:39 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:40 volumio wpa_supplicant[986]: RRM: Ignoring radio measurement request: Not RRM network
Jul 08 19:49:40 volumio go-librespot[1416]: time="2025-07-08T19:49:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy"
Jul 08 19:49:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Jul 08 19:49:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Jul 08 19:49:40 volumio wpa_supplicant[986]: RRM: Ignoring radio measurement request: Not RRM network
Jul 08 19:49:40 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:40 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:40 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:40 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:40 volumio dhcpcd[730]: wlan0: leased 192.168.178.84 for 864000 seconds
Jul 08 19:49:40 volumio avahi-daemon[668]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.84.
Jul 08 19:49:40 volumio avahi-daemon[668]: New relevant interface wlan0.IPv4 for mDNS.
Jul 08 19:49:40 volumio dhcpcd[730]: wlan0: adding route to 192.168.178.0/24
Jul 08 19:49:40 volumio avahi-daemon[668]: Registering new address record for 192.168.178.84 on wlan0.IPv4.
Jul 08 19:49:40 volumio dhcpcd[730]: wlan0: adding default route via 192.168.178.1
Jul 08 19:49:41 volumio systemd[1]: Stopping Network Time Service...
Jul 08 19:49:41 volumio ntpd[2018]: ntpd exiting on signal 15 (Terminated)
Jul 08 19:49:41 volumio systemd[1]: ntp.service: Succeeded.
Jul 08 19:49:41 volumio systemd[1]: Stopped Network Time Service.
Jul 08 19:49:41 volumio systemd[1]: Starting Network Time Service...
Jul 08 19:49:41 volumio ntpd[2101]: ntpd 4.2.8p12@1.3728-o (1): Starting
Jul 08 19:49:41 volumio ntpd[2101]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103
Jul 08 19:49:41 volumio systemd[1]: Started Network Time Service.
Jul 08 19:49:41 volumio ntpd[2107]: proto: precision = 0.796 usec (-20)
Jul 08 19:49:41 volumio ntpd[2107]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Jul 08 19:49:41 volumio ntpd[2107]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Jul 08 19:49:41 volumio ntpd[2107]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 193 days ago
Jul 08 19:49:41 volumio ntpd[2107]: Listen and drop on 0 v6wildcard [::]:123
Jul 08 19:49:41 volumio ntpd[2107]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jul 08 19:49:41 volumio ntpd[2107]: Listen normally on 2 lo 127.0.0.1:123
Jul 08 19:49:41 volumio ntpd[2107]: Listen normally on 3 eth0 192.168.178.5:123
Jul 08 19:49:41 volumio ntpd[2107]: Listen normally on 4 wlan0 192.168.178.84:123
Jul 08 19:49:41 volumio ntpd[2107]: Listening on routing socket on fd #21 for interface updates
Jul 08 19:49:41 volumio ntpd[2107]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 08 19:49:41 volumio ntpd[2107]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 08 19:49:41 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:41 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:41 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:41 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:42 volumio volumio[1116]: info: Discovery: A device disappeared from network
Jul 08 19:49:42 volumio volumio[1116]: info: Discovery: Device volumio disappeared from network
Jul 08 19:49:42 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:42 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:42 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:42 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:42 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 08 19:49:42 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 08 19:49:42 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 08 19:49:42 volumio volumio[1116]: info: BOOT COMPLETED
Jul 08 19:49:43 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 08 19:49:43 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jul 08 19:49:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1.
Jul 08 19:49:43 volumio systemd[1]: Stopped go-librespot Daemon.
Jul 08 19:49:43 volumio systemd[1]: Started go-librespot Daemon.
Jul 08 19:49:43 volumio go-librespot[2129]: go-librespot daemon starting...
Jul 08 19:49:43 volumio go-librespot[2129]: time="2025-07-08T19:49:43+02:00" level=info msg="running go-librespot 0.2.0"
Jul 08 19:49:43 volumio go-librespot[2129]: time="2025-07-08T19:49:43+02:00" level=debug msg="app state loaded"
Jul 08 19:49:43 volumio go-librespot[2129]: time="2025-07-08T19:49:43+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Jul 08 19:49:43 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:43 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:43 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:43 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:44 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:44 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:44 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:44 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:45 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:45 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:45 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:45 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:46 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:46 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:46 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:46 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:47 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:47 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:47 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:47 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:48 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:48 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:48 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:48 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:49 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:49 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:49 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:49 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:50 volumio volumio-time-update[645]: volumio-time-update-util: Date not found in response
Jul 08 19:49:50 volumio volumio-time-update[645]: volumio-time-update-util: Retrying in 5 seconds...
Jul 08 19:49:50 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:50 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:50 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:50 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:51 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:51 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:51 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:51 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:52 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:52 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:52 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:52 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:52 volumio volumio[1116]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.819&uuid=b875e45cb20b3c7ad16f79f3e438efea" http://updates.volumio.org/downloader-v1/track-device
Jul 08 19:49:52 volumio volumio[1116]: % Total % Received % Xferd Average Speed Time Time Time Current
Jul 08 19:49:52 volumio volumio[1116]: Dload Upload Total Spent Left Speed
Jul 08 19:49:52 volumio volumio[1116]: [2.2K blob data]
Jul 08 19:49:52 volumio volumio[1116]: retrying in 5 seconds, trial 0
Jul 08 19:49:53 volumio volumio[1116]: info: Volumio Calling Home
Jul 08 19:49:53 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:53 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:53 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:53 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:54 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:54 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:54 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:54 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:55 volumio volumio-time-update[645]: volumio-time-update-util: Fetching time from Volumio...
Jul 08 19:49:55 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:55 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:55 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:55 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:56 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:56 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:56 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:56 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:57 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:57 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:57 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:57 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:58 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:58 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:58 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:58 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:59 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:59 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:49:59 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:49:59 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:00 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:00 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:00 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:00 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:01 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:01 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:01 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:01 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:02 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:02 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:02 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:02 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:03 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:03 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:03 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:03 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:04 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:04 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:04 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:04 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:05 volumio volumio[1116]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo ENOTFOUND oauth-performer.prod.vlmapi.io
Jul 08 19:50:05 volumio lircd[1488]: lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:05 volumio lircd[1488]: lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:05 volumio lircd-0.10.1[1488]: Error: could not get file information for /dev/lirc0
Jul 08 19:50:05 volumio lircd-0.10.1[1488]: default_init(): No such file or directory
Jul 08 19:50:06 volumio volumio[1116]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 08 19:50:06 volumio volumio[1116]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com
Jul 08 19:50:06 volumio volumio[1116]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) {
Jul 08 19:50:06 volumio volumio[1116]: errno: -3007,
Jul 08 19:50:06 volumio volumio[1116]: code: 'ENOTFOUND',
Jul 08 19:50:06 volumio volumio[1116]: syscall: 'getaddrinfo',
Jul 08 19:50:06 volumio volumio[1116]: hostname: 'ws.audioscrobbler.com'
Jul 08 19:50:06 volumio volumio[1116]: }
Jul 08 19:50:06 volumio volumio[1116]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 08 19:50:06 volumio sudo[2190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-08 19:49
Jul 08 19:50:06 volumio sudo[2190]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST"
VOLUMIO_VERSION="3.819"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"