-- Logs begin at Mon 2025-06-30 14:14:44 CST, end at Mon 2025-06-30 14:18:06 CST. --
Jun 30 14:17:01 volumio CRON[2797]: pam_unix(cron:session): session opened for user root by (uid=0)
Jun 30 14:17:01 volumio CRON[2798]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jun 30 14:17:01 volumio CRON[2797]: pam_unix(cron:session): session closed for user root
Jun 30 14:17:08 volumio wpa_supplicant[1275]: wlan0: SME: Trying to authenticate with 1c:60:de:0c:09:1c (SSID='MERCURY_091C' freq=2437 MHz)
Jun 30 14:17:08 volumio kernel: wlan0: authenticate with 1c:60:de:0c:09:1c
Jun 30 14:17:08 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Jun 30 14:17:08 volumio kernel: wlan0: send auth to 1c:60:de:0c:09:1c (try 1/3)
Jun 30 14:17:08 volumio kernel: wlan0: send auth to 1c:60:de:0c:09:1c (try 2/3)
Jun 30 14:17:08 volumio kernel: wlan0: send auth to 1c:60:de:0c:09:1c (try 3/3)
Jun 30 14:17:08 volumio wpa_supplicant[1275]: wlan0: Trying to associate with 1c:60:de:0c:09:1c (SSID='MERCURY_091C' freq=2437 MHz)
Jun 30 14:17:08 volumio kernel: wlan0: authenticated
Jun 30 14:17:08 volumio kernel: wlan0: associate with 1c:60:de:0c:09:1c (try 1/3)
Jun 30 14:17:09 volumio kernel: wlan0: RX AssocResp from 1c:60:de:0c:09:1c (capab=0x431 status=0 aid=6)
Jun 30 14:17:09 volumio kernel: wlan0: associated
Jun 30 14:17:09 volumio wpa_supplicant[1275]: wlan0: Associated with 1c:60:de:0c:09:1c
Jun 30 14:17:09 volumio wpa_supplicant[1275]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Jun 30 14:17:18 volumio kernel: wlan0: deauthenticated from 1c:60:de:0c:09:1c (Reason: 15=4WAY_HANDSHAKE_TIMEOUT)
Jun 30 14:17:18 volumio wpa_supplicant[1275]: wlan0: CTRL-EVENT-DISCONNECTED bssid=1c:60:de:0c:09:1c reason=15
Jun 30 14:17:18 volumio wpa_supplicant[1275]: wlan0: WPA: 4-Way Handshake failed - pre-shared key may be incorrect
Jun 30 14:17:18 volumio wpa_supplicant[1275]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="MERCURY_091C" auth_failures=4 duration=77 reason=WRONG_KEY
Jun 30 14:17:18 volumio wpa_supplicant[1275]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Jun 30 14:17:18 volumio wpa_supplicant[1275]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=CN
Jun 30 14:17:23 volumio volumio[1501]: info: Enabling plugin peppy_screensaver
Jun 30 14:17:23 volumio volumio[1501]: info: Loading plugin "peppy_screensaver"...
Jun 30 14:17:23 volumio volumio[1501]: info: Applying required configuration parameters for plugin peppy_screensaver
Jun 30 14:17:23 volumio volumio[1501]: info: Preparing to generate the ALSA configuration file
Jun 30 14:17:23 volumio volumio[1501]: info: The plugin alsa_controller has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Jun 30 14:17:23 volumio volumio[1501]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Jun 30 14:17:23 volumio volumio[1501]: info: Reading ALSA contributions from plugins.
Jun 30 14:17:23 volumio volumio[1501]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Jun 30 14:17:23 volumio volumio[1501]: info: Asound.conf file written
Jun 30 14:17:23 volumio sudo[2888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jun 30 14:17:23 volumio sudo[2888]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 14:17:23 volumio sudo[2888]: pam_unix(sudo:session): session closed for user root
Jun 30 14:17:24 volumio volumio[1501]: info: Output device has changed, restarting MPD
Jun 30 14:17:24 volumio sudo[2893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 14:17:24 volumio sudo[2893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 14:17:24 volumio volumio[1501]: info: Output device has changed, restarting Shairport Sync
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 14:17:24 volumio sudo[2893]: pam_unix(sudo:session): session closed for user root
Jun 30 14:17:24 volumio sudo[2896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 14:17:24 volumio sudo[2896]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 14:17:24 volumio systemd[1]: Stopping Music Player Daemon...
Jun 30 14:17:24 volumio volumio[1501]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 14:17:24 volumio volumio[1501]: info: PLUGIN START: peppy_screensaver
Jun 30 14:17:24 volumio volumio[1501]: info: Loading i18n strings for locale zh
Jun 30 14:17:24 volumio systemd[1]: mpd.service: Succeeded.
Jun 30 14:17:24 volumio systemd[1]: Stopped Music Player Daemon.
Jun 30 14:17:24 volumio volumio[1501]: info: /tmp/myfifo created
Jun 30 14:17:24 volumio volumio[1501]: info: /tmp/myfifosa created
Jun 30 14:17:24 volumio systemd[1]: Starting Music Player Daemon...
Jun 30 14:17:24 volumio sudo[2907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0
Jun 30 14:17:24 volumio sudo[2907]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 14:17:24 volumio sudo[2907]: pam_unix(sudo:session): session closed for user root
Jun 30 14:17:24 volumio volumio[1501]: info: snd-dummy loaded
Jun 30 14:17:24 volumio volumio[1501]: info: Error: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Jun 30 14:17:24 volumio volumio[1501]: info: MPD Permissions set
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio sudo[2902]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 14:17:24 volumio sudo[2902]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 14:17:24 volumio sudo[2902]: pam_unix(sudo:session): session closed for user root
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jun 30 14:17:24 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 14:17:24 volumio volumio[1501]: error: Upnp client error: Error: This socket has been ended by the other party
Jun 30 14:17:24 volumio volumio[1501]: info: Starting Shairport Sync
Jun 30 14:17:24 volumio sudo[2918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 14:17:24 volumio sudo[2918]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 14:17:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 14:17:24 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 30 14:17:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 14:17:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 14:17:24 volumio sudo[2918]: pam_unix(sudo:session): session closed for user root
Jun 30 14:17:24 volumio volumio[1501]: info: Shairport-Sync Started
Jun 30 14:17:24 volumio mpd[2914]: Jun 30 14:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 30 14:17:24 volumio systemd[1]: Started Music Player Daemon.
Jun 30 14:17:24 volumio sudo[2896]: pam_unix(sudo:session): session closed for user root
Jun 30 14:17:24 volumio volumio[1501]: error: updateQueue error: null
Jun 30 14:17:25 volumio volumio[1501]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 14:17:35 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 30 14:17:35 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 30 14:17:35 volumio volumio-remote-updater[773]: Test mode enabled
Jun 30 14:17:35 volumio volumio-remote-updater[773]: No alpha test mode
Jun 30 14:17:35 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jun 30 14:17:36 volumio volumio[1501]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Disable UI controls during DLNA playback
- Fix for Cast functionality halting due to memory filling up
- Fix for XML parsing on web-radio search
NEW ADDITIONS
- Add link for downloading CORRD in the side-menu
","title":"Update v3.818","updateavailable":true}
Jun 30 14:17:36 volumio volumio[1501]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jun 30 14:18:05 volumio volumio[1501]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 14:18:05 volumio volumio[1501]: Error: connect ETIMEDOUT 31.13.95.34:80
Jun 30 14:18:05 volumio volumio[1501]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jun 30 14:18:05 volumio volumio[1501]: errno: -110,
Jun 30 14:18:05 volumio volumio[1501]: code: 'ETIMEDOUT',
Jun 30 14:18:05 volumio volumio[1501]: syscall: 'connect',
Jun 30 14:18:05 volumio volumio[1501]: address: '31.13.95.34',
Jun 30 14:18:05 volumio volumio[1501]: port: 80
Jun 30 14:18:05 volumio volumio[1501]: }
Jun 30 14:18:05 volumio volumio[1501]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 14:18:06 volumio sudo[3131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 14:17
Jun 30 14:18:06 volumio sudo[3131]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"