-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Mon 2024-08-26 12:06:18 CEST. -- Aug 26 12:05:00 volumio sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 12:03 Aug 26 12:05:00 volumio sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:00 volumio sudo[1197]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio sudo[1290]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio sudo[1130]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio sudo[1120]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio wireless.js[1241]: Stopped aP Aug 26 12:05:00 volumio volumio[994]: Terminated Aug 26 12:05:00 volumio volumio[994]: child_process.js:655 Aug 26 12:05:00 volumio volumio[994]: throw err; Aug 26 12:05:00 volumio volumio[994]: ^ Aug 26 12:05:00 volumio volumio[994]: Error: Command failed: /usr/bin/sudo /bin/journalctl --since="2024-08-26 12:03" > /tmp/crashdump Aug 26 12:05:00 volumio volumio[994]: Terminated Aug 26 12:05:00 volumio volumio[994]: at checkExecSyncError (child_process.js:616:11) Aug 26 12:05:00 volumio volumio[994]: at execSync (child_process.js:652:15) Aug 26 12:05:00 volumio volumio[994]: at Object. (/volumio/crashreport.js:14:18) Aug 26 12:05:00 volumio volumio[994]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Aug 26 12:05:00 volumio volumio[994]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Aug 26 12:05:00 volumio volumio[994]: at Module.load (internal/modules/cjs/loader.js:928:32) Aug 26 12:05:00 volumio volumio[994]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Aug 26 12:05:00 volumio volumio[994]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) Aug 26 12:05:00 volumio volumio[994]: at internal/main/run_main_module.js:17:47 { Aug 26 12:05:00 volumio volumio[994]: status: 143, Aug 26 12:05:00 volumio volumio[994]: signal: null, Aug 26 12:05:00 volumio volumio[994]: output: [ Aug 26 12:05:00 volumio volumio[994]: null, Aug 26 12:05:00 volumio volumio[994]: Buffer(0) [Uint8Array] [], Aug 26 12:05:00 volumio volumio[994]: Buffer(11) [Uint8Array] [ Aug 26 12:05:00 volumio volumio[994]: 84, 101, 114, 109, Aug 26 12:05:00 volumio volumio[994]: 105, 110, 97, 116, Aug 26 12:05:00 volumio volumio[994]: 101, 100, 10 Aug 26 12:05:00 volumio volumio[994]: ] Aug 26 12:05:00 volumio volumio[994]: ], Aug 26 12:05:00 volumio volumio[994]: pid: 1289, Aug 26 12:05:00 volumio volumio[994]: stdout: Buffer(0) [Uint8Array] [], Aug 26 12:05:00 volumio volumio[994]: stderr: Buffer(11) [Uint8Array] [ Aug 26 12:05:00 volumio volumio[994]: 84, 101, 114, 109, Aug 26 12:05:00 volumio volumio[994]: 105, 110, 97, 116, Aug 26 12:05:00 volumio volumio[994]: 101, 100, 10 Aug 26 12:05:00 volumio volumio[994]: ] Aug 26 12:05:00 volumio volumio[994]: } Aug 26 12:05:00 volumio volumio[994]: child_process.js:655 Aug 26 12:05:00 volumio volumio[994]: throw err; Aug 26 12:05:00 volumio volumio[994]: ^ Aug 26 12:05:00 volumio volumio[994]: Error: Command failed: /usr/bin/node /volumio/crashreport.js "spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT" Aug 26 12:05:00 volumio volumio[994]: Terminated Aug 26 12:05:00 volumio volumio[994]: child_process.js:655 Aug 26 12:05:00 volumio volumio[994]: throw err; Aug 26 12:05:00 volumio volumio[994]: ^ Aug 26 12:05:00 volumio volumio[994]: Error: Command failed: /usr/bin/sudo /bin/journalctl --since="2024-08-26 12:03" > /tmp/crashdump Aug 26 12:05:00 volumio volumio[994]: Terminated Aug 26 12:05:00 volumio volumio[994]: at checkExecSyncError (child_process.js:616:11) Aug 26 12:05:00 volumio volumio[994]: at execSync (child_process.js:652:15) Aug 26 12:05:00 volumio volumio[994]: at Object. (/volumio/crashreport.js:14:18) Aug 26 12:05:00 volumio volumio[994]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Aug 26 12:05:00 volumio volumio[994]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Aug 26 12:05:00 volumio volumio[994]: at Module.load (internal/modules/cjs/loader.js:928:32) Aug 26 12:05:00 volumio volumio[994]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Aug 26 12:05:00 volumio volumio[994]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) Aug 26 12:05:00 volumio volumio[994]: at internal/main/run_main_module.js:17:47 { Aug 26 12:05:00 volumio volumio[994]: status: 143, Aug 26 12:05:00 volumio volumio[994]: signal: null, Aug 26 12:05:00 volumio volumio[994]: output: [ Aug 26 12:05:00 volumio volumio[994]: null, Aug 26 12:05:00 volumio volumio[994]: Buffer(0) [Uint8Array] [], Aug 26 12:05:00 volumio volumio[994]: Buffer(11) [Uint8Array] [ Aug 26 12:05:00 volumio volumio[994]: 84, 101, 114, 109, Aug 26 12:05:00 volumio volumio[994]: 105, 110, 97, 116, Aug 26 12:05:00 volumio volumio[994]: 101, 100, 10 Aug 26 12:05:00 volumio volumio[994]: ] Aug 26 12:05:00 volumio volumio[994]: ], Aug 26 12:05:00 volumio volumio[994]: pid: 1289, Aug 26 12:05:00 volumio volumio[994]: stdout: Buffer(0) [Uint8Array] [], Aug 26 12:05:00 volumio volumio[994]: stderr: Buffer(11) [Uint8Array] [ Aug 26 12:05:00 volumio volumio[994]: 84, 101, 114, 109, Aug 26 12:05:00 volumio volumio[994]: 105, 110, 97, 116, Aug 26 12:05:00 volumio volumio[994]: 101, 100, 10 Aug 26 12:05:00 volumio volumio[994]: ] Aug 26 12:05:00 volumio volumio[994]: } Aug 26 12:05:00 volumio volumio[994]: at checkExecSyncError (child_process.js:616:11) Aug 26 12:05:00 volumio volumio[994]: at execSync (child_process.js:652:15) Aug 26 12:05:00 volumio volumio[994]: at process. (/volumio/index.js:78:3) Aug 26 12:05:00 volumio volumio[994]: at process.emit (events.js:315:20) Aug 26 12:05:00 volumio volumio[994]: at process._fatalException (internal/process/execution.js:163:25) { Aug 26 12:05:00 volumio volumio[994]: status: 1, Aug 26 12:05:00 volumio volumio[994]: signal: null, Aug 26 12:05:00 volumio volumio[994]: output: [ Aug 26 12:05:00 volumio volumio[994]: null, Aug 26 12:05:00 volumio volumio[994]: Buffer(0) [Uint8Array] [], Aug 26 12:05:00 volumio volumio[994]: Buffer(1076) [Uint8Array] [ Aug 26 12:05:00 volumio volumio[994]: 84, 101, 114, 109, 105, 110, 97, 116, 101, 100, 10, 99, Aug 26 12:05:00 volumio volumio[994]: 104, 105, 108, 100, 95, 112, 114, 111, 99, 101, 115, 115, Aug 26 12:05:00 volumio volumio[994]: 46, 106, 115, 58, 54, 53, 53, 10, 32, 32, 32, 32, Aug 26 12:05:00 volumio volumio[994]: 116, 104, 114, 111, 119, 32, 101, 114, 114, 59, 10, 32, Aug 26 12:05:00 volumio volumio[994]: 32, 32, 32, 94, 10, 10, 69, 114, 114, 111, 114, 58, Aug 26 12:05:00 volumio volumio[994]: 32, 67, 111, 109, 109, 97, 110, 100, 32, 102, 97, 105, Aug 26 12:05:00 volumio volumio[994]: 108, 101, 100, 58, 32, 47, 117, 115, 114, 47, 98, 105, Aug 26 12:05:00 volumio volumio[994]: 110, 47, 115, 117, 100, 111, 32, 47, 98, 105, 110, 47, Aug 26 12:05:00 volumio volumio[994]: 106, 111, 117, 114, Aug 26 12:05:00 volumio volumio[994]: ... 976 more items Aug 26 12:05:00 volumio volumio[994]: ] Aug 26 12:05:00 volumio volumio[994]: ], Aug 26 12:05:00 volumio volumio[994]: pid: 1268, Aug 26 12:05:00 volumio volumio[994]: stdout: Buffer(0) [Uint8Array] [], Aug 26 12:05:00 volumio volumio[994]: stderr: Buffer(1076) [Uint8Array] [ Aug 26 12:05:00 volumio volumio[994]: 84, 101, 114, 109, 105, 110, 97, 116, 101, 100, 10, 99, Aug 26 12:05:00 volumio volumio[994]: 104, 105, 108, 100, 95, 112, 114, 111, 99, 101, 115, 115, Aug 26 12:05:00 volumio volumio[994]: 46, 106, 115, 58, 54, 53, 53, 10, 32, 32, 32, 32, Aug 26 12:05:00 volumio volumio[994]: 116, 104, 114, 111, 119, 32, 101, 114, 114, 59, 10, 32, Aug 26 12:05:00 volumio volumio[994]: 32, 32, 32, 94, 10, 10, 69, 114, 114, 111, 114, 58, Aug 26 12:05:00 volumio volumio[994]: 32, 67, 111, 109, 109, 97, 110, 100, 32, 102, 97, 105, Aug 26 12:05:00 volumio volumio[994]: 108, 101, 100, 58, 32, 47, 117, 115, 114, 47, 98, 105, Aug 26 12:05:00 volumio volumio[994]: 110, 47, 115, 117, 100, 111, 32, 47, 98, 105, 110, 47, Aug 26 12:05:00 volumio volumio[994]: 106, 111, 117, 114, Aug 26 12:05:00 volumio volumio[994]: ... 976 more items Aug 26 12:05:00 volumio volumio[994]: ] Aug 26 12:05:00 volumio volumio[994]: } Aug 26 12:05:00 volumio sudo[1297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 26 12:05:00 volumio sudo[1297]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:00 volumio volumio-remote-updater[680]: [2024-08-26 12:05:00] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 26 12:05:00 volumio volumio-remote-updater[680]: [2024-08-26 12:05:00] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 26 12:05:00 volumio sudo[1297]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 26 12:05:00 volumio sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Aug 26 12:05:00 volumio sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:00 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=7/NOTRUNNING Aug 26 12:05:00 volumio sudo[1193]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 26 12:05:00 volumio sudo[1299]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio systemd[1]: Started dynamicswap service. Aug 26 12:05:00 volumio sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 26 12:05:00 volumio sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:00 volumio sudo[1307]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 26 12:05:00 volumio sudo[1322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Aug 26 12:05:00 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 26 12:05:00 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Aug 26 12:05:00 volumio sudo[1322]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:00 volumio systemd[1]: Started dynamicswap service. Aug 26 12:05:00 volumio systemd[1]: Stopped Volumio Backend Module. Aug 26 12:05:00 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 26 12:05:00 volumio sudo[1322]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:00 volumio wireless.js[1241]: SETTING APPROPRIATE REG DOMAIN: DE Aug 26 12:05:01 volumio sudo[1352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 26 12:05:01 volumio sudo[1352]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:01 volumio sudo[1352]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:01 volumio sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Aug 26 12:05:01 volumio sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:01 volumio sudo[1354]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:01 volumio wireless.js[1241]: SUCCESSFULLY SET NEW REGDOMAIN: DE Aug 26 12:05:01 volumio wireless.js[1241]: Start wireless flow Aug 26 12:05:01 volumio wireless.js[1241]: Stopped hotspot (if there).. Aug 26 12:05:01 volumio sudo[1360]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 26 12:05:01 volumio sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:01 volumio sudo[1360]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:01 volumio sudo[1362]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 26 12:05:01 volumio sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:01 volumio mpd[1250]: Aug 26 12:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 26 12:05:01 volumio systemd[1]: Started Music Player Daemon. Aug 26 12:05:01 volumio sudo[1362]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:01 volumio wireless.js[1241]: DHCP IP Aug 26 12:05:01 volumio wireless.js[1241]: Start ap Aug 26 12:05:01 volumio wpa_supplicant[1366]: Successfully initialized wpa_supplicant Aug 26 12:05:01 volumio sudo[1367]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Aug 26 12:05:01 volumio sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:01 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 26 12:05:01 volumio dhcpcd[1368]: main: control_open: Connection refused Aug 26 12:05:01 volumio dhcpcd[1368]: dev: loaded udev Aug 26 12:05:01 volumio dhcpcd-run-hooks[1400]: wlan0: starting wpa_supplicant Aug 26 12:05:02 volumio dhcpcd-run-hooks[1474]: wlan0: failed to start wpa_supplicant Aug 26 12:05:02 volumio dhcpcd-run-hooks[1476]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Aug 26 12:05:02 volumio dhcpcd[1368]: wlan0: connected to Access Point `' Aug 26 12:05:02 volumio dhcpcd[1368]: no interfaces have a carrier Aug 26 12:05:02 volumio dhcpcd[1507]: eth0: waiting for carrier Aug 26 12:05:02 volumio dhcpcd[1507]: wlan0: waiting for carrier Aug 26 12:05:02 volumio dhcpcd[1368]: forked to background, child pid 1507 Aug 26 12:05:02 volumio sudo[1367]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:02 volumio wpa_supplicant[1407]: wlan0: Trying to associate with SSID 'PosteMobile_237C8A_2.4G' Aug 26 12:05:02 volumio wireless.js[1241]: trying... Aug 26 12:05:02 volumio sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:02 volumio sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:02 volumio sudo[1593]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:03 volumio dhcpcd[1507]: wlan0: carrier acquired Aug 26 12:05:03 volumio dhcpcd[1507]: wlan0: connected to Access Point `PosteMobile_237C8A_2.4G' Aug 26 12:05:03 volumio wpa_supplicant[1407]: wlan0: Associated with d4:72:26:23:7c:8a Aug 26 12:05:03 volumio wpa_supplicant[1407]: wlan0: CTRL-EVENT-CONNECTED - Connection to d4:72:26:23:7c:8a completed [id=1 id_str=] Aug 26 12:05:03 volumio wpa_supplicant[1407]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 26 12:05:03 volumio wpa_supplicant[1407]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=IT Aug 26 12:05:03 volumio dhcpcd[1507]: DUID 00:01:00:01:2d:4b:cc:69:b8:27:eb:b2:dc:3d Aug 26 12:05:03 volumio dhcpcd[1507]: wlan0: IAID eb:e7:89:68 Aug 26 12:05:03 volumio dhcpcd[1507]: wlan0: adding address fe80::8934:fc7:3da4:29e6 Aug 26 12:05:03 volumio dhcpcd[1507]: ipv6_addaddr1: Permission denied Aug 26 12:05:03 volumio dhcpcd[1507]: wlan0: carrier lost Aug 26 12:05:03 volumio dhcpcd[1507]: wlan0: carrier acquired Aug 26 12:05:03 volumio dhcpcd[1507]: wlan0: IAID eb:e7:89:68 Aug 26 12:05:03 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Aug 26 12:05:03 volumio wireless.js[1241]: trying... Aug 26 12:05:03 volumio sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:03 volumio sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:03 volumio sudo[1816]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:04 volumio dhcpcd[1507]: wlan0: soliciting an IPv6 router Aug 26 12:05:04 volumio dhcpcd[1507]: wlan0: rebinding lease of 192.168.0.124 Aug 26 12:05:04 volumio ntpd[819]: Deleting interface #3 wlan0, 192.168.0.124#123, interface stats: received=0, sent=0, dropped=0, active_time=19 secs Aug 26 12:05:04 volumio wireless.js[1241]: trying... Aug 26 12:05:04 volumio sudo[2046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:04 volumio sudo[2046]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:04 volumio sudo[2046]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:05 volumio volumio-remote-updater[680]: [2024-08-26 12:05:05] [info] asio async_connect error: system:111 (Connection refused) Aug 26 12:05:05 volumio volumio-remote-updater[680]: [2024-08-26 12:05:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 26 12:05:05 volumio volumio-remote-updater[680]: [2024-08-26 12:05:05] [error] handle_connect error: Underlying Transport Error Aug 26 12:05:05 volumio wireless.js[1241]: trying... Aug 26 12:05:05 volumio sudo[2276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:05 volumio sudo[2276]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:05 volumio sudo[2276]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:06 volumio wireless.js[1241]: trying... Aug 26 12:05:06 volumio sudo[2506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:06 volumio sudo[2506]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:06 volumio sudo[2506]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:07 volumio wireless.js[1241]: trying... Aug 26 12:05:07 volumio sudo[2734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:07 volumio sudo[2734]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:07 volumio sudo[2734]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:08 volumio wireless.js[1241]: trying... Aug 26 12:05:08 volumio sudo[2960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:08 volumio sudo[2960]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:08 volumio sudo[2960]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:09 volumio dhcpcd[1507]: wlan0: probing for an IPv4LL address Aug 26 12:05:09 volumio dhcpcd[1507]: wlan0: DHCP lease expired Aug 26 12:05:09 volumio dhcpcd[1507]: wlan0: soliciting a DHCP lease Aug 26 12:05:09 volumio wireless.js[1241]: trying... Aug 26 12:05:09 volumio sudo[3201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:09 volumio sudo[3201]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:09 volumio sudo[3201]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:10 volumio wireless.js[1241]: trying... Aug 26 12:05:10 volumio sudo[3431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:10 volumio sudo[3431]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:10 volumio sudo[3431]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:11 volumio wireless.js[1241]: trying... Aug 26 12:05:11 volumio sudo[3660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:11 volumio sudo[3660]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:11 volumio sudo[3660]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:12 volumio volumio-remote-updater[680]: [2024-08-26 12:05:12] [info] asio async_connect error: system:111 (Connection refused) Aug 26 12:05:12 volumio volumio-remote-updater[680]: [2024-08-26 12:05:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 26 12:05:12 volumio volumio-remote-updater[680]: [2024-08-26 12:05:12] [error] handle_connect error: Underlying Transport Error Aug 26 12:05:12 volumio wireless.js[1241]: trying... Aug 26 12:05:12 volumio sudo[3890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:12 volumio sudo[3890]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:12 volumio sudo[3890]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:13 volumio wireless.js[1241]: trying... Aug 26 12:05:13 volumio sudo[4121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:13 volumio sudo[4121]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:13 volumio sudo[4121]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:14 volumio dhcpcd[1507]: wlan0: using IPv4LL address 169.254.12.79 Aug 26 12:05:14 volumio avahi-daemon[678]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.12.79. Aug 26 12:05:14 volumio avahi-daemon[678]: New relevant interface wlan0.IPv4 for mDNS. Aug 26 12:05:14 volumio avahi-daemon[678]: Registering new address record for 169.254.12.79 on wlan0.IPv4. Aug 26 12:05:14 volumio dhcpcd[1507]: wlan0: adding route to 169.254.0.0/16 Aug 26 12:05:14 volumio dhcpcd[1507]: wlan0: adding default route Aug 26 12:05:14 volumio wireless.js[1241]: trying... Aug 26 12:05:14 volumio sudo[4360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 26 12:05:14 volumio sudo[4360]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:14 volumio sudo[4360]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:14 volumio wireless.js[1241]: Connected to: ----PosteMobile_237C8A_2.4G Aug 26 12:05:14 volumio wireless.js[1241]: ---- Aug 26 12:05:14 volumio sudo[4371]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 12:05:14 volumio sudo[4371]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:14 volumio sudo[4371]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:14 volumio wireless.js[1241]: ... joined AP, wlan0 IPv4 is 169.254.12.79, ipV6 is undefined Aug 26 12:05:14 volumio wireless.js[1241]: It's done! AP Aug 26 12:05:14 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 26 12:05:14 volumio systemd[1]: Started Wireless Services. Aug 26 12:05:14 volumio systemd[1]: Started Volumio Backend Module. Aug 26 12:05:15 volumio ntpd[819]: Listen normally on 4 wlan0 169.254.12.79:123 Aug 26 12:05:15 volumio ntpd[819]: new interface(s) found: waking up resolver Aug 26 12:05:17 volumio volumio[4399]: info: ------------------------------------------- Aug 26 12:05:17 volumio volumio[4399]: info: ----- Volumio3 ---- Aug 26 12:05:17 volumio volumio[4399]: info: ------------------------------------------- Aug 26 12:05:17 volumio volumio[4399]: info: ----- System startup ---- Aug 26 12:05:17 volumio volumio[4399]: info: ------------------------------------------- Aug 26 12:05:18 volumio volumio[4399]: info: MYVOLUMIO Environment detected Aug 26 12:05:18 volumio volumio[4399]: info: Plugin folders cleanup Aug 26 12:05:18 volumio volumio[4399]: info: Scanning into folder /volumio/app/plugins/ Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category audio_interface Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category miscellanea Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category music_service Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category plugins.json Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category system_controller Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category user_interface Aug 26 12:05:18 volumio volumio[4399]: info: Scanning into folder /data/plugins/ Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category audio_interface Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category music_service Aug 26 12:05:18 volumio volumio[4399]: info: Scanning category user_interface Aug 26 12:05:18 volumio volumio[4399]: info: Plugin folders cleanup completed Aug 26 12:05:18 volumio volumio[4399]: info: ------------------------------------------- Aug 26 12:05:18 volumio volumio[4399]: info: ----- Core plugins startup ---- Aug 26 12:05:18 volumio volumio[4399]: info: ------------------------------------------- Aug 26 12:05:18 volumio volumio[4399]: info: Loading plugins from folder /volumio/app/plugins/ Aug 26 12:05:18 volumio volumio[4399]: info: Adding plugin upnp to MyMusic Plugins Aug 26 12:05:18 volumio volumio[4399]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 26 12:05:18 volumio volumio[4399]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 26 12:05:18 volumio volumio[4399]: info: Loading plugins from folder /data/plugins/ Aug 26 12:05:18 volumio volumio[4399]: info: Loading plugin "system"... Aug 26 12:05:18 volumio volumio[4399]: info: Loading plugin "appearance"... Aug 26 12:05:19 volumio volumio[4399]: info: Loading plugin "network"... Aug 26 12:05:19 volumio volumio[4399]: info: Refreshing Cached IP Addresses Aug 26 12:05:19 volumio sudo[4800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 12:05:19 volumio sudo[4800]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:19 volumio sudo[4800]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:19 volumio volumio[4399]: info: Loading plugin "services"... Aug 26 12:05:19 volumio sudo[4803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 12:05:19 volumio sudo[4803]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:19 volumio volumio[4399]: info: Loading plugin "alsa_controller"... Aug 26 12:05:19 volumio sudo[4806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 26 12:05:19 volumio sudo[4806]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:19 volumio sudo[4803]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:19 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 12:05:19 volumio volumio[4399]: info: Loading plugin "wizard"... Aug 26 12:05:20 volumio volumio[4399]: info: Loading plugin "networkfs"... Aug 26 12:05:20 volumio volumio[4399]: info: Starting Udev Watcher for removable devices Aug 26 12:05:20 volumio volumio[4399]: info: Ignoring mount for partition: boot Aug 26 12:05:20 volumio volumio[4399]: info: Ignoring mount for partition: volumio Aug 26 12:05:20 volumio volumio[4399]: info: Ignoring mount for partition: volumio_data Aug 26 12:05:20 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 12:05:20 volumio volumio[4399]: info: Loading plugin "volumio_command_line_client"... Aug 26 12:05:20 volumio volumio[4399]: info: Loading plugin "upnp"... Aug 26 12:05:20 volumio volumio[4399]: info: [1724666720105] Starting Upmpd Daemon Aug 26 12:05:20 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 12:05:20 volumio volumio[4399]: info: Loading plugin "my_music"... Aug 26 12:05:20 volumio volumio[4399]: info: Loading plugin "mpd"... Aug 26 12:05:20 volumio volumio[4399]: info: Loading plugin "upnp_browser"... Aug 26 12:05:20 volumio sudo[4806]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:20 volumio volumio[4399]: info: Loading plugin "alarm-clock"... Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "airplay_emulation"... Aug 26 12:05:21 volumio volumio[4399]: info: Starting Shairport Sync Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "last_100"... Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "webradio"... Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "i2s_dacs"... Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "volumiodiscovery"... Aug 26 12:05:21 volumio volumio[4399]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 26 12:05:21 volumio volumio[4399]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 12:05:21 volumio volumio[4399]: *** WARNING *** For more information see Aug 26 12:05:21 volumio node[4399]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 26 12:05:21 volumio volumio[4399]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 26 12:05:21 volumio volumio[4399]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 12:05:21 volumio volumio[4399]: *** WARNING *** For more information see Aug 26 12:05:21 volumio node[4399]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 12:05:21 volumio node[4399]: *** WARNING *** For more information see Aug 26 12:05:21 volumio node[4399]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 26 12:05:21 volumio node[4399]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 12:05:21 volumio node[4399]: *** WARNING *** For more information see Aug 26 12:05:21 volumio volumio[4399]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 26 12:05:21 volumio volumio[4399]: info: Discovery: Started advertising with name: Volumio Aug 26 12:05:21 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 12:05:21 volumio volumio[4399]: info: Plugin spop is not enabled Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "outputs"... Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "albumart"... Aug 26 12:05:21 volumio volumio[4399]: info: Plugin example_plugin is not enabled Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "inputs"... Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "updater_comm"... Aug 26 12:05:21 volumio volumio[4399]: info: Plugin mpdemulation is not enabled Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "rest_api"... Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "websocket"... Aug 26 12:05:21 volumio volumio[4399]: info: Starting Socket.io Server version 2.3.0 Aug 26 12:05:21 volumio volumio[4399]: info: Loading plugin "fusiondsp"... Aug 26 12:05:21 volumio volumio[4399]: Forking 3 albumart workers Aug 26 12:05:22 volumio volumio[4399]: info: Applying required configuration parameters for plugin fusiondsp Aug 26 12:05:22 volumio volumio[4399]: info: Plugin motherearthradio is not enabled Aug 26 12:05:22 volumio volumio[4399]: info: Loading plugin "touch_display"... Aug 26 12:05:22 volumio volumio-remote-updater[680]: [2024-08-26 12:05:22] [connect] Successful connection Aug 26 12:05:23 volumio volumio[4399]: info: Applying required configuration parameters for plugin touch_display Aug 26 12:05:23 volumio volumio[4399]: info: Loading i18n strings for locale it Aug 26 12:05:23 volumio volumio[4399]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 26 12:05:23 volumio volumio[4399]: Updating browse sources language Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 12:05:23 volumio volumio[4399]: Starting albumart workers Aug 26 12:05:23 volumio volumio[4399]: Starting albumart workers Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::initPlayerControls Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 12:05:23 volumio volumio[4399]: Express server listening on port 3000 Aug 26 12:05:23 volumio volumio[4399]: [Metrics] WebUI: 6s 985.26ms Aug 26 12:05:23 volumio volumio[4399]: Starting albumart workers Aug 26 12:05:23 volumio volumio[4399]: info: CoreStateMachine::resetVolumioState Aug 26 12:05:23 volumio volumio[4399]: info: CoreStateMachine::getcurrentVolume Aug 26 12:05:23 volumio volumio[4399]: info: CoreCommandRouter::volumioRetrievevolume Aug 26 12:05:23 volumio volumio-remote-updater[680]: [2024-08-26 12:05:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724666722 101 Aug 26 12:05:24 volumio volumio[4399]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Aug 26 12:05:24 volumio volumio[4399]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:24 volumio volumio[4399]: info: Reloading queue from file Aug 26 12:05:24 volumio volumio[4399]: info: VolumeController:: Volume=0 Mute =false Aug 26 12:05:24 volumio volumio[4399]: info: CoreStateMachine::pushState Aug 26 12:05:24 volumio volumio[4399]: info: CorePlayQueue::getTrack 0 Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::volumioPushState Aug 26 12:05:24 volumio volumio[4399]: info: CoreStateMachine::updateTrackBlock Aug 26 12:05:24 volumio volumio[4399]: info: CorePlayQueue::getTrackBlock Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::volumioRetrievevolume Aug 26 12:05:24 volumio volumio[4399]: info: CoreStateMachine::setRepeat false single undefined Aug 26 12:05:24 volumio volumio[4399]: info: CoreStateMachine::pushState Aug 26 12:05:24 volumio volumio[4399]: info: CorePlayQueue::getTrack 0 Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::volumioPushState Aug 26 12:05:24 volumio volumio[4399]: info: CoreStateMachine::setRandom false Aug 26 12:05:24 volumio volumio[4399]: info: CoreStateMachine::pushState Aug 26 12:05:24 volumio volumio[4399]: info: CorePlayQueue::getTrack 0 Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::volumioPushState Aug 26 12:05:24 volumio volumio[4399]: info: Setting Device type: Raspberry PI Aug 26 12:05:24 volumio volumio[4399]: info: Completed loading Core Plugins Aug 26 12:05:24 volumio volumio[4399]: info: Preparing to generate the ALSA configuration file Aug 26 12:05:24 volumio volumio[4399]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 26 12:05:24 volumio volumio[4399]: info: Reading ALSA contributions from plugins. Aug 26 12:05:24 volumio volumio[4399]: info: VolumeController:: Volume=0 Mute =false Aug 26 12:05:24 volumio volumio[4399]: info: CoreStateMachine::pushState Aug 26 12:05:24 volumio volumio[4399]: info: CorePlayQueue::getTrack 0 Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::volumioPushState Aug 26 12:05:24 volumio volumio[4399]: info: Asound.conf file unchanged, so no further update is needed Aug 26 12:05:24 volumio volumio[4399]: info: Output device has changed, restarting MPD Aug 26 12:05:24 volumio volumio[4399]: info: Output device has changed, restarting Shairport Sync Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:24 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:24 volumio sudo[4932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 12:05:24 volumio sudo[4932]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:24 volumio sudo[4938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 12:05:24 volumio sudo[4938]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:24 volumio sudo[4932]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:24 volumio systemd[1]: Stopping Music Player Daemon... Aug 26 12:05:25 volumio systemd[1]: mpd.service: Succeeded. Aug 26 12:05:25 volumio volumio[4399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 12:05:25 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 12:05:25 volumio volumio[4399]: info: ___________ START PLUGINS ___________ Aug 26 12:05:25 volumio volumio[4399]: info: ControllerMpd::onStart: Initializing MPD Aug 26 12:05:25 volumio volumio[4399]: info: Creating MPD Configuration file Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 12:05:25 volumio systemd[1]: Starting Music Player Daemon... Aug 26 12:05:25 volumio volumio[4399]: info: [1724666725091] CoreMusicLibrary::Adding element Server multimediali Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:25 volumio sudo[4956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 12:05:25 volumio sudo[4952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 12:05:25 volumio sudo[4956]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:25 volumio sudo[4952]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:25 volumio sudo[4952]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:25 volumio sudo[4944]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 12:05:25 volumio sudo[4944]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:25 volumio sudo[4944]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:25 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 26 12:05:25 volumio systemd[1]: mpd.service: Succeeded. Aug 26 12:05:25 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 12:05:25 volumio volumio[4399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:25 volumio systemd[1]: Starting Music Player Daemon... Aug 26 12:05:25 volumio volumio[4399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 12:05:25 volumio volumio[4399]: info: [1724666725435] CoreMusicLibrary::Adding element Last_100 Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 12:05:25 volumio volumio[4399]: info: [1724666725440] CoreMusicLibrary::Adding element Webradio Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 12:05:25 volumio sudo[4966]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 12:05:25 volumio sudo[4966]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 12:05:25 volumio sudo[4966]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:25 volumio volumio[4399]: info: Initializing BBC Radios Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:25 volumio volumio[4399]: info: Loading i18n strings for locale it Aug 26 12:05:25 volumio volumio[4399]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:25 volumio volumio[4399]: info: FusionDsp - mixtype--------------------- Hardware Aug 26 12:05:25 volumio volumio[4399]: info: Loading i18n strings for locale it Aug 26 12:05:25 volumio volumio[4399]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 26 12:05:25 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 12:05:25 volumio volumio[4399]: info: Volumio Calling Home Aug 26 12:05:25 volumio volumio[4399]: info: Preparing to generate the ALSA configuration file Aug 26 12:05:25 volumio sudo[4998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 26 12:05:25 volumio sudo[4998]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:25 volumio systemd[1]: Reloading. Aug 26 12:05:25 volumio volumio[4399]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 26 12:05:25 volumio volumio[4399]: info: Reading ALSA contributions from plugins. Aug 26 12:05:25 volumio volumio[4399]: info: MPD Permissions set Aug 26 12:05:25 volumio volumio[4399]: info: MPD Permissions set Aug 26 12:05:26 volumio volumio[4399]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Aug 26 12:05:26 volumio volumio[4399]: info: Starting Shairport Sync Aug 26 12:05:26 volumio volumio[4399]: info: Starting Shairport Sync Aug 26 12:05:26 volumio volumio[4399]: info: Starting Shairport Sync Aug 26 12:05:26 volumio volumio[4399]: info: Asound.conf file unchanged, so no further update is needed Aug 26 12:05:26 volumio volumio[4399]: info: Output device has changed, restarting MPD Aug 26 12:05:26 volumio sudo[5025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 12:05:26 volumio sudo[5025]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:26 volumio sudo[5026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 12:05:26 volumio sudo[5026]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:26 volumio sudo[5022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 12:05:26 volumio volumio[4399]: info: Output device has changed, restarting Shairport Sync Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:26 volumio sudo[5022]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:26 volumio sudo[5032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 12:05:26 volumio sudo[5032]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:26 volumio sudo[5029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 12:05:26 volumio sudo[5029]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:26 volumio sudo[5029]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:26 volumio volumio[4399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 12:05:26 volumio volumio[4399]: info: MPD Permissions set Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:26 volumio volumio[4399]: info: Starting Shairport Sync Aug 26 12:05:26 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 26 12:05:26 volumio sudo[5050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 12:05:26 volumio sudo[5050]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:27 volumio sudo[4998]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:27 volumio volumio[4399]: info: touch_display: systemctl daemon-reload succeeded. Aug 26 12:05:27 volumio sudo[5062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Aug 26 12:05:27 volumio sudo[5062]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:27 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 26 12:05:27 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 26 12:05:27 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 26 12:05:27 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 26 12:05:27 volumio systemd[1]: mpd.service: Succeeded. Aug 26 12:05:27 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 12:05:27 volumio sudo[5062]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:27 volumio volumio[4399]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Aug 26 12:05:27 volumio volumio[4399]: info: touch_display: Volumio Kiosk started Aug 26 12:05:27 volumio volumio[4399]: info: CoreCommandRouter::volumioGetState Aug 26 12:05:27 volumio volumio[4399]: info: CorePlayQueue::getTrack 0 Aug 26 12:05:27 volumio volumio[4399]: info: CoreCommandRouter::volumioGetState Aug 26 12:05:27 volumio volumio[4399]: info: CorePlayQueue::getTrack 0 Aug 26 12:05:27 volumio systemd[1]: Starting Music Player Daemon... Aug 26 12:05:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 26 12:05:27 volumio sudo[5025]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:27 volumio sudo[5026]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:27 volumio sudo[5022]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:27 volumio sudo[5050]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:27 volumio volumio[4399]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 26 12:05:27 volumio volumio[4399]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Aug 26 12:05:27 volumio volumio[4399]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 26 12:05:27 volumio volumio[4399]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 26 12:05:27 volumio volumio[4399]: info: camilladsp service started and running in background, instance 1 Aug 26 12:05:27 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:05:27 volumio sudo[5064]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 12:05:27 volumio sudo[5064]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:27 volumio sudo[5064]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:27 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 26 12:05:27 volumio volumio[4399]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Aug 26 12:05:27 volumio volumio[4399]: info: FusionDsp loaded Aug 26 12:05:27 volumio volumio[4399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 12:05:27 volumio sudo[5087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 26 12:05:27 volumio volumio[4399]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 26 12:05:27 volumio volumio[4399]: info: Adding Signal Path Element [object Object] Aug 26 12:05:27 volumio volumio[4399]: info: Adding fusiondspeq DSP Signal Path Element Aug 26 12:05:27 volumio sudo[5087]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:27 volumio volumio[4399]: info: FusionDsp - ---- installed callbackRead Aug 26 12:05:27 volumio volumio[4399]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 12:05:27 volumio volumio[4399]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 26 12:05:27 volumio volumio[4399]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 26 12:05:27 volumio volumio[4399]: at onErrorNT (internal/child_process.js:465:16) Aug 26 12:05:27 volumio volumio[4399]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 26 12:05:27 volumio volumio[4399]: errno: -2, Aug 26 12:05:27 volumio volumio[4399]: code: 'ENOENT', Aug 26 12:05:27 volumio volumio[4399]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 26 12:05:27 volumio volumio[4399]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 26 12:05:27 volumio volumio[4399]: spawnargs: [ Aug 26 12:05:27 volumio volumio[4399]: '-p', Aug 26 12:05:27 volumio volumio[4399]: 9876, Aug 26 12:05:27 volumio volumio[4399]: '-o', Aug 26 12:05:27 volumio volumio[4399]: '/tmp/camilladsp.log', Aug 26 12:05:27 volumio volumio[4399]: '-l', Aug 26 12:05:27 volumio volumio[4399]: 'warn', Aug 26 12:05:27 volumio volumio[4399]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 26 12:05:27 volumio volumio[4399]: ] Aug 26 12:05:27 volumio volumio[4399]: } Aug 26 12:05:27 volumio volumio[4399]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 12:05:27 volumio sudo[5087]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:28 volumio sudo[5099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 12:04 Aug 26 12:05:28 volumio sudo[5099]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:05:28 volumio sudo[5099]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:29 volumio mpd[5084]: Aug 26 12:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 26 12:05:29 volumio systemd[1]: Started Music Player Daemon. Aug 26 12:05:29 volumio sudo[5032]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:29 volumio sudo[4956]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:29 volumio sudo[4938]: pam_unix(sudo:session): session closed for user root Aug 26 12:05:53 volumio volumio-remote-updater[680]: [2024-08-26 12:05:53] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Aug 26 12:05:58 volumio volumio-remote-updater[680]: [2024-08-26 12:05:58] [connect] Successful connection Aug 26 12:05:59 volumio ntpd[819]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Aug 26 12:06:04 volumio nmbd[770]: [2024/08/26 12:06:04.598187, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 26 12:06:04 volumio nmbd[770]: Packet send failed to 192.168.0.255(138) ERRNO=Network is unreachable Aug 26 12:06:06 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 26 12:06:06 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 26 12:06:06 volumio systemd[1]: Started dynamicswap service. Aug 26 12:06:06 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 26 12:06:06 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 26 12:06:06 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Aug 26 12:06:06 volumio systemd[1]: Stopped Volumio Backend Module. Aug 26 12:06:06 volumio systemd[1]: Started Volumio Backend Module. Aug 26 12:06:06 volumio systemd[1]: Started dynamicswap service. Aug 26 12:06:06 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 26 12:06:08 volumio volumio[5169]: info: ------------------------------------------- Aug 26 12:06:08 volumio volumio[5169]: info: ----- Volumio3 ---- Aug 26 12:06:08 volumio volumio[5169]: info: ------------------------------------------- Aug 26 12:06:08 volumio volumio[5169]: info: ----- System startup ---- Aug 26 12:06:08 volumio volumio[5169]: info: ------------------------------------------- Aug 26 12:06:09 volumio volumio[5169]: info: MYVOLUMIO Environment detected Aug 26 12:06:09 volumio volumio[5169]: info: Plugin folders cleanup Aug 26 12:06:09 volumio volumio[5169]: info: Scanning into folder /volumio/app/plugins/ Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category audio_interface Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category miscellanea Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category music_service Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category plugins.json Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category system_controller Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category user_interface Aug 26 12:06:09 volumio volumio[5169]: info: Scanning into folder /data/plugins/ Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category audio_interface Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category music_service Aug 26 12:06:09 volumio volumio[5169]: info: Scanning category user_interface Aug 26 12:06:09 volumio volumio[5169]: info: Plugin folders cleanup completed Aug 26 12:06:09 volumio volumio[5169]: info: ------------------------------------------- Aug 26 12:06:09 volumio volumio[5169]: info: ----- Core plugins startup ---- Aug 26 12:06:09 volumio volumio[5169]: info: ------------------------------------------- Aug 26 12:06:09 volumio volumio[5169]: info: Loading plugins from folder /volumio/app/plugins/ Aug 26 12:06:09 volumio volumio[5169]: info: Adding plugin upnp to MyMusic Plugins Aug 26 12:06:09 volumio volumio[5169]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 26 12:06:09 volumio volumio[5169]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 26 12:06:09 volumio volumio[5169]: info: Loading plugins from folder /data/plugins/ Aug 26 12:06:09 volumio volumio[5169]: info: Loading plugin "system"... Aug 26 12:06:09 volumio volumio[5169]: info: Loading plugin "appearance"... Aug 26 12:06:09 volumio dhcpcd[1507]: wlan0: offered 192.168.0.124 from 192.168.0.1 Aug 26 12:06:09 volumio dhcpcd[1507]: wlan0: probing address 192.168.0.124/24 Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "network"... Aug 26 12:06:10 volumio volumio[5169]: info: Refreshing Cached IP Addresses Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "services"... Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "alsa_controller"... Aug 26 12:06:10 volumio sudo[5379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 12:06:10 volumio sudo[5377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 12:06:10 volumio sudo[5379]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:10 volumio sudo[5377]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:10 volumio sudo[5379]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:10 volumio sudo[5377]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:10 volumio sudo[5381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 26 12:06:10 volumio sudo[5381]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:10 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "wizard"... Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "networkfs"... Aug 26 12:06:10 volumio volumio[5169]: info: Starting Udev Watcher for removable devices Aug 26 12:06:10 volumio volumio[5169]: info: Ignoring mount for partition: boot Aug 26 12:06:10 volumio volumio[5169]: info: Ignoring mount for partition: volumio Aug 26 12:06:10 volumio volumio[5169]: info: Ignoring mount for partition: volumio_data Aug 26 12:06:10 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "volumio_command_line_client"... Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "upnp"... Aug 26 12:06:10 volumio volumio[5169]: info: [1724666770822] Starting Upmpd Daemon Aug 26 12:06:10 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "my_music"... Aug 26 12:06:10 volumio volumio[5169]: info: Loading plugin "mpd"... Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "upnp_browser"... Aug 26 12:06:11 volumio volumio-remote-updater[680]: [2024-08-26 12:06:11] [connect] Successful connection Aug 26 12:06:11 volumio sudo[5381]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "alarm-clock"... Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "airplay_emulation"... Aug 26 12:06:11 volumio volumio[5169]: info: Starting Shairport Sync Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "last_100"... Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "webradio"... Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "i2s_dacs"... Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "volumiodiscovery"... Aug 26 12:06:11 volumio volumio[5169]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 26 12:06:11 volumio volumio[5169]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 12:06:11 volumio volumio[5169]: *** WARNING *** For more information see Aug 26 12:06:11 volumio volumio[5169]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 26 12:06:11 volumio node[5169]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 26 12:06:11 volumio volumio[5169]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 12:06:11 volumio volumio[5169]: *** WARNING *** For more information see Aug 26 12:06:11 volumio node[5169]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 12:06:11 volumio node[5169]: *** WARNING *** For more information see Aug 26 12:06:11 volumio node[5169]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 26 12:06:11 volumio node[5169]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 12:06:11 volumio node[5169]: *** WARNING *** For more information see Aug 26 12:06:11 volumio volumio[5169]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 26 12:06:11 volumio volumio[5169]: info: Discovery: Started advertising with name: Volumio Aug 26 12:06:11 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 12:06:11 volumio volumio[5169]: info: Plugin spop is not enabled Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "outputs"... Aug 26 12:06:11 volumio volumio[5169]: info: Loading plugin "albumart"... Aug 26 12:06:12 volumio volumio[5169]: info: Plugin example_plugin is not enabled Aug 26 12:06:12 volumio volumio[5169]: info: Loading plugin "inputs"... Aug 26 12:06:12 volumio volumio[5169]: info: Loading plugin "updater_comm"... Aug 26 12:06:12 volumio volumio[5169]: info: Plugin mpdemulation is not enabled Aug 26 12:06:12 volumio volumio[5169]: info: Loading plugin "rest_api"... Aug 26 12:06:12 volumio volumio[5169]: info: Loading plugin "websocket"... Aug 26 12:06:12 volumio volumio[5169]: info: Starting Socket.io Server version 2.3.0 Aug 26 12:06:12 volumio volumio[5169]: info: Loading plugin "fusiondsp"... Aug 26 12:06:12 volumio volumio[5169]: Forking 3 albumart workers Aug 26 12:06:12 volumio volumio[5169]: info: Applying required configuration parameters for plugin fusiondsp Aug 26 12:06:12 volumio volumio[5169]: info: Plugin motherearthradio is not enabled Aug 26 12:06:12 volumio volumio[5169]: info: Loading plugin "touch_display"... Aug 26 12:06:13 volumio volumio[5169]: info: Applying required configuration parameters for plugin touch_display Aug 26 12:06:13 volumio volumio[5169]: info: Loading i18n strings for locale it Aug 26 12:06:13 volumio volumio[5169]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 26 12:06:13 volumio volumio[5169]: Updating browse sources language Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 12:06:13 volumio volumio[5169]: Starting albumart workers Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::initPlayerControls Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: Starting albumart workers Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 12:06:13 volumio volumio[5169]: Express server listening on port 3000 Aug 26 12:06:13 volumio volumio[5169]: Starting albumart workers Aug 26 12:06:13 volumio volumio[5169]: [Metrics] WebUI: 6s 94.56ms Aug 26 12:06:13 volumio volumio[5169]: info: CoreStateMachine::resetVolumioState Aug 26 12:06:13 volumio volumio[5169]: info: CoreStateMachine::getcurrentVolume Aug 26 12:06:13 volumio volumio[5169]: info: CoreCommandRouter::volumioRetrievevolume Aug 26 12:06:13 volumio volumio-remote-updater[680]: [2024-08-26 12:06:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724666771 101 Aug 26 12:06:13 volumio volumio[5169]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Aug 26 12:06:14 volumio volumio[5169]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:14 volumio volumio[5169]: info: Reloading queue from file Aug 26 12:06:14 volumio volumio[5169]: info: CoreStateMachine::setRepeat false single undefined Aug 26 12:06:14 volumio volumio[5169]: info: CoreStateMachine::pushState Aug 26 12:06:14 volumio volumio[5169]: info: CorePlayQueue::getTrack 0 Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::volumioPushState Aug 26 12:06:14 volumio volumio[5169]: info: CoreStateMachine::setRandom false Aug 26 12:06:14 volumio volumio[5169]: info: CoreStateMachine::pushState Aug 26 12:06:14 volumio volumio[5169]: info: CorePlayQueue::getTrack 0 Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::volumioPushState Aug 26 12:06:14 volumio volumio[5169]: info: Setting Device type: Raspberry PI Aug 26 12:06:14 volumio dhcpcd[1507]: wlan0: leased 192.168.0.124 for 86400 seconds Aug 26 12:06:14 volumio avahi-daemon[678]: Registering new address record for 192.168.0.124 on wlan0.IPv4. Aug 26 12:06:14 volumio dhcpcd[1507]: wlan0: adding route to 192.168.0.0/24 Aug 26 12:06:14 volumio dhcpcd[1507]: wlan0: changing default route via 192.168.0.1 Aug 26 12:06:14 volumio volumio[5169]: info: Completed loading Core Plugins Aug 26 12:06:14 volumio volumio[5169]: info: Preparing to generate the ALSA configuration file Aug 26 12:06:14 volumio volumio[5169]: info: VolumeController:: Volume=0 Mute =false Aug 26 12:06:14 volumio volumio[5169]: info: CoreStateMachine::pushState Aug 26 12:06:14 volumio volumio[5169]: info: CorePlayQueue::getTrack 0 Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::volumioPushState Aug 26 12:06:14 volumio volumio[5169]: info: CoreStateMachine::updateTrackBlock Aug 26 12:06:14 volumio volumio[5169]: info: CorePlayQueue::getTrackBlock Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::volumioRetrievevolume Aug 26 12:06:14 volumio volumio[5169]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 26 12:06:14 volumio volumio[5169]: info: Reading ALSA contributions from plugins. Aug 26 12:06:14 volumio avahi-daemon[678]: Withdrawing address record for 169.254.12.79 on wlan0. Aug 26 12:06:14 volumio avahi-daemon[678]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.12.79. Aug 26 12:06:14 volumio dhcpcd[1507]: wlan0: deleting route to 169.254.0.0/16 Aug 26 12:06:14 volumio avahi-daemon[678]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.124. Aug 26 12:06:14 volumio dhcpcd[1507]: wlan0: pid 1507 deleted default route via 192.168.0.1 Aug 26 12:06:14 volumio volumio[5169]: info: Asound.conf file unchanged, so no further update is needed Aug 26 12:06:14 volumio volumio[5169]: info: Output device has changed, restarting MPD Aug 26 12:06:14 volumio volumio[5169]: info: Output device has changed, restarting Shairport Sync Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:14 volumio sudo[5487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 12:06:14 volumio sudo[5492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 12:06:14 volumio sudo[5487]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:14 volumio sudo[5492]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:14 volumio sudo[5487]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:14 volumio systemd[1]: Stopping Music Player Daemon... Aug 26 12:06:14 volumio volumio[5169]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 12:06:14 volumio volumio[5169]: info: ___________ START PLUGINS ___________ Aug 26 12:06:14 volumio systemd[1]: mpd.service: Succeeded. Aug 26 12:06:14 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 12:06:14 volumio volumio[5169]: info: ControllerMpd::onStart: Initializing MPD Aug 26 12:06:14 volumio volumio[5169]: info: Creating MPD Configuration file Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 12:06:14 volumio volumio[5169]: info: [1724666774865] CoreMusicLibrary::Adding element Server multimediali Aug 26 12:06:14 volumio systemd[1]: Starting Music Player Daemon... Aug 26 12:06:14 volumio sudo[5504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 12:06:14 volumio sudo[5504]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:14 volumio sudo[5504]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 12:06:14 volumio sudo[5506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 12:06:14 volumio sudo[5506]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:14 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 26 12:06:14 volumio systemd[1]: mpd.service: Succeeded. Aug 26 12:06:14 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:14 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:14 volumio systemd[1]: Starting Music Player Daemon... Aug 26 12:06:15 volumio volumio[5169]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 12:06:15 volumio volumio[5169]: info: [1724666775067] CoreMusicLibrary::Adding element Last_100 Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 12:06:15 volumio volumio[5169]: info: [1724666775073] CoreMusicLibrary::Adding element Webradio Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 12:06:15 volumio sudo[5510]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 12:06:15 volumio sudo[5510]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:15 volumio volumio[5169]: info: Initializing BBC Radios Aug 26 12:06:15 volumio sudo[5510]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: Loading i18n strings for locale it Aug 26 12:06:15 volumio volumio[5169]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: FusionDsp - mixtype--------------------- Hardware Aug 26 12:06:15 volumio volumio[5169]: info: Loading i18n strings for locale it Aug 26 12:06:15 volumio volumio[5169]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 12:06:15 volumio volumio[5169]: info: Volumio Calling Home Aug 26 12:06:15 volumio volumio[5169]: info: Preparing to generate the ALSA configuration file Aug 26 12:06:15 volumio sudo[5538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 26 12:06:15 volumio sudo[5538]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:15 volumio systemd[1]: Reloading. Aug 26 12:06:15 volumio volumio[5169]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 26 12:06:15 volumio volumio[5169]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 26 12:06:15 volumio volumio[5169]: info: Reading ALSA contributions from plugins. Aug 26 12:06:15 volumio volumio[5169]: info: MPD Permissions set Aug 26 12:06:15 volumio volumio[5169]: info: MPD Permissions set Aug 26 12:06:15 volumio volumio[5169]: info: VolumeController:: Volume=0 Mute =false Aug 26 12:06:15 volumio volumio[5169]: info: CoreStateMachine::pushState Aug 26 12:06:15 volumio volumio[5169]: info: CorePlayQueue::getTrack 0 Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::volumioPushState Aug 26 12:06:15 volumio volumio[5169]: info: Volumio called home Aug 26 12:06:15 volumio volumio[5169]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:15 volumio volumio[5169]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Aug 26 12:06:15 volumio volumio[5169]: info: Starting Shairport Sync Aug 26 12:06:15 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 26 12:06:15 volumio volumio[5169]: info: Starting Shairport Sync Aug 26 12:06:16 volumio volumio[5169]: info: Starting Shairport Sync Aug 26 12:06:16 volumio sudo[5562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 12:06:16 volumio sudo[5562]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:16 volumio sudo[5565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 12:06:16 volumio sudo[5565]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:16 volumio sudo[5568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 12:06:16 volumio sudo[5568]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::volumioGetState Aug 26 12:06:16 volumio volumio[5169]: info: CorePlayQueue::getTrack 0 Aug 26 12:06:16 volumio volumio[5169]: info: Asound.conf file unchanged, so no further update is needed Aug 26 12:06:16 volumio volumio[5169]: info: Output device has changed, restarting MPD Aug 26 12:06:16 volumio volumio[5169]: info: Output device has changed, restarting Shairport Sync Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:16 volumio sudo[5571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 12:06:16 volumio sudo[5571]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:16 volumio sudo[5571]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:16 volumio sudo[5574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 12:06:16 volumio sudo[5574]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:16 volumio volumio[5169]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 12:06:16 volumio volumio[5169]: info: MPD Permissions set Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio ntpd[819]: Listen normally on 5 wlan0 192.168.0.124:123 Aug 26 12:06:16 volumio ntpd[819]: Deleting interface #4 wlan0, 169.254.12.79#123, interface stats: received=0, sent=0, dropped=0, active_time=61 secs Aug 26 12:06:16 volumio ntpd[819]: new interface(s) found: waking up resolver Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:16 volumio volumio[5169]: info: Starting Shairport Sync Aug 26 12:06:16 volumio sudo[5584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 12:06:16 volumio sudo[5584]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:16 volumio sudo[5538]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:16 volumio volumio[5169]: info: touch_display: systemctl daemon-reload succeeded. Aug 26 12:06:16 volumio sudo[5588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Aug 26 12:06:16 volumio sudo[5588]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 26 12:06:16 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 26 12:06:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 26 12:06:16 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 26 12:06:16 volumio systemd[1]: mpd.service: Succeeded. Aug 26 12:06:16 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 12:06:16 volumio sudo[5588]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:16 volumio volumio[5169]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Aug 26 12:06:16 volumio volumio[5169]: info: touch_display: Volumio Kiosk started Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::volumioGetState Aug 26 12:06:16 volumio volumio[5169]: info: CorePlayQueue::getTrack 0 Aug 26 12:06:16 volumio volumio[5169]: info: CoreCommandRouter::volumioGetState Aug 26 12:06:16 volumio volumio[5169]: info: CorePlayQueue::getTrack 0 Aug 26 12:06:16 volumio systemd[1]: Starting Music Player Daemon... Aug 26 12:06:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 26 12:06:16 volumio sudo[5562]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:16 volumio sudo[5568]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:16 volumio sudo[5565]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:16 volumio sudo[5584]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:16 volumio volumio[5169]: info: Shairport-Sync Started Aug 26 12:06:16 volumio volumio[5169]: Error adding Membership: Error: addMembership EINVAL Aug 26 12:06:16 volumio volumio[5169]: info: Shairport-Sync Started Aug 26 12:06:16 volumio volumio[5169]: info: Shairport-Sync Started Aug 26 12:06:16 volumio volumio[5169]: info: Shairport-Sync Started Aug 26 12:06:16 volumio volumio[5169]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Aug 26 12:06:16 volumio sudo[5590]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 12:06:16 volumio sudo[5590]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:16 volumio volumio[5169]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Aug 26 12:06:16 volumio sudo[5590]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:17 volumio volumio[5169]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Aug 26 12:06:17 volumio volumio[5169]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 26 12:06:17 volumio volumio[5169]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 26 12:06:17 volumio volumio[5169]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Aug 26 12:06:17 volumio volumio[5169]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 26 12:06:17 volumio volumio[5169]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 26 12:06:17 volumio volumio[5169]: info: camilladsp service started and running in background, instance 1 Aug 26 12:06:17 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 12:06:17 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 26 12:06:17 volumio volumio[5169]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Aug 26 12:06:17 volumio volumio[5169]: info: FusionDsp loaded Aug 26 12:06:17 volumio volumio[5169]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 12:06:17 volumio sudo[5618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 26 12:06:17 volumio sudo[5618]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 12:06:17 volumio volumio[5169]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 26 12:06:17 volumio volumio[5169]: info: Adding Signal Path Element [object Object] Aug 26 12:06:17 volumio volumio[5169]: info: Adding fusiondspeq DSP Signal Path Element Aug 26 12:06:17 volumio volumio[5169]: info: FusionDsp - ---- installed callbackRead Aug 26 12:06:17 volumio volumio[5169]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 12:06:17 volumio volumio[5169]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 26 12:06:17 volumio volumio[5169]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 26 12:06:17 volumio volumio[5169]: at onErrorNT (internal/child_process.js:465:16) Aug 26 12:06:17 volumio volumio[5169]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 26 12:06:17 volumio volumio[5169]: errno: -2, Aug 26 12:06:17 volumio volumio[5169]: code: 'ENOENT', Aug 26 12:06:17 volumio volumio[5169]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 26 12:06:17 volumio volumio[5169]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 26 12:06:17 volumio volumio[5169]: spawnargs: [ Aug 26 12:06:17 volumio volumio[5169]: '-p', Aug 26 12:06:17 volumio volumio[5169]: 9876, Aug 26 12:06:17 volumio volumio[5169]: '-o', Aug 26 12:06:17 volumio volumio[5169]: '/tmp/camilladsp.log', Aug 26 12:06:17 volumio volumio[5169]: '-l', Aug 26 12:06:17 volumio volumio[5169]: 'warn', Aug 26 12:06:17 volumio volumio[5169]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 26 12:06:17 volumio volumio[5169]: ] Aug 26 12:06:17 volumio volumio[5169]: } Aug 26 12:06:17 volumio volumio[5169]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 12:06:17 volumio sudo[5618]: pam_unix(sudo:session): session closed for user root Aug 26 12:06:18 volumio sudo[5635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 12:05 Aug 26 12:06:18 volumio sudo[5635]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"