-- Logs begin at Thu 2019-02-14 19:11:58 JST, end at Sat 2026-04-04 10:34:48 JST. -- Apr 04 10:33:44 volumioes9023w systemd-timedated[1077]: Changed local time to Sat Apr 4 10:33:44 2026 Apr 04 10:33:44 volumioes9023w sudo[1075]: pam_unix(sudo:session): session closed for user root Apr 04 10:33:44 volumioes9023w volumio-time-update[591]: volumio-time-update-util: System time updated successfully. Apr 04 10:33:44 volumioes9023w systemd[1]: Started Volumio Time Update Utility. Apr 04 10:33:44 volumioes9023w systemd[1]: Reached target Multi-User System. Apr 04 10:33:44 volumioes9023w systemd[1]: Reached target Graphical Interface. Apr 04 10:33:44 volumioes9023w systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 04 10:33:44 volumioes9023w systemd[1]: Starting Daily apt download activities... Apr 04 10:33:44 volumioes9023w systemd[1]: Starting Daily man-db regeneration... Apr 04 10:33:44 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 04 10:33:44 volumioes9023w systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 04 10:33:44 volumioes9023w systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Loading plugin "wizard"... Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Loading plugin "networkfs"... Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Starting Udev Watcher for removable devices Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Ignoring mount for partition: boot Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Ignoring mount for partition: volumio Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Ignoring mount for partition: volumio_data Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Ignoring mount for partition: boot Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Ignoring mount for partition: volumio Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Ignoring mount for partition: volumio_data Apr 04 10:33:44 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Loading plugin "volumio_command_line_client"... Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Loading plugin "upnp"... Apr 04 10:33:44 volumioes9023w volumio[1027]: info: [1775266424344] Starting Upmpd Daemon Apr 04 10:33:44 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Loading plugin "my_music"... Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Loading plugin "mpd"... Apr 04 10:33:44 volumioes9023w systemd[1]: man-db.service: Succeeded. Apr 04 10:33:44 volumioes9023w systemd[1]: Started Daily man-db regeneration. Apr 04 10:33:44 volumioes9023w volumio[1027]: info: Loading plugin "upnp_browser"... Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Starting UPNP Browser Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Loading plugin "alarm-clock"... Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Loading plugin "airplay_emulation"... Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Starting Shairport Sync Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Loading plugin "last_100"... Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Loading plugin "webradio"... Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Loading plugin "i2s_dacs"... Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Loading plugin "volumiodiscovery"... Apr 04 10:33:45 volumioes9023w volumio[1027]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 04 10:33:45 volumioes9023w volumio[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 04 10:33:45 volumioes9023w volumio[1027]: *** WARNING *** For more information see Apr 04 10:33:45 volumioes9023w node[1027]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 04 10:33:45 volumioes9023w volumio[1027]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 04 10:33:45 volumioes9023w volumio[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 04 10:33:45 volumioes9023w volumio[1027]: *** WARNING *** For more information see Apr 04 10:33:45 volumioes9023w node[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 04 10:33:45 volumioes9023w node[1027]: *** WARNING *** For more information see Apr 04 10:33:45 volumioes9023w node[1027]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 04 10:33:45 volumioes9023w node[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 04 10:33:45 volumioes9023w node[1027]: *** WARNING *** For more information see Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Discovery: Started advertising with name: undefined Apr 04 10:33:45 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 04 10:33:45 volumioes9023w volumio[1027]: info: Loading plugin "spop"... Apr 04 10:33:47 volumioes9023w sudo[1090]: pam_unix(sudo:session): session closed for user root Apr 04 10:33:56 volumioes9023w volumio-remote-updater[592]: [2026-04-04 10:33:56] [connect] Successful connection Apr 04 10:34:11 volumioes9023w volumio-remote-updater[592]: [2026-04-04 10:34:11] [connect] Successful connection Apr 04 10:34:14 volumioes9023w systemd[1]: systemd-timedated.service: Succeeded. Apr 04 10:34:23 volumioes9023w ntpd[759]: Soliciting pool server 142.91.108.61 Apr 04 10:34:23 volumioes9023w ntpd[759]: Soliciting pool server 138.3.209.153 Apr 04 10:34:24 volumioes9023w ntpd[759]: Soliciting pool server 162.159.200.1 Apr 04 10:34:24 volumioes9023w ntpd[759]: Soliciting pool server 162.159.200.1 Apr 04 10:34:25 volumioes9023w ntpd[759]: Soliciting pool server 43.167.237.61 Apr 04 10:34:26 volumioes9023w volumio-remote-updater[592]: [2026-04-04 10:34:26] [connect] Successful connection Apr 04 10:34:26 volumioes9023w ntpd[759]: Soliciting pool server 172.105.192.74 Apr 04 10:34:26 volumioes9023w ntpd[759]: Soliciting pool server 129.250.35.251 Apr 04 10:34:26 volumioes9023w ntpd[759]: Soliciting pool server 194.0.5.123 Apr 04 10:34:27 volumioes9023w ntpd[759]: Soliciting pool server 142.91.105.55 Apr 04 10:34:27 volumioes9023w ntpd[759]: Soliciting pool server 162.159.200.123 Apr 04 10:34:27 volumioes9023w ntpd[759]: Soliciting pool server 157.7.213.62 Apr 04 10:34:27 volumioes9023w systemd[1]: apt-daily.service: Succeeded. Apr 04 10:34:27 volumioes9023w systemd[1]: Started Daily apt download activities. Apr 04 10:34:28 volumioes9023w systemd[1]: Starting Daily apt upgrade and clean activities... Apr 04 10:34:28 volumioes9023w ntpd[759]: Soliciting pool server 160.16.113.133 Apr 04 10:34:28 volumioes9023w ntpd[759]: Soliciting pool server 46.250.253.227 Apr 04 10:34:28 volumioes9023w ntpd[759]: Soliciting pool server 110.4.129.114 Apr 04 10:34:28 volumioes9023w volumio[1027]: info: Loading plugin "youtube2"... Apr 04 10:34:29 volumioes9023w systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 04 10:34:29 volumioes9023w systemd[1]: Started Daily apt upgrade and clean activities. Apr 04 10:34:29 volumioes9023w systemd[1]: Startup finished in 41.276s (kernel) + 1min 25.953s (userspace) = 2min 7.230s. Apr 04 10:34:29 volumioes9023w ntpd[759]: Soliciting pool server 117.102.178.88 Apr 04 10:34:29 volumioes9023w ntpd[759]: Soliciting pool server 45.76.211.39 Apr 04 10:34:29 volumioes9023w ntpd[759]: Soliciting pool server 208.88.66.8 Apr 04 10:34:30 volumioes9023w ntpd[759]: Soliciting pool server 2400:8902::2000:12ff:fecd:605 Apr 04 10:34:30 volumioes9023w ntpd[759]: Soliciting pool server 167.179.119.205 Apr 04 10:34:30 volumioes9023w ntpd[759]: Soliciting pool server 85.121.122.62 Apr 04 10:34:32 volumioes9023w ntpd[759]: receive: Unexpected origin timestamp 0xed7ae927.5d5cc5f2 does not match aorg 0000000000.00000000 from server@142.91.105.55 xmt 0xed7ae928.93e3b624 Apr 04 10:34:32 volumioes9023w ntpd[759]: receive: Unexpected origin timestamp 0xed7ae927.5d5b7793 does not match aorg 0000000000.00000000 from server@110.4.129.114 xmt 0xed7ae928.92ce4fe8 Apr 04 10:34:32 volumioes9023w volumio[1027]: info: Loading plugin "ytmusic"... Apr 04 10:34:36 volumioes9023w volumio[1027]: info: Loading plugin "autostart"... Apr 04 10:34:36 volumioes9023w volumio[1027]: info: Applying required configuration parameters for plugin autostart Apr 04 10:34:36 volumioes9023w volumio[1027]: info: AutoStart - onVolumioStart - read config.json Apr 04 10:34:36 volumioes9023w volumio[1027]: info: Loading plugin "now_playing"... Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Loading plugin "outputs"... Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Loading plugin "albumart"... Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Plugin example_plugin is not enabled Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Loading plugin "inputs"... Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Loading plugin "updater_comm"... Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Plugin mpdemulation is not enabled Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Loading plugin "rest_api"... Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Loading plugin "websocket"... Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Starting Socket.io Server version 2.3.0 Apr 04 10:34:38 volumioes9023w volumio[1027]: info: Loading plugin "mpdoutput"... Apr 04 10:34:38 volumioes9023w volumio[1027]: Forking 3 albumart workers Apr 04 10:34:38 volumioes9023w volumio[1027]: Starting albumart workers Apr 04 10:34:38 volumioes9023w volumio[1027]: Starting albumart workers Apr 04 10:34:38 volumioes9023w volumio[1027]: Starting albumart workers Apr 04 10:34:42 volumioes9023w volumio-remote-updater[592]: [2026-04-04 10:34:42] [connect] Successful connection Apr 04 10:34:46 volumioes9023w volumio[1027]: info: Loading plugin "80s80s"... Apr 04 10:34:46 volumioes9023w volumio[1027]: info: Applying required configuration parameters for plugin 80s80s Apr 04 10:34:46 volumioes9023w volumio[1027]: info: [1775266486918] [80s80s] API delay: 30 Apr 04 10:34:46 volumioes9023w volumio[1027]: info: Loading plugin "personal_radio"... Apr 04 10:34:47 volumioes9023w volumio[1027]: info: ControllerPersonalRadio::constructor Apr 04 10:34:47 volumioes9023w volumio[1027]: info: Loading plugin "touch_display"... Apr 04 10:34:48 volumioes9023w volumio[1027]: info: Applying required configuration parameters for plugin touch_display Apr 04 10:34:48 volumioes9023w volumio[1027]: info: Loading i18n strings for locale ja Apr 04 10:34:48 volumioes9023w volumio[1027]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Apr 04 10:34:48 volumioes9023w volumio[1027]: Updating browse sources language Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::initPlayerControls Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 10:34:48 volumioes9023w volumio[1027]: Express server listening on port 3000 Apr 04 10:34:48 volumioes9023w volumio[1027]: [Metrics] WebUI: 66s 292.80ms Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreStateMachine::resetVolumioState Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreStateMachine::getcurrentVolume Apr 04 10:34:48 volumioes9023w volumio[1027]: info: CoreCommandRouter::volumioRetrievevolume Apr 04 10:34:48 volumioes9023w volumio[1027]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 04 10:34:48 volumioes9023w volumio[1027]: TypeError: Cannot read property 'charAt' of undefined Apr 04 10:34:48 volumioes9023w volumio[1027]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24) Apr 04 10:34:48 volumioes9023w volumio[1027]: at listOnTimeout (internal/timers.js:554:17) Apr 04 10:34:48 volumioes9023w volumio[1027]: at processTimers (internal/timers.js:497:7) Apr 04 10:34:48 volumioes9023w volumio[1027]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 04 10:34:48 volumioes9023w sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-04 10:33 Apr 04 10:34:48 volumioes9023w sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"