-- Logs begin at Mon 2024-06-03 06:35:43 UTC, end at Mon 2024-07-22 06:41:26 UTC. -- Jul 22 06:40:57 ft4385-d029 systemd[1]: Time has been changed Jul 22 06:40:57 ft4385-d029 systemd[1]: Started Music Player Daemon. Jul 22 06:40:57 ft4385-d029 rc.local[689]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 06:40:57 ft4385-d029 rc.local[689]: command_len 207 Jul 22 06:40:57 ft4385-d029 rc.local[689]: pushSourceInfo Jul 22 06:40:57 ft4385-d029 rc.local[689]: { Jul 22 06:40:57 ft4385-d029 rc.local[689]: "source": 1, Jul 22 06:40:57 ft4385-d029 rc.local[689]: "title": "This is Title", Jul 22 06:40:57 ft4385-d029 rc.local[689]: "artist": "This is artist", Jul 22 06:40:57 ft4385-d029 rc.local[689]: "album": "This is album xxxxxxxxxxxxxxxxxxxxxxxxxxxxxx", Jul 22 06:40:57 ft4385-d029 rc.local[689]: "phonename": "Huawei Mate 50", Jul 22 06:40:57 ft4385-d029 rc.local[689]: "decode": "APTX-HD 44.1kHz" Jul 22 06:40:57 ft4385-d029 rc.local[689]: } Jul 22 06:40:58 ft4385-d029 wireless.js[882]: WIRELESS: No wireless interface, exiting Jul 22 06:40:58 ft4385-d029 systemd[1]: wireless.service: control process exited, code=exited status=1 Jul 22 06:40:58 ft4385-d029 systemd[1]: Failed to start Wireless Services. Jul 22 06:40:58 ft4385-d029 systemd[1]: Unit wireless.service entered failed state. Jul 22 06:40:58 ft4385-d029 systemd[1]: Starting Volumio Backend Module... Jul 22 06:40:58 ft4385-d029 systemd[1]: Started Volumio Backend Module. Jul 22 06:40:58 ft4385-d029 systemd[1]: Started LSB: start Samba daemons for the AD DC. Jul 22 06:40:58 ft4385-d029 winbind[692]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Jul 22 06:40:58 ft4385-d029 winbind[692]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 22 06:40:58 ft4385-d029 winbind[692]: Unable to setup corepath for winbindd: No such file or directory Jul 22 06:40:58 ft4385-d029 winbind[692]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jul 22 06:40:58 ft4385-d029 winbind[692]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 22 06:40:58 ft4385-d029 winbind[692]: Unable to setup corepath for winbindd: No such file or directory Jul 22 06:40:58 ft4385-d029 winbind[692]: [2024/07/22 06:40:58, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:58 ft4385-d029 winbind[692]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 22 06:40:58 ft4385-d029 winbind[692]: [2024/07/22 06:40:58, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:58 ft4385-d029 winbind[692]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 22 06:40:58 ft4385-d029 winbind[692]: [2024/07/22 06:40:58, 0] ../source3/winbindd/winbindd.c:1549(main) Jul 22 06:40:58 ft4385-d029 winbind[692]: winbindd version 4.2.14-Debian started. Jul 22 06:40:58 ft4385-d029 winbind[692]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jul 22 06:40:58 ft4385-d029 winbind[692]: [2024/07/22 06:40:58, 0] ../lib/util/util.c:220(directory_create_or_exist) Jul 22 06:40:58 ft4385-d029 winbind[692]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jul 22 06:40:58 ft4385-d029 winbind[692]: [2024/07/22 06:40:58, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jul 22 06:40:58 ft4385-d029 winbind[692]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 22 06:40:58 ft4385-d029 winbind[692]: [2024/07/22 06:40:58, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jul 22 06:40:58 ft4385-d029 winbind[692]: Unable to setup corepath for winbindd: No such file or directory Jul 22 06:40:58 ft4385-d029 winbindd[987]: [2024/07/22 06:40:58.905122, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:58 ft4385-d029 winbindd[987]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 22 06:40:58 ft4385-d029 winbindd[987]: [2024/07/22 06:40:58.907127, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:58 ft4385-d029 winbindd[987]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 22 06:40:58 ft4385-d029 nmbd[989]: [2024/07/22 06:40:58.946213, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:58 ft4385-d029 nmbd[989]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 22 06:40:58 ft4385-d029 winbindd[990]: [2024/07/22 06:40:58.948739, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Jul 22 06:40:58 ft4385-d029 winbindd[990]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jul 22 06:40:58 ft4385-d029 nmbd[989]: [2024/07/22 06:40:58.950380, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:58 ft4385-d029 nmbd[989]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 22 06:40:58 ft4385-d029 nmbd[991]: [2024/07/22 06:40:58.961583, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Jul 22 06:40:58 ft4385-d029 nmbd[991]: started asyncdns process 992 Jul 22 06:40:58 ft4385-d029 nmbd[991]: [2024/07/22 06:40:58.986262, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jul 22 06:40:58 ft4385-d029 nmbd[991]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jul 22 06:40:58 ft4385-d029 systemd[1]: Started LSB: start Winbind daemon. Jul 22 06:40:58 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:40:58 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:40:58 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:40:58 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:40:59 ft4385-d029 winbindd[990]: [2024/07/22 06:40:59.003351, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jul 22 06:40:59 ft4385-d029 winbindd[990]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jul 22 06:40:59 ft4385-d029 winbindd[998]: [2024/07/22 06:40:59.019389, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:59 ft4385-d029 winbindd[998]: Unable to open new log file '/var/log/samba/log.wb-FT4385-D029': No such file or directory Jul 22 06:40:59 ft4385-d029 systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Jul 22 06:40:59 ft4385-d029 winbind[692]: [2024/07/22 06:40:58.905122, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:59 ft4385-d029 winbind[692]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 22 06:40:59 ft4385-d029 winbind[692]: [2024/07/22 06:40:58.907127, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:59 ft4385-d029 winbind[692]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 22 06:40:59 ft4385-d029 nmbd[702]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Jul 22 06:40:59 ft4385-d029 nmbd[702]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 22 06:40:59 ft4385-d029 nmbd[702]: Unable to setup corepath for nmbd: No such file or directory Jul 22 06:40:59 ft4385-d029 nmbd[702]: [2024/07/22 06:40:58, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:59 ft4385-d029 nmbd[702]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 22 06:40:59 ft4385-d029 nmbd[702]: [2024/07/22 06:40:58, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:59 ft4385-d029 nmbd[702]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 22 06:40:59 ft4385-d029 nmbd[702]: [2024/07/22 06:40:58, 0] ../source3/nmbd/nmbd.c:908(main) Jul 22 06:40:59 ft4385-d029 nmbd[702]: nmbd version 4.2.14-Debian started. Jul 22 06:40:59 ft4385-d029 nmbd[702]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jul 22 06:40:59 ft4385-d029 nmbd[702]: [2024/07/22 06:40:58.946213, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:59 ft4385-d029 nmbd[702]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 22 06:40:59 ft4385-d029 nmbd[702]: [2024/07/22 06:40:58.950380, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:40:59 ft4385-d029 nmbd[702]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 22 06:40:59 ft4385-d029 winbind[692]: . Jul 22 06:40:59 ft4385-d029 nmbd[702]: . Jul 22 06:40:59 ft4385-d029 volumio[994]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:40:59 ft4385-d029 systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Jul 22 06:40:59 ft4385-d029 rc.local[689]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 06:41:00 ft4385-d029 rc.local[689]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 06:41:00 ft4385-d029 rc.local[689]: [2024-07-22 06:41:00] [info] asio async_connect error: asio.system:111 (Connection refused) Jul 22 06:41:00 ft4385-d029 rc.local[689]: [2024-07-22 06:41:00] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Jul 22 06:41:00 ft4385-d029 rc.local[689]: [2024-07-22 06:41:00] [error] handle_connect error: Connection refused Jul 22 06:41:00 ft4385-d029 smbd[1001]: Starting SMB/CIFS daemon: smbd[2024/07/22 06:41:00, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1001]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1001]: [2024/07/22 06:41:00, 0] ../lib/util/util.c:220(directory_create_or_exist) Jul 22 06:41:00 ft4385-d029 smbd[1001]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1001]: [2024/07/22 06:41:00, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jul 22 06:41:00 ft4385-d029 smbd[1001]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 22 06:41:00 ft4385-d029 smbd[1001]: [2024/07/22 06:41:00, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jul 22 06:41:00 ft4385-d029 smbd[1001]: Unable to setup corepath for smbd: No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1001]: [2024/07/22 06:41:00, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1001]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1001]: [2024/07/22 06:41:00, 0] ../source3/smbd/server.c:1241(main) Jul 22 06:41:00 ft4385-d029 smbd[1001]: smbd version 4.2.14-Debian started. Jul 22 06:41:00 ft4385-d029 smbd[1001]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jul 22 06:41:00 ft4385-d029 smbd[1013]: [2024/07/22 06:41:00.720839, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1013]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1013]: [2024/07/22 06:41:00.723530, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1013]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1013]: [2024/07/22 06:41:00.724010, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1013]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1001]: [2024/07/22 06:41:00.720839, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1001]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1001]: [2024/07/22 06:41:00.723530, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1001]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1001]: [2024/07/22 06:41:00.724010, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1001]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:00 ft4385-d029 systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Jul 22 06:41:00 ft4385-d029 smbd[1001]: . Jul 22 06:41:00 ft4385-d029 avahi-daemon[728]: Received response from host 192.168.23.146 with invalid source port 44703 on interface 'eth0.0' Jul 22 06:41:00 ft4385-d029 winbindd[1017]: [2024/07/22 06:41:00.811764, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 winbindd[1017]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Jul 22 06:41:00 ft4385-d029 winbindd[1018]: [2024/07/22 06:41:00.873123, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 winbindd[1018]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Jul 22 06:41:00 ft4385-d029 smbd[1014]: [2024/07/22 06:41:00.922786, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jul 22 06:41:00 ft4385-d029 smbd[1014]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jul 22 06:41:00 ft4385-d029 smbd[1019]: [2024/07/22 06:41:00.932630, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 22 06:41:00 ft4385-d029 smbd[1019]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 22 06:41:01 ft4385-d029 rc.local[689]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Jul 22 06:41:01 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:01 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:01 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:01 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:01 ft4385-d029 volumio[1024]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:01 ft4385-d029 volumio-remote-updater[679]: [2024-07-22 06:41:01] [info] asio async_connect error: system:111 (Connection refused) Jul 22 06:41:01 ft4385-d029 volumio-remote-updater[679]: [2024-07-22 06:41:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 22 06:41:01 ft4385-d029 volumio-remote-updater[679]: [2024-07-22 06:41:01] [error] handle_connect error: Underlying Transport Error Jul 22 06:41:03 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:03 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:03 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:03 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:03 ft4385-d029 volumio[1038]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:03 ft4385-d029 volumio[973]: info: ------------------------------------------- Jul 22 06:41:03 ft4385-d029 volumio[973]: info: ----- Fortex ---- Jul 22 06:41:03 ft4385-d029 volumio[973]: info: ------------------------------------------- Jul 22 06:41:03 ft4385-d029 volumio[973]: info: ----- System startup ---- Jul 22 06:41:03 ft4385-d029 volumio[973]: info: ------------------------------------------- Jul 22 06:41:05 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:05 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:05 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:05 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:05 ft4385-d029 volumio[1041]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Plugin folders cleanup Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Scanning into folder /volumio/app/plugins/ Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Scanning category audio_interface Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Scanning category miscellanea Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Scanning category music_service Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Scanning category plugins.json Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Scanning category system_controller Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Scanning category user_interface Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Scanning into folder /data/plugins/ Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Plugin folders cleanup completed Jul 22 06:41:05 ft4385-d029 volumio[973]: info: ------------------------------------------- Jul 22 06:41:05 ft4385-d029 volumio[973]: info: ----- Core plugins startup ---- Jul 22 06:41:05 ft4385-d029 volumio[973]: info: ------------------------------------------- Jul 22 06:41:05 ft4385-d029 volumio[973]: info: Loading plugins from folder /volumio/app/plugins/ Jul 22 06:41:06 ft4385-d029 volumio[973]: info: Adding plugin upnp to MyMusic Plugins Jul 22 06:41:06 ft4385-d029 volumio[973]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 22 06:41:06 ft4385-d029 volumio[973]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 22 06:41:06 ft4385-d029 volumio[973]: info: Loading plugins from folder /data/plugins/ Jul 22 06:41:06 ft4385-d029 volumio[973]: info: Loading plugin "system"... Jul 22 06:41:06 ft4385-d029 volumio[973]: info: Loading plugin "appearance"... Jul 22 06:41:07 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:07 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:07 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:07 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:08 ft4385-d029 volumio[1046]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:10 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:10 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:10 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:10 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:10 ft4385-d029 volumio[1049]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:11 ft4385-d029 rc.local[689]: [2024-07-22 06:41:11] [connect] Successful connection Jul 22 06:41:11 ft4385-d029 volumio-remote-updater[679]: [2024-07-22 06:41:11] [connect] Successful connection Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Loading plugin "network"... Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Refreshing Cached IP Addresses Jul 22 06:41:12 ft4385-d029 sudo[1053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 22 06:41:12 ft4385-d029 sudo[1053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:12 ft4385-d029 sudo[1053]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:12 ft4385-d029 sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 06:41:12 ft4385-d029 sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:12 ft4385-d029 sudo[1055]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:12 ft4385-d029 sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd-edimax.conf Jul 22 06:41:12 ft4385-d029 sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Loading plugin "services"... Jul 22 06:41:12 ft4385-d029 sudo[1058]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Loading plugin "alsa_controller"... Jul 22 06:41:12 ft4385-d029 sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Jul 22 06:41:12 ft4385-d029 sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:12 ft4385-d029 sudo[1063]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Loading plugin "wizard"... Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Loading plugin "volumio_command_line_client"... Jul 22 06:41:12 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:12 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:12 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:12 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:12 ft4385-d029 volumio[1066]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Loading plugin "upnp"... Jul 22 06:41:12 ft4385-d029 volumio[973]: info: [1721630472550] Starting Upmpd Daemon Jul 22 06:41:12 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Loading plugin "my_music"... Jul 22 06:41:12 ft4385-d029 volumio[973]: info: Loading plugin "mpd"... Jul 22 06:41:13 ft4385-d029 volumio[973]: info: Loading plugin "upnp_browser"... Jul 22 06:41:14 ft4385-d029 volumio[973]: info: Loading plugin "networkfs"... Jul 22 06:41:14 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:14 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:14 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:14 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:14 ft4385-d029 volumio[1075]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:14 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 22 06:41:14 ft4385-d029 volumio[973]: info: Loading plugin "alarm-clock"... Jul 22 06:41:15 ft4385-d029 volumio[973]: info: Loading plugin "airplay_emulation"... Jul 22 06:41:15 ft4385-d029 volumio[973]: info: Starting Shairport Sync Jul 22 06:41:15 ft4385-d029 volumio[973]: info: Loading plugin "last_100"... Jul 22 06:41:15 ft4385-d029 volumio[973]: info: Loading plugin "webradio"... Jul 22 06:41:15 ft4385-d029 volumio[973]: info: Loading plugin "i2s_dacs"... Jul 22 06:41:15 ft4385-d029 volumio[973]: info: I2S DAC not set, start Auto-detection Jul 22 06:41:15 ft4385-d029 volumio[973]: info: Loading plugin "volumiodiscovery"... Jul 22 06:41:16 ft4385-d029 volumio[973]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 22 06:41:16 ft4385-d029 node[973]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 22 06:41:16 ft4385-d029 node[973]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 06:41:16 ft4385-d029 node[973]: *** WARNING *** For more information see Jul 22 06:41:16 ft4385-d029 node[973]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 22 06:41:16 ft4385-d029 node[973]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 06:41:16 ft4385-d029 node[973]: *** WARNING *** For more information see Jul 22 06:41:16 ft4385-d029 volumio[973]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 06:41:16 ft4385-d029 volumio[973]: *** WARNING *** For more information see Jul 22 06:41:16 ft4385-d029 volumio[973]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 22 06:41:16 ft4385-d029 volumio[973]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 22 06:41:16 ft4385-d029 volumio[973]: *** WARNING *** For more information see Jul 22 06:41:16 ft4385-d029 volumio[973]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 22 06:41:16 ft4385-d029 volumio[973]: Discovery: StartAdv! undefined Jul 22 06:41:16 ft4385-d029 volumio[973]: Discovery: Started advertising... ft4385-d029 - undefined Jul 22 06:41:16 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 22 06:41:16 ft4385-d029 volumio[973]: info: Loading plugin "outputs"... Jul 22 06:41:16 ft4385-d029 volumio[973]: info: Loading plugin "albumart"... Jul 22 06:41:16 ft4385-d029 volumio[973]: info: Plugin example_plugin is not enabled Jul 22 06:41:16 ft4385-d029 volumio[973]: info: Loading plugin "inputs"... Jul 22 06:41:16 ft4385-d029 volumio[973]: info: Loading plugin "volspotconnect2"... Jul 22 06:41:16 ft4385-d029 volumio[973]: Forking 3 albumart workers Jul 22 06:41:16 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:16 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:16 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:16 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:17 ft4385-d029 volumio[1093]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:19 ft4385-d029 volumio[973]: Starting albumart workers Jul 22 06:41:19 ft4385-d029 volumio[973]: Starting albumart workers Jul 22 06:41:19 ft4385-d029 volumio[973]: [SpotifyConnect2] Creating VLS config file Jul 22 06:41:19 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:19 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:19 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:19 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:19 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:19 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:19 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:19 ft4385-d029 volumio[973]: [SpotifyConnect2] <> or Mixer found, using softvol Jul 22 06:41:19 ft4385-d029 volumio[973]: Starting albumart workers Jul 22 06:41:19 ft4385-d029 volumio[973]: info: Loading plugin "updater_comm"... Jul 22 06:41:19 ft4385-d029 volumio[1109]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:20 ft4385-d029 volumio[973]: info: Plugin mpdemulation is not enabled Jul 22 06:41:20 ft4385-d029 volumio[973]: info: Loading plugin "rest_api"... Jul 22 06:41:20 ft4385-d029 volumio[973]: info: Loading plugin "websocket"... Jul 22 06:41:20 ft4385-d029 volumio[973]: info: ___________ START PLUGINS ___________ Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 22 06:41:20 ft4385-d029 volumio[973]: info: [1721630480765] CoreMusicLibrary::Adding element Media Servers Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:20 ft4385-d029 volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:20 ft4385-d029 volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 22 06:41:20 ft4385-d029 volumio[973]: info: [1721630480952] CoreMusicLibrary::Adding element Last_100 Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 22 06:41:20 ft4385-d029 volumio[973]: info: [1721630480962] CoreMusicLibrary::Adding element Webradio Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 22 06:41:20 ft4385-d029 volumio[973]: [SpotifyConnect2] Creating VLS config file Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:20 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:20 ft4385-d029 volumio[973]: [SpotifyConnect2] <> or Mixer found, using softvol Jul 22 06:41:21 ft4385-d029 volumio[973]: [SpotifyConnect2] Starting metadata listener Jul 22 06:41:21 ft4385-d029 sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 22 06:41:21 ft4385-d029 volumio[973]: info: Loading i18n strings for locale en Jul 22 06:41:21 ft4385-d029 sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:21 ft4385-d029 volumio[973]: Updating browse sources language Jul 22 06:41:21 ft4385-d029 volumio[973]: Cannot find translation for sourceMedia Servers Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 06:41:21 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::initPlayerControls Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: info: BOOT COMPLETED Jul 22 06:41:21 ft4385-d029 volumio[973]: [Metrics] CommandRouter: 17s 431.89ms Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM softvolume Jul 22 06:41:21 ft4385-d029 volumio[973]: aplay: main:722: audio open error: No such file or directory Jul 22 06:41:21 ft4385-d029 volumio[973]: Cannot play startup sound Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::Close All Modals sent Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::Close All Modals sent Jul 22 06:41:21 ft4385-d029 volumio[973]: Express server listening on port 3000 Jul 22 06:41:21 ft4385-d029 volumio[973]: [Metrics] WebUI: 18s 970.94ms Jul 22 06:41:21 ft4385-d029 volumio[973]: Volumio Calling Home Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreStateMachine::resetVolumioState Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreStateMachine::getcurrentVolume Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioRetrievevolume Jul 22 06:41:21 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:21 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:21 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:21 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:21 ft4385-d029 sudo[1143]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:21 ft4385-d029 volumio[1154]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:21 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 06:41:21 ft4385-d029 volumio[973]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 22 06:41:22 ft4385-d029 volumio[973]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jul 22 06:41:22 ft4385-d029 volumio[973]: [SpotifyConnect2] Vollibrespot Daemon service started! Jul 22 06:41:22 ft4385-d029 volumio[973]: [Metrics] SpotifyConnect: 1s 305.14ms Jul 22 06:41:22 ft4385-d029 volumio[973]: info: MPD running with PID732 Jul 22 06:41:22 ft4385-d029 volumio[973]: ,establishing connection Jul 22 06:41:22 ft4385-d029 volumio[973]: info: Permissions for /etc/hostapd/hostapd.conf Jul 22 06:41:22 ft4385-d029 sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jul 22 06:41:22 ft4385-d029 sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:22 ft4385-d029 sudo[1162]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:22 ft4385-d029 volumio[973]: info: Permissions for /etc/hostapd/hostapd-edimax.conf Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 22 06:41:22 ft4385-d029 sudo[1165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jul 22 06:41:22 ft4385-d029 sudo[1165]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:22 ft4385-d029 systemd[1]: Starting Wireless Services... Jul 22 06:41:22 ft4385-d029 sudo[1169]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 22 06:41:22 ft4385-d029 sudo[1169]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:22 ft4385-d029 wifistart.sh[1168]: command failed: No such device (-19) Jul 22 06:41:22 ft4385-d029 sudo[1169]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 06:41:22 ft4385-d029 volumio[973]: info: VolumeController:: Volume=undefined Mute =false Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreStateMachine::pushState Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrack 0 Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioPushState Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreStateMachine::updateTrackBlock Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrackBlock Jul 22 06:41:22 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioRetrievevolume Jul 22 06:41:22 ft4385-d029 volumio[973]: info: Volumio called home Jul 22 06:41:23 ft4385-d029 sudo[1184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 22 06:41:23 ft4385-d029 sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:23 ft4385-d029 sudo[1184]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:23 ft4385-d029 sudo[1186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 06:41:23 ft4385-d029 sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:23 ft4385-d029 sudo[1186]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:23 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioGetState Jul 22 06:41:23 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrack 0 Jul 22 06:41:23 ft4385-d029 rc.local[689]: command_len 9 Jul 22 06:41:23 ft4385-d029 rc.local[689]: getQueue Jul 22 06:41:23 ft4385-d029 rc.local[689]: Jul 22 06:41:23 ft4385-d029 volumio[973]: info: Jul 22 06:41:23 ft4385-d029 volumio[973]: ---------------------------- Client requests Volume 100 Jul 22 06:41:23 ft4385-d029 volumio[973]: info: VolumeController::SetAlsaVolume100 Jul 22 06:41:23 ft4385-d029 volumio[973]: info: CoreStateMachine::pushState Jul 22 06:41:23 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrack 0 Jul 22 06:41:23 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioPushState Jul 22 06:41:23 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 06:41:23 ft4385-d029 volumio[973]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jul 22 06:41:23 ft4385-d029 wireless.js[1175]: WIRELESS: No wireless interface, exiting Jul 22 06:41:23 ft4385-d029 volumio[973]: info: Reloading queue from file Jul 22 06:41:23 ft4385-d029 systemd[1]: wireless.service: control process exited, code=exited status=1 Jul 22 06:41:23 ft4385-d029 systemd[1]: Failed to start Wireless Services. Jul 22 06:41:23 ft4385-d029 systemd[1]: Unit wireless.service entered failed state. Jul 22 06:41:23 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:23 ft4385-d029 sudo[1165]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:23 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:23 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:23 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:23 ft4385-d029 volumio[973]: error: updateQueue error: null Jul 22 06:41:23 ft4385-d029 volumio[973]: error: Failed LSINFO: Error: [50@0] {} No such directory Jul 22 06:41:23 ft4385-d029 volumio[1199]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:23 ft4385-d029 volumio[973]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jul 22 06:41:23 ft4385-d029 volumio[973]: info: Setting volume on startup at 100 Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreStateMachine::setRepeat true single undefined Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreStateMachine::pushState Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrack 0 Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioPushState Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreStateMachine::setRandom true Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreStateMachine::pushState Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrack 0 Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioPushState Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 06:41:24 ft4385-d029 volumio[973]: info: VolumeController:: Volume=undefined Mute =false Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreStateMachine::pushState Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrack 0 Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioPushState Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioGetState Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrack 0 Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CoreCommandRouter::volumioGetState Jul 22 06:41:24 ft4385-d029 volumio[973]: info: CorePlayQueue::getTrack 0 Jul 22 06:41:24 ft4385-d029 volumio[973]: info: Starting Shairport Sync Jul 22 06:41:24 ft4385-d029 volumio[973]: info: Starting Shairport Sync Jul 22 06:41:24 ft4385-d029 sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 06:41:24 ft4385-d029 sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:24 ft4385-d029 volumio[973]: Discovery: adding ab4510d3-e69f-454f-8bd1-4594ea10b84c Jul 22 06:41:24 ft4385-d029 volumio[973]: info: mDNS: Found device Volumio Jul 22 06:41:24 ft4385-d029 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 22 06:41:24 ft4385-d029 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 06:41:24 ft4385-d029 volumio[973]: error: Could not retrieve plugin audio_interface multiroom Jul 22 06:41:24 ft4385-d029 sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 06:41:24 ft4385-d029 sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:24 ft4385-d029 sudo[1208]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:24 ft4385-d029 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 06:41:24 ft4385-d029 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 22 06:41:24 ft4385-d029 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 06:41:24 ft4385-d029 sudo[1210]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:24 ft4385-d029 volumio[973]: info: Shairport-Sync Started Jul 22 06:41:24 ft4385-d029 volumio[973]: Error adding Membership: Error: addMembership EINVAL Jul 22 06:41:24 ft4385-d029 volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 06:41:24 ft4385-d029 volumio[973]: TypeError: Cannot read property 'UUID' of undefined Jul 22 06:41:24 ft4385-d029 volumio[973]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:174:53) Jul 22 06:41:24 ft4385-d029 volumio[973]: at emitTwo (events.js:126:13) Jul 22 06:41:24 ft4385-d029 volumio[973]: at Browser.emit (events.js:214:7) Jul 22 06:41:24 ft4385-d029 volumio[973]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jul 22 06:41:24 ft4385-d029 volumio[973]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Jul 22 06:41:24 ft4385-d029 volumio[973]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jul 22 06:41:24 ft4385-d029 volumio[973]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Jul 22 06:41:24 ft4385-d029 volumio[973]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Jul 22 06:41:24 ft4385-d029 sudo[1218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 22 06:41:24 ft4385-d029 sudo[1218]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 06:41:24 ft4385-d029 volumio[973]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 06:41:24 ft4385-d029 systemd[1]: Starting UPnP Renderer front-end to MPD... Jul 22 06:41:24 ft4385-d029 systemd[1]: Started UPnP Renderer front-end to MPD. Jul 22 06:41:24 ft4385-d029 sudo[1218]: pam_unix(sudo:session): session closed for user root Jul 22 06:41:25 ft4385-d029 systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jul 22 06:41:25 ft4385-d029 systemd[1]: Stopping Volspotconnect2 Daemon... Jul 22 06:41:25 ft4385-d029 systemd[1]: Starting Volspotconnect2 Daemon... Jul 22 06:41:25 ft4385-d029 systemd[1]: Started Volspotconnect2 Daemon. Jul 22 06:41:26 ft4385-d029 volumio[1235]: /volumio/app/plugins/music_service/volspotconnect2/startconnect.sh: line 4: ./vollibrespot: Permission denied Jul 22 06:41:26 ft4385-d029 sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 06:40 Jul 22 06:41:26 ft4385-d029 sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Oct 10 12:33:12 HKT 2022" VOLUMIO_VERSION="1.1" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_HASH="d41d8cd98f00b204e9800998ecf8427e"