-- Logs begin at Sun 2018-05-20 11:50:48 UTC, end at Tue 2025-02-18 09:50:54 UTC. -- Feb 18 09:49:06 volumio systemd[1]: Failed to start Wireless Services. Feb 18 09:49:06 volumio systemd[1]: Unit wireless.service entered failed state. Feb 18 09:49:06 volumio systemd[1]: Starting Volumio Backend Module... Feb 18 09:49:06 volumio systemd[1]: Started Volumio Backend Module. Feb 18 09:49:09 volumio volumio-remote-updater[491]: [2025-02-18 09:49:09] [info] asio async_connect error: system:111 (Connection refused) Feb 18 09:49:09 volumio volumio-remote-updater[491]: [2025-02-18 09:49:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 18 09:49:09 volumio volumio-remote-updater[491]: [2025-02-18 09:49:09] [error] handle_connect error: Underlying Transport Error Feb 18 09:49:09 volumio udisks-glue[489]: Unable to get property "DeviceFile": Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken. Feb 18 09:49:19 volumio volumio-remote-updater[491]: [2025-02-18 09:49:19] [info] asio async_connect error: system:111 (Connection refused) Feb 18 09:49:19 volumio volumio-remote-updater[491]: [2025-02-18 09:49:19] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 18 09:49:19 volumio volumio-remote-updater[491]: [2025-02-18 09:49:19] [error] handle_connect error: Underlying Transport Error Feb 18 09:49:29 volumio volumio-remote-updater[491]: [2025-02-18 09:49:29] [info] asio async_connect error: system:111 (Connection refused) Feb 18 09:49:29 volumio volumio-remote-updater[491]: [2025-02-18 09:49:29] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 18 09:49:29 volumio volumio-remote-updater[491]: [2025-02-18 09:49:29] [error] handle_connect error: Underlying Transport Error Feb 18 09:49:34 volumio udisks-glue[489]: Unable to get property "DeviceFile": Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken. Feb 18 09:49:39 volumio volumio-remote-updater[491]: [2025-02-18 09:49:39] [info] asio async_connect error: system:111 (Connection refused) Feb 18 09:49:39 volumio volumio-remote-updater[491]: [2025-02-18 09:49:39] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 18 09:49:39 volumio volumio-remote-updater[491]: [2025-02-18 09:49:39] [error] handle_connect error: Underlying Transport Error Feb 18 09:49:49 volumio volumio-remote-updater[491]: [2025-02-18 09:49:49] [info] asio async_connect error: system:111 (Connection refused) Feb 18 09:49:49 volumio volumio-remote-updater[491]: [2025-02-18 09:49:49] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 18 09:49:49 volumio volumio-remote-updater[491]: [2025-02-18 09:49:49] [error] handle_connect error: Underlying Transport Error Feb 18 09:49:54 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. Feb 18 09:49:55 volumio winbind[498]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Feb 18 09:49:55 volumio winbind[498]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Feb 18 09:49:55 volumio winbind[498]: Unable to setup corepath for winbindd: No such file or directory Feb 18 09:49:55 volumio winbind[498]: mkdir failed on directory /var/log/samba/cores: No such file or directory Feb 18 09:49:55 volumio winbind[498]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Feb 18 09:49:55 volumio winbind[498]: Unable to setup corepath for winbindd: No such file or directory Feb 18 09:49:55 volumio winbind[498]: [2025/02/18 09:49:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:49:55 volumio winbind[498]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Feb 18 09:49:55 volumio winbind[498]: [2025/02/18 09:49:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:49:55 volumio winbind[498]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Feb 18 09:49:55 volumio winbind[498]: [2025/02/18 09:49:55, 0] ../source3/winbindd/winbindd.c:1549(main) Feb 18 09:49:55 volumio winbind[498]: winbindd version 4.2.14-Debian started. Feb 18 09:49:55 volumio winbind[498]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Feb 18 09:49:55 volumio winbind[498]: [2025/02/18 09:49:55, 0] ../lib/util/util.c:220(directory_create_or_exist) Feb 18 09:49:55 volumio winbind[498]: mkdir failed on directory /var/log/samba/cores: No such file or directory Feb 18 09:49:55 volumio winbind[498]: [2025/02/18 09:49:55, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Feb 18 09:49:55 volumio winbind[498]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Feb 18 09:49:55 volumio winbind[498]: [2025/02/18 09:49:55, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Feb 18 09:49:55 volumio winbind[498]: Unable to setup corepath for winbindd: No such file or directory Feb 18 09:49:55 volumio nmbd[515]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Feb 18 09:49:55 volumio nmbd[515]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Feb 18 09:49:55 volumio nmbd[515]: Unable to setup corepath for nmbd: No such file or directory Feb 18 09:49:55 volumio nmbd[784]: [2025/02/18 09:49:55.425424, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:49:55 volumio nmbd[784]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Feb 18 09:49:55 volumio nmbd[515]: [2025/02/18 09:49:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:49:55 volumio nmbd[515]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Feb 18 09:49:55 volumio nmbd[515]: [2025/02/18 09:49:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:49:55 volumio nmbd[515]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Feb 18 09:49:55 volumio nmbd[515]: [2025/02/18 09:49:55, 0] ../source3/nmbd/nmbd.c:908(main) Feb 18 09:49:55 volumio nmbd[515]: nmbd version 4.2.14-Debian started. Feb 18 09:49:55 volumio nmbd[515]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Feb 18 09:49:55 volumio nmbd[515]: [2025/02/18 09:49:55.425424, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:49:55 volumio nmbd[515]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Feb 18 09:49:59 volumio volumio-remote-updater[491]: [2025-02-18 09:49:59] [info] asio async_connect error: system:111 (Connection refused) Feb 18 09:49:59 volumio volumio-remote-updater[491]: [2025-02-18 09:49:59] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 18 09:49:59 volumio volumio-remote-updater[491]: [2025-02-18 09:49:59] [error] handle_connect error: Underlying Transport Error Feb 18 09:49:59 volumio udisks-glue[489]: Unable to get property "DeviceFile": Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken. Feb 18 09:50:04 volumio winbindd[782]: [2025/02/18 09:50:04.627314, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:04 volumio winbindd[782]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Feb 18 09:50:04 volumio nmbd[784]: [2025/02/18 09:50:04.628274, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:04 volumio nmbd[784]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Feb 18 09:50:04 volumio winbindd[782]: [2025/02/18 09:50:04.628498, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:04 volumio winbindd[782]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Feb 18 09:50:04 volumio nmbd[786]: [2025/02/18 09:50:04.632652, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Feb 18 09:50:04 volumio nmbd[786]: started asyncdns process 787 Feb 18 09:50:04 volumio winbind[498]: [2025/02/18 09:50:04.627314, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:04 volumio winbind[498]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Feb 18 09:50:04 volumio winbind[498]: [2025/02/18 09:50:04.628498, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:04 volumio winbind[498]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Feb 18 09:50:04 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Feb 18 09:50:04 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Feb 18 09:50:04 volumio nmbd[515]: [2025/02/18 09:50:04.628274, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:04 volumio nmbd[515]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Feb 18 09:50:04 volumio udisks-glue[489]: Device file /dev/mmcblk0 inserted Feb 18 09:50:04 volumio nmbd[515]: . Feb 18 09:50:04 volumio nmbd[786]: [2025/02/18 09:50:04.660916, 0] ../lib/util/become_daemon.c:124(daemon_ready) Feb 18 09:50:04 volumio nmbd[786]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 18 09:50:06 volumio winbind[498]: . Feb 18 09:50:06 volumio systemd[1]: Started LSB: start Winbind daemon. Feb 18 09:50:06 volumio winbindd[801]: [2025/02/18 09:50:06.072026, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Feb 18 09:50:06 volumio winbindd[801]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 18 09:50:06 volumio smbd[789]: Starting SMB/CIFS daemon: smbd[2025/02/18 09:50:06, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:06 volumio smbd[789]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:06 volumio smbd[789]: [2025/02/18 09:50:06, 0] ../lib/util/util.c:220(directory_create_or_exist) Feb 18 09:50:06 volumio smbd[789]: mkdir failed on directory /var/log/samba/cores: No such file or directory Feb 18 09:50:06 volumio smbd[789]: [2025/02/18 09:50:06, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Feb 18 09:50:06 volumio smbd[789]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Feb 18 09:50:06 volumio smbd[789]: [2025/02/18 09:50:06, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Feb 18 09:50:06 volumio smbd[789]: Unable to setup corepath for smbd: No such file or directory Feb 18 09:50:06 volumio smbd[789]: [2025/02/18 09:50:06, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:06 volumio smbd[789]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:06 volumio smbd[789]: [2025/02/18 09:50:06, 0] ../source3/smbd/server.c:1241(main) Feb 18 09:50:06 volumio smbd[789]: smbd version 4.2.14-Debian started. Feb 18 09:50:06 volumio smbd[789]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Feb 18 09:50:06 volumio smbd[799]: [2025/02/18 09:50:06.306797, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:06 volumio smbd[799]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:06 volumio smbd[799]: [2025/02/18 09:50:06.308454, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:06 volumio smbd[799]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:06 volumio smbd[799]: [2025/02/18 09:50:06.308709, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:06 volumio smbd[799]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:06 volumio smbd[789]: [2025/02/18 09:50:06.306797, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:06 volumio smbd[789]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:06 volumio smbd[789]: [2025/02/18 09:50:06.308454, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:06 volumio smbd[789]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:06 volumio smbd[789]: [2025/02/18 09:50:06.308709, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:06 volumio smbd[789]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:06 volumio smbd[789]: . Feb 18 09:50:06 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Feb 18 09:50:06 volumio systemd[1]: Starting Multi-User System. Feb 18 09:50:06 volumio systemd[1]: Reached target Multi-User System. Feb 18 09:50:06 volumio systemd[1]: Starting Graphical Interface. Feb 18 09:50:06 volumio systemd[1]: Reached target Graphical Interface. Feb 18 09:50:06 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 18 09:50:06 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 18 09:50:06 volumio systemd[1]: Startup finished in 19.256s (kernel) + 5min 35.778s (userspace) = 5min 55.034s. Feb 18 09:50:06 volumio volumio[767]: info: ------------------------------------------- Feb 18 09:50:06 volumio volumio[767]: info: ----- Volumio2 ---- Feb 18 09:50:06 volumio volumio[767]: info: ------------------------------------------- Feb 18 09:50:06 volumio volumio[767]: info: ----- System startup ---- Feb 18 09:50:06 volumio volumio[767]: info: ------------------------------------------- Feb 18 09:50:06 volumio volumio[767]: info: Plugin folders cleanup Feb 18 09:50:06 volumio volumio[767]: info: Scanning into folder /volumio/app/plugins/ Feb 18 09:50:06 volumio volumio[767]: info: Scanning category audio_interface Feb 18 09:50:06 volumio volumio[767]: info: Scanning category miscellanea Feb 18 09:50:06 volumio volumio[767]: info: Scanning category music_service Feb 18 09:50:06 volumio volumio[767]: info: Scanning category plugins.json Feb 18 09:50:06 volumio volumio[767]: info: Scanning category system_controller Feb 18 09:50:06 volumio volumio[767]: info: Scanning category user_interface Feb 18 09:50:06 volumio volumio[767]: info: Scanning into folder /data/plugins/ Feb 18 09:50:06 volumio volumio[767]: info: Plugin folders cleanup completed Feb 18 09:50:06 volumio volumio[767]: info: ------------------------------------------- Feb 18 09:50:06 volumio volumio[767]: info: ----- Core plugins startup ---- Feb 18 09:50:06 volumio volumio[767]: info: ------------------------------------------- Feb 18 09:50:06 volumio volumio[767]: info: Loading plugins from folder /volumio/app/plugins/ Feb 18 09:50:06 volumio volumio[767]: info: Loading plugins from folder /data/plugins/ Feb 18 09:50:06 volumio volumio[767]: info: Loading plugin "system"... Feb 18 09:50:07 volumio volumio[767]: info: Loading plugin "appearance"... Feb 18 09:50:09 volumio volumio-remote-updater[491]: [2025-02-18 09:50:09] [connect] Successful connection Feb 18 09:50:15 volumio volumio[767]: info: Loading plugin "network"... Feb 18 09:50:17 volumio volumio[767]: info: Loading plugin "services"... Feb 18 09:50:17 volumio volumio[767]: info: Loading plugin "alsa_controller"... Feb 18 09:50:17 volumio ntfs-3g[812]: Version 2014.2.15AR.2 integrated FUSE 28 Feb 18 09:50:17 volumio ntfs-3g[812]: Mounted /dev/mmcblk0p5 (Read-Write, label "新加卷", NTFS 3.1) Feb 18 09:50:17 volumio ntfs-3g[812]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Feb 18 09:50:17 volumio ntfs-3g[812]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/mmcblk0p5,blkdev,blksize=4096 Feb 18 09:50:17 volumio ntfs-3g[812]: Global ownership and permissions enforced, configuration type 7 Feb 18 09:50:18 volumio volumio[767]: info: Loading plugin "wizard"... Feb 18 09:50:18 volumio volumio[767]: info: Loading plugin "volumio_command_line_client"... Feb 18 09:50:18 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:18 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:18 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:18 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:18 volumio udisks-glue[489]: Device file /dev/mmcblk1boot0 inserted Feb 18 09:50:18 volumio udisks-glue[489]: Trying to automount /dev/mmcblk1boot0... Feb 18 09:50:18 volumio volumio[767]: info: Loading plugin "upnp"... Feb 18 09:50:18 volumio volumio[767]: info: [1739872218374] Starting Upmpd Daemon Feb 18 09:50:18 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 18 09:50:18 volumio volumio[767]: info: Loading plugin "my_music"... Feb 18 09:50:18 volumio volumio[767]: info: Loading plugin "mpd"... Feb 18 09:50:19 volumio winbindd[801]: [2025/02/18 09:50:19.166746, 0] ../lib/util/become_daemon.c:124(daemon_ready) Feb 18 09:50:19 volumio winbindd[801]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 18 09:50:19 volumio winbindd[820]: [2025/02/18 09:50:19.171700, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:19 volumio winbindd[820]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Feb 18 09:50:19 volumio volumio[767]: info: Loading plugin "upnp_browser"... Feb 18 09:50:22 volumio udisks-glue[489]: Failed to automount /dev/mmcblk1boot0: Error mounting: mount: unknown filesystem type 'minix' Feb 18 09:50:22 volumio udisks-glue[489]: Device file /dev/mmcblk0p5 mounted at /media/??? Feb 18 09:50:24 volumio volumio-remote-updater[491]: [2025-02-18 09:50:24] [connect] Successful connection Feb 18 09:50:24 volumio systemd[1]: Starting Music Player Daemon... Feb 18 09:50:24 volumio winbindd[830]: [2025/02/18 09:50:24.674487, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:24 volumio winbindd[830]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Feb 18 09:50:24 volumio winbindd[831]: [2025/02/18 09:50:24.717382, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:24 volumio winbindd[831]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Feb 18 09:50:24 volumio smbd[806]: [2025/02/18 09:50:24.755928, 0] ../lib/util/become_daemon.c:124(daemon_ready) Feb 18 09:50:24 volumio smbd[806]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 18 09:50:24 volumio smbd[832]: [2025/02/18 09:50:24.761481, 0] ../lib/util/debug.c:603(reopen_logs_internal) Feb 18 09:50:24 volumio smbd[832]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Feb 18 09:50:25 volumio volumio[767]: info: Loading plugin "networkfs"... Feb 18 09:50:25 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 18 09:50:25 volumio volumio[767]: info: Loading plugin "alarm-clock"... Feb 18 09:50:25 volumio systemd[1]: Started Music Player Daemon. Feb 18 09:50:25 volumio udisks-glue[489]: Updating DB (#1) ... Feb 18 09:50:25 volumio udisks-glue[489]: volume: n/a repeat: off random: off single: off consume: off Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "airplay_emulation"... Feb 18 09:50:26 volumio volumio[767]: info: [1739872226038] Starting Shairport Sync Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "last_100"... Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "webradio"... Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "i2s_dacs"... Feb 18 09:50:26 volumio volumio[767]: info: I2S DAC not set, start Auto-detection Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "volumiodiscovery"... Feb 18 09:50:26 volumio volumio[767]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 18 09:50:26 volumio node[767]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 18 09:50:26 volumio node[767]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 18 09:50:26 volumio node[767]: *** WARNING *** For more information see Feb 18 09:50:26 volumio node[767]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 18 09:50:26 volumio node[767]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 18 09:50:26 volumio node[767]: *** WARNING *** For more information see Feb 18 09:50:26 volumio volumio[767]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 18 09:50:26 volumio volumio[767]: *** WARNING *** For more information see Feb 18 09:50:26 volumio volumio[767]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 18 09:50:26 volumio volumio[767]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 18 09:50:26 volumio volumio[767]: *** WARNING *** For more information see Feb 18 09:50:26 volumio volumio[767]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 18 09:50:26 volumio volumio[767]: Discovery: StartAdv! undefined Feb 18 09:50:26 volumio volumio[767]: Discovery: Started advertising... Volumio - undefined Feb 18 09:50:26 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "albumart"... Feb 18 09:50:26 volumio volumio[767]: info: Plugin example_plugin is not enabled Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "updater_comm"... Feb 18 09:50:26 volumio volumio[767]: info: Plugin mpdemulation is not enabled Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "rest_api"... Feb 18 09:50:26 volumio volumio[767]: info: Loading plugin "websocket"... Feb 18 09:50:26 volumio volumio[767]: info: ___________ START PLUGINS ___________ Feb 18 09:50:26 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 09:50:26 volumio volumio[767]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 18 09:50:26 volumio volumio[767]: info: [1739872226873] CoreMusicLibrary::Adding element Media Servers Feb 18 09:50:26 volumio volumio[767]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 18 09:50:26 volumio volumio[767]: info: [1739872226903] CoreMusicLibrary::Adding element Last_100 Feb 18 09:50:26 volumio volumio[767]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 18 09:50:26 volumio volumio[767]: info: [1739872226908] CoreMusicLibrary::Adding element Webradio Feb 18 09:50:26 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 09:50:26 volumio volumio[767]: info: ------------------------------------------- Feb 18 09:50:26 volumio volumio[767]: info: ----- MyVolumio plugins startup ---- Feb 18 09:50:26 volumio volumio[767]: info: ------------------------------------------- Feb 18 09:50:26 volumio volumio[767]: info: Loading plugins from folder /myvolumio/plugins Feb 18 09:50:26 volumio volumio[767]: info: Loading plugins from folder /data/myvolumio/plugins Feb 18 09:50:26 volumio volumio[767]: info: Loading i18n strings for locale zh Feb 18 09:50:26 volumio volumio[767]: Updating browse sources language Feb 18 09:50:26 volumio volumio[767]: Cannot find translation for sourceMedia Servers Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::initPlayerControls Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 09:50:27 volumio volumio[767]: info: BOOT COMPLETED Feb 18 09:50:27 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 09:50:27 volumio kernel: ALSA sound/usb/pcm.c:349 setting usb interface 1:1 Feb 18 09:50:27 volumio kernel: ALSA sound/usb/endpoint.c:436 Creating new playback data endpoint #1 Feb 18 09:50:27 volumio kernel: ALSA sound/usb/endpoint.c:436 Creating new capture sync endpoint #81 Feb 18 09:50:27 volumio kernel: ALSA sound/usb/endpoint.c:807 Setting params for ep #1 (type 0, 8 urbs), ret=0 Feb 18 09:50:27 volumio kernel: ALSA sound/usb/endpoint.c:807 Setting params for ep #81 (type 1, 4 urbs), ret=0 Feb 18 09:50:27 volumio kernel: ALSA sound/usb/pcm.c:231 Starting data EP @eb3b0000 Feb 18 09:50:27 volumio kernel: ALSA sound/usb/pcm.c:260 Starting sync EP @eb3bc000 Feb 18 09:50:32 volumio kernel: WARN::urb_dequeue:969: urb->hcpriv == NULL! urb = e624f500 status=-104 Feb 18 09:50:32 volumio kernel: _hcd_isoc_complete:Uknown urb status -2 Feb 18 09:50:32 volumio volumio[767]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Feb 18 09:50:32 volumio volumio[767]: info: CoreCommandRouter::Close All Modals sent Feb 18 09:50:32 volumio volumio[767]: info: CoreCommandRouter::Close All Modals sent Feb 18 09:50:32 volumio volumio[767]: Express server listening on port 3000 Feb 18 09:50:32 volumio volumio[767]: Volumio Calling Home Feb 18 09:50:32 volumio kernel: changed the Multicast,mcount=4 Feb 18 09:50:32 volumio kernel: add mac address:01:00:5e:00:00:01,bit=32 Feb 18 09:50:32 volumio kernel: add mac address:33:33:00:00:00:01,bit=1 Feb 18 09:50:32 volumio kernel: add mac address:01:00:5e:00:00:fb,bit=48 Feb 18 09:50:33 volumio kernel: add mac address:01:00:5e:7f:ff:fa,bit=20 Feb 18 09:50:33 volumio kernel: set hash low=100002,high=10001 Feb 18 09:50:33 volumio kernel: changed the filter setting to :4 Feb 18 09:50:33 volumio volumio[767]: info: CoreStateMachine::resetVolumioState Feb 18 09:50:33 volumio volumio[767]: info: CoreStateMachine::getcurrentVolume Feb 18 09:50:33 volumio volumio[767]: info: CoreCommandRouter::volumioRetrievevolume Feb 18 09:50:33 volumio volumio[767]: info: CoreStateMachine::updateTrackBlock Feb 18 09:50:33 volumio volumio[767]: info: CorePlayQueue::getTrackBlock Feb 18 09:50:33 volumio volumio[767]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 18 09:50:33 volumio volumio[767]: info: Cannot initialize MPD Connection: MPD is not running Feb 18 09:50:33 volumio sudo[886]: pam_unix(sudo:auth): conversation failed Feb 18 09:50:33 volumio sudo[886]: pam_unix(sudo:auth): auth could not identify password for [volumio] Feb 18 09:50:33 volumio volumio[767]: info: VolumeController:: Volume=100 Mute =false Feb 18 09:50:33 volumio volumio[767]: info: CoreStateMachine::pushState Feb 18 09:50:33 volumio volumio[767]: info: CoreStateMachine::getState Feb 18 09:50:33 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:33 volumio volumio[767]: info: CoreCommandRouter::volumioPushState Feb 18 09:50:33 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 09:50:33 volumio volumio[767]: info: interfaceApi::pushState Feb 18 09:50:33 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 18 09:50:33 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 18 09:50:34 volumio volumio[767]: info: Feb 18 09:50:34 volumio volumio[767]: ---------------------------- Client requests Volume 100 Feb 18 09:50:34 volumio volumio[767]: info: VolumeController::SetAlsaVolume100 Feb 18 09:50:34 volumio volumio[767]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} Feb 18 09:50:34 volumio volumio[767]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Feb 18 09:50:34 volumio volumio[767]: We trust you have received the usual lecture from the local System Feb 18 09:50:34 volumio volumio[767]: Administrator. It usually boils down to these three things: Feb 18 09:50:34 volumio volumio[767]: #1) Respect the privacy of others. Feb 18 09:50:34 volumio volumio[767]: #2) Think before you type. Feb 18 09:50:34 volumio volumio[767]: #3) With great power comes great responsibility. Feb 18 09:50:34 volumio volumio[767]: sudo: no tty present and no askpass program specified Feb 18 09:50:34 volumio volumio[767]: info: Reloading queue from file Feb 18 09:50:34 volumio volumio[767]: info: VolumeController::Volume 100 Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::pushState Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::getState Feb 18 09:50:34 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:34 volumio volumio[767]: info: CoreCommandRouter::volumioPushState Feb 18 09:50:34 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 09:50:34 volumio volumio[767]: info: interfaceApi::pushState Feb 18 09:50:34 volumio volumio[767]: info: Setting volume on startup at 100 Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::setRepeat null single undefined Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::pushState Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::getState Feb 18 09:50:34 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:34 volumio volumio[767]: info: CoreCommandRouter::volumioPushState Feb 18 09:50:34 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 09:50:34 volumio volumio[767]: info: interfaceApi::pushState Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::setRandom null Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::pushState Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::getState Feb 18 09:50:34 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:34 volumio volumio[767]: info: CoreCommandRouter::volumioPushState Feb 18 09:50:34 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 09:50:34 volumio volumio[767]: info: interfaceApi::pushState Feb 18 09:50:34 volumio volumio[767]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/新加卷/邓丽君/邓丽君日本语UHQCD/邓丽君《日本语精选》.flac","favourite":false} Feb 18 09:50:34 volumio volumio[767]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/新加卷/邓丽君/邓丽君日本语UHQCD/邓丽君《日本语精选》.flac","favourite":false} Feb 18 09:50:34 volumio volumio[767]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/新加卷/邓丽君/邓丽君日本语UHQCD/邓丽君《日本语精选》.flac","favourite":false} Feb 18 09:50:34 volumio sudo[892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 18 09:50:34 volumio sudo[892]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 09:50:34 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Feb 18 09:50:34 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Feb 18 09:50:34 volumio sudo[894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Feb 18 09:50:34 volumio sudo[894]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 09:50:34 volumio sudo[892]: pam_unix(sudo:session): session closed for user root Feb 18 09:50:34 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Feb 18 09:50:34 volumio systemd[1]: Started ShairportSync AirTunes receiver. Feb 18 09:50:34 volumio sudo[894]: pam_unix(sudo:session): session closed for user root Feb 18 09:50:34 volumio volumio[767]: Discovery: adding 9bcef350-ecfe-45b9-b558-1e574a719c8e Feb 18 09:50:34 volumio volumio[767]: info: mDNS: Found device Volumio Feb 18 09:50:34 volumio shairport-sync[898]: Successful Startup Feb 18 09:50:34 volumio volumio[767]: info: Upmpdcli Daemon Started Feb 18 09:50:34 volumio volumio[767]: info: [1739872234597] Shairport-Sync Started Feb 18 09:50:34 volumio volumio[767]: Error adding Membership: Error: addMembership EINVAL Feb 18 09:50:34 volumio volumio[767]: info: CoreCommandRouter::volumioGetState Feb 18 09:50:34 volumio volumio[767]: info: CoreStateMachine::getState Feb 18 09:50:34 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:39 volumio volumio-remote-updater[491]: [2025-02-18 09:50:39] [connect] Successful connection Feb 18 09:50:39 volumio volumio-remote-updater[491]: [2025-02-18 09:50:39] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1739872239 101 Feb 18 09:50:39 volumio volumio[767]: info: CoreCommandRouter::volumioGetState Feb 18 09:50:39 volumio volumio[767]: info: CoreStateMachine::getState Feb 18 09:50:39 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:39 volumio volumio[767]: info: CoreCommandRouter::volumioGetBrowseSources Feb 18 09:50:39 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 18 09:50:39 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 18 09:50:39 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 18 09:50:39 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 18 09:50:39 volumio volumio[767]: Plugin multiroom or method getMultiroom not found Feb 18 09:50:39 volumio volumio[767]: info: Listing playlists Feb 18 09:50:41 volumio volumio[767]: info: CoreCommandRouter::volumioPlay Feb 18 09:50:41 volumio volumio[767]: UNSET VOLATILE Feb 18 09:50:41 volumio volumio[767]: info: CoreStateMachine::play index undefined Feb 18 09:50:41 volumio volumio[767]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 09:50:41 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:41 volumio volumio[767]: info: CoreStateMachine::startPlaybackTimer Feb 18 09:50:41 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:41 volumio volumio[767]: info: ControllerMpd::clearAddPlayTracks USB/新加卷/邓丽君/邓丽君日本语UHQCD/邓丽君《日本语精选》.flac Feb 18 09:50:41 volumio volumio[767]: info: ControllerMpd::sendMpdCommand stop Feb 18 09:50:43 volumio volumio[767]: info: CoreCommandRouter::volumioPlay Feb 18 09:50:43 volumio volumio[767]: UNSET VOLATILE Feb 18 09:50:43 volumio volumio[767]: info: CoreStateMachine::play index undefined Feb 18 09:50:43 volumio volumio[767]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 09:50:43 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:43 volumio volumio[767]: info: CoreStateMachine::startPlaybackTimer Feb 18 09:50:43 volumio volumio[767]: info: CorePlayQueue::getTrack 0 Feb 18 09:50:43 volumio volumio[767]: info: ControllerMpd::clearAddPlayTracks USB/新加卷/邓丽君/邓丽君日本语UHQCD/邓丽君《日本语精选》.flac Feb 18 09:50:43 volumio volumio[767]: info: ControllerMpd::sendMpdCommand stop Feb 18 09:50:43 volumio volumio[767]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml805armv7&variante=volumio&version=-0.5&uuid=e20528b73f166b6daf9cc4587e0cc2ed" http://updates.volumio.org:7070/downloader-v1/track-device Feb 18 09:50:43 volumio volumio[767]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 18 09:50:43 volumio volumio[767]: Dload Upload Total Spent Left Speed Feb 18 09:50:43 volumio volumio[767]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Feb 18 09:50:43 volumio volumio[767]: retrying in 5 seconds, trial 0 Feb 18 09:50:43 volumio volumio[767]: Volumio Calling Home Feb 18 09:50:44 volumio volumio[767]: info: CoreCommandRouter::volumioGetQueue Feb 18 09:50:44 volumio volumio[767]: info: CoreStateMachine::getQueue Feb 18 09:50:44 volumio volumio[767]: info: CorePlayQueue::getQueue Feb 18 09:50:52 volumio volumio[767]: info: CoreCommandRouter::volumioPlay Feb 18 09:50:52 volumio volumio[767]: UNSET VOLATILE Feb 18 09:50:52 volumio volumio[767]: info: CoreStateMachine::play index 2 Feb 18 09:50:52 volumio volumio[767]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 09:50:52 volumio volumio[767]: info: CoreStateMachine::stop Feb 18 09:50:52 volumio volumio[767]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 09:50:52 volumio volumio[767]: UNSET VOLATILE Feb 18 09:50:52 volumio volumio[767]: info: CoreStateMachine::play index undefined Feb 18 09:50:52 volumio volumio[767]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 09:50:52 volumio volumio[767]: info: CorePlayQueue::getTrack 2 Feb 18 09:50:52 volumio volumio[767]: info: CoreStateMachine::startPlaybackTimer Feb 18 09:50:52 volumio volumio[767]: info: CorePlayQueue::getTrack 2 Feb 18 09:50:52 volumio volumio[767]: info: ControllerMpd::sendMpdCommand stop Feb 18 09:50:52 volumio volumio[767]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 18 09:50:52 volumio volumio[767]: info: CURURI: music-library Feb 18 09:50:52 volumio volumio[767]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 09:50:52 volumio volumio[767]: TypeError: Cannot read property 'then' of undefined Feb 18 09:50:52 volumio volumio[767]: at ControllerMpd.lsInfo (/volumio/app/plugins/music_service/mpd/index.js:1202:16) Feb 18 09:50:52 volumio volumio[767]: at ControllerMpd.handleBrowseUri (/volumio/app/plugins/music_service/mpd/index.js:2875:25) Feb 18 09:50:52 volumio volumio[767]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1000:29) Feb 18 09:50:52 volumio volumio[767]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:328:47) Feb 18 09:50:52 volumio volumio[767]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:354:32) Feb 18 09:50:52 volumio volumio[767]: at emitTwo (events.js:126:13) Feb 18 09:50:52 volumio volumio[767]: at Socket.emit (events.js:214:7) Feb 18 09:50:52 volumio volumio[767]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 18 09:50:52 volumio volumio[767]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Feb 18 09:50:52 volumio volumio[767]: at process._tickCallback (internal/process/next_tick.js:180:9) Feb 18 09:50:52 volumio volumio[767]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 09:50:54 volumio sudo[1018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-18 09:49 Feb 18 09:50:54 volumio sudo[1018]: 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="e9f9f8a3db5777d6fd0c3a774be9b1b94af105ea" VOLUMIO_FE_VERSION="df21d3ba3dc59991cc81c091c75d497bcca20c56" VOLUMIO_BE_VERSION="4a8f425c7326cc87432caa67d4c33e53ec5f8c82" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Вс май 20 14:50:48 MSK 2018" VOLUMIO_VERSION="-0.5" VOLUMIO_HARDWARE="aml805armv7"