-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Mon 2024-07-22 11:59:09 CST. -- Jul 22 11:58:00 volumio volumio[4939]: info: CoreStateMachine::pushState Jul 22 11:58:00 volumio volumio[4939]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::volumioPushState Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 11:58:00 volumio volumio[4939]: info: CoreStateMachine::updateTrackBlock Jul 22 11:58:00 volumio volumio[4939]: info: CorePlayQueue::getTrackBlock Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::volumioRetrievevolume Jul 22 11:58:00 volumio volumio[4939]: info: MPD running with PID2323 Jul 22 11:58:00 volumio volumio[4939]: ,establishing connection Jul 22 11:58:00 volumio sudo[5095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 22 11:58:00 volumio sudo[5095]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:00 volumio hostapd[2384]: wlan0: STA 14:d8:64:4c:f2:43 IEEE 802.11: deauthenticated due to inactivity (timer DEAUTH/REMOVE) Jul 22 11:58:00 volumio sudo[5100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 11:58:00 volumio sudo[5095]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:00 volumio sudo[5100]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:00 volumio sudo[5100]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:00 volumio kernel: wlan0: deauthenticated from 14:d8:64:4c:f2:43 (Reason: 6=CLASS2_FRAME_FROM_NONAUTH_STA) Jul 22 11:58:00 volumio avahi-daemon[2107]: Withdrawing address record for 192.168.23.121 on wlan0. Jul 22 11:58:00 volumio systemd-networkd[2139]: wlan0: Lost carrier Jul 22 11:58:00 volumio avahi-daemon[2107]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.23.121. Jul 22 11:58:00 volumio systemd-networkd[2139]: wlan0: DHCP lease lost Jul 22 11:58:00 volumio hostapd[2384]: wlan0: STA 14:d8:64:4c:f2:43 IEEE 802.11: disassociated Jul 22 11:58:00 volumio avahi-daemon[2107]: Interface wlan0.IPv4 no longer relevant for mDNS. Jul 22 11:58:00 volumio wpa_supplicant[2436]: wlan0: CTRL-EVENT-DISCONNECTED bssid=14:d8:64:4c:f2:43 reason=0 Jul 22 11:58:00 volumio rc.local[2329]: [2024-07-22 11:58:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1721620677 101 Jul 22 11:58:00 volumio rc.local[2329]: sio connected Jul 22 11:58:00 volumio volumio[4939]: info: CoreStateMachine::pushState Jul 22 11:58:00 volumio volumio[4939]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::volumioPushState Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 22 11:58:00 volumio volumio[4939]: info: CoreCommandRouter::volumioGetState Jul 22 11:58:00 volumio volumio[4939]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:01 volumio volumio[4939]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jul 22 11:58:01 volumio volumio[4939]: sudo: /usr/sbin/i2cdetect: command not found Jul 22 11:58:01 volumio volumio[4939]: info: Reloading queue from file Jul 22 11:58:01 volumio volumio[4939]: error: updateQueue error: null Jul 22 11:58:01 volumio volumio[4939]: info: CoreStateMachine::setRepeat null single undefined Jul 22 11:58:01 volumio volumio[4939]: info: CoreStateMachine::pushState Jul 22 11:58:01 volumio volumio[4939]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:01 volumio volumio[4939]: info: CoreCommandRouter::volumioPushState Jul 22 11:58:01 volumio volumio[4939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 11:58:01 volumio volumio[4939]: info: CoreStateMachine::setRandom null Jul 22 11:58:01 volumio volumio[4939]: info: CoreStateMachine::pushState Jul 22 11:58:01 volumio volumio[4939]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:01 volumio volumio[4939]: info: CoreCommandRouter::volumioPushState Jul 22 11:58:01 volumio volumio[4939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 11:58:01 volumio volumio[4939]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 11:58:01 volumio volumio[4939]: TypeError: Cannot read property 'UUID' of undefined Jul 22 11:58:01 volumio volumio[4939]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:174:53) Jul 22 11:58:01 volumio volumio[4939]: at emitTwo (events.js:126:13) Jul 22 11:58:01 volumio volumio[4939]: at Browser.emit (events.js:214:7) Jul 22 11:58:01 volumio volumio[4939]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jul 22 11:58:01 volumio volumio[4939]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Jul 22 11:58:01 volumio volumio[4939]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jul 22 11:58:01 volumio volumio[4939]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Jul 22 11:58:01 volumio volumio[4939]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Jul 22 11:58:01 volumio volumio[4939]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 11:58:02 volumio wpa_supplicant[2436]: wlan0: Trying to associate with 14:d8:64:4c:f2:43 (SSID='FORTEX' freq=2412 MHz) Jul 22 11:58:02 volumio wpa_supplicant[2436]: Failed to add supported operating classes IE Jul 22 11:58:02 volumio kernel: wlan0: authenticate with 14:d8:64:4c:f2:43 Jul 22 11:58:02 volumio kernel: wlan0: send auth to 14:d8:64:4c:f2:43 (try 1/3) Jul 22 11:58:02 volumio kernel: wlan0: authenticated Jul 22 11:58:02 volumio kernel: wlan0: associate with 14:d8:64:4c:f2:43 (try 1/3) Jul 22 11:58:02 volumio kernel: wlan0: RX AssocResp from 14:d8:64:4c:f2:43 (capab=0x1c11 status=0 aid=2) Jul 22 11:58:02 volumio kernel: wlan0: associated Jul 22 11:58:02 volumio wpa_supplicant[2436]: wlan0: Associated with 14:d8:64:4c:f2:43 Jul 22 11:58:02 volumio systemd-networkd[2139]: wlan0: Gained carrier Jul 22 11:58:02 volumio wpa_supplicant[2436]: wlan0: WPA: Key negotiation completed with 14:d8:64:4c:f2:43 [PTK=CCMP GTK=CCMP] Jul 22 11:58:02 volumio wpa_supplicant[2436]: wlan0: CTRL-EVENT-CONNECTED - Connection to 14:d8:64:4c:f2:43 completed [id=0 id_str=] Jul 22 11:58:02 volumio kernel: wlan0: Limiting TX power to 35 (35 - 0) dBm as advertised by 14:d8:64:4c:f2:43 Jul 22 11:58:03 volumio sudo[5134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 11:57 Jul 22 11:58:03 volumio sudo[5134]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:03 volumio sudo[5134]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:03 volumio rc.local[2329]: [2024-07-22 11:58:03] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 22 11:58:03 volumio rc.local[2329]: [2024-07-22 11:58:03] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 22 11:58:03 volumio rc.local[5121]: curl: (56) Recv failure: Connection reset by peer Jul 22 11:58:03 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 22 11:58:03 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 22 11:58:03 volumio systemd[1]: Started dynamicswap service. Jul 22 11:58:03 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 22 11:58:03 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12. Jul 22 11:58:03 volumio systemd[1]: Started dynamicswap service. Jul 22 11:58:03 volumio systemd[1]: Stopped Volumio Backend Module. Jul 22 11:58:03 volumio systemd[1]: Started Volumio Backend Module. Jul 22 11:58:03 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 22 11:58:04 volumio rc.local[5168]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:04 volumio rc.local[5171]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:05 volumio rc.local[5173]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:06 volumio systemd-networkd[2139]: wlan0: DHCPv4 address 192.168.23.121/24 via 192.168.23.1 Jul 22 11:58:06 volumio avahi-daemon[2107]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.23.121. Jul 22 11:58:06 volumio avahi-daemon[2107]: New relevant interface wlan0.IPv4 for mDNS. Jul 22 11:58:06 volumio avahi-daemon[2107]: Registering new address record for 192.168.23.121 on wlan0.IPv4. Jul 22 11:58:07 volumio volumio[5154]: info: ------------------------------------------- Jul 22 11:58:07 volumio volumio[5154]: info: ----- Volumio2 ---- Jul 22 11:58:07 volumio volumio[5154]: info: ------------------------------------------- Jul 22 11:58:07 volumio volumio[5154]: info: ----- System startup ---- Jul 22 11:58:07 volumio volumio[5154]: info: ------------------------------------------- Jul 22 11:58:08 volumio volumio[5154]: info: Plugin folders cleanup Jul 22 11:58:08 volumio volumio[5154]: info: Scanning into folder /volumio/app/plugins/ Jul 22 11:58:08 volumio volumio[5154]: info: Scanning category audio_interface Jul 22 11:58:08 volumio volumio[5154]: info: Scanning category miscellanea Jul 22 11:58:08 volumio rc.local[2329]: [2024-07-22 11:58:08] [connect] Successful connection Jul 22 11:58:08 volumio volumio[5154]: info: Scanning category music_service Jul 22 11:58:08 volumio volumio[5154]: info: Scanning category plugins.json Jul 22 11:58:08 volumio volumio[5154]: info: Scanning category system_controller Jul 22 11:58:08 volumio volumio[5154]: info: Scanning category user_interface Jul 22 11:58:08 volumio volumio[5154]: info: Scanning into folder /data/plugins/ Jul 22 11:58:08 volumio volumio[5154]: info: Plugin folders cleanup completed Jul 22 11:58:08 volumio volumio[5154]: info: ------------------------------------------- Jul 22 11:58:08 volumio volumio[5154]: info: ----- Core plugins startup ---- Jul 22 11:58:08 volumio volumio[5154]: info: ------------------------------------------- Jul 22 11:58:08 volumio volumio[5154]: info: Loading plugins from folder /volumio/app/plugins/ Jul 22 11:58:08 volumio volumio[5154]: info: Adding plugin upnp to MyMusic Plugins Jul 22 11:58:08 volumio volumio[5154]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 22 11:58:08 volumio volumio[5154]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 22 11:58:08 volumio volumio[5154]: info: Loading plugins from folder /data/plugins/ Jul 22 11:58:08 volumio volumio[5154]: info: Loading plugin "system"... Jul 22 11:58:08 volumio volumio[5154]: info: Loading plugin "appearance"... Jul 22 11:58:12 volumio volumio[5154]: info: Loading plugin "network"... Jul 22 11:58:12 volumio volumio[5154]: info: Refreshing Cached IP Addresses Jul 22 11:58:12 volumio sudo[5191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 22 11:58:12 volumio volumio[5154]: info: Loading plugin "services"... Jul 22 11:58:12 volumio volumio[5154]: info: Loading plugin "alsa_controller"... Jul 22 11:58:12 volumio sudo[5191]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:12 volumio sudo[5191]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:12 volumio volumio[5154]: info: Loading plugin "wizard"... Jul 22 11:58:12 volumio volumio[5154]: info: Loading plugin "volumio_command_line_client"... Jul 22 11:58:12 volumio sudo[5196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 11:58:13 volumio sudo[5196]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:13 volumio sudo[5196]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:13 volumio volumio[5154]: info: Loading plugin "upnp"... Jul 22 11:58:13 volumio volumio[5154]: info: [1721620693118] Starting Upmpd Daemon Jul 22 11:58:13 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 22 11:58:13 volumio volumio[5154]: info: Loading plugin "my_music"... Jul 22 11:58:13 volumio volumio[5154]: info: Loading plugin "mpd"... Jul 22 11:58:13 volumio volumio[5154]: info: Loading plugin "upnp_browser"... Jul 22 11:58:14 volumio volumio[5154]: info: Loading plugin "networkfs"... Jul 22 11:58:14 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 22 11:58:14 volumio volumio[5154]: info: Loading plugin "alarm-clock"... Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "airplay_emulation"... Jul 22 11:58:15 volumio volumio[5154]: info: Starting Shairport Sync Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "last_100"... Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "webradio"... Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "i2s_dacs"... Jul 22 11:58:15 volumio volumio[5154]: info: I2S DAC not set, start Auto-detection Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "volumiodiscovery"... Jul 22 11:58:15 volumio volumio[5154]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 22 11:58:15 volumio volumio[5154]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 11:58:15 volumio node[5154]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 22 11:58:15 volumio volumio[5154]: *** WARNING *** For more information see Jul 22 11:58:15 volumio volumio[5154]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 22 11:58:15 volumio volumio[5154]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 11:58:15 volumio volumio[5154]: *** WARNING *** For more information see Jul 22 11:58:15 volumio node[5154]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 11:58:15 volumio node[5154]: *** WARNING *** For more information see Jul 22 11:58:15 volumio node[5154]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 22 11:58:15 volumio node[5154]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 11:58:15 volumio node[5154]: *** WARNING *** For more information see Jul 22 11:58:15 volumio volumio[5154]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 22 11:58:15 volumio volumio[5154]: Discovery: StartAdv! undefined Jul 22 11:58:15 volumio volumio[5154]: Discovery: Started advertising... Volumio - undefined Jul 22 11:58:15 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "outputs"... Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "albumart"... Jul 22 11:58:15 volumio volumio[5154]: info: Plugin example_plugin is not enabled Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "inputs"... Jul 22 11:58:15 volumio volumio[5154]: info: Loading plugin "updater_comm"... Jul 22 11:58:16 volumio volumio[5154]: info: Plugin mpdemulation is not enabled Jul 22 11:58:16 volumio volumio[5154]: info: Loading plugin "rest_api"... Jul 22 11:58:16 volumio volumio[5154]: info: Loading plugin "websocket"... Jul 22 11:58:16 volumio volumio[5154]: info: ___________ START PLUGINS ___________ Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 22 11:58:16 volumio volumio[5154]: info: [1721620696395] CoreMusicLibrary::Adding element Media Servers Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 22 11:58:16 volumio volumio[5154]: info: [1721620696606] CoreMusicLibrary::Adding element Last_100 Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 22 11:58:16 volumio volumio[5154]: info: [1721620696620] CoreMusicLibrary::Adding element Webradio Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 22 11:58:16 volumio volumio[5220]: Forking 1 albumart workers Jul 22 11:58:16 volumio volumio[5154]: info: Loading i18n strings for locale zh Jul 22 11:58:16 volumio volumio[5154]: Updating browse sources language Jul 22 11:58:16 volumio volumio[5154]: Cannot find translation for sourceMedia Servers Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::initPlayerControls Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 11:58:16 volumio volumio[5154]: info: BOOT COMPLETED Jul 22 11:58:16 volumio volumio[5154]: [Metrics] CommandRouter: 9s 950.50ms Jul 22 11:58:17 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 11:58:17 volumio kernel: sunxi-spdif 2036000.spdif: active: 1 Jul 22 11:58:18 volumio volumio[5232]: Starting albumart workers Jul 22 11:58:21 volumio rc.local[2329]: [2024-07-22 11:58:20] [connect] Successful connection Jul 22 11:58:22 volumio volumio[5154]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 22 11:58:22 volumio volumio[5154]: info: CoreCommandRouter::Close All Modals sent Jul 22 11:58:22 volumio volumio[5154]: info: CoreCommandRouter::Close All Modals sent Jul 22 11:58:22 volumio volumio[5154]: Express server listening on port 3000 Jul 22 11:58:22 volumio volumio[5154]: [Metrics] WebUI: 16s 376.89ms Jul 22 11:58:22 volumio volumio[5154]: info: Cannot retrieve data for calling home Jul 22 11:58:22 volumio volumio[5154]: info: CoreStateMachine::resetVolumioState Jul 22 11:58:22 volumio volumio[5154]: info: CoreStateMachine::getcurrentVolume Jul 22 11:58:22 volumio volumio[5154]: info: CoreCommandRouter::volumioRetrievevolume Jul 22 11:58:22 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 11:58:22 volumio volumio[5154]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 22 11:58:23 volumio volumio[5154]: info: CoreStateMachine::pushState Jul 22 11:58:23 volumio volumio[5154]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::volumioPushState Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 11:58:23 volumio volumio[5154]: info: CoreStateMachine::updateTrackBlock Jul 22 11:58:23 volumio volumio[5154]: info: CorePlayQueue::getTrackBlock Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::volumioRetrievevolume Jul 22 11:58:23 volumio volumio[5154]: info: MPD running with PID2323 Jul 22 11:58:23 volumio volumio[5154]: ,establishing connection Jul 22 11:58:23 volumio sudo[5270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 22 11:58:23 volumio sudo[5270]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:23 volumio sudo[5270]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:23 volumio sudo[5274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 11:58:23 volumio rc.local[2329]: [2024-07-22 11:58:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1721620700 101 Jul 22 11:58:23 volumio rc.local[2329]: sio connected Jul 22 11:58:23 volumio volumio[5154]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jul 22 11:58:23 volumio volumio[5154]: sudo: /usr/sbin/i2cdetect: command not found Jul 22 11:58:23 volumio volumio[5154]: info: CoreStateMachine::pushState Jul 22 11:58:23 volumio volumio[5154]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::volumioPushState Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 22 11:58:23 volumio sudo[5274]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:23 volumio sudo[5274]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 22 11:58:23 volumio volumio[5154]: info: CoreCommandRouter::volumioGetState Jul 22 11:58:23 volumio volumio[5154]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:24 volumio volumio[5154]: info: Reloading queue from file Jul 22 11:58:24 volumio volumio[5154]: error: updateQueue error: null Jul 22 11:58:24 volumio volumio[5154]: info: CoreStateMachine::setRepeat null single undefined Jul 22 11:58:24 volumio volumio[5154]: info: CoreStateMachine::pushState Jul 22 11:58:24 volumio volumio[5154]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:24 volumio volumio[5154]: info: CoreCommandRouter::volumioPushState Jul 22 11:58:24 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 11:58:24 volumio volumio[5154]: info: CoreStateMachine::setRandom null Jul 22 11:58:24 volumio volumio[5154]: info: CoreStateMachine::pushState Jul 22 11:58:24 volumio volumio[5154]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:24 volumio volumio[5154]: info: CoreCommandRouter::volumioPushState Jul 22 11:58:24 volumio volumio[5154]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 11:58:25 volumio volumio[5154]: info: CoreCommandRouter::volumioGetState Jul 22 11:58:25 volumio volumio[5154]: info: CorePlayQueue::getTrack 0 Jul 22 11:58:25 volumio volumio[5154]: info: Starting Shairport Sync Jul 22 11:58:25 volumio volumio[5154]: info: Starting Shairport Sync Jul 22 11:58:25 volumio volumio[5154]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 11:58:25 volumio volumio[5154]: TypeError: Cannot read property 'UUID' of undefined Jul 22 11:58:25 volumio volumio[5154]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:174:53) Jul 22 11:58:25 volumio volumio[5154]: at emitTwo (events.js:126:13) Jul 22 11:58:25 volumio volumio[5154]: at Browser.emit (events.js:214:7) Jul 22 11:58:25 volumio volumio[5154]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jul 22 11:58:25 volumio volumio[5154]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Jul 22 11:58:25 volumio volumio[5154]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jul 22 11:58:25 volumio volumio[5154]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Jul 22 11:58:25 volumio volumio[5154]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Jul 22 11:58:25 volumio volumio[5154]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 11:58:25 volumio sudo[5298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 11:58:25 volumio sudo[5300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 11:58:25 volumio sudo[5298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:25 volumio sudo[5300]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 11:58:26 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 22 11:58:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 22 11:58:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 11:58:26 volumio sudo[5300]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:26 volumio sudo[5298]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:27 volumio sudo[5336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 11:57 Jul 22 11:58:27 volumio sudo[5336]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 11:58:27 volumio sudo[5336]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:27 volumio rc.local[2329]: [2024-07-22 11:58:27] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 22 11:58:27 volumio rc.local[2329]: [2024-07-22 11:58:27] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 22 11:58:27 volumio rc.local[5319]: curl: (56) Recv failure: Connection reset by peer Jul 22 11:58:27 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 22 11:58:28 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 22 11:58:28 volumio systemd[1]: Started dynamicswap service. Jul 22 11:58:28 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 22 11:58:28 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 13. Jul 22 11:58:28 volumio systemd[1]: Started dynamicswap service. Jul 22 11:58:28 volumio systemd[1]: Stopped Volumio Backend Module. Jul 22 11:58:28 volumio systemd[1]: Started Volumio Backend Module. Jul 22 11:58:28 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 22 11:58:28 volumio rc.local[5370]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:29 volumio rc.local[5372]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:30 volumio rc.local[5374]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:30 volumio rc.local[5376]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:31 volumio volumio[5356]: info: ------------------------------------------- Jul 22 11:58:31 volumio volumio[5356]: info: ----- Volumio2 ---- Jul 22 11:58:31 volumio volumio[5356]: info: ------------------------------------------- Jul 22 11:58:31 volumio volumio[5356]: info: ----- System startup ---- Jul 22 11:58:31 volumio volumio[5356]: info: ------------------------------------------- Jul 22 11:58:32 volumio rc.local[2329]: [2024-07-22 11:58:32] [connect] Successful connection Jul 22 11:58:33 volumio volumio[5356]: info: Plugin folders cleanup Jul 22 11:58:33 volumio volumio[5356]: info: Scanning into folder /volumio/app/plugins/ Jul 22 11:58:33 volumio volumio[5356]: info: Scanning category audio_interface Jul 22 11:58:33 volumio volumio[5356]: info: Scanning category miscellanea Jul 22 11:58:33 volumio volumio[5356]: info: Scanning category music_service Jul 22 11:58:33 volumio volumio[5356]: info: Scanning category plugins.json Jul 22 11:58:33 volumio volumio[5356]: info: Scanning category system_controller Jul 22 11:58:33 volumio volumio[5356]: info: Scanning category user_interface Jul 22 11:58:33 volumio volumio[5356]: info: Scanning into folder /data/plugins/ Jul 22 11:58:33 volumio volumio[5356]: info: Plugin folders cleanup completed Jul 22 11:58:33 volumio volumio[5356]: info: ------------------------------------------- Jul 22 11:58:33 volumio volumio[5356]: info: ----- Core plugins startup ---- Jul 22 11:58:33 volumio volumio[5356]: info: ------------------------------------------- Jul 22 11:58:33 volumio volumio[5356]: info: Loading plugins from folder /volumio/app/plugins/ Jul 22 11:58:33 volumio volumio[5356]: info: Adding plugin upnp to MyMusic Plugins Jul 22 11:58:33 volumio volumio[5356]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 22 11:58:33 volumio volumio[5356]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 22 11:58:33 volumio volumio[5356]: info: Loading plugins from folder /data/plugins/ Jul 22 11:58:33 volumio volumio[5356]: info: Loading plugin "system"... Jul 22 11:58:33 volumio volumio[5356]: info: Loading plugin "appearance"... Jul 22 11:58:34 volumio sudo[5392]: root : TTY=ttyAS0 ; PWD=/root ; USER=root ; COMMAND=/usr/bin/systemctl stop volumio.service Jul 22 11:58:34 volumio sudo[5392]: pam_unix(sudo:session): session opened for user root by root(uid=0) Jul 22 11:58:34 volumio systemd[1]: Stopping Volumio Backend Module... Jul 22 11:58:34 volumio rc.local[5378]: curl: (56) Recv failure: Connection reset by peer Jul 22 11:58:34 volumio rc.local[2329]: [2024-07-22 11:58:34] [error] handle_read_http_response error: asio.system:104 (Connection reset by peer) Jul 22 11:58:34 volumio rc.local[2329]: [2024-07-22 11:58:34] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Jul 22 11:58:34 volumio systemd[1]: volumio.service: Succeeded. Jul 22 11:58:34 volumio systemd[1]: Stopped Volumio Backend Module. Jul 22 11:58:34 volumio sudo[5392]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:34 volumio rc.local[5404]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:35 volumio rc.local[5406]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:36 volumio rc.local[5408]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:36 volumio rc.local[5410]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:37 volumio rc.local[5412]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:37 volumio rc.local[5414]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:38 volumio rc.local[5416]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:39 volumio rc.local[5418]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:39 volumio nmbd[2324]: [2024/07/22 11:58:39.380899, 0] ../../source3/nmbd/nmbd_packets.c:1285(process_dgram) Jul 22 11:58:39 volumio nmbd[2324]: process_dgram: ignoring malformed3 (datasize = 494, len=408, off=100) datagram packet sent to name WORKGROUP<00> from IP 192.168.23.127 Jul 22 11:58:39 volumio nmbd[2324]: [2024/07/22 11:58:39.382082, 0] ../../source3/nmbd/nmbd_packets.c:1285(process_dgram) Jul 22 11:58:39 volumio nmbd[2324]: process_dgram: ignoring malformed3 (datasize = 494, len=408, off=100) datagram packet sent to name WORKGROUP<00> from IP 192.168.23.127 Jul 22 11:58:39 volumio nmbd[2324]: [2024/07/22 11:58:39.383161, 0] ../../source3/nmbd/nmbd_packets.c:1285(process_dgram) Jul 22 11:58:39 volumio nmbd[2324]: process_dgram: ignoring malformed3 (datasize = 494, len=408, off=100) datagram packet sent to name WORKGROUP<00> from IP 192.168.23.127 Jul 22 11:58:39 volumio nmbd[2324]: [2024/07/22 11:58:39.477323, 0] ../../source3/nmbd/nmbd_packets.c:1285(process_dgram) Jul 22 11:58:39 volumio nmbd[2324]: process_dgram: ignoring malformed3 (datasize = 494, len=408, off=100) datagram packet sent to name WORKGROUP<00> from IP 192.168.23.127 Jul 22 11:58:39 volumio nmbd[2324]: [2024/07/22 11:58:39.478496, 0] ../../source3/nmbd/nmbd_packets.c:1285(process_dgram) Jul 22 11:58:39 volumio nmbd[2324]: process_dgram: ignoring malformed3 (datasize = 494, len=408, off=100) datagram packet sent to name WORKGROUP<00> from IP 192.168.23.127 Jul 22 11:58:39 volumio nmbd[2324]: [2024/07/22 11:58:39.479407, 0] ../../source3/nmbd/nmbd_packets.c:1285(process_dgram) Jul 22 11:58:39 volumio nmbd[2324]: process_dgram: ignoring malformed3 (datasize = 494, len=408, off=100) datagram packet sent to name WORKGROUP<00> from IP 192.168.23.127 Jul 22 11:58:39 volumio rc.local[5420]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:40 volumio rc.local[5422]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:40 volumio rc.local[5424]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:41 volumio rc.local[5426]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:41 volumio rc.local[2329]: [2024-07-22 11:58:41] [info] asio async_connect error: asio.system:111 (Connection refused) Jul 22 11:58:41 volumio rc.local[2329]: [2024-07-22 11:58:41] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Jul 22 11:58:41 volumio rc.local[2329]: [2024-07-22 11:58:41] [error] handle_connect error: Connection refused Jul 22 11:58:42 volumio rc.local[5428]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:42 volumio rc.local[5430]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:43 volumio rc.local[5432]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:43 volumio rc.local[5434]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:44 volumio rc.local[5449]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:45 volumio rc.local[5486]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:45 volumio rc.local[5488]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:46 volumio rc.local[5490]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:46 volumio rc.local[5492]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:47 volumio rc.local[5494]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:48 volumio rc.local[5496]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:48 volumio rc.local[5504]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:49 volumio rc.local[5506]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:50 volumio rc.local[5508]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:50 volumio rc.local[5510]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 11:58:53 volumio rc.local[2329]: [2024-07-22 11:58:53] [connect] Successful connection Jul 22 11:58:57 volumio sudo[5524]: root : TTY=ttyAS0 ; PWD=/volumio ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 22 11:58:57 volumio sudo[5524]: pam_unix(sudo:session): session opened for user root by root(uid=0) Jul 22 11:58:57 volumio sudo[5526]: root : TTY=ttyAS0 ; PWD=/volumio ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 11:58:57 volumio sudo[5524]: pam_unix(sudo:session): session closed for user root Jul 22 11:58:57 volumio sudo[5526]: pam_unix(sudo:session): session opened for user root by root(uid=0) Jul 22 11:58:57 volumio sudo[5526]: pam_unix(sudo:session): session closed for user root Jul 22 11:59:00 volumio node[5497]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 22 11:59:00 volumio node[5497]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 11:59:00 volumio node[5497]: *** WARNING *** For more information see Jul 22 11:59:00 volumio node[5497]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 22 11:59:00 volumio node[5497]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 11:59:00 volumio node[5497]: *** WARNING *** For more information see Jul 22 11:59:02 volumio kernel: sunxi-spdif 2036000.spdif: active: 1 Jul 22 11:59:07 volumio systemd-resolved[2309]: Grace period over, resuming full feature set (UDP+EDNS0) for DNS server 211.136.192.6. Jul 22 11:59:07 volumio systemd-resolved[2309]: Using degraded feature set (UDP) for DNS server 211.136.192.6. Jul 22 11:59:09 volumio sudo[5599]: volumio : TTY=ttyAS0 ; PWD=/volumio ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 11:58 Jul 22 11:59:09 volumio sudo[5599]: pam_unix(sudo:session): session opened for user root by root(uid=0) NAME="Ubuntu" VERSION="20.04.5 LTS (Focal Fossa)" ID=ubuntu ID_LIKE=debian PRETTY_NAME="Ubuntu 20.04.5 LTS" VERSION_ID="20.04" HOME_URL="https://www.ubuntu.com/" SUPPORT_URL="https://help.ubuntu.com/" BUG_REPORT_URL="https://bugs.launchpad.net/ubuntu/" PRIVACY_POLICY_URL="https://www.ubuntu.com/legal/terms-and-policies/privacy-policy" VERSION_CODENAME=focal UBUNTU_CODENAME=focal VOLUMIO_BUILD_VERSION="" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7"