-- Logs begin at Mon 2025-05-26 15:39:47 JST, end at Tue 2025-05-27 13:53:23 JST. -- May 27 13:52:02 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard May 27 13:52:02 smsl-n100 volumio[16389]: info: CoreCommandRouter::Reload Ui May 27 13:52:04 smsl-n100 sudo[24219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 27 13:52:04 smsl-n100 sudo[24219]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:04 smsl-n100 sudo[24219]: pam_unix(sudo:session): session closed for user root May 27 13:52:04 smsl-n100 sudo[24222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 27 13:52:04 smsl-n100 sudo[24222]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:04 smsl-n100 sudo[24222]: pam_unix(sudo:session): session closed for user root May 27 13:52:04 smsl-n100 volumio[16389]: verbose: New Socket.io Connection to 192.168.0.109 from 192.168.0.103 UA: Mozilla/5.0 (Linux; Android 14; I11_S Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::volumioGetVisibleSources May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode May 27 13:52:04 smsl-n100 volumio[16389]: xcb_connection_has_error() returned true May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones May 27 13:52:04 smsl-n100 volumio[16389]: info: Received Get System Info May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 13:52:04 smsl-n100 volumio[16389]: info: Discovery: Getting this device information May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::volumioGetState May 27 13:52:04 smsl-n100 volumio[16389]: info: CorePlayQueue::getTrack 3 May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 13:52:04 smsl-n100 volumio-remote-updater[549]: No test mode May 27 13:52:04 smsl-n100 volumio-remote-updater[549]: No alpha test mode May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 13:52:04 smsl-n100 volumio[16389]: info: Retrieving Cloud Streaming UI May 27 13:52:04 smsl-n100 volumio[16389]: info: Getting Tidal Cloud Configuration May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 13:52:04 smsl-n100 volumio[16389]: info: Getting Qobuz Cloud Configuration May 27 13:52:04 smsl-n100 volumio[16389]: info: Asking plugin for UI Config May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 13:52:04 smsl-n100 volumio[16389]: info: Getting Spotify Cloud Configuration May 27 13:52:04 smsl-n100 volumio[16389]: info: Asking plugin for UI Config May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 13:52:04 smsl-n100 volumio[16389]: info: Saving Spotify Acccount May 27 13:52:04 smsl-n100 volumio[16389]: info: Got it May 27 13:52:04 smsl-n100 volumio[16389]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 27 13:52:04 smsl-n100 volumio[16389]: info: Got Tidal Cloud Configuration May 27 13:52:04 smsl-n100 volumio[16389]: info: Got it May 27 13:52:04 smsl-n100 volumio[16389]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 13:52:05 smsl-n100 sudo[24229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 27 13:52:05 smsl-n100 sudo[24229]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:05 smsl-n100 sudo[24229]: pam_unix(sudo:session): session closed for user root May 27 13:52:05 smsl-n100 sudo[24232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 27 13:52:05 smsl-n100 sudo[24232]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:05 smsl-n100 sudo[24232]: pam_unix(sudo:session): session closed for user root May 27 13:52:05 smsl-n100 volumio[16389]: verbose: New Socket.io Connection to 192.168.0.109 from 192.168.0.107 UA: Mozilla/5.0 (Linux; Android 5.1.1; HWT31 Build/Federer; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/95.0.4638.74 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 May 27 13:52:05 smsl-n100 volumio[16389]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::volumioGetVisibleSources May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode May 27 13:52:05 smsl-n100 volumio[16389]: xcb_connection_has_error() returned true May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones May 27 13:52:05 smsl-n100 volumio[16389]: info: Received Get System Info May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 13:52:05 smsl-n100 volumio[16389]: info: Discovery: Getting this device information May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::volumioGetState May 27 13:52:05 smsl-n100 volumio[16389]: info: CorePlayQueue::getTrack 3 May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 13:52:05 smsl-n100 volumio-remote-updater[549]: No test mode May 27 13:52:05 smsl-n100 volumio-remote-updater[549]: No alpha test mode May 27 13:52:05 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage May 27 13:52:05 smsl-n100 volumio[16389]: info: Loading i18n strings for locale ja May 27 13:52:06 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone May 27 13:52:06 smsl-n100 volumio[16389]: info: Setting timezone to Asia/Tokyo May 27 13:52:06 smsl-n100 sudo[24239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime May 27 13:52:06 smsl-n100 sudo[24239]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:06 smsl-n100 sudo[24239]: pam_unix(sudo:session): session closed for user root May 27 13:52:06 smsl-n100 sudo[24242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Tokyo /etc/localtime May 27 13:52:06 smsl-n100 sudo[24242]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:06 smsl-n100 sudo[24242]: pam_unix(sudo:session): session closed for user root May 27 13:52:06 smsl-n100 sudo[24245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime May 27 13:52:06 smsl-n100 sudo[24245]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:06 smsl-n100 sudo[24245]: pam_unix(sudo:session): session closed for user root May 27 13:52:06 smsl-n100 sudo[24248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Tokyo May 27 13:52:06 smsl-n100 sudo[24248]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:06 smsl-n100 dbus-daemon[563]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.64' (uid=0 pid=24249 comm="/usr/bin/timedatectl set-timezone Asia/Tokyo ") May 27 13:52:06 smsl-n100 systemd[1]: Starting Time & Date Service... May 27 13:52:20 smsl-n100 volumio-remote-updater[549]: [2025-05-27 13:52:20] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] May 27 13:52:25 smsl-n100 volumio-remote-updater[549]: [2025-05-27 13:52:25] [connect] Successful connection May 27 13:52:31 smsl-n100 dbus-daemon[563]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) May 27 13:52:31 smsl-n100 sudo[24248]: pam_unix(sudo:session): session closed for user root May 27 13:52:31 smsl-n100 volumio[16389]: Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) May 27 13:52:31 smsl-n100 volumio[16389]: info: Could not set timezone, retrying May 27 13:52:31 smsl-n100 volumio[16389]: info: Fetching Streaming Services browse cache May 27 13:52:31 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 13:52:31 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 13:52:31 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage May 27 13:52:31 smsl-n100 volumio[16389]: info: Loading i18n strings for locale ja May 27 13:52:31 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone May 27 13:52:31 smsl-n100 volumio[16389]: info: Setting timezone to Asia/Tokyo May 27 13:52:31 smsl-n100 sudo[24305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime May 27 13:52:31 smsl-n100 sudo[24305]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:31 smsl-n100 sudo[24305]: pam_unix(sudo:session): session closed for user root May 27 13:52:31 smsl-n100 sudo[24308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Tokyo /etc/localtime May 27 13:52:31 smsl-n100 sudo[24308]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:31 smsl-n100 sudo[24308]: pam_unix(sudo:session): session closed for user root May 27 13:52:31 smsl-n100 sudo[24311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime May 27 13:52:31 smsl-n100 sudo[24311]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:31 smsl-n100 sudo[24311]: pam_unix(sudo:session): session closed for user root May 27 13:52:31 smsl-n100 sudo[24314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Tokyo May 27 13:52:31 smsl-n100 sudo[24314]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:31 smsl-n100 dbus-daemon[563]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.65' (uid=0 pid=24315 comm="/usr/bin/timedatectl set-timezone Asia/Tokyo ") May 27 13:52:38 smsl-n100 volumio-remote-updater[549]: [2025-05-27 13:52:38] [connect] Successful connection May 27 13:52:53 smsl-n100 volumio-remote-updater[549]: [2025-05-27 13:52:53] [connect] Successful connection May 27 13:52:56 smsl-n100 dbus-daemon[563]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) May 27 13:52:56 smsl-n100 sudo[24314]: pam_unix(sudo:session): session closed for user root May 27 13:52:56 smsl-n100 volumio[16389]: Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) May 27 13:52:56 smsl-n100 volumio[16389]: info: Could not set timezone, retrying May 27 13:52:56 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 27 13:52:56 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 27 13:52:57 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 27 13:52:57 smsl-n100 volumio[16389]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 27 13:52:57 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 27 13:52:57 smsl-n100 volumio[16389]: info: Received Get System Version May 27 13:52:57 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 27 13:52:57 smsl-n100 volumio[16389]: info: Received Get System Info May 27 13:52:57 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 13:52:57 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 13:52:57 smsl-n100 volumio[16389]: info: Discovery: Getting this device information May 27 13:52:57 smsl-n100 volumio[16389]: info: CoreCommandRouter::volumioGetState May 27 13:52:57 smsl-n100 volumio[16389]: info: CorePlayQueue::getTrack 3 May 27 13:52:57 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 13:52:57 smsl-n100 sudo[24356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 27 13:52:57 smsl-n100 sudo[24356]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:57 smsl-n100 volumio[16389]: ------------------------------------ BT MESSAGE: BT STATUS: running May 27 13:52:57 smsl-n100 volumio[16389]: ------------------------------------ BT MESSAGE: BT STATUS: running May 27 13:52:57 smsl-n100 volumio[16389]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 27 13:52:57 smsl-n100 volumio[16389]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 27 13:52:57 smsl-n100 volumio[16389]: info: Fetching Streaming Services browse cache May 27 13:52:57 smsl-n100 sudo[24359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Tokyo May 27 13:52:57 smsl-n100 sudo[24359]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:52:57 smsl-n100 dbus-daemon[563]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.66' (uid=0 pid=24360 comm="/usr/bin/timedatectl set-timezone Asia/Tokyo ") May 27 13:53:01 smsl-n100 sudo[24356]: pam_unix(sudo:session): session closed for user root May 27 13:53:08 smsl-n100 volumio-remote-updater[549]: [2025-05-27 13:53:08] [connect] Successful connection May 27 13:53:22 smsl-n100 dbus-daemon[563]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) May 27 13:53:22 smsl-n100 sudo[24359]: pam_unix(sudo:session): session closed for user root May 27 13:53:22 smsl-n100 volumio[16389]: Failed to set time zone: Connection timed out May 27 13:53:22 smsl-n100 volumio[16389]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 13:53:22 smsl-n100 volumio[16389]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Asia/Tokyo' May 27 13:53:22 smsl-n100 volumio[16389]: Failed to set time zone: Connection timed out May 27 13:53:22 smsl-n100 volumio[16389]: at checkExecSyncError (child_process.js:790:11) May 27 13:53:22 smsl-n100 volumio[16389]: at execSync (child_process.js:863:15) May 27 13:53:22 smsl-n100 volumio[16389]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9) May 27 13:53:22 smsl-n100 volumio[16389]: at listOnTimeout (internal/timers.js:557:17) May 27 13:53:22 smsl-n100 volumio[16389]: at processTimers (internal/timers.js:500:7) { May 27 13:53:22 smsl-n100 volumio[16389]: status: 1, May 27 13:53:22 smsl-n100 volumio[16389]: signal: null, May 27 13:53:22 smsl-n100 volumio[16389]: output: [ null, '', 'Failed to set time zone: Connection timed out\n' ], May 27 13:53:22 smsl-n100 volumio[16389]: pid: 24358, May 27 13:53:22 smsl-n100 volumio[16389]: stdout: '', May 27 13:53:22 smsl-n100 volumio[16389]: stderr: 'Failed to set time zone: Connection timed out\n' May 27 13:53:22 smsl-n100 volumio[16389]: } May 27 13:53:22 smsl-n100 volumio[16389]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 13:53:23 smsl-n100 sudo[24463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-27 13:52 May 27 13:53:23 smsl-n100 sudo[24463]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 13:53:23 smsl-n100 volumio-remote-updater[549]: [2025-05-27 13:53:23] [connect] Successful connection PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"