-- Logs begin at Thu 2025-02-27 18:48:23 +08, end at Sat 2025-03-15 12:19:47 +08. -- Mar 15 12:18:04 volumio kernel: hwmon hwmon1: Voltage normalised Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 15 12:18:06 volumio volumio[6571]: info: Adding plugin bluetooth to MyMusic Plugins Mar 15 12:18:06 volumio volumio[6571]: info: Adding plugin multiroom to MyMusic Plugins Mar 15 12:18:06 volumio volumio[6571]: info: Adding plugin metavolumio to MyMusic Plugins Mar 15 12:18:06 volumio volumio[6571]: info: Adding plugin cd_controller to MyMusic Plugins Mar 15 12:18:06 volumio volumio[6571]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 15 12:18:06 volumio volumio[6571]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 15 12:18:06 volumio volumio[6571]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 15 12:18:06 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 15 12:18:09 volumio volumio[6571]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 15 12:18:09 volumio volumio[6571]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 15 12:18:09 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 12:18:09 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 12:18:09 volumio volumio[6571]: info: Starting MyVolumio Remote Streaming Endpoints Mar 15 12:18:09 volumio volumio[6571]: info: MyVolumio not started Mar 15 12:18:09 volumio volumio[6571]: info: Initializing device activation check Mar 15 12:18:09 volumio volumio[6571]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 15 12:18:09 volumio volumio[6571]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 15 12:18:12 volumio volumio[6571]: info: Starting Streaming Service Transparent Proxy Mar 15 12:18:12 volumio volumio[6571]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 15 12:18:12 volumio volumio[6571]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 15 12:18:12 volumio volumio[6571]: info: Streaming services startup Mar 15 12:18:12 volumio volumio[6571]: info: Starting Streaming Daemon Mar 15 12:18:12 volumio sudo[6885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 15 12:18:12 volumio sudo[6885]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 12:18:12 volumio volumio[6571]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 15 12:18:12 volumio sudo[6885]: pam_unix(sudo:session): session closed for user root Mar 15 12:18:12 volumio volumio[6571]: error: Cannot start Volumio Streaming Daemon Mar 15 12:18:12 volumio volumio[6571]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 15 12:18:12 volumio volumio[6571]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 15 12:18:14 volumio volumio[6571]: STREAMING PROXY: Starting server on port 3245 Mar 15 12:18:14 volumio volumio[6571]: Node JS runtime: 14 Mar 15 12:18:24 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 15 12:18:24 volumio volumio[6571]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 15 12:18:24 volumio volumio[6571]: info: CoreCommandRouter::volumioGetState Mar 15 12:18:24 volumio volumio[6571]: info: CorePlayQueue::getTrack 0 Mar 15 12:18:29 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 15 12:18:29 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 15 12:18:29 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 15 12:18:29 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 15 12:18:29 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 15 12:18:29 volumio volumio[6571]: info: CoreCommandRouter::volumioGetBrowseSources Mar 15 12:18:29 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 15 12:18:32 volumio volumio[6571]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 15 12:18:32 volumio volumio[6571]: info: Completed starting MyVolumio Plugin Mar 15 12:18:32 volumio volumio[6571]: [Metrics] CommandRouter: 78s 59.08ms Mar 15 12:18:32 volumio volumio[6571]: info: CoreCommandRouter::volumiosetStartupVolume Mar 15 12:18:32 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 15 12:18:32 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 15 12:18:32 volumio volumio[6571]: info: CoreCommandRouter::Close All Modals sent Mar 15 12:18:32 volumio volumio[6571]: info: CoreCommandRouter::Close All Modals sent Mar 15 12:18:33 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 15 12:18:33 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 15 12:18:33 volumio volumio[6571]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 15 12:18:39 volumio volumio[6571]: info: BOOT COMPLETED Mar 15 12:18:48 volumio kernel: hwmon hwmon1: Voltage normalised Mar 15 12:18:50 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 15 12:18:56 volumio kernel: hwmon hwmon1: Voltage normalised Mar 15 12:18:56 volumio systemd[1]: mpd.service: State 'stop-sigterm' timed out. Killing. Mar 15 12:18:56 volumio systemd[1]: mpd.service: Killing process 4457 (mpd) with signal SIGKILL. Mar 15 12:18:56 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=9/KILL Mar 15 12:18:56 volumio systemd[1]: mpd.service: Failed with result 'timeout'. Mar 15 12:18:56 volumio systemd[1]: Stopped Music Player Daemon. Mar 15 12:18:56 volumio systemd[1]: Starting Music Player Daemon... Mar 15 12:18:57 volumio sudo[6998]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 15 12:18:57 volumio sudo[6998]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 12:18:57 volumio sudo[6998]: pam_unix(sudo:session): session closed for user root Mar 15 12:18:58 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 15 12:19:00 volumio mpd[7000]: Mar 15 12:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 15 12:19:00 volumio systemd[1]: Started Music Player Daemon. Mar 15 12:19:00 volumio mpd_monitor.sh[602]: MPD Monitor Service: MPD restarted due to no mpc output. Mar 15 12:19:00 volumio sudo[6694]: pam_unix(sudo:session): session closed for user root Mar 15 12:19:00 volumio sudo[6703]: pam_unix(sudo:session): session closed for user root Mar 15 12:19:00 volumio volumio[6571]: error: MPD error: The expression evaluated to a falsy value: Mar 15 12:19:00 volumio volumio[6571]: assert.ok(self.idling) Mar 15 12:19:00 volumio volumio[6571]: error: The expression evaluated to a falsy value: Mar 15 12:19:00 volumio volumio[6571]: assert.ok(self.idling) Mar 15 12:19:00 volumio volumio[6571]: info: MPD running with PID7000 Mar 15 12:19:00 volumio volumio[6571]: ,establishing connection Mar 15 12:19:00 volumio volumio[6571]: error: updateQueue error: null Mar 15 12:19:00 volumio volumio[6571]: error: updateQueue error: null Mar 15 12:19:05 volumio volumio[6571]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 15 12:19:15 volumio kernel: hwmon hwmon1: Voltage normalised Mar 15 12:19:21 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 15 12:19:27 volumio kernel: hwmon hwmon1: Voltage normalised Mar 15 12:19:29 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 15 12:19:38 volumio kernel: hwmon hwmon1: Voltage normalised Mar 15 12:19:40 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 15 12:19:46 volumio volumio[6571]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 12:19:46 volumio volumio[6571]: Error: connect ETIMEDOUT 108.160.172.1:80 Mar 15 12:19:46 volumio volumio[6571]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 15 12:19:46 volumio volumio[6571]: errno: -110, Mar 15 12:19:46 volumio volumio[6571]: code: 'ETIMEDOUT', Mar 15 12:19:46 volumio volumio[6571]: syscall: 'connect', Mar 15 12:19:46 volumio volumio[6571]: address: '108.160.172.1', Mar 15 12:19:46 volumio volumio[6571]: port: 80 Mar 15 12:19:46 volumio volumio[6571]: } Mar 15 12:19:46 volumio volumio[6571]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 12:19:47 volumio sudo[7139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-15 12:18 Mar 15 12:19:47 volumio sudo[7139]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"