-- Logs begin at Mon 2025-06-30 10:29:46 UTC, end at Mon 2025-06-30 10:31:28 UTC. -- Jun 30 10:30:00 volumio smbd[807]: Starting SMB/CIFS daemon: smbd[2025/06/30 10:30:00, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[807]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio smbd[807]: [2025/06/30 10:30:00, 0] ../lib/util/util.c:220(directory_create_or_exist) Jun 30 10:30:00 volumio smbd[807]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jun 30 10:30:00 volumio smbd[807]: [2025/06/30 10:30:00, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jun 30 10:30:00 volumio smbd[807]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jun 30 10:30:00 volumio smbd[807]: [2025/06/30 10:30:00, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jun 30 10:30:00 volumio smbd[807]: Unable to setup corepath for smbd: No such file or directory Jun 30 10:30:00 volumio smbd[807]: [2025/06/30 10:30:00, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[807]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio smbd[807]: [2025/06/30 10:30:00, 0] ../source3/smbd/server.c:1241(main) Jun 30 10:30:00 volumio smbd[807]: smbd version 4.2.14-Debian started. Jun 30 10:30:00 volumio smbd[807]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jun 30 10:30:00 volumio smbd[843]: [2025/06/30 10:30:00.075627, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[843]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio smbd[843]: [2025/06/30 10:30:00.077371, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[843]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio smbd[843]: [2025/06/30 10:30:00.077630, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[843]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio smbd[807]: [2025/06/30 10:30:00.075627, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[807]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio smbd[807]: [2025/06/30 10:30:00.077371, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[807]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio smbd[807]: [2025/06/30 10:30:00.077630, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[807]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Jun 30 10:30:00 volumio smbd[807]: . Jun 30 10:30:00 volumio winbindd[849]: [2025/06/30 10:30:00.133441, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio winbindd[849]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Jun 30 10:30:00 volumio winbindd[850]: [2025/06/30 10:30:00.194349, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio winbindd[850]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Jun 30 10:30:00 volumio smbd[846]: [2025/06/30 10:30:00.225029, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jun 30 10:30:00 volumio smbd[846]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 30 10:30:00 volumio smbd[851]: [2025/06/30 10:30:00.228690, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 30 10:30:00 volumio smbd[851]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 30 10:30:00 volumio wpa_supplicant[838]: wlan0: SME: Trying to authenticate with 7e:01:2d:a5:2d:73 (SSID='asdf' freq=2462 MHz) Jun 30 10:30:00 volumio kernel: wlan0: authenticate with 7e:01:2d:a5:2d:73 Jun 30 10:30:00 volumio wpa_supplicant[838]: wlan0: Trying to associate with 7e:01:2d:a5:2d:73 (SSID='asdf' freq=2462 MHz) Jun 30 10:30:00 volumio kernel: wlan0: send auth to 7e:01:2d:a5:2d:73 (try 1/3) Jun 30 10:30:00 volumio kernel: wlan0: authenticated Jun 30 10:30:00 volumio kernel: wlan0: associate with 7e:01:2d:a5:2d:73 (try 1/3) Jun 30 10:30:00 volumio kernel: wlan0: RX AssocResp from 7e:01:2d:a5:2d:73 (capab=0x431 status=0 aid=4) Jun 30 10:30:00 volumio kernel: wlan0: associated Jun 30 10:30:00 volumio wpa_supplicant[838]: wlan0: Associated with 7e:01:2d:a5:2d:73 Jun 30 10:30:00 volumio wpa_supplicant[838]: wlan0: WPA: Key negotiation completed with 7e:01:2d:a5:2d:73 [PTK=CCMP GTK=CCMP] Jun 30 10:30:00 volumio wpa_supplicant[838]: wlan0: CTRL-EVENT-CONNECTED - Connection to 7e:01:2d:a5:2d:73 completed [id=0 id_str=] Jun 30 10:30:00 volumio dhcpcd[809]: wlan0: carrier acquired Jun 30 10:30:00 volumio dhcpcd[809]: wlan0: rebinding lease of 192.168.137.239 Jun 30 10:30:00 volumio dhcpcd[809]: wlan0: leased 192.168.137.239 for 604800 seconds Jun 30 10:30:00 volumio dhcpcd[809]: wlan0: adding host route to 192.168.137.239 via 127.0.0.1 Jun 30 10:30:00 volumio dhcpcd[809]: wlan0: adding route to 192.168.137.0/24 Jun 30 10:30:00 volumio dhcpcd[809]: wlan0: adding default route via 192.168.137.1 Jun 30 10:30:00 volumio avahi-daemon[628]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.137.239. Jun 30 10:30:00 volumio avahi-daemon[628]: New relevant interface wlan0.IPv4 for mDNS. Jun 30 10:30:00 volumio avahi-daemon[628]: Registering new address record for 192.168.137.239 on wlan0.IPv4. Jun 30 10:30:00 volumio dhcpcd[809]: forked to background, child pid 906 Jun 30 10:30:00 volumio sudo[803]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:00 volumio wireless.js[710]: trying... Jun 30 10:30:00 volumio sudo[908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 30 10:30:00 volumio sudo[908]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:00 volumio sudo[908]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:00 volumio wireless.js[710]: Connected to: ----asdf Jun 30 10:30:00 volumio wireless.js[710]: ---- Jun 30 10:30:00 volumio sudo[911]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 10:30:00 volumio sudo[911]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:00 volumio sudo[911]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:00 volumio wireless.js[710]: ... joined AP, wlan0 IPv4 is 192.168.137.239, ipV6 is undefined Jun 30 10:30:00 volumio wireless.js[710]: It's done! AP Jun 30 10:30:00 volumio systemd[1]: Started Wireless Services. Jun 30 10:30:00 volumio systemd[1]: Starting Volumio Backend Module... Jun 30 10:30:00 volumio systemd[1]: Started Volumio Backend Module. Jun 30 10:30:00 volumio systemd[1]: Starting Start Volumio Kiosk... Jun 30 10:30:00 volumio systemd[1]: Started Start Volumio Kiosk. Jun 30 10:30:00 volumio systemd[1]: Starting Volumio Streaming Daemon... Jun 30 10:30:01 volumio systemd[1]: Started Volumio Streaming Daemon. Jun 30 10:30:01 volumio systemd[1]: Starting Multi-User System. Jun 30 10:30:01 volumio systemd[1]: Reached target Multi-User System. Jun 30 10:30:01 volumio systemd[1]: Starting Graphical Interface. Jun 30 10:30:01 volumio systemd[1]: Reached target Graphical Interface. Jun 30 10:30:01 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 30 10:30:01 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 30 10:30:01 volumio systemd[1]: Startup finished in 20.161s (kernel) + 15.010s (userspace) = 35.171s. Jun 30 10:30:01 volumio volumio-streaming-daemon[921]: ############################ Jun 30 10:30:01 volumio volumio-streaming-daemon[921]: # Volumio Streaming Daemon # Jun 30 10:30:01 volumio volumio-streaming-daemon[921]: # Running on port 7777 # Jun 30 10:30:01 volumio volumio-streaming-daemon[921]: ############################ Jun 30 10:30:01 volumio startx[919]: X.Org X Server 1.16.4 Jun 30 10:30:01 volumio startx[919]: Release Date: 2014-12-20 Jun 30 10:30:01 volumio startx[919]: X Protocol Version 11, Revision 0 Jun 30 10:30:01 volumio startx[919]: Build Operating System: Linux 4.9.0-4-amd64 i686 Debian Jun 30 10:30:01 volumio startx[919]: Current Operating System: Linux volumio 3.18.25 #4 SMP Mon Feb 12 18:30:53 CET 2018 i686 Jun 30 10:30:01 volumio startx[919]: Kernel command line: BOOT_IMAGE=vmlinuz-3.18.25 ro imgpart=UUID=112e9cbe-9047-4a11-9f8d-ded784ddc83b bootpart=UUID=F7E8-8F97 imgfile=volumio_current.sqsh quiet splash plymouth.ignore-serial-consoles vt.global_cursor_default=0 loglevel=0 USE_KMSG=no initrd=volumio.initrd Jun 30 10:30:01 volumio startx[919]: Build Date: 16 October 2017 08:08:13AM Jun 30 10:30:01 volumio startx[919]: xorg-server 2:1.16.4-1+deb8u2 (http://www.debian.org/support) Jun 30 10:30:01 volumio startx[919]: Current version of pixman: 0.32.6 Jun 30 10:30:01 volumio startx[919]: Before reporting problems, check http://wiki.x.org Jun 30 10:30:01 volumio startx[919]: to make sure that you have the latest version. Jun 30 10:30:01 volumio startx[919]: Markers: (--) probed, (**) from config file, (==) default setting, Jun 30 10:30:01 volumio startx[919]: (++) from command line, (!!) notice, (II) informational, Jun 30 10:30:01 volumio startx[919]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jun 30 10:30:01 volumio startx[919]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon Jun 30 10:30:01 2025 Jun 30 10:30:01 volumio startx[919]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jun 30 10:30:01 volumio ntpd[668]: Listen normally on 3 wlan0 192.168.137.239 UDP 123 Jun 30 10:30:01 volumio ntpd[668]: peers refreshed Jun 30 10:30:03 volumio nmbd[805]: [2025/06/30 10:30:03.916082, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jun 30 10:30:03 volumio nmbd[805]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 30 10:30:05 volumio ntpd_intres[749]: DNS 0.debian.pool.ntp.org -> 162.159.200.1 Jun 30 10:30:05 volumio ntpd_intres[749]: DNS 1.debian.pool.ntp.org -> 89.169.135.41 Jun 30 10:30:05 volumio kernel: random: nonblocking pool is initialized Jun 30 10:30:05 volumio ntpd_intres[749]: DNS 2.debian.pool.ntp.org -> 45.79.130.187 Jun 30 10:30:05 volumio ntpd_intres[749]: DNS 3.debian.pool.ntp.org -> 162.159.200.123 Jun 30 10:30:05 volumio volumio-remote-updater[591]: [2025-06-30 10:30:05] [connect] Successful connection Jun 30 10:30:05 volumio volumio[914]: info: ------------------------------------------- Jun 30 10:30:05 volumio volumio[914]: info: ----- Volumio2 ---- Jun 30 10:30:05 volumio volumio[914]: info: ------------------------------------------- Jun 30 10:30:05 volumio volumio[914]: info: ----- System startup ---- Jun 30 10:30:05 volumio volumio[914]: info: ------------------------------------------- Jun 30 10:30:05 volumio volumio[914]: info: MYVOLUMIO Environment detected Jun 30 10:30:05 volumio volumio[914]: info: Plugin folders cleanup Jun 30 10:30:05 volumio volumio[914]: info: Scanning into folder /volumio/app/plugins/ Jun 30 10:30:05 volumio volumio[914]: info: Scanning category audio_interface Jun 30 10:30:05 volumio volumio[914]: info: Scanning category miscellanea Jun 30 10:30:05 volumio volumio[914]: info: Scanning category music_service Jun 30 10:30:05 volumio volumio[914]: info: Scanning category plugins.json Jun 30 10:30:05 volumio volumio[914]: info: Scanning category system_controller Jun 30 10:30:05 volumio volumio[914]: info: Scanning category user_interface Jun 30 10:30:05 volumio volumio[914]: info: Scanning into folder /data/plugins/ Jun 30 10:30:05 volumio volumio[914]: info: Plugin folders cleanup completed Jun 30 10:30:05 volumio volumio[914]: info: ------------------------------------------- Jun 30 10:30:05 volumio volumio[914]: info: ----- Core plugins startup ---- Jun 30 10:30:05 volumio volumio[914]: info: ------------------------------------------- Jun 30 10:30:05 volumio volumio[914]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 10:30:05 volumio volumio[914]: info: Adding plugin upnp to MyMusic Plugins Jun 30 10:30:05 volumio volumio[914]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 10:30:05 volumio volumio[914]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 10:30:05 volumio volumio[914]: info: Loading plugins from folder /data/plugins/ Jun 30 10:30:05 volumio volumio[914]: info: Loading plugin "system"... Jun 30 10:30:05 volumio volumio[914]: info: Loading plugin "appearance"... Jun 30 10:30:08 volumio volumio[914]: info: Loading plugin "network"... Jun 30 10:30:09 volumio volumio[914]: info: Loading plugin "services"... Jun 30 10:30:09 volumio volumio[914]: info: Loading plugin "alsa_controller"... Jun 30 10:30:09 volumio volumio[914]: info: Loading plugin "wizard"... Jun 30 10:30:09 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google.com", got "ns1.google.com" Jun 30 10:30:09 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google.com", got "ns4.google.com" Jun 30 10:30:09 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google.com", got "ns3.google.com" Jun 30 10:30:09 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google.com", got "ns2.google.com" Jun 30 10:30:09 volumio volumio[914]: info: Loading plugin "volumio_command_line_client"... Jun 30 10:30:09 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:09 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:09 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:09 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:09 volumio volumio[914]: info: Loading plugin "upnp"... Jun 30 10:30:09 volumio volumio[914]: info: [1751279409606] Starting Upmpd Daemon Jun 30 10:30:09 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 10:30:09 volumio volumio[914]: info: Loading plugin "my_music"... Jun 30 10:30:09 volumio volumio[914]: info: Loading plugin "mpd"... Jun 30 10:30:10 volumio volumio[914]: info: Loading plugin "upnp_browser"... Jun 30 10:30:10 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "translate.googleapis.com", got "ns2.google.com" Jun 30 10:30:10 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "translate.googleapis.com", got "ns4.google.com" Jun 30 10:30:10 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "translate.googleapis.com", got "ns3.google.com" Jun 30 10:30:10 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "translate.googleapis.com", got "ns1.google.com" Jun 30 10:30:11 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "clients.l.google.com", got "ns4.google.com" Jun 30 10:30:11 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "clients.l.google.com", got "ns3.google.com" Jun 30 10:30:11 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "clients.l.google.com", got "ns2.google.com" Jun 30 10:30:11 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "clients.l.google.com", got "ns1.google.com" Jun 30 10:30:12 volumio systemd[1]: Time has been changed Jun 30 10:30:13 volumio volumio[914]: info: Loading plugin "networkfs"... Jun 30 10:30:13 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 10:30:13 volumio volumio[914]: info: Loading plugin "alarm-clock"... Jun 30 10:30:13 volumio volumio[914]: info: Loading plugin "airplay_emulation"... Jun 30 10:30:13 volumio volumio[914]: info: Starting Shairport Sync Jun 30 10:30:13 volumio volumio[914]: info: Loading plugin "last_100"... Jun 30 10:30:13 volumio volumio[914]: info: Loading plugin "webradio"... Jun 30 10:30:14 volumio volumio[914]: info: Loading plugin "i2s_dacs"... Jun 30 10:30:14 volumio volumio[914]: info: I2S DAC not set, start Auto-detection Jun 30 10:30:14 volumio volumio[914]: info: Loading plugin "volumiodiscovery"... Jun 30 10:30:14 volumio volumio[914]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 10:30:14 volumio node[914]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 10:30:14 volumio node[914]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 10:30:14 volumio node[914]: *** WARNING *** For more information see Jun 30 10:30:14 volumio node[914]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 10:30:14 volumio node[914]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 10:30:14 volumio node[914]: *** WARNING *** For more information see Jun 30 10:30:14 volumio volumio[914]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 10:30:14 volumio volumio[914]: *** WARNING *** For more information see Jun 30 10:30:14 volumio volumio[914]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 10:30:14 volumio volumio[914]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 10:30:14 volumio volumio[914]: *** WARNING *** For more information see Jun 30 10:30:14 volumio volumio[914]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 10:30:14 volumio volumio[914]: Discovery: StartAdv! undefined Jun 30 10:30:14 volumio volumio[914]: Discovery: Started advertising... Volumio - undefined Jun 30 10:30:14 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 10:30:14 volumio volumio[914]: info: Loading plugin "outputs"... Jun 30 10:30:14 volumio volumio[914]: info: Loading plugin "albumart"... Jun 30 10:30:14 volumio volumio[914]: info: Plugin example_plugin is not enabled Jun 30 10:30:14 volumio volumio[914]: info: Loading plugin "inputs"... Jun 30 10:30:14 volumio volumio[914]: info: Loading plugin "updater_comm"... Jun 30 10:30:15 volumio volumio[914]: info: Plugin mpdemulation is not enabled Jun 30 10:30:15 volumio volumio[914]: info: Loading plugin "rest_api"... Jun 30 10:30:15 volumio volumio[914]: info: Loading plugin "websocket"... Jun 30 10:30:15 volumio volumio[914]: info: ___________ START PLUGINS ___________ Jun 30 10:30:15 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 10:30:15 volumio volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 10:30:15 volumio volumio[914]: info: [1751279415454] CoreMusicLibrary::Adding element Media Servers Jun 30 10:30:15 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 10:30:15 volumio volumio[914]: Forking 1 albumart workers Jun 30 10:30:15 volumio volumio[914]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 10:30:15 volumio volumio[914]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 10:30:15 volumio volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 10:30:15 volumio volumio[914]: info: [1751279415587] CoreMusicLibrary::Adding element Last_100 Jun 30 10:30:15 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 10:30:15 volumio volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 10:30:15 volumio volumio[914]: info: [1751279415599] CoreMusicLibrary::Adding element Webradio Jun 30 10:30:15 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 10:30:15 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 10:30:15 volumio volumio[914]: info: ------------------------------------------- Jun 30 10:30:15 volumio volumio[914]: info: ----- MyVolumio plugins startup ---- Jun 30 10:30:15 volumio volumio[914]: info: ------------------------------------------- Jun 30 10:30:15 volumio volumio[914]: info: Loading plugins from folder /myvolumio/plugins Jun 30 10:30:15 volumio volumio[914]: info: Loading plugins from folder /data/myvolumio/plugins Jun 30 10:30:15 volumio volumio[914]: info: Loading plugin "cd_controller"... Jun 30 10:30:15 volumio volumio[914]: info: Loading plugin "streaming_services"... Jun 30 10:30:16 volumio volumio[914]: info: Loading plugin "my_volumio"... Jun 30 10:30:16 volumio volumio[914]: Starting albumart workers Jun 30 10:30:17 volumio volumio[914]: info: Adding CD REST API Endpoints Jun 30 10:30:17 volumio volumio[914]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Jun 30 10:30:17 volumio volumio[914]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Jun 30 10:30:17 volumio volumio[914]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Jun 30 10:30:17 volumio volumio[914]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jun 30 10:30:17 volumio volumio[914]: info: Detecting CD presence Jun 30 10:30:17 volumio volumio[914]: info: Streaming services startup Jun 30 10:30:17 volumio volumio[914]: info: Starting Streaming Daemon Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: Starting MyVolumio Remote Streaming Endpoints Jun 30 10:30:17 volumio sudo[1115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 30 10:30:17 volumio sudo[1115]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:17 volumio systemd[1]: Stopping Volumio Streaming Daemon... Jun 30 10:30:17 volumio systemd[1]: Starting Volumio Streaming Daemon... Jun 30 10:30:17 volumio systemd[1]: Started Volumio Streaming Daemon. Jun 30 10:30:17 volumio sudo[1115]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:17 volumio volumio[914]: info: Loading i18n strings for locale ru Jun 30 10:30:17 volumio volumio-streaming-daemon[1118]: ############################ Jun 30 10:30:17 volumio volumio-streaming-daemon[1118]: # Volumio Streaming Daemon # Jun 30 10:30:17 volumio volumio-streaming-daemon[1118]: # Running on port 7777 # Jun 30 10:30:17 volumio volumio-streaming-daemon[1118]: ############################ Jun 30 10:30:17 volumio volumio[914]: Updating browse sources language Jun 30 10:30:17 volumio volumio[914]: Cannot find translation for sourceMedia Servers Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::initPlayerControls Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 10:30:17 volumio volumio[914]: info: BOOT COMPLETED Jun 30 10:30:17 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 10:30:20 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "ssl.gstatic.com", got "ns4.google.com" Jun 30 10:30:20 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "ssl.gstatic.com", got "ns1.google.com" Jun 30 10:30:20 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "ssl.gstatic.com", got "ns3.google.com" Jun 30 10:30:20 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "ssl.gstatic.com", got "ns2.google.com" Jun 30 10:30:20 volumio volumio-remote-updater[591]: [2025-06-30 10:30:20] [connect] Successful connection Jun 30 10:30:21 volumio dhcpcd[498]: timed out Jun 30 10:30:21 volumio dhcpcd[498]: exited Jun 30 10:30:21 volumio ifup[465]: dhcpcd[498]: timed out Jun 30 10:30:21 volumio ifup[465]: dhcpcd[498]: exited Jun 30 10:30:21 volumio ifup[465]: Failed to bring up eth0. Jun 30 10:30:22 volumio volumio[914]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jun 30 10:30:22 volumio volumio[914]: info: CoreCommandRouter::Close All Modals sent Jun 30 10:30:22 volumio volumio[914]: info: CoreCommandRouter::Close All Modals sent Jun 30 10:30:22 volumio volumio[914]: Express server listening on port 3000 Jun 30 10:30:22 volumio volumio[914]: info: Setting Device type: x86 Jun 30 10:30:22 volumio volumio[914]: Volumio Calling Home Jun 30 10:30:22 volumio volumio[914]: info: MyVolumio not started Jun 30 10:30:22 volumio volumio[914]: info: Initializing device activation check Jun 30 10:30:22 volumio volumio[914]: info: CoreStateMachine::resetVolumioState Jun 30 10:30:22 volumio volumio[914]: info: CoreStateMachine::getcurrentVolume Jun 30 10:30:22 volumio volumio[914]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 10:30:23 volumio node[914]: gethostby*.getanswer: asked for "opml.radiotime.com.cdn.cloudflare.net", got "d.gtld-servers.net" Jun 30 10:30:23 volumio node[914]: gethostby*.getanswer: asked for "opml.radiotime.com.cdn.cloudflare.net", got "b.gtld-servers.net" Jun 30 10:30:23 volumio node[914]: gethostby*.getanswer: asked for "opml.radiotime.com.cdn.cloudflare.net", got "c.gtld-servers.net" Jun 30 10:30:23 volumio node[914]: gethostby*.getanswer: asked for "opml.radiotime.com.cdn.cloudflare.net", got "f.gtld-servers.net" Jun 30 10:30:23 volumio sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 10:30:23 volumio sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:23 volumio sudo[1134]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:23 volumio volumio[914]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 30 10:30:23 volumio node[914]: gethostby*.getanswer: asked for "radio-directory.firebaseapp.com", got "ns-cloud-c1.googledomains.com" Jun 30 10:30:23 volumio node[914]: gethostby*.getanswer: asked for "radio-directory.firebaseapp.com", got "ns-cloud-c3.googledomains.com" Jun 30 10:30:23 volumio node[914]: gethostby*.getanswer: asked for "radio-directory.firebaseapp.com", got "ns-cloud-c2.googledomains.com" Jun 30 10:30:23 volumio node[914]: gethostby*.getanswer: asked for "radio-directory.firebaseapp.com", got "ns-cloud-c4.googledomains.com" Jun 30 10:30:23 volumio volumio[914]: info: MPD running with PID630 ,establishing connection Jun 30 10:30:23 volumio sudo[1138]: pam_unix(sudo:auth): conversation failed Jun 30 10:30:23 volumio sudo[1138]: pam_unix(sudo:auth): auth could not identify password for [volumio] Jun 30 10:30:23 volumio volumio-remote-updater[591]: [2025-06-30 10:30:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1751279420 101 Jun 30 10:30:23 volumio volumio[914]: info: VolumeController:: Volume=41 Mute =false Jun 30 10:30:23 volumio volumio[914]: info: CoreStateMachine::pushState Jun 30 10:30:23 volumio volumio[914]: info: CoreStateMachine::getState Jun 30 10:30:23 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:30:23 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jun 30 10:30:23 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 10:30:23 volumio volumio[914]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jun 30 10:30:23 volumio volumio[914]: We trust you have received the usual lecture from the local System Jun 30 10:30:23 volumio volumio[914]: Administrator. It usually boils down to these three things: Jun 30 10:30:23 volumio volumio[914]: #1) Respect the privacy of others. Jun 30 10:30:23 volumio volumio[914]: #2) Think before you type. Jun 30 10:30:23 volumio volumio[914]: #3) With great power comes great responsibility. Jun 30 10:30:23 volumio volumio[914]: sudo: no tty present and no askpass program specified Jun 30 10:30:23 volumio volumio[914]: info: Reloading queue from file Jun 30 10:30:23 volumio volumio[914]: info: Jun 30 10:30:23 volumio volumio[914]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Jun 30 10:30:23 volumio volumio[914]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Jun 30 10:30:23 volumio volumio[914]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Jun 30 10:30:23 volumio volumio[914]: at emitOne (events.js:116:13) Jun 30 10:30:23 volumio volumio[914]: at Socket.emit (events.js:211:7) Jun 30 10:30:23 volumio volumio[914]: at addChunk (_stream_readable.js:263:12) Jun 30 10:30:23 volumio volumio[914]: at readableAddChunk (_stream_readable.js:246:13) Jun 30 10:30:23 volumio volumio[914]: at Socket.Readable.push (_stream_readable.js:208:10) Jun 30 10:30:23 volumio volumio[914]: at Pipe.onread (net.js:607:20) Jun 30 10:30:23 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 30 10:30:23 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 30 10:30:23 volumio volumio[914]: info: CoreStateMachine::setRepeat null single undefined Jun 30 10:30:23 volumio volumio[914]: info: CoreStateMachine::pushState Jun 30 10:30:23 volumio volumio[914]: info: CoreStateMachine::getState Jun 30 10:30:23 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:30:23 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jun 30 10:30:23 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 10:30:23 volumio volumio[914]: info: CoreStateMachine::setRandom null Jun 30 10:30:23 volumio volumio[914]: info: CoreStateMachine::pushState Jun 30 10:30:23 volumio volumio[914]: info: CoreStateMachine::getState Jun 30 10:30:23 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:30:23 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jun 30 10:30:23 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 10:30:23 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 30 10:30:24 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:24 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Jun 30 10:30:24 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 30 10:30:24 volumio sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jun 30 10:30:24 volumio sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:24 volumio sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jun 30 10:30:24 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:24 volumio sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:24 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jun 30 10:30:24 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jun 30 10:30:24 volumio sudo[1146]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:24 volumio sudo[1147]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:24 volumio volumio[914]: info: Upmpdcli Daemon Started Jun 30 10:30:24 volumio volumio[914]: info: Shairport-Sync Started Jun 30 10:30:24 volumio volumio[914]: Error adding Membership: Error: addMembership EINVAL Jun 30 10:30:24 volumio volumio[914]: info: Shairport-Sync Started Jun 30 10:30:24 volumio volumio[914]: info: CoreCommandRouter::volumioGetState Jun 30 10:30:24 volumio volumio[914]: info: CoreStateMachine::getState Jun 30 10:30:24 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:30:24 volumio shairport-sync[1154]: Successful Startup Jun 30 10:30:24 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google-analytics.com", got "ns3.google.com" Jun 30 10:30:24 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google-analytics.com", got "ns4.google.com" Jun 30 10:30:24 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google-analytics.com", got "ns1.google.com" Jun 30 10:30:24 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google-analytics.com", got "ns2.google.com" Jun 30 10:30:25 volumio volumio[914]: Discovery: adding a84e146d-741b-45bf-b182-118fdd4e3ed5 Jun 30 10:30:25 volumio volumio[914]: info: mDNS: Found device Volumio Jun 30 10:30:25 volumio sudo[1182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 10:30:25 volumio sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:25 volumio sudo[1182]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:26 volumio volumio[914]: info: Fetching Streaming Services browse cache Jun 30 10:30:26 volumio volumio[914]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Jun 30 10:30:26 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 10:30:26 volumio volumio[914]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Jun 30 10:30:26 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn.paddle.com", got "jean.ns.cloudflare.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn.paddle.com", got "jean.ns.cloudflare.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn.paddle.com", got "jean.ns.cloudflare.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn.paddle.com", got "hank.ns.cloudflare.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn.paddle.com", got "hank.ns.cloudflare.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn.paddle.com", got "hank.ns.cloudflare.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.googletagmanager.com", got "ns1.google.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.googletagmanager.com", got "ns3.google.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.googletagmanager.com", got "ns4.google.com" Jun 30 10:30:29 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.googletagmanager.com", got "ns2.google.com" Jun 30 10:30:33 volumio volumio[914]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 10:30:33 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 10:30:33 volumio volumio[914]: info: CoreCommandRouter::volumioGetState Jun 30 10:30:33 volumio volumio[914]: info: CoreStateMachine::getState Jun 30 10:30:33 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:30:33 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 30 10:30:33 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 10:30:33 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 10:30:33 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 10:30:33 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 10:30:33 volumio volumio[914]: info: Listing playlists Jun 30 10:30:33 volumio sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 10:30:33 volumio sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:33 volumio sudo[1250]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:33 volumio sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 10:30:33 volumio sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:30:33 volumio sudo[1252]: pam_unix(sudo:session): session closed for user root Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "analytics-alv.google.com", got "ns3.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "analytics-alv.google.com", got "ns2.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "analytics-alv.google.com", got "ns1.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "analytics-alv.google.com", got "ns4.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "stats.g.doubleclick.net", got "ns2.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "stats.g.doubleclick.net", got "ns1.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "stats.g.doubleclick.net", got "ns4.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "stats.g.doubleclick.net", got "ns3.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google.ru", got "ns2.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google.ru", got "ns4.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google.ru", got "ns3.google.com" Jun 30 10:30:34 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "www.google.ru", got "ns1.google.com" Jun 30 10:30:35 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn-profiles.tunein.com.cdn.cloudflare.net", got "b.gtld-servers.net" Jun 30 10:30:35 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn-profiles.tunein.com.cdn.cloudflare.net", got "c.gtld-servers.net" Jun 30 10:30:35 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn-profiles.tunein.com.cdn.cloudflare.net", got "f.gtld-servers.net" Jun 30 10:30:35 volumio chromium[973]: chromium --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000: gethostby*.getanswer: asked for "cdn-profiles.tunein.com.cdn.cloudflare.net", got "d.gtld-servers.net" Jun 30 10:30:35 volumio kernel: perf interrupt took too long (2530 > 2500), lowering kernel.perf_event_max_sample_rate to 50000 Jun 30 10:30:45 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 10:30:45 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns2.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns1.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns2.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns1.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns2.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns1.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns2.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns1.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns2.registrar-servers.com" Jun 30 10:30:45 volumio node[914]: gethostby*.getanswer: asked for "pushupdates.volumio.org", got "dns1.registrar-servers.com" Jun 30 10:31:14 volumio volumio[914]: info: CoreCommandRouter::volumioPlay Jun 30 10:31:14 volumio volumio[914]: UNSET VOLATILE Jun 30 10:31:14 volumio volumio[914]: info: CoreStateMachine::play index undefined Jun 30 10:31:14 volumio volumio[914]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 10:31:14 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:31:14 volumio volumio[914]: info: CoreStateMachine::startPlaybackTimer Jun 30 10:31:14 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:31:14 volumio volumio[914]: info: [1751279474447] ControllerWebradio::clearAddPlayTrack Jun 30 10:31:14 volumio volumio[914]: info: ControllerMpd::sendMpdCommand stop Jun 30 10:31:14 volumio volumio[914]: info: sending command... Jun 30 10:31:14 volumio volumio[914]: info: parsing response... Jun 30 10:31:14 volumio volumio[914]: info: ControllerMpd::sendMpdCommand clear Jun 30 10:31:14 volumio volumio[914]: info: sending command... Jun 30 10:31:14 volumio volumio[914]: info: Jun 30 10:31:14 volumio volumio[914]: ---------------------------- MPD announces system playlist update Jun 30 10:31:14 volumio volumio[914]: info: Ignoring MPD Status Update Jun 30 10:31:14 volumio volumio[914]: info: parsing response... Jun 30 10:31:14 volumio volumio[914]: info: ControllerMpd::sendMpdCommand load "https://myradio24.org/98107" Jun 30 10:31:14 volumio volumio[914]: info: sending command... Jun 30 10:31:14 volumio volumio[914]: info: Jun 30 10:31:14 volumio volumio[914]: info: ------------------------------ 36ms Jun 30 10:31:15 volumio volumio[914]: info: ControllerMpd::sendMpdCommand add "https://myradio24.org/98107" Jun 30 10:31:15 volumio volumio[914]: info: sending command... Jun 30 10:31:15 volumio volumio[914]: info: Jun 30 10:31:15 volumio volumio[914]: ---------------------------- MPD announces system playlist update Jun 30 10:31:15 volumio volumio[914]: info: Ignoring MPD Status Update Jun 30 10:31:15 volumio volumio[914]: info: parsing response... Jun 30 10:31:15 volumio volumio[914]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 30 10:31:15 volumio volumio[914]: info: ControllerMpd::sendMpdCommand play Jun 30 10:31:15 volumio volumio[914]: info: sending command... Jun 30 10:31:15 volumio volumio[914]: info: ------------------------------ 24ms Jun 30 10:31:15 volumio volumio[914]: info: parsing response... Jun 30 10:31:16 volumio volumio[914]: info: Jun 30 10:31:16 volumio volumio[914]: ---------------------------- MPD announces state update: player Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::getState Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::sendMpdCommand status Jun 30 10:31:16 volumio volumio[914]: info: sending command... Jun 30 10:31:16 volumio volumio[914]: info: parsing response... Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::parseState Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::sendMpdCommand playlistinfo Jun 30 10:31:16 volumio volumio[914]: info: sending command... Jun 30 10:31:16 volumio volumio[914]: info: Jun 30 10:31:16 volumio volumio[914]: ---------------------------- MPD announces system playlist update Jun 30 10:31:16 volumio volumio[914]: info: Ignoring MPD Status Update Jun 30 10:31:16 volumio volumio[914]: info: Jun 30 10:31:16 volumio volumio[914]: ---------------------------- MPD announces state update: player Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::getState Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::sendMpdCommand status Jun 30 10:31:16 volumio volumio[914]: info: parsing response... Jun 30 10:31:16 volumio volumio[914]: info: sending command... Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::parseTrackInfo Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::pushState Jun 30 10:31:16 volumio volumio[914]: info: CoreCommandRouter::servicePushState Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::syncState Jun 30 10:31:16 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:31:16 volumio volumio[914]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"98107","artist":"Radio 88 Ga Ga","album":null,"uri":"https://myradio24.org/98107","trackType":"org/98107"} Jun 30 10:31:16 volumio volumio[914]: info: CURRENT POSITION 0 Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::syncState stateService play Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::syncState currentStatus stop Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::pushState Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::getState Jun 30 10:31:16 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jun 30 10:31:16 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 10:31:16 volumio sudo[1557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 10:31:16 volumio volumio[914]: info: ------------------------------ 174ms Jun 30 10:31:16 volumio sudo[1557]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:31:16 volumio volumio[914]: info: ------------------------------ 165ms Jun 30 10:31:16 volumio volumio[914]: info: parsing response... Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::parseState Jun 30 10:31:16 volumio sudo[1557]: pam_unix(sudo:session): session closed for user root Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::sendMpdCommand playlistinfo Jun 30 10:31:16 volumio volumio[914]: info: sending command... Jun 30 10:31:16 volumio volumio[914]: info: parsing response... Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::parseTrackInfo Jun 30 10:31:16 volumio volumio[914]: info: ControllerMpd::pushState Jun 30 10:31:16 volumio volumio[914]: info: CoreCommandRouter::servicePushState Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::syncState Jun 30 10:31:16 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:31:16 volumio volumio[914]: info: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"98107","artist":"Radio 88 Ga Ga","album":null,"uri":"https://myradio24.org/98107","trackType":"org/98107"} Jun 30 10:31:16 volumio volumio[914]: info: CURRENT POSITION 0 Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::syncState stateService play Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::syncState currentStatus play Jun 30 10:31:16 volumio volumio[914]: info: Received an update from plugin. extracting info from payload Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::pushState Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::getState Jun 30 10:31:16 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jun 30 10:31:16 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::pushState Jun 30 10:31:16 volumio volumio[914]: info: CoreStateMachine::getState Jun 30 10:31:16 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jun 30 10:31:16 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 10:31:17 volumio sudo[1567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 10:31:17 volumio sudo[1567]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:31:17 volumio sudo[1567]: pam_unix(sudo:session): session closed for user root Jun 30 10:31:17 volumio volumio[914]: info: ------------------------------ 324ms Jun 30 10:31:17 volumio sudo[1569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 10:31:17 volumio sudo[1569]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 10:31:17 volumio sudo[1569]: pam_unix(sudo:session): session closed for user root Jun 30 10:31:25 volumio volumio[914]: info: CoreCommandRouter::volumioGetQueue Jun 30 10:31:25 volumio volumio[914]: info: CoreStateMachine::getQueue Jun 30 10:31:25 volumio volumio[914]: info: CorePlayQueue::getQueue Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: No input data Jun 30 10:31:26 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jun 30 10:31:26 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: webradio , goto Jun 30 10:31:26 volumio volumio[914]: info: Error : CoreCommandRouter::executeOnPlugin: No method [goto] in plugin webradio Jun 30 10:31:26 volumio volumio[914]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 10:31:26 volumio volumio[914]: TypeError: Cannot read property 'then' of undefined Jun 30 10:31:26 volumio volumio[914]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:434:18) Jun 30 10:31:26 volumio volumio[914]: at emitTwo (events.js:126:13) Jun 30 10:31:26 volumio volumio[914]: at Socket.emit (events.js:214:7) Jun 30 10:31:26 volumio volumio[914]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jun 30 10:31:26 volumio volumio[914]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jun 30 10:31:26 volumio volumio[914]: at process._tickCallback (internal/process/next_tick.js:180:9) Jun 30 10:31:26 volumio volumio[914]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 10:31:28 volumio sudo[1637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 10:30 Jun 30 10:31:28 volumio sudo[1637]: 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="76d896b632a135005f5aa213e11ff0507bc3485c" VOLUMIO_FE_VERSION="021732c5252c1ad4fb85955339e1f032fe4ae9f0" VOLUMIO_BE_VERSION="caf6c0f9a8e3cd984391aa77621b50a9247127b8" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 26 18:50:55 CEST 2019" VOLUMIO_VERSION="2.598" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="2bc7ee5a34981bd0185e253ef95d1e9b"