-- Logs begin at Thu 2019-02-14 18:12:06 CST, end at Mon 2026-05-25 12:01:04 CST. -- May 25 12:00:02 volumio volumio[2622]: verbose: New Socket.io Connection to 192.168.5.108:3000 from 192.168.5.15 UA: Dart/3.10 (dart:io) Total Clients: 8 May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 12:00:02 volumio volumio[2622]: info: Discovery: Getting this device information May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:02 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 12:00:02 volumio volumio[2622]: info: Discovery: Getting this device information May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:02 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 12:00:02 volumio volumio[2622]: info: Discovery: Getting this device information May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:02 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 25 12:00:02 volumio volumio[2622]: verbose: New Socket.io Connection to 192.168.5.108:3000 from 192.168.5.15 UA: Dart/3.10 (dart:io) Total Clients: 9 May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone May 25 12:00:02 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 25 12:00:02 volumio sudo[3313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 25 12:00:02 volumio sudo[3313]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:02 volumio sudo[3313]: pam_unix(sudo:session): session closed for user root May 25 12:00:02 volumio sudo[3318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 25 12:00:02 volumio sudo[3318]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:02 volumio sudo[3326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 25 12:00:02 volumio sudo[3326]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:02 volumio sudo[3332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 25 12:00:03 volumio sudo[3332]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:03 volumio sudo[3343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 12:00:03 volumio sudo[3318]: pam_unix(sudo:session): session closed for user root May 25 12:00:03 volumio sudo[3326]: pam_unix(sudo:session): session closed for user root May 25 12:00:03 volumio sudo[3343]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:03 volumio sudo[3343]: pam_unix(sudo:session): session closed for user root May 25 12:00:03 volumio sudo[3347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 12:00:03 volumio sudo[3347]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:03 volumio sudo[3332]: pam_unix(sudo:session): session closed for user root May 25 12:00:03 volumio sudo[3347]: pam_unix(sudo:session): session closed for user root May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 12:00:03 volumio volumio[2622]: info: Discovery: Getting this device information May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:03 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 12:00:03 volumio volumio[2622]: info: Discovery: Getting this device information May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:03 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:03 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:03 volumio volumio[2622]: verbose: New Socket.io Connection to 192.168.5.108:3000 from 192.168.5.15 UA: Dart/3.10 (dart:io) Total Clients: 9 May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 25 12:00:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 25 12:00:04 volumio sudo[3360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 12:00:04 volumio sudo[3360]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:04 volumio sudo[3360]: pam_unix(sudo:session): session closed for user root May 25 12:00:04 volumio sudo[3362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 12:00:04 volumio sudo[3362]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:04 volumio sudo[3362]: pam_unix(sudo:session): session closed for user root May 25 12:00:04 volumio volumio[2622]: verbose: New Socket.io Connection to 192.168.5.108 from 192.168.5.15 UA: Mozilla/5.0 (Linux; Android 16; PGEM10 Build/BP2A.250605.015; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/147.0.7727.55 Mobile Safari/537.36 Total Clients: 9 May 25 12:00:04 volumio sudo[3369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 12:00:04 volumio sudo[3369]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:04 volumio sudo[3369]: pam_unix(sudo:session): session closed for user root May 25 12:00:04 volumio sudo[3371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 12:00:04 volumio sudo[3371]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:04 volumio sudo[3371]: pam_unix(sudo:session): session closed for user root May 25 12:00:04 volumio volumio[2622]: verbose: New Socket.io Connection to 192.168.5.108 from 192.168.5.15 UA: Mozilla/5.0 (Linux; Android 16; PGEM10 Build/BP2A.250605.015; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/147.0.7727.55 Mobile Safari/537.36 Total Clients: 10 May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::volumioGetVisibleSources May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:04 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::volumioGetQueue May 25 12:00:04 volumio volumio[2622]: info: CoreStateMachine::getQueue May 25 12:00:04 volumio volumio[2622]: info: CorePlayQueue::getQueue May 25 12:00:04 volumio volumio[2622]: info: Listing playlists May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 12:00:04 volumio volumio[2622]: info: Received Get System Info May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 12:00:04 volumio volumio[2622]: info: Discovery: Getting this device information May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:04 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:04 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 25 12:00:04 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 25 12:00:05 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 25 12:00:06 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 25 12:00:06 volumio volumio[2622]: info: Received Get System Info May 25 12:00:06 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 12:00:06 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 12:00:06 volumio volumio[2622]: info: Discovery: Getting this device information May 25 12:00:06 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:06 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:06 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 12:00:10 volumio volumio[2622]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 12:00:11 volumio volumio[2622]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory May 25 12:00:11 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 25 12:00:11 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 25 12:00:11 volumio sudo[3383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 25 12:00:11 volumio sudo[3383]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:11 volumio sudo[3383]: pam_unix(sudo:session): session closed for user root May 25 12:00:11 volumio sudo[3388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 25 12:00:11 volumio sudo[3388]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:11 volumio sudo[3396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 25 12:00:11 volumio sudo[3396]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:11 volumio sudo[3388]: pam_unix(sudo:session): session closed for user root May 25 12:00:11 volumio sudo[3403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 25 12:00:11 volumio sudo[3403]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:11 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 25 12:00:11 volumio sudo[3412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 12:00:11 volumio sudo[3412]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:11 volumio sudo[3396]: pam_unix(sudo:session): session closed for user root May 25 12:00:11 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 25 12:00:11 volumio sudo[3412]: pam_unix(sudo:session): session closed for user root May 25 12:00:11 volumio sudo[3403]: pam_unix(sudo:session): session closed for user root May 25 12:00:11 volumio sudo[3420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 12:00:11 volumio sudo[3420]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:11 volumio sudo[3420]: pam_unix(sudo:session): session closed for user root May 25 12:00:11 volumio sudo[3427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 25 12:00:11 volumio sudo[3427]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:11 volumio sudo[3427]: pam_unix(sudo:session): session closed for user root May 25 12:00:11 volumio volumio[2622]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 25 12:00:11 volumio volumio[2622]: wlan0 Interface doesn't support scanning. May 25 12:00:11 volumio volumio[2622]: info: Cannot use regular scanning, forcing with ap-force May 25 12:00:11 volumio sudo[3434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 25 12:00:11 volumio sudo[3434]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 12:00:11 volumio sudo[3434]: pam_unix(sudo:session): session closed for user root May 25 12:00:11 volumio volumio[2622]: command failed: No such device (-19) May 25 12:00:11 volumio volumio[2622]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 25 12:00:11 volumio volumio[2622]: command failed: No such device (-19) May 25 12:00:12 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 12:00:12 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 12:00:12 volumio volumio[2622]: info: Discovery: Getting this device information May 25 12:00:12 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:12 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:12 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 12:00:12 volumio volumio[2622]: verbose: New Socket.io Connection to 192.168.5.108:3000 from 192.168.5.15 UA: Dart/3.10 (dart:io) Total Clients: 11 May 25 12:00:12 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 25 12:00:12 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 25 12:00:40 volumio volumio[2622]: info: Clearing queue after UPNP request May 25 12:00:40 volumio volumio[2622]: info: CoreStateMachine::ClearQueue May 25 12:00:40 volumio volumio[2622]: info: CoreStateMachine::stop May 25 12:00:40 volumio volumio[2622]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 12:00:40 volumio volumio[2622]: info: CorePlayQueue::clearPlayQueue May 25 12:00:40 volumio volumio[2622]: info: CorePlayQueue::saveQueue May 25 12:00:40 volumio volumio[2622]: info: CoreCommandRouter::volumioPushState May 25 12:00:40 volumio volumio[2622]: info: CoreCommandRouter::volumioPushQueue May 25 12:00:40 volumio volumio[2622]: info: May 25 12:00:40 volumio volumio[2622]: ---------------------------- MPD announces system playlist update May 25 12:00:40 volumio volumio[2622]: info: Ignoring MPD Status Update May 25 12:00:40 volumio volumio[2622]: error: updateQueue error: null May 25 12:00:40 volumio volumio[2622]: info: ------------------------------ 5ms May 25 12:00:40 volumio volumio[2622]: info: Starting UPNP Playback May 25 12:00:40 volumio volumio[2622]: info: Preparing playback through UPNP May 25 12:00:40 volumio volumio[2622]: info: CoreCommandRouter::volumioGetState May 25 12:00:40 volumio volumio[2622]: info: CorePlayQueue::getTrack 0 May 25 12:00:40 volumio volumio[2622]: info: CoreStateMachine::setConsumeUpdateService mpd May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces system playlist update May 25 12:00:41 volumio volumio[2622]: info: Ignoring MPD Status Update May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 5ms May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces system playlist update May 25 12:00:41 volumio volumio[2622]: info: Ignoring MPD Status Update May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces system playlist update May 25 12:00:41 volumio volumio[2622]: info: Ignoring MPD Status Update May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 8ms May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 6ms May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces system playlist update May 25 12:00:41 volumio volumio[2622]: info: Ignoring MPD Status Update May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 4ms May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces system playlist update May 25 12:00:41 volumio volumio[2622]: info: Ignoring MPD Status Update May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 5ms May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces system playlist update May 25 12:00:41 volumio volumio[2622]: info: Ignoring MPD Status Update May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 5ms May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces state update: player May 25 12:00:41 volumio volumio[2622]: info: ControllerMpd::getState May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::sendMpdCommand status May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces state update: player May 25 12:00:41 volumio volumio[2622]: info: ControllerMpd::getState May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::sendMpdCommand status May 25 12:00:41 volumio volumio[2622]: info: sendMpdCommand status took 18 milliseconds May 25 12:00:41 volumio volumio[2622]: info: sendMpdCommand status took 5 milliseconds May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::parseState May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::parseState May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces system playlist update May 25 12:00:41 volumio volumio[2622]: info: Ignoring MPD Status Update May 25 12:00:41 volumio volumio[2622]: info: May 25 12:00:41 volumio volumio[2622]: ---------------------------- MPD announces state update: player May 25 12:00:41 volumio volumio[2622]: info: sendMpdCommand playlistinfo took 15 milliseconds May 25 12:00:41 volumio volumio[2622]: info: sendMpdCommand playlistinfo took 14 milliseconds May 25 12:00:41 volumio volumio[2622]: info: ControllerMpd::getState May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::sendMpdCommand status May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::parseTrackInfo May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::parseTrackInfo May 25 12:00:41 volumio volumio[2622]: info: ControllerMpd::pushState May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::servicePushState May 25 12:00:41 volumio volumio[2622]: verbose: In UPNP mode May 25 12:00:41 volumio volumio[2622]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":194,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱如初见","artist":"村里人贾高兴 (Performer)","album":null,"uri":"http://car-er.kuwo.cn/32ae09805af8862d96a97d53db244076/6a13c968/resource/30106/trackmedia/M500001glXpK3tqekF.mp3","trackType":"mp3"} May 25 12:00:41 volumio volumio[2622]: verbose: CURRENT POSITION 0 May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::syncState stateService play May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::syncState currentStatus stop May 25 12:00:41 volumio volumio[2622]: info: ControllerMpd::pushState May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::servicePushState May 25 12:00:41 volumio volumio[2622]: verbose: In UPNP mode May 25 12:00:41 volumio volumio[2622]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":194,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱如初见","artist":"村里人贾高兴 (Performer)","album":null,"uri":"http://car-er.kuwo.cn/32ae09805af8862d96a97d53db244076/6a13c968/resource/30106/trackmedia/M500001glXpK3tqekF.mp3","trackType":"mp3"} May 25 12:00:41 volumio volumio[2622]: verbose: CURRENT POSITION 0 May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::syncState stateService play May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::syncState currentStatus play May 25 12:00:41 volumio volumio[2622]: info: Received an update from plugin. extracting info from payload May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::pushState May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::volumioPushState May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::pushState May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::volumioPushState May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 105ms May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 142ms May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 124ms May 25 12:00:41 volumio volumio[2622]: info: sendMpdCommand status took 114 milliseconds May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::parseState May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 12:00:41 volumio volumio[2622]: info: sendMpdCommand playlistinfo took 35 milliseconds May 25 12:00:41 volumio volumio[2622]: verbose: ControllerMpd::parseTrackInfo May 25 12:00:41 volumio volumio[2622]: info: ControllerMpd::pushState May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::servicePushState May 25 12:00:41 volumio volumio[2622]: verbose: In UPNP mode May 25 12:00:41 volumio volumio[2622]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":194,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱如初见","artist":"村里人贾高兴","album":"爱如初见","uri":"http://car-er.kuwo.cn/32ae09805af8862d96a97d53db244076/6a13c968/resource/30106/trackmedia/M500001glXpK3tqekF.mp3","trackType":"mp3"} May 25 12:00:41 volumio volumio[2622]: verbose: CURRENT POSITION 0 May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::syncState stateService play May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::syncState currentStatus play May 25 12:00:41 volumio volumio[2622]: info: Received an update from plugin. extracting info from payload May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::pushState May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::volumioPushState May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::pushState May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::volumioPushState May 25 12:00:41 volumio volumio[2622]: info: ------------------------------ 231ms May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::volumioGetQueue May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::getQueue May 25 12:00:41 volumio volumio[2622]: info: CorePlayQueue::getQueue May 25 12:00:41 volumio volumio[2622]: info: CoreCommandRouter::volumioGetQueue May 25 12:00:41 volumio volumio[2622]: info: CoreStateMachine::getQueue May 25 12:00:41 volumio volumio[2622]: info: CorePlayQueue::getQueue May 25 12:01:02 volumio volumio[2815]: 95 May 25 12:01:02 volumio volumio[2815]: % Total % Received % Xferd Average Speed Time Time Time Current May 25 12:01:02 volumio volumio[2815]: Dload Upload Total Spent Left Speed May 25 12:01:02 volumio volumio[2622]: info: May 25 12:01:02 volumio volumio[2622]: ---------------------------- Client requests Volume 95 May 25 12:01:02 volumio volumio[2622]: info: VolumeController::SetAlsaVolume95 May 25 12:01:03 volumio volumio[2622]: info: CoreStateMachine::pushState May 25 12:01:03 volumio volumio[2622]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 12:01:03 volumio volumio[2622]: info: CoreCommandRouter::volumioPushState May 25 12:01:03 volumio volumio[2815]: [158B blob data] May 25 12:01:03 volumio volumio[2815]: {"time":1779681662962,"response":"volume Success"}95 May 25 12:01:03 volumio volumio[2622]: info: CoreCommandRouter::volumioGetQueue May 25 12:01:03 volumio volumio[2622]: info: CoreStateMachine::getQueue May 25 12:01:03 volumio volumio[2622]: info: CorePlayQueue::getQueue May 25 12:01:03 volumio volumio[2622]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 May 25 12:01:03 volumio volumio[2622]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 12:01:03 volumio volumio[2622]: Error: connect ETIMEDOUT 203.111.254.117:443 May 25 12:01:03 volumio volumio[2622]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 25 12:01:03 volumio volumio[2622]: errno: -110, May 25 12:01:03 volumio volumio[2622]: code: 'ETIMEDOUT', May 25 12:01:03 volumio volumio[2622]: syscall: 'connect', May 25 12:01:03 volumio volumio[2622]: address: '203.111.254.117', May 25 12:01:03 volumio volumio[2622]: port: 443 May 25 12:01:03 volumio volumio[2622]: } May 25 12:01:03 volumio volumio[2622]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 12:01:04 volumio sudo[3565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-25 12:00 May 25 12:01:04 volumio sudo[3565]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 21 Oct 2023 12:20:14 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="rockpie" VOLUMIO_DEVICENAME="RockPi E" VOLUMIO_HASH="9324f16779958d03cb8ac5fdddcb0054"