-- Logs begin at Thu 2019-02-14 19:11:58 JST, end at Thu 2026-03-26 18:21:27 JST. -- Mar 26 18:20:00 volumioes9023w volumio[980]: info: Loading plugin "airplay_emulation"... Mar 26 18:20:00 volumioes9023w volumio[980]: info: Starting Shairport Sync Mar 26 18:20:00 volumioes9023w volumio[980]: info: Loading plugin "last_100"... Mar 26 18:20:00 volumioes9023w volumio[980]: info: Loading plugin "webradio"... Mar 26 18:20:00 volumioes9023w volumio[980]: info: Loading plugin "i2s_dacs"... Mar 26 18:20:00 volumioes9023w volumio[980]: info: Loading plugin "volumiodiscovery"... Mar 26 18:20:00 volumioes9023w volumio[980]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 26 18:20:00 volumioes9023w volumio[980]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 26 18:20:00 volumioes9023w volumio[980]: *** WARNING *** For more information see Mar 26 18:20:00 volumioes9023w volumio[980]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 26 18:20:00 volumioes9023w node[980]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 26 18:20:00 volumioes9023w volumio[980]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 26 18:20:00 volumioes9023w volumio[980]: *** WARNING *** For more information see Mar 26 18:20:00 volumioes9023w node[980]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 26 18:20:00 volumioes9023w node[980]: *** WARNING *** For more information see Mar 26 18:20:00 volumioes9023w node[980]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 26 18:20:00 volumioes9023w node[980]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 26 18:20:00 volumioes9023w node[980]: *** WARNING *** For more information see Mar 26 18:20:00 volumioes9023w volumio[980]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 26 18:20:00 volumioes9023w volumio[980]: info: Discovery: Started advertising with name: undefined Mar 26 18:20:00 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 26 18:20:00 volumioes9023w volumio[980]: info: Loading plugin "spop"... Mar 26 18:20:02 volumioes9023w systemd[1]: apt-daily.service: Succeeded. Mar 26 18:20:02 volumioes9023w systemd[1]: Started Daily apt download activities. Mar 26 18:20:02 volumioes9023w systemd[1]: Starting Daily apt upgrade and clean activities... Mar 26 18:20:03 volumioes9023w volumio[980]: info: Loading plugin "youtube2"... Mar 26 18:20:03 volumioes9023w systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 26 18:20:03 volumioes9023w systemd[1]: Started Daily apt upgrade and clean activities. Mar 26 18:20:03 volumioes9023w systemd[1]: Startup finished in 35.904s (kernel) + 1min 48ms (userspace) = 1min 35.952s. Mar 26 18:20:06 volumioes9023w volumio[980]: info: Loading plugin "ytmusic"... Mar 26 18:20:11 volumioes9023w volumio-remote-updater[601]: [2026-03-26 18:20:11] [connect] Successful connection Mar 26 18:20:15 volumioes9023w ntpd[754]: Soliciting pool server 208.88.66.8 Mar 26 18:20:16 volumioes9023w ntpd[754]: Soliciting pool server 162.159.200.1 Mar 26 18:20:17 volumioes9023w ntpd[754]: Soliciting pool server 85.121.50.82 Mar 26 18:20:17 volumioes9023w ntpd[754]: Soliciting pool server 162.159.200.123 Mar 26 18:20:18 volumioes9023w ntpd[754]: Soliciting pool server 172.105.192.74 Mar 26 18:20:18 volumioes9023w ntpd[754]: Soliciting pool server 103.131.151.30 Mar 26 18:20:18 volumioes9023w ntpd[754]: Soliciting pool server 129.250.35.251 Mar 26 18:20:19 volumioes9023w ntpd[754]: Soliciting pool server 138.3.209.153 Mar 26 18:20:19 volumioes9023w ntpd[754]: Soliciting pool server 142.91.105.55 Mar 26 18:20:19 volumioes9023w ntpd[754]: Soliciting pool server 167.179.119.205 Mar 26 18:20:20 volumioes9023w ntpd[754]: Soliciting pool server 45.76.211.39 Mar 26 18:20:20 volumioes9023w ntpd[754]: Soliciting pool server 129.250.35.250 Mar 26 18:20:20 volumioes9023w ntpd[754]: Soliciting pool server 142.91.108.61 Mar 26 18:20:21 volumioes9023w ntpd[754]: Soliciting pool server 160.16.113.133 Mar 26 18:20:21 volumioes9023w ntpd[754]: Soliciting pool server 43.229.16.149 Mar 26 18:20:21 volumioes9023w ntpd[754]: Soliciting pool server 85.121.122.62 Mar 26 18:20:22 volumioes9023w ntpd[754]: Soliciting pool server 108.160.132.224 Mar 26 18:20:22 volumioes9023w ntpd[754]: Soliciting pool server 163.44.119.85 Mar 26 18:20:48 volumioes9023w ntpd[754]: receive: Unexpected origin timestamp 0xed6f78d8.49f15bc5 does not match aorg 0000000000.00000000 from server@85.121.50.82 xmt 0xed6f78f0.eae77a1e Mar 26 18:20:48 volumioes9023w ntpd[754]: receive: Unexpected origin timestamp 0xed6f78d8.49efd1f9 does not match aorg 0000000000.00000000 from server@172.105.192.74 xmt 0xed6f78f0.eaee14de Mar 26 18:20:48 volumioes9023w ntpd[754]: receive: Unexpected origin timestamp 0xed6f78d8.49eefceb does not match aorg 0000000000.00000000 from server@103.131.151.30 xmt 0xed6f78f0.eb442c7f Mar 26 18:20:48 volumioes9023w ntpd[754]: receive: Unexpected origin timestamp 0xed6f78d8.49ec5e44 does not match aorg 0000000000.00000000 from server@43.229.16.149 xmt 0xed6f78f0.ec0742e5 Mar 26 18:20:48 volumioes9023w ntpd[754]: receive: Unexpected origin timestamp 0xed6f78d8.49ee299d does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xed6f78f0.eb1859c8 Mar 26 18:20:50 volumioes9023w volumio-remote-updater[601]: [2026-03-26 18:20:50] [connect] Successful connection Mar 26 18:20:53 volumioes9023w systemd[1]: systemd-timedated.service: Succeeded. Mar 26 18:21:05 volumioes9023w volumio-remote-updater[601]: [2026-03-26 18:21:05] [connect] Successful connection Mar 26 18:21:14 volumioes9023w volumio[980]: info: Loading plugin "autostart"... Mar 26 18:21:14 volumioes9023w volumio[980]: info: Applying required configuration parameters for plugin autostart Mar 26 18:21:14 volumioes9023w volumio[980]: info: AutoStart - onVolumioStart - read config.json Mar 26 18:21:14 volumioes9023w volumio[980]: info: Loading plugin "now_playing"... Mar 26 18:21:16 volumioes9023w volumio[980]: info: Loading plugin "outputs"... Mar 26 18:21:16 volumioes9023w volumio[980]: info: Loading plugin "albumart"... Mar 26 18:21:16 volumioes9023w volumio[980]: info: Plugin example_plugin is not enabled Mar 26 18:21:16 volumioes9023w volumio[980]: info: Loading plugin "inputs"... Mar 26 18:21:16 volumioes9023w volumio[980]: info: Loading plugin "updater_comm"... Mar 26 18:21:16 volumioes9023w volumio[980]: info: Plugin mpdemulation is not enabled Mar 26 18:21:16 volumioes9023w volumio[980]: info: Loading plugin "rest_api"... Mar 26 18:21:16 volumioes9023w volumio[980]: info: Loading plugin "websocket"... Mar 26 18:21:16 volumioes9023w volumio[980]: info: Starting Socket.io Server version 2.3.0 Mar 26 18:21:16 volumioes9023w volumio[980]: info: Loading plugin "mpdoutput"... Mar 26 18:21:16 volumioes9023w volumio[980]: Forking 3 albumart workers Mar 26 18:21:16 volumioes9023w volumio[980]: info: Loading plugin "80s80s"... Mar 26 18:21:16 volumioes9023w volumio[980]: Starting albumart workers Mar 26 18:21:16 volumioes9023w volumio[980]: Starting albumart workers Mar 26 18:21:16 volumioes9023w volumio[980]: Starting albumart workers Mar 26 18:21:20 volumioes9023w volumio-remote-updater[601]: [2026-03-26 18:21:20] [connect] Successful connection Mar 26 18:21:25 volumioes9023w volumio[980]: info: Applying required configuration parameters for plugin 80s80s Mar 26 18:21:25 volumioes9023w volumio[980]: info: [1774516885157] [80s80s] API delay: 30 Mar 26 18:21:25 volumioes9023w volumio[980]: info: Loading plugin "personal_radio"... Mar 26 18:21:25 volumioes9023w volumio[980]: info: ControllerPersonalRadio::constructor Mar 26 18:21:25 volumioes9023w volumio[980]: info: Loading plugin "touch_display"... Mar 26 18:21:26 volumioes9023w volumio[980]: info: Applying required configuration parameters for plugin touch_display Mar 26 18:21:26 volumioes9023w volumio[980]: info: Loading i18n strings for locale ja Mar 26 18:21:26 volumioes9023w volumio[980]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 26 18:21:26 volumioes9023w volumio[980]: Updating browse sources language Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::initPlayerControls Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 18:21:26 volumioes9023w volumio[980]: Express server listening on port 3000 Mar 26 18:21:26 volumioes9023w volumio[980]: [Metrics] WebUI: 89s 388.92ms Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreStateMachine::resetVolumioState Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreStateMachine::getcurrentVolume Mar 26 18:21:26 volumioes9023w volumio[980]: info: CoreCommandRouter::volumioRetrievevolume Mar 26 18:21:26 volumioes9023w volumio[980]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 18:21:26 volumioes9023w volumio[980]: TypeError: Cannot read property 'charAt' of undefined Mar 26 18:21:26 volumioes9023w volumio[980]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24) Mar 26 18:21:26 volumioes9023w volumio[980]: at listOnTimeout (internal/timers.js:554:17) Mar 26 18:21:26 volumioes9023w volumio[980]: at processTimers (internal/timers.js:497:7) Mar 26 18:21:26 volumioes9023w volumio[980]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 18:21:27 volumioes9023w sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-26 18:20 Mar 26 18:21:27 volumioes9023w sudo[1381]: 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"