-- Logs begin at Sun 2024-04-21 00:51:51 CEST, end at Sun 2024-04-21 15:05:48 CEST. -- Apr 21 15:05:16 imperum-pml systemd[1212]: Time has been changed Apr 21 15:05:16 imperum-pml systemd[1]: Time has been changed Apr 21 15:05:17 imperum-pml volumio-remote-updater[624]: [2024-04-21 15:05:17] [info] asio async_connect error: system:111 (Connection refused) Apr 21 15:05:17 imperum-pml volumio-remote-updater[624]: [2024-04-21 15:05:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 21 15:05:17 imperum-pml volumio-remote-updater[624]: [2024-04-21 15:05:17] [error] handle_connect error: Underlying Transport Error Apr 21 15:05:17 imperum-pml systemd[1]: Stopped hotspot.service. Apr 21 15:05:17 imperum-pml sudo[1600]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 15:05:17 imperum-pml sudo[1600]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:17 imperum-pml sudo[1600]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:17 imperum-pml sudo[1608]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 15:05:17 imperum-pml sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:17 imperum-pml sudo[1608]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:18 imperum-pml avahi-daemon[689]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Apr 21 15:05:18 imperum-pml avahi-daemon[689]: New relevant interface wlan0.IPv4 for mDNS. Apr 21 15:05:18 imperum-pml avahi-daemon[689]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Apr 21 15:05:18 imperum-pml kernel: brcmfmac: power management disabled Apr 21 15:05:18 imperum-pml systemd[1]: Starting hotspot.service... Apr 21 15:05:18 imperum-pml systemd[1]: Started hotspot.service. Apr 21 15:05:18 imperum-pml systemd[1]: Starting dhcpd.service... Apr 21 15:05:18 imperum-pml systemd[1]: Starting dnsmasq.service... Apr 21 15:05:18 imperum-pml systemd[1]: Started Wireless Services. Apr 21 15:05:18 imperum-pml systemd[1]: Starting Volumio Backend Module... Apr 21 15:05:18 imperum-pml systemd[1]: Started Volumio Backend Module. Apr 21 15:05:18 imperum-pml systemd[1]: Starting Volumio Streaming Daemon... Apr 21 15:05:18 imperum-pml systemd[1]: Started Volumio Streaming Daemon. Apr 21 15:05:18 imperum-pml systemd[1]: Starting play from usb card... Apr 21 15:05:18 imperum-pml systemd[1]: Started play from usb card. Apr 21 15:05:18 imperum-pml systemd[1]: Starting Uno para gobernarlos a todos... Apr 21 15:05:18 imperum-pml systemd[1]: Started Uno para gobernarlos a todos. Apr 21 15:05:18 imperum-pml systemd[1]: Starting Multi-User System. Apr 21 15:05:18 imperum-pml systemd[1]: Reached target Multi-User System. Apr 21 15:05:18 imperum-pml systemd[1]: Starting Graphical Interface. Apr 21 15:05:18 imperum-pml systemd[1]: Reached target Graphical Interface. Apr 21 15:05:18 imperum-pml systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 21 15:05:18 imperum-pml dhcpd[1622]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 15:05:18 imperum-pml dhcpd[1622]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 15:05:18 imperum-pml dhcpd[1622]: All rights reserved. Apr 21 15:05:18 imperum-pml dhcpd[1622]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 15:05:18 imperum-pml dhcpd[1622]: Config file: /etc/dhcp/dhcpd.conf Apr 21 15:05:18 imperum-pml dhcpd[1622]: Database file: /var/lib/dhcp/dhcpd.leases Apr 21 15:05:18 imperum-pml dhcpd[1622]: PID file: /var/run/dhcpd.pid Apr 21 15:05:18 imperum-pml hotspot[1622]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 15:05:18 imperum-pml hotspot[1622]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 15:05:18 imperum-pml hotspot[1622]: All rights reserved. Apr 21 15:05:18 imperum-pml hotspot[1622]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 15:05:18 imperum-pml hotspot[1622]: Config file: /etc/dhcp/dhcpd.conf Apr 21 15:05:18 imperum-pml hotspot[1622]: Database file: /var/lib/dhcp/dhcpd.leases Apr 21 15:05:18 imperum-pml hotspot[1622]: PID file: /var/run/dhcpd.pid Apr 21 15:05:18 imperum-pml dhcpd[1622]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 15:05:18 imperum-pml dhcpd[1622]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 15:05:18 imperum-pml dhcpd[1622]: All rights reserved. Apr 21 15:05:18 imperum-pml dhcpd[1622]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 15:05:18 imperum-pml dhcpd[1622]: Wrote 7 leases to leases file. Apr 21 15:05:18 imperum-pml hotspot[1622]: Wrote 7 leases to leases file. Apr 21 15:05:18 imperum-pml bash[1628]: 1 DECLARACION DE VARIABLES ------------------------- Apr 21 15:05:18 imperum-pml systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 21 15:05:18 imperum-pml bash[1628]: 2 LECTURA ARCHIVO CONFIGURACION ------------------------- Apr 21 15:05:18 imperum-pml bash[1628]: 3 FIN LECTURA ARCHIVO CONFIGURACION ------------------------- Apr 21 15:05:18 imperum-pml bash[1628]: 3 1 FIN LECTURA ARCHIVO CONFIGURACION ------------------------- --- --- Apr 21 15:05:18 imperum-pml bash[1628]: 4 ARMAZON DEL FUTURIBLE JSON ------------------------- Apr 21 15:05:18 imperum-pml bash[1628]: 5 ARMAZON DEL FUTURIBLE JSON ------------------------- Apr 21 15:05:18 imperum-pml bash[1628]: --- INICIO WHILE --- Apr 21 15:05:18 imperum-pml bash[1628]: 6 CHECK CONECTIVIDAD ------------------------- Apr 21 15:05:18 imperum-pml dnsmasq[1648]: started, version 2.72 cachesize 150 Apr 21 15:05:18 imperum-pml dnsmasq[1648]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect Apr 21 15:05:18 imperum-pml dnsmasq[1648]: reading /etc/resolv.conf Apr 21 15:05:18 imperum-pml dnsmasq[1648]: using nameserver 192.168.1.1#53 Apr 21 15:05:18 imperum-pml dnsmasq[1648]: using nameserver 208.67.222.222#53 Apr 21 15:05:18 imperum-pml dnsmasq[1648]: using nameserver 208.67.222.222#53 Apr 21 15:05:18 imperum-pml dnsmasq[1648]: using nameserver 208.67.220.220#53 Apr 21 15:05:18 imperum-pml systemd[1]: Started dnsmasq.service. Apr 21 15:05:18 imperum-pml systemd[1]: Starting Host and Network Name Lookups. Apr 21 15:05:18 imperum-pml systemd[1]: Reached target Host and Network Name Lookups. Apr 21 15:05:18 imperum-pml dhcpd[1622]: Apr 21 15:05:18 imperum-pml dhcpd[1622]: No subnet declaration for eth0 (192.168.1.136). Apr 21 15:05:18 imperum-pml dhcpd[1622]: ** Ignoring requests on eth0. If this is not what Apr 21 15:05:18 imperum-pml dhcpd[1622]: you want, please write a subnet declaration Apr 21 15:05:18 imperum-pml dhcpd[1622]: in your dhcpd.conf file for the network segment Apr 21 15:05:18 imperum-pml dhcpd[1622]: to which interface eth0 is attached. ** Apr 21 15:05:18 imperum-pml dhcpd[1622]: Apr 21 15:05:18 imperum-pml hotspot[1622]: No subnet declaration for eth0 (192.168.1.136). Apr 21 15:05:18 imperum-pml hotspot[1622]: ** Ignoring requests on eth0. If this is not what Apr 21 15:05:18 imperum-pml hotspot[1622]: you want, please write a subnet declaration Apr 21 15:05:18 imperum-pml hotspot[1622]: in your dhcpd.conf file for the network segment Apr 21 15:05:18 imperum-pml hotspot[1622]: to which interface eth0 is attached. ** Apr 21 15:05:18 imperum-pml dnsmasq[1648]: read /etc/hosts - 1 addresses Apr 21 15:05:18 imperum-pml bash[1628]: SI hay conectividad Apr 21 15:05:18 imperum-pml bash[1628]: 7 CHECK CONECTIVIDAD ------------------------- Apr 21 15:05:18 imperum-pml sudo[1652]: volumio : TTY=unknown ; PWD=/home/volumio/tcnimperum/bin ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 15:05:18 imperum-pml sudo[1652]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:18 imperum-pml sudo[1652]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:18 imperum-pml dhcpd[1622]: Listening on LPF/wlan0/b8:27:eb:dd:66:b7/192.168.211.0/24 Apr 21 15:05:18 imperum-pml dhcpd[1622]: Sending on LPF/wlan0/b8:27:eb:dd:66:b7/192.168.211.0/24 Apr 21 15:05:18 imperum-pml dhcpd[1622]: Sending on Socket/fallback/fallback-net Apr 21 15:05:18 imperum-pml dhcpd[1662]: Server starting service. Apr 21 15:05:18 imperum-pml systemd[1]: Started dhcpd.service. Apr 21 15:05:18 imperum-pml systemd[1]: Startup finished in 8.965s (kernel) + 41.519s (userspace) = 50.484s. Apr 21 15:05:18 imperum-pml hotspot[1622]: Listening on LPF/wlan0/b8:27:eb:dd:66:b7/192.168.211.0/24 Apr 21 15:05:18 imperum-pml hotspot[1622]: Sending on LPF/wlan0/b8:27:eb:dd:66:b7/192.168.211.0/24 Apr 21 15:05:18 imperum-pml hotspot[1622]: Sending on Socket/fallback/fallback-net Apr 21 15:05:18 imperum-pml volumio-streaming-daemon[1626]: ############################ Apr 21 15:05:18 imperum-pml volumio-streaming-daemon[1626]: # Volumio Streaming Daemon # Apr 21 15:05:18 imperum-pml volumio-streaming-daemon[1626]: # Running on port 7777 # Apr 21 15:05:18 imperum-pml volumio-streaming-daemon[1626]: ############################ Apr 21 15:05:18 imperum-pml sudo[1668]: volumio : TTY=unknown ; PWD=/home/volumio/tcnimperum/bin ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 21 15:05:18 imperum-pml volumio-streaming-daemon[1626]: Environment: production Apr 21 15:05:18 imperum-pml sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:18 imperum-pml hotspot[1621]: Launching Hostapd 2.8 Apr 21 15:05:18 imperum-pml hotspot[1621]: Configuration file: /etc/hostapd/hostapd.conf Apr 21 15:05:18 imperum-pml hotspot[1621]: wlan0: Could not connect to kernel driver Apr 21 15:05:18 imperum-pml hotspot[1621]: Using interface wlan0 with hwaddr b8:27:eb:dd:66:b7 and ssid "IMPERUM-PML" Apr 21 15:05:18 imperum-pml hotspot[1621]: wlan0: interface state UNINITIALIZED->ENABLED Apr 21 15:05:18 imperum-pml hotspot[1621]: wlan0: AP-ENABLED Apr 21 15:05:19 imperum-pml ntpd[842]: Listen normally on 4 wlan0 192.168.211.1 UDP 123 Apr 21 15:05:19 imperum-pml ntpd[842]: peers refreshed Apr 21 15:05:20 imperum-pml volumio[1625]: info: ------------------------------------------- Apr 21 15:05:20 imperum-pml volumio[1625]: info: ----- Volumio2 ---- Apr 21 15:05:20 imperum-pml volumio[1625]: info: ------------------------------------------- Apr 21 15:05:20 imperum-pml volumio[1625]: info: ----- System startup ---- Apr 21 15:05:20 imperum-pml volumio[1625]: info: ------------------------------------------- Apr 21 15:05:20 imperum-pml volumio[1625]: info: MYVOLUMIO Environment detected Apr 21 15:05:22 imperum-pml volumio[1625]: info: Plugin folders cleanup Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning into folder /volumio/app/plugins/ Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning category audio_interface Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning category miscellanea Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning category music_service Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning category plugins.json Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning category system_controller Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning category user_interface Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning into folder /data/plugins/ Apr 21 15:05:22 imperum-pml volumio[1625]: info: Scanning category music_service Apr 21 15:05:22 imperum-pml volumio[1625]: info: Plugin folders cleanup completed Apr 21 15:05:22 imperum-pml volumio[1625]: info: ------------------------------------------- Apr 21 15:05:22 imperum-pml volumio[1625]: info: ----- Core plugins startup ---- Apr 21 15:05:22 imperum-pml volumio[1625]: info: ------------------------------------------- Apr 21 15:05:22 imperum-pml volumio[1625]: info: Loading plugins from folder /volumio/app/plugins/ Apr 21 15:05:22 imperum-pml volumio[1625]: info: Adding plugin upnp to MyMusic Plugins Apr 21 15:05:22 imperum-pml volumio[1625]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 21 15:05:22 imperum-pml volumio[1625]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 21 15:05:22 imperum-pml volumio[1625]: info: Loading plugins from folder /data/plugins/ Apr 21 15:05:22 imperum-pml volumio[1625]: info: Loading plugin "system"... Apr 21 15:05:22 imperum-pml volumio[1625]: info: Loading plugin "appearance"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "network"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "services"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "alsa_controller"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "wizard"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "volumio_command_line_client"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "upnp"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: [1713704723422] Starting Upmpd Daemon Apr 21 15:05:23 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "cardplay_monitor"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "fakeAlsaController"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "fake_spop"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "mainmenu"... Apr 21 15:05:23 imperum-pml volumio[1625]: info: Loading plugin "menuOptions"... Apr 21 15:05:24 imperum-pml volumio[1625]: info: Loading plugin "my_music"... Apr 21 15:05:24 imperum-pml volumio[1625]: info: Loading plugin "user_data"... Apr 21 15:05:24 imperum-pml volumio[1625]: info: Loading plugin "mpd"... Apr 21 15:05:24 imperum-pml volumio[1625]: info: Loading plugin "upnp_browser"... Apr 21 15:05:25 imperum-pml cron[647]: 2024-04-21 15:05:25 1ryWsm-0000RS-Ue Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=120 Apr 21 15:05:25 imperum-pml exim[1702]: 2024-04-21 15:05:25 1ryWsm-0000RS-Ue <= volumio@localhost U=volumio P=local S=821 Apr 21 15:05:25 imperum-pml exim[1702]: 2024-04-21 15:05:25 1ryWsm-0000RS-Ue Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=120 Apr 21 15:05:25 imperum-pml exim[1702]: exim: could not open panic log - aborting: see message(s) above Apr 21 15:05:25 imperum-pml cron[647]: 2024-04-21 15:05:25 1ryWsm-0000RS-Ue <= volumio@localhost U=volumio P=local S=821 Apr 21 15:05:25 imperum-pml cron[647]: 2024-04-21 15:05:25 1ryWsm-0000RS-Ue Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=120 Apr 21 15:05:25 imperum-pml cron[647]: exim: could not open panic log - aborting: see message(s) above Apr 21 15:05:25 imperum-pml CRON[1209]: (volumio) MAIL (mailed 196 bytes of output but got status 0x0001 from MTA ) Apr 21 15:05:25 imperum-pml CRON[1209]: pam_unix(cron:session): session closed for user volumio Apr 21 15:05:25 imperum-pml CRON[1709]: pam_unix(cron:session): session opened for user volumio by (uid=0) Apr 21 15:05:25 imperum-pml CRON[1711]: pam_unix(cron:session): session opened for user volumio by (uid=0) Apr 21 15:05:25 imperum-pml CRON[1710]: pam_unix(cron:session): session opened for user volumio by (uid=0) Apr 21 15:05:25 imperum-pml CRON[1721]: (volumio) CMD (/home/volumio/tcnimperum/send > /home/volumio/testsend.txt) Apr 21 15:05:25 imperum-pml CRON[1722]: (volumio) CMD (/home/volumio/tcnimperum/process > /home/volumio/test.txt) Apr 21 15:05:25 imperum-pml CRON[1724]: (volumio) CMD (/home/volumio/protocoloTCN/bin/client > /dev/null 2>&1) Apr 21 15:05:25 imperum-pml CRON[1711]: pam_unix(cron:session): session closed for user volumio Apr 21 15:05:25 imperum-pml sudo[1730]: volumio : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/rm -r /home/volumio/tcnimperum/reciente Apr 21 15:05:25 imperum-pml sudo[1732]: volumio : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/rm -r /home/volumio/tcnimperum/sendpoint Apr 21 15:05:25 imperum-pml sudo[1732]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:25 imperum-pml sudo[1730]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:25 imperum-pml sudo[1730]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:25 imperum-pml sudo[1732]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:25 imperum-pml volumio[1625]: info: Loading plugin "networkfs"... Apr 21 15:05:25 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 15:05:25 imperum-pml volumio[1625]: info: Loading plugin "alarm-clock"... Apr 21 15:05:25 imperum-pml volumio[1625]: info: Loading plugin "airplay_emulation"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: Starting Shairport Sync Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "last_100"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "webradio"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "i2s_dacs"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "volumiodiscovery"... Apr 21 15:05:26 imperum-pml volumio[1625]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 15:05:26 imperum-pml node[1625]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 15:05:26 imperum-pml node[1625]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 15:05:26 imperum-pml node[1625]: *** WARNING *** For more information see Apr 21 15:05:26 imperum-pml node[1625]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 15:05:26 imperum-pml node[1625]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 15:05:26 imperum-pml node[1625]: *** WARNING *** For more information see Apr 21 15:05:26 imperum-pml volumio[1625]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 15:05:26 imperum-pml volumio[1625]: *** WARNING *** For more information see Apr 21 15:05:26 imperum-pml volumio[1625]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 15:05:26 imperum-pml volumio[1625]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 15:05:26 imperum-pml volumio[1625]: *** WARNING *** For more information see Apr 21 15:05:26 imperum-pml volumio[1625]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 21 15:05:26 imperum-pml volumio[1625]: Discovery: StartAdv! undefined Apr 21 15:05:26 imperum-pml volumio[1625]: Discovery: Started advertising... imperum-pml - undefined Apr 21 15:05:26 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "outputs"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "albumart"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: Plugin example_plugin is not enabled Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "inputs"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "initialCheck"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: MYVOLUMIO Environment detected Apr 21 15:05:26 imperum-pml sudo[1764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/vcgencmd display_power 0 Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "installCheck"... Apr 21 15:05:26 imperum-pml sudo[1764]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:26 imperum-pml sudo[1766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "updater_comm"... Apr 21 15:05:26 imperum-pml sudo[1766]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:26 imperum-pml sudo[1764]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:26 imperum-pml sudo[1766]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:26 imperum-pml volumio[1625]: info: Plugin mpdemulation is not enabled Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "rest_api"... Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "websocket"... Apr 21 15:05:26 imperum-pml volumio[1625]: Forking 3 albumart workers Apr 21 15:05:26 imperum-pml volumio[1625]: info: Loading plugin "spop"... Apr 21 15:05:27 imperum-pml volumio-remote-updater[624]: [2024-04-21 15:05:27] [connect] Successful connection Apr 21 15:05:28 imperum-pml kernel: brcmfmac: brcmf_escan_timeout: timer expired Apr 21 15:05:28 imperum-pml sudo[1668]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:28 imperum-pml sudo[1817]: volumio : TTY=unknown ; PWD=/home/volumio/tcnimperum/bin ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 21 15:05:28 imperum-pml sudo[1817]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:28 imperum-pml systemd[1]: Starting Wireless Services... Apr 21 15:05:28 imperum-pml sudo[1823]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Apr 21 15:05:28 imperum-pml sudo[1823]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:28 imperum-pml volumio[1625]: Starting albumart workers Apr 21 15:05:28 imperum-pml sudo[1823]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:29 imperum-pml volumio[1625]: Starting albumart workers Apr 21 15:05:29 imperum-pml volumio[1625]: Starting albumart workers Apr 21 15:05:29 imperum-pml wireless.js[1832]: Cleaning previous... Apr 21 15:05:29 imperum-pml systemd[1]: Stopping dhcpd.service... Apr 21 15:05:29 imperum-pml systemd[1]: Stopping Host and Network Name Lookups. Apr 21 15:05:29 imperum-pml systemd[1]: Stopped target Host and Network Name Lookups. Apr 21 15:05:29 imperum-pml systemd[1]: Stopping dnsmasq.service... Apr 21 15:05:29 imperum-pml dnsmasq[1648]: exiting on receipt of SIGTERM Apr 21 15:05:29 imperum-pml systemd[1]: Stopped dnsmasq.service. Apr 21 15:05:29 imperum-pml systemd[1]: Stopped dhcpd.service. Apr 21 15:05:29 imperum-pml systemd[1]: Stopping hotspot.service... Apr 21 15:05:30 imperum-pml volumio[1625]: info: Loading plugin "volspotconnect2"... Apr 21 15:05:30 imperum-pml volumio[1625]: info: Loading plugin "zoutputDevice"... Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: spop , rebuildSPOPDAndRestartDaemon Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: volspotconnect2 , rebuildRestartDaemon Apr 21 15:05:30 imperum-pml volumio[1625]: Creating VLS config file Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: mpd , mpdInit Apr 21 15:05:30 imperum-pml volumio[1625]: info: Creating MPD Configuration file Apr 21 15:05:30 imperum-pml sudo[1857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 15:05:30 imperum-pml volumio[1625]: info: ___________ START PLUGINS ___________ Apr 21 15:05:30 imperum-pml sudo[1857]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 15:05:30 imperum-pml volumio[1625]: info: [1713704730570] CoreMusicLibrary::Adding element Media Servers Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 15:05:30 imperum-pml sudo[1860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 15:05:30 imperum-pml sudo[1857]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:30 imperum-pml sudo[1860]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:30 imperum-pml systemd[1]: Stopping Music Player Daemon... Apr 21 15:05:30 imperum-pml volumio[1625]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 15:05:30 imperum-pml volumio[1625]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 15:05:30 imperum-pml volumio[1625]: info: [1713704730743] CoreMusicLibrary::Adding element Last_100 Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 15:05:30 imperum-pml volumio[1625]: info: [1713704730751] CoreMusicLibrary::Adding element Webradio Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 15:05:30 imperum-pml volumio[1625]: Creating VLS config file Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:30 imperum-pml volumio[1625]: [SpotifyConnect] Starting metadata listener Apr 21 15:05:30 imperum-pml volumio[1625]: info: ------------------------------------------- Apr 21 15:05:30 imperum-pml volumio[1625]: info: ----- MyVolumio plugins startup ---- Apr 21 15:05:30 imperum-pml volumio[1625]: info: ------------------------------------------- Apr 21 15:05:30 imperum-pml sudo[1878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Apr 21 15:05:30 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 21 15:05:30 imperum-pml sudo[1878]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:30 imperum-pml sudo[1881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Apr 21 15:05:30 imperum-pml volumio[1625]: info: Loading i18n strings for locale es Apr 21 15:05:30 imperum-pml systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Apr 21 15:05:30 imperum-pml systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Apr 21 15:05:30 imperum-pml systemd[1]: Starting Spotify Daemon... Apr 21 15:05:30 imperum-pml systemd[1]: Started Spotify Daemon. Apr 21 15:05:30 imperum-pml volumio[1625]: Updating browse sources language Apr 21 15:05:30 imperum-pml volumio[1625]: Cannot find translation for sourceMedia Servers Apr 21 15:05:30 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 15:05:30 imperum-pml sudo[1881]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::initPlayerControls Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Apr 21 15:05:31 imperum-pml systemd[1]: Starting Volspotconnect2 Daemon... Apr 21 15:05:31 imperum-pml sudo[1878]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:31 imperum-pml systemd[1]: Started Volspotconnect2 Daemon. Apr 21 15:05:31 imperum-pml sudo[1881]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:31 imperum-pml systemd[1]: Starting Music Player Daemon... Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1625]: info: BOOT COMPLETED Apr 21 15:05:31 imperum-pml volumio[1625]: [Metrics] CommandRouter: 10s 513.84ms Apr 21 15:05:31 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 15:05:31 imperum-pml volumio[1891]: vollibrespot v0.2.0 0c51076 2020-04-17 (librespot 8d65d82 2020-03-10) -- Built On 2020-04-17 Apr 21 15:05:31 imperum-pml volumio[1891]: Reading Config from "volspotify.toml" Apr 21 15:05:31 imperum-pml volumio[1891]: Malformed config key: missing field `Authentication` Apr 21 15:05:31 imperum-pml systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Apr 21 15:05:31 imperum-pml systemd[1]: Unit volspotconnect2.service entered failed state. Apr 21 15:05:31 imperum-pml kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 21 15:05:31 imperum-pml volumio[1886]: 2024-04-21 15:05:31 [SPTF] 13:05:31.405 I [offline_authorizer.cpp:297] Unable to login offline: no such user Apr 21 15:05:31 imperum-pml volumio[1886]: 2024-04-21 15:05:31 [SPTF] 13:05:31.409 I [ap:1752] Connecting to AP ap.spotify.com:4070 Apr 21 15:05:31 imperum-pml volumio[1886]: 2024-04-21 15:05:31 [SPTF] 13:05:31.460 I [ap:1226] Connected to AP: 104.199.65.124:4070 Apr 21 15:05:31 imperum-pml volumio[1886]: 2024-04-21 15:05:31 [SPTF] 13:05:31.745 E [ap:3953] Connection error: 410 Apr 21 15:05:31 imperum-pml volumio[1886]: 2024-04-21 15:05:31 [WARN] Login failed: Bad username and/or password Apr 21 15:05:31 imperum-pml volumio[1886]: 2024-04-21 15:05:31 [ERR ] Could not get the playlist container. Apr 21 15:05:31 imperum-pml systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Apr 21 15:05:31 imperum-pml systemd[1]: Unit spop.service entered failed state. Apr 21 15:05:32 imperum-pml systemd[1]: Started Music Player Daemon. Apr 21 15:05:32 imperum-pml sudo[1860]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:33 imperum-pml systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Apr 21 15:05:33 imperum-pml systemd[1]: Stopping Volspotconnect2 Daemon... Apr 21 15:05:33 imperum-pml systemd[1]: Starting Volspotconnect2 Daemon... Apr 21 15:05:33 imperum-pml systemd[1]: Started Volspotconnect2 Daemon. Apr 21 15:05:33 imperum-pml volumio[1916]: vollibrespot v0.2.0 0c51076 2020-04-17 (librespot 8d65d82 2020-03-10) -- Built On 2020-04-17 Apr 21 15:05:33 imperum-pml volumio[1916]: Reading Config from "volspotify.toml" Apr 21 15:05:33 imperum-pml volumio[1916]: Malformed config key: missing field `Authentication` Apr 21 15:05:33 imperum-pml systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Apr 21 15:05:33 imperum-pml systemd[1]: Unit volspotconnect2.service entered failed state. Apr 21 15:05:34 imperum-pml hotspot[1847]: Killing Hostapd Apr 21 15:05:34 imperum-pml sudo[1926]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall hostapd Apr 21 15:05:34 imperum-pml sudo[1926]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:34 imperum-pml hotspot[1847]: hostapd: no process found Apr 21 15:05:34 imperum-pml sudo[1926]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:34 imperum-pml hotspot[1847]: Killing Dhcpd Apr 21 15:05:35 imperum-pml sudo[1934]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall dhcpd Apr 21 15:05:35 imperum-pml sudo[1934]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:35 imperum-pml hotspot[1847]: dhcpd: no process found Apr 21 15:05:35 imperum-pml sudo[1934]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:35 imperum-pml systemd[1]: hotspot.service: control process exited, code=exited status=1 Apr 21 15:05:35 imperum-pml systemd[1]: Stopped hotspot.service. Apr 21 15:05:35 imperum-pml systemd[1]: Unit hotspot.service entered failed state. Apr 21 15:05:35 imperum-pml sudo[1944]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 15:05:35 imperum-pml sudo[1944]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:35 imperum-pml avahi-daemon[689]: Withdrawing address record for 192.168.211.1 on wlan0. Apr 21 15:05:35 imperum-pml avahi-daemon[689]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Apr 21 15:05:35 imperum-pml avahi-daemon[689]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 21 15:05:35 imperum-pml sudo[1944]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:35 imperum-pml sudo[1952]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 15:05:35 imperum-pml sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:35 imperum-pml systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Apr 21 15:05:35 imperum-pml systemd[1]: Stopping Volspotconnect2 Daemon... Apr 21 15:05:35 imperum-pml systemd[1]: Starting Volspotconnect2 Daemon... Apr 21 15:05:35 imperum-pml systemd[1]: Started Volspotconnect2 Daemon. Apr 21 15:05:35 imperum-pml volumio[1958]: vollibrespot v0.2.0 0c51076 2020-04-17 (librespot 8d65d82 2020-03-10) -- Built On 2020-04-17 Apr 21 15:05:35 imperum-pml volumio[1958]: Reading Config from "volspotify.toml" Apr 21 15:05:35 imperum-pml volumio[1958]: Malformed config key: missing field `Authentication` Apr 21 15:05:35 imperum-pml systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Apr 21 15:05:35 imperum-pml systemd[1]: Unit volspotconnect2.service entered failed state. Apr 21 15:05:35 imperum-pml CRON[1710]: pam_unix(cron:session): session closed for user volumio Apr 21 15:05:36 imperum-pml sudo[1952]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:36 imperum-pml sudo[1817]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:36 imperum-pml wireless.js[1832]: Stopped aP Apr 21 15:05:36 imperum-pml wireless.js[1832]: Start wireless flow Apr 21 15:05:36 imperum-pml wireless.js[1832]: Stopped hotspot (if there).. Apr 21 15:05:36 imperum-pml sudo[1975]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 15:05:36 imperum-pml sudo[1975]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:36 imperum-pml sudo[1975]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:36 imperum-pml sudo[1983]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 15:05:36 imperum-pml sudo[1983]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:36 imperum-pml sudo[1983]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:36 imperum-pml wireless.js[1832]: DHCP IP Apr 21 15:05:36 imperum-pml wireless.js[1832]: Start ap Apr 21 15:05:36 imperum-pml wpa_supplicant[1991]: Successfully initialized wpa_supplicant Apr 21 15:05:36 imperum-pml wpa_supplicant[1991]: nl80211: Could not configure driver mode Apr 21 15:05:36 imperum-pml sudo[1992]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 21 15:05:36 imperum-pml kernel: brcmfmac: power management disabled Apr 21 15:05:36 imperum-pml sudo[1992]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:36 imperum-pml dhcpcd[1998]: version 6.0.5 starting Apr 21 15:05:36 imperum-pml dhcpcd[1998]: eth0: soliciting an IPv6 router Apr 21 15:05:36 imperum-pml dhcpcd[1998]: eth0: using static address 192.168.1.136 Apr 21 15:05:36 imperum-pml dhcpcd[1998]: eth0: adding host route to 192.168.1.136 via 127.0.0.1 Apr 21 15:05:36 imperum-pml dhcpcd[1998]: eth0: adding route to 192.168.1.0/24 Apr 21 15:05:36 imperum-pml dhcpcd[1998]: eth0: adding default route via 192.168.1.1 Apr 21 15:05:36 imperum-pml dhcpcd[2058]: wlan0: waiting for carrier Apr 21 15:05:36 imperum-pml dhcpcd[2058]: eth0: removing route to 192.168.1.0/24 Apr 21 15:05:36 imperum-pml dhcpcd[2058]: eth0: removing default route via 192.168.1.1 Apr 21 15:05:36 imperum-pml dhcpcd[1998]: forked to background, child pid 2058 Apr 21 15:05:36 imperum-pml sudo[1992]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:36 imperum-pml volumio[1625]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 21 15:05:36 imperum-pml volumio[1625]: info: CoreCommandRouter::Close All Modals sent Apr 21 15:05:36 imperum-pml volumio[1625]: info: CoreCommandRouter::Close All Modals sent Apr 21 15:05:36 imperum-pml volumio[1625]: Express server listening on port 3000 Apr 21 15:05:36 imperum-pml volumio[1625]: [Metrics] WebUI: 16s 416.35ms Apr 21 15:05:36 imperum-pml volumio[1625]: Volumio Calling Home Apr 21 15:05:36 imperum-pml volumio[1625]: (node:1625) [DEP0013] DeprecationWarning: Calling an asynchronous function without callback is deprecated. Apr 21 15:05:36 imperum-pml volumio[1625]: (node:1625) [DEP0013] DeprecationWarning: Calling an asynchronous function without callback is deprecated. Apr 21 15:05:36 imperum-pml volumio[1625]: (node:1625) [DEP0013] DeprecationWarning: Calling an asynchronous function without callback is deprecated. Apr 21 15:05:36 imperum-pml volumio[1625]: (node:1625) [DEP0013] DeprecationWarning: Calling an asynchronous function without callback is deprecated. Apr 21 15:05:36 imperum-pml volumio[1625]: info: CoreStateMachine::resetVolumioState Apr 21 15:05:36 imperum-pml volumio[1625]: info: CoreStateMachine::getcurrentVolume Apr 21 15:05:36 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 15:05:36 imperum-pml volumio[1625]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 21 15:05:36 imperum-pml sudo[2070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Apr 21 15:05:36 imperum-pml sudo[2070]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:36 imperum-pml systemd[1]: Stopping Volspotconnect2 Daemon... Apr 21 15:05:36 imperum-pml systemd[1]: Starting Volspotconnect2 Daemon... Apr 21 15:05:36 imperum-pml systemd[1]: Started Volspotconnect2 Daemon. Apr 21 15:05:36 imperum-pml sudo[2070]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:36 imperum-pml volumio[2075]: vollibrespot v0.2.0 0c51076 2020-04-17 (librespot 8d65d82 2020-03-10) -- Built On 2020-04-17 Apr 21 15:05:36 imperum-pml volumio[2075]: Reading Config from "volspotify.toml" Apr 21 15:05:36 imperum-pml volumio[2075]: Malformed config key: missing field `Authentication` Apr 21 15:05:36 imperum-pml systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Apr 21 15:05:36 imperum-pml systemd[1]: Unit volspotconnect2.service entered failed state. Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::Close All Modals sent Apr 21 15:05:37 imperum-pml sudo[2087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 15:05:37 imperum-pml sudo[2087]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:37 imperum-pml sudo[2087]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:37 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:37 imperum-pml sudo[2096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:37 imperum-pml volumio[1625]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 21 15:05:37 imperum-pml sudo[2096]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:37 imperum-pml sudo[2096]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:37 imperum-pml volumio[1625]: info: Setting Device type: Raspberry PI Apr 21 15:05:37 imperum-pml volumio[1625]: [SpotifyConnect] Vollibrespot Daemon service started! Apr 21 15:05:37 imperum-pml volumio[1625]: [Metrics] SpotifyConnect: 6s 586.69ms Apr 21 15:05:37 imperum-pml volumio[1625]: info: SpopD Daemon Started Apr 21 15:05:37 imperum-pml volumio[1625]: info: MPD Permissions set Apr 21 15:05:37 imperum-pml volumio[1625]: info: MPD running with PID692 ,establishing connection Apr 21 15:05:37 imperum-pml volumio[1625]: info: VolumeController:: Volume=100 Mute =false Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::pushState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::getState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CorePlayQueue::getTrack 0 Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioPushState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::updateTrackBlock Apr 21 15:05:37 imperum-pml volumio[1625]: info: CorePlayQueue::getTrackBlock Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 15:05:37 imperum-pml volumio[1625]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'username' of undefined Apr 21 15:05:37 imperum-pml volumio[1625]: at autorizacion (/volumio/http/index.js:53:62) Apr 21 15:05:37 imperum-pml volumio[1625]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Apr 21 15:05:37 imperum-pml volumio[1625]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Apr 21 15:05:37 imperum-pml volumio[1625]: at /volumio/node_modules/express/lib/router/index.js:284:7 Apr 21 15:05:37 imperum-pml volumio[1625]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Apr 21 15:05:37 imperum-pml volumio[1625]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Apr 21 15:05:37 imperum-pml volumio[1625]: at allowCrossDomain (/volumio/http/index.js:83:9) Apr 21 15:05:37 imperum-pml volumio[1625]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Apr 21 15:05:37 imperum-pml volumio[1625]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Apr 21 15:05:37 imperum-pml volumio[1625]: at /volumio/node_modules/express/lib/router/index.js:284:7 Apr 21 15:05:37 imperum-pml volumio[1625]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Apr 21 15:05:37 imperum-pml volumio[1625]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Apr 21 15:05:37 imperum-pml volumio[1625]: at /volumio/node_modules/connect-busboy/index.js:14:14 Apr 21 15:05:37 imperum-pml volumio[1625]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Apr 21 15:05:37 imperum-pml volumio[1625]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Apr 21 15:05:37 imperum-pml volumio[1625]: at /volumio/node_modules/express/lib/router/index.js:284:7 Apr 21 15:05:37 imperum-pml volumio[1625]: error: MPD error: false == true Apr 21 15:05:37 imperum-pml volumio[1625]: error: MPD error: false == true Apr 21 15:05:37 imperum-pml volumio[1625]: info: MPD running with PID1901 ,establishing connection Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 15:05:37 imperum-pml volumio[1625]: info: Reloading queue from file Apr 21 15:05:37 imperum-pml volumio[1625]: info: Apr 21 15:05:37 imperum-pml volumio[1625]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Apr 21 15:05:37 imperum-pml volumio[1625]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Apr 21 15:05:37 imperum-pml volumio[1625]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Apr 21 15:05:37 imperum-pml volumio[1625]: at emitOne (events.js:116:13) Apr 21 15:05:37 imperum-pml volumio[1625]: at Socket.emit (events.js:211:7) Apr 21 15:05:37 imperum-pml volumio[1625]: at addChunk (_stream_readable.js:263:12) Apr 21 15:05:37 imperum-pml volumio[1625]: at readableAddChunk (_stream_readable.js:246:13) Apr 21 15:05:37 imperum-pml volumio[1625]: at Socket.Readable.push (_stream_readable.js:208:10) Apr 21 15:05:37 imperum-pml volumio[1625]: at Pipe.onread (net.js:607:20) Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::setRepeat true single undefined Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::pushState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::getState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CorePlayQueue::getTrack 0 Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioPushState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::setRandom true Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::pushState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::getState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CorePlayQueue::getTrack 0 Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioPushState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 15:05:37 imperum-pml volumio[1625]: info: VolumeController:: Volume=100 Mute =false Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::pushState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreStateMachine::getState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CorePlayQueue::getTrack 0 Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioPushState Apr 21 15:05:37 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 15:05:37 imperum-pml volumio[1625]: info: Apr 21 15:05:37 imperum-pml volumio[1625]: info: mDNS: A device disapperared from network Apr 21 15:05:37 imperum-pml volumio[1625]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Apr 21 15:05:37 imperum-pml volumio[1625]: info: Starting Shairport Sync Apr 21 15:05:37 imperum-pml volumio[1625]: info: Starting Shairport Sync Apr 21 15:05:37 imperum-pml ntpd[842]: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=18 secs Apr 21 15:05:37 imperum-pml ntpd[842]: peers refreshed Apr 21 15:05:37 imperum-pml sudo[2118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 15:05:38 imperum-pml sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:38 imperum-pml sudo[2120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 15:05:38 imperum-pml sudo[2120]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:38 imperum-pml sudo[2124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 21 15:05:38 imperum-pml sudo[2124]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:38 imperum-pml systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 21 15:05:38 imperum-pml systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 15:05:38 imperum-pml systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 21 15:05:38 imperum-pml sudo[2118]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:38 imperum-pml systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 21 15:05:38 imperum-pml systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 15:05:38 imperum-pml systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 21 15:05:38 imperum-pml systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 15:05:38 imperum-pml sudo[2120]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:38 imperum-pml volumio[1625]: Discovery: adding df3b82f0-ab0c-479e-8a85-90fc398574a7 Apr 21 15:05:38 imperum-pml volumio[1625]: info: mDNS: Found device imperum-pml Apr 21 15:05:38 imperum-pml sudo[2124]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:38 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioGetState Apr 21 15:05:38 imperum-pml volumio[1625]: info: CoreStateMachine::getState Apr 21 15:05:38 imperum-pml volumio[1625]: info: CorePlayQueue::getTrack 0 Apr 21 15:05:38 imperum-pml sudo[2149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 15:05:38 imperum-pml sudo[2149]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:38 imperum-pml sudo[2149]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:38 imperum-pml sudo[2166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 15:05:38 imperum-pml sudo[2166]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:38 imperum-pml volumio[1625]: info: Shairport-Sync Started Apr 21 15:05:38 imperum-pml sudo[2166]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:38 imperum-pml volumio[1625]: Error adding Membership: Error: addMembership EINVAL Apr 21 15:05:38 imperum-pml volumio[1625]: info: Setting volume on startup at 100 Apr 21 15:05:38 imperum-pml volumio[1625]: info: Upmpdcli Daemon Started Apr 21 15:05:38 imperum-pml volumio[1625]: info: Shairport-Sync Started Apr 21 15:05:38 imperum-pml volumio[1625]: info: CoreCommandRouter::volumioGetState Apr 21 15:05:38 imperum-pml volumio[1625]: info: CoreStateMachine::getState Apr 21 15:05:38 imperum-pml volumio[1625]: info: CorePlayQueue::getTrack 0 Apr 21 15:05:38 imperum-pml sudo[2176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 15:05:38 imperum-pml sudo[2176]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:38 imperum-pml sudo[2176]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:38 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:38 imperum-pml sudo[2185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:38 imperum-pml sudo[2185]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:38 imperum-pml sudo[2185]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:38 imperum-pml wpa_supplicant[2011]: wlan0: Trying to associate with 1c:64:99:c5:fe:7e (SSID='MIWIFI_GH9k' freq=5540 MHz) Apr 21 15:05:38 imperum-pml systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Apr 21 15:05:38 imperum-pml systemd[1]: Stopping Volspotconnect2 Daemon... Apr 21 15:05:38 imperum-pml systemd[1]: Starting Volspotconnect2 Daemon... Apr 21 15:05:38 imperum-pml systemd[1]: Started Volspotconnect2 Daemon. Apr 21 15:05:39 imperum-pml volumio[2205]: vollibrespot v0.2.0 0c51076 2020-04-17 (librespot 8d65d82 2020-03-10) -- Built On 2020-04-17 Apr 21 15:05:39 imperum-pml volumio[2205]: Reading Config from "volspotify.toml" Apr 21 15:05:39 imperum-pml wpa_supplicant[2011]: wlan0: Associated with 1c:64:99:c5:fe:7e Apr 21 15:05:39 imperum-pml wpa_supplicant[2011]: wlan0: WPA: Key negotiation completed with 1c:64:99:c5:fe:7e [PTK=CCMP GTK=CCMP] Apr 21 15:05:39 imperum-pml wpa_supplicant[2011]: wlan0: CTRL-EVENT-CONNECTED - Connection to 1c:64:99:c5:fe:7e completed [id=0 id_str=] Apr 21 15:05:39 imperum-pml dhcpcd[2058]: wlan0: carrier acquired Apr 21 15:05:39 imperum-pml dhcpcd[2058]: wlan0: soliciting an IPv6 router Apr 21 15:05:39 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 21 15:05:39 imperum-pml sudo[2227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 21 15:05:39 imperum-pml sudo[2227]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 21 15:05:39 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 21 15:05:39 imperum-pml volumio[1625]: info: Adding plugin bluetooth to MyMusic Plugins Apr 21 15:05:39 imperum-pml sudo[2227]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:39 imperum-pml dhcpcd[2058]: wlan0: rebinding lease of 192.168.1.137 Apr 21 15:05:40 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:40 imperum-pml sudo[2237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:40 imperum-pml sudo[2237]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:40 imperum-pml sudo[2237]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:41 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:41 imperum-pml sudo[2246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:41 imperum-pml sudo[2246]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:41 imperum-pml sudo[2246]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:41 imperum-pml volumio[2205]: [Vollibrespot] : Using Alsa backend with device: compresor Apr 21 15:05:42 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:42 imperum-pml sudo[2255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:42 imperum-pml sudo[2255]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:42 imperum-pml sudo[2255]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:42 imperum-pml volumio[1625]: info: Adding plugin cd_controller to MyMusic Plugins Apr 21 15:05:42 imperum-pml volumio-remote-updater[624]: [2024-04-21 15:05:42] [connect] Successful connection Apr 21 15:05:43 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:43 imperum-pml sudo[2266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:43 imperum-pml sudo[2266]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:43 imperum-pml sudo[2266]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:43 imperum-pml volumio[1625]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 21 15:05:43 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 21 15:05:44 imperum-pml volumio[2205]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Apr 21 15:05:44 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:44 imperum-pml sudo[2302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:44 imperum-pml sudo[2302]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:44 imperum-pml sudo[2302]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:45 imperum-pml dhcpcd[2058]: wlan0: leased 192.168.1.137 for 86400 seconds Apr 21 15:05:45 imperum-pml avahi-daemon[689]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.137. Apr 21 15:05:45 imperum-pml avahi-daemon[689]: New relevant interface wlan0.IPv4 for mDNS. Apr 21 15:05:45 imperum-pml dhcpcd[2058]: wlan0: adding host route to 192.168.1.137 via 127.0.0.1 Apr 21 15:05:45 imperum-pml dhcpcd[2058]: wlan0: adding route to 192.168.1.0/24 Apr 21 15:05:45 imperum-pml dhcpcd[2058]: wlan0: adding default route via 192.168.1.1 Apr 21 15:05:45 imperum-pml avahi-daemon[689]: Registering new address record for 192.168.1.137 on wlan0.IPv4. Apr 21 15:05:45 imperum-pml dhcpcd[2058]: eth0: adding route to 192.168.1.0/24 Apr 21 15:05:45 imperum-pml systemd[1]: Stopping LSB: Start NTP daemon... Apr 21 15:05:45 imperum-pml ntpd[842]: ntpd exiting on signal 15 Apr 21 15:05:45 imperum-pml ntp[2411]: Stopping NTP server: ntpd. Apr 21 15:05:45 imperum-pml systemd[1]: Starting LSB: Start NTP daemon... Apr 21 15:05:45 imperum-pml ntpd[2429]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Apr 21 15:05:45 imperum-pml ntpd[2430]: proto: precision = 0.469 usec Apr 21 15:05:45 imperum-pml ntpd[2430]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 21 15:05:45 imperum-pml systemd[1]: Started LSB: Start NTP daemon. Apr 21 15:05:45 imperum-pml ntp[2422]: Starting NTP server: ntpd. Apr 21 15:05:45 imperum-pml ntpd[2430]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 21 15:05:45 imperum-pml ntpd[2430]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 21 15:05:45 imperum-pml ntpd[2430]: Listen normally on 3 eth0 192.168.1.136 UDP 123 Apr 21 15:05:45 imperum-pml ntpd[2430]: Listen normally on 4 wlan0 192.168.1.137 UDP 123 Apr 21 15:05:45 imperum-pml ntpd[2430]: peers refreshed Apr 21 15:05:45 imperum-pml ntpd[2430]: Listening on routing socket on fd #21 for interface updates Apr 21 15:05:45 imperum-pml wireless.js[1832]: trying... Apr 21 15:05:45 imperum-pml sudo[2432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 15:05:45 imperum-pml dhcpcd[2058]: eth0: removing route to 192.168.1.0/24 Apr 21 15:05:45 imperum-pml sudo[2432]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:45 imperum-pml sudo[2432]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:45 imperum-pml wireless.js[1832]: Connected to: ----MIWIFI_GH9k Apr 21 15:05:45 imperum-pml wireless.js[1832]: ---- Apr 21 15:05:45 imperum-pml sudo[2441]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 15:05:45 imperum-pml sudo[2441]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:45 imperum-pml sudo[2441]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:45 imperum-pml wireless.js[1832]: ... joined AP, wlan0 IPv4 is 192.168.1.137, ipV6 is undefined Apr 21 15:05:45 imperum-pml wireless.js[1832]: It's done! AP Apr 21 15:05:45 imperum-pml systemd[1]: Started Wireless Services. Apr 21 15:05:46 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 21 15:05:47 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 21 15:05:47 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 21 15:05:47 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 15:05:47 imperum-pml volumio[1625]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 15:05:47 imperum-pml volumio[1625]: info: Starting MyVolumio Remote Streaming Endpoints Apr 21 15:05:47 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 21 15:05:47 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 21 15:05:47 imperum-pml volumio[1625]: info: Streaming services startup Apr 21 15:05:47 imperum-pml volumio[1625]: info: Starting Streaming Daemon Apr 21 15:05:47 imperum-pml volumio[1625]: info: MyVolumio not started Apr 21 15:05:47 imperum-pml volumio[1625]: info: Initializing device activation check Apr 21 15:05:47 imperum-pml sudo[2451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 21 15:05:47 imperum-pml sudo[2451]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:47 imperum-pml volumio[1625]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 21 15:05:47 imperum-pml systemd[1]: Stopping Volumio Streaming Daemon... Apr 21 15:05:47 imperum-pml systemd[1]: Starting Volumio Streaming Daemon... Apr 21 15:05:47 imperum-pml systemd[1]: Started Volumio Streaming Daemon. Apr 21 15:05:47 imperum-pml sudo[2451]: pam_unix(sudo:session): session closed for user root Apr 21 15:05:47 imperum-pml volumio-streaming-daemon[2457]: ############################ Apr 21 15:05:47 imperum-pml volumio-streaming-daemon[2457]: # Volumio Streaming Daemon # Apr 21 15:05:47 imperum-pml volumio-streaming-daemon[2457]: # Running on port 7777 # Apr 21 15:05:47 imperum-pml volumio-streaming-daemon[2457]: ############################ Apr 21 15:05:47 imperum-pml volumio[1625]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 15:05:47 imperum-pml volumio-streaming-daemon[2457]: Environment: production Apr 21 15:05:47 imperum-pml volumio[1625]: { Error: addMembership ENODEV Apr 21 15:05:47 imperum-pml volumio[1625]: at _errnoException (util.js:1022:11) Apr 21 15:05:47 imperum-pml volumio[1625]: at Socket.addMembership (dgram.js:615:11) Apr 21 15:05:47 imperum-pml volumio[1625]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Apr 21 15:05:47 imperum-pml volumio[1625]: at ontimeout (timers.js:482:11) Apr 21 15:05:47 imperum-pml volumio[1625]: at tryOnTimeout (timers.js:317:5) Apr 21 15:05:47 imperum-pml volumio[1625]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Apr 21 15:05:47 imperum-pml volumio[1625]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 15:05:48 imperum-pml bash[1627]: Simple mixer control 'Mic',0 Apr 21 15:05:48 imperum-pml bash[1627]: Capabilities: pvolume pvolume-joined cvolume cvolume-joined pswitch pswitch-joined cswitch cswitch-joined Apr 21 15:05:48 imperum-pml bash[1627]: Playback channels: Mono Apr 21 15:05:48 imperum-pml bash[1627]: Capture channels: Mono Apr 21 15:05:48 imperum-pml bash[1627]: Limits: Playback 0 - 31 Capture 0 - 35 Apr 21 15:05:48 imperum-pml bash[1627]: Mono: Playback 16 [56%] [-7.00dB] [off] Capture 12 [21%] [0.00dB] [on] Apr 21 15:05:48 imperum-pml bash[1627]: Simple mixer control 'Mic',0 Apr 21 15:05:48 imperum-pml bash[1627]: Capabilities: pvolume pvolume-joined cvolume cvolume-joined pswitch pswitch-joined cswitch cswitch-joined Apr 21 15:05:48 imperum-pml bash[1627]: Playback channels: Mono Apr 21 15:05:48 imperum-pml bash[1627]: Capture channels: Mono Apr 21 15:05:48 imperum-pml bash[1627]: Limits: Playback 0 - 31 Capture 0 - 35 Apr 21 15:05:48 imperum-pml bash[1627]: Mono: Playback 16 [56%] [-7.00dB] [off] Capture 6 [9%] [-6.00dB] [on] Apr 21 15:05:48 imperum-pml sudo[2493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 15:04 Apr 21 15:05:48 imperum-pml sudo[2493]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 15:05:48 imperum-pml kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="ba22215fabbe766d668749499a1c25fcefd90f0a" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="043dcaee624f27d121213b83af11a9f2feac0945" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 18 01:32:43 CET 2020" VOLUMIO_VERSION="2.729" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5a0b29326faa8f5d0f5fe95d9e58c069"