-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sun 2025-10-26 14:42:04 GMT. -- Oct 26 14:41:00 smsl-n100 mpd[1362]: Oct 26 14:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 26 14:41:00 smsl-n100 systemd[1]: Started Music Player Daemon. Oct 26 14:41:00 smsl-n100 volumio[961]: Upnp client error: Error: This socket has been ended by the other party Oct 26 14:41:00 smsl-n100 volumio[961]: Upnp client error: Error: This socket has been ended by the other party Oct 26 14:41:00 smsl-n100 sudo[1337]: pam_unix(sudo:session): session closed for user root Oct 26 14:41:00 smsl-n100 sudo[1348]: pam_unix(sudo:session): session closed for user root Oct 26 14:41:00 smsl-n100 dbus-daemon[539]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.36' (uid=1000 pid=1477 comm="/usr/bin/pulseaudio --high-priority=true ") Oct 26 14:41:00 smsl-n100 systemd[1]: Starting Bluetooth service... Oct 26 14:41:00 smsl-n100 volumio[961]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 26 14:41:00 smsl-n100 pulseaudio[1477]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Oct 26 14:41:00 smsl-n100 pulseaudio[1477]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Applying permissions Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Setting BT discoverable and pairable Oct 26 14:41:00 smsl-n100 bluetoothd[1500]: Bluetooth daemon 5.50 Oct 26 14:41:00 smsl-n100 bluetoothd[1500]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Oct 26 14:41:00 smsl-n100 dbus-daemon[539]: [system] Successfully activated service 'org.bluez' Oct 26 14:41:00 smsl-n100 systemd[1]: Started Bluetooth service. Oct 26 14:41:00 smsl-n100 bluetoothd[1500]: Starting SDP server Oct 26 14:41:00 smsl-n100 bluetoothd[1500]: Excluding (cli) sap Oct 26 14:41:00 smsl-n100 bluetoothd[1500]: kernel lacks bnep-protocol support Oct 26 14:41:00 smsl-n100 bluetoothd[1500]: System does not support network plugin Oct 26 14:41:00 smsl-n100 dbus-daemon[539]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.38' (uid=0 pid=1500 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Oct 26 14:41:00 smsl-n100 bluetoothd[1500]: Bluetooth management interface 1.14 initialized Oct 26 14:41:00 smsl-n100 volumiobt[1449]: [bluetooth]# -e power on Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Invalid command in menu main: -e Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Use "help" for a list of available commands in a menu. Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Use "menu " if you want to enter any submenu. Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Use "back" if you want to return to menu main. Oct 26 14:41:00 smsl-n100 volumiobt[1449]: [bluetooth]# agent on Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Failed to register agent object Oct 26 14:41:00 smsl-n100 volumiobt[1449]: [bluetooth]# discoverable on Oct 26 14:41:00 smsl-n100 volumiobt[1449]: No default controller available Oct 26 14:41:00 smsl-n100 volumiobt[1449]: [bluetooth]# pairable on Oct 26 14:41:00 smsl-n100 volumiobt[1449]: No default controller available Oct 26 14:41:00 smsl-n100 volumiobt[1449]: [bluetooth]# agent NoInputNoOutput Oct 26 14:41:00 smsl-n100 volumiobt[1449]: Failed to register agent object Oct 26 14:41:00 smsl-n100 volumiobt[1449]: [bluetooth]# default-agent Oct 26 14:41:00 smsl-n100 volumiobt[1449]: No agent is registered Oct 26 14:41:00 smsl-n100 volumiobt[1449]: [bluetooth]# quit Oct 26 14:41:00 smsl-n100 pulseaudio[1477]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Oct 26 14:41:00 smsl-n100 volumio[961]: error: MPD error: The expression evaluated to a falsy value: Oct 26 14:41:00 smsl-n100 volumio[961]: assert.ok(self.idling) Oct 26 14:41:00 smsl-n100 volumio[961]: error: The expression evaluated to a falsy value: Oct 26 14:41:00 smsl-n100 volumio[961]: assert.ok(self.idling) Oct 26 14:41:00 smsl-n100 volumiobt[1449]: [59B blob data] Oct 26 14:41:00 smsl-n100 systemd[1]: Starting Hostname Service... Oct 26 14:41:00 smsl-n100 volumio[961]: info: MPD running with PID1362 Oct 26 14:41:00 smsl-n100 volumio[961]: ,establishing connection Oct 26 14:41:00 smsl-n100 volumio[961]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 26 14:41:00 smsl-n100 volumio[961]: error: updateQueue error: null Oct 26 14:41:00 smsl-n100 volumio[961]: info: Executing endpoint tc_getconfig Oct 26 14:41:00 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 26 14:41:00 smsl-n100 dbus-daemon[539]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 26 14:41:00 smsl-n100 systemd[1]: Started Hostname Service. Oct 26 14:41:00 smsl-n100 vtcs[1492]: STARTING TidalConnect services, version: 1.4.0.34 Oct 26 14:41:00 smsl-n100 volumio[961]: error: updateQueue error: null Oct 26 14:41:01 smsl-n100 vtcs[1492]: STARTED TidalConnect services. Oct 26 14:41:01 smsl-n100 volumio[961]: info: Executing endpoint tc_connect Oct 26 14:41:01 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 26 14:41:01 smsl-n100 volumio[961]: info: Connecting to TidalConnect Oct 26 14:41:01 smsl-n100 volumio[961]: info: CoreCommandRouter::servicePushState Oct 26 14:41:01 smsl-n100 volumio[961]: info: CoreStateMachine::pushState Oct 26 14:41:01 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:01 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioPushState Oct 26 14:41:01 smsl-n100 volumio[961]: info: MRS: Pushing multiroomSync output update for this device Oct 26 14:41:01 smsl-n100 volumio[961]: info: MRS: Pushing multiroomSync output Oct 26 14:41:01 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:01 smsl-n100 volumio[961]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Oct 26 14:41:01 smsl-n100 volumio[961]: info: CoreCommandRouter::servicePushState Oct 26 14:41:01 smsl-n100 volumio[961]: info: CoreStateMachine::pushState Oct 26 14:41:01 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:01 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioPushState Oct 26 14:41:01 smsl-n100 volumio[961]: info: MRS: Pushing multiroomSync output update for this device Oct 26 14:41:01 smsl-n100 volumio[961]: info: MRS: Pushing multiroomSync output Oct 26 14:41:01 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:01 smsl-n100 volumio[961]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Oct 26 14:41:02 smsl-n100 volumio[961]: info: TidalConnect service started! Oct 26 14:41:02 smsl-n100 volumio[961]: info: Completed starting Core Plugins Oct 26 14:41:02 smsl-n100 volumio[961]: info: ------------------------------------------- Oct 26 14:41:02 smsl-n100 volumio[961]: info: ----- MyVolumio plugins startup ---- Oct 26 14:41:02 smsl-n100 volumio[961]: info: ------------------------------------------- Oct 26 14:41:02 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 26 14:41:04 smsl-n100 volumio[1335]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 26 14:41:05 smsl-n100 volumio[1335]: ................++++ Oct 26 14:41:05 smsl-n100 volumio[961]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 26 14:41:08 smsl-n100 volumio[1335]: .....................................++++ Oct 26 14:41:08 smsl-n100 volumio[1335]: e is 65537 (0x010001) Oct 26 14:41:08 smsl-n100 volumio[1335]: writing RSA key Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 26 14:41:10 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 26 14:41:11 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 26 14:41:12 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 26 14:41:12 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 26 14:41:12 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:12 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:12 smsl-n100 volumio[961]: info: Starting MyVolumio Remote Streaming Endpoints Oct 26 14:41:13 smsl-n100 volumio[961]: info: MyVolumio login type: Token Oct 26 14:41:13 smsl-n100 volumio[961]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 26 14:41:13 smsl-n100 volumio[961]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Oct 26 14:41:13 smsl-n100 volumio[961]: error: MyVolumio Custom Token format not valid, refreshing it Oct 26 14:41:14 smsl-n100 volumio[961]: info: MyVolumio login type: Token Oct 26 14:41:14 smsl-n100 volumio[961]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 26 14:41:15 smsl-n100 volumio[961]: info: MyVolumio token set successfully Oct 26 14:41:15 smsl-n100 volumio[961]: info: MYVOLUMIO: Adding device Oct 26 14:41:15 smsl-n100 volumio[961]: info: MYVOLUMIO: Evaluating Server Oct 26 14:41:15 smsl-n100 volumio[961]: info: MyVolumio status changed Oct 26 14:41:15 smsl-n100 volumio[961]: info: Streaming services startup Oct 26 14:41:15 smsl-n100 volumio[961]: info: Starting Streaming Daemon Oct 26 14:41:15 smsl-n100 volumio[961]: info: Removing browser output: myVolumio user plan is not superstar Oct 26 14:41:15 smsl-n100 volumio[961]: info: Removing audio output: Oct 26 14:41:15 smsl-n100 volumio[961]: info: Stoppping Tunnel 1 Oct 26 14:41:15 smsl-n100 sudo[1605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 26 14:41:15 smsl-n100 sudo[1605]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 14:41:15 smsl-n100 sudo[1605]: pam_unix(sudo:session): session closed for user root Oct 26 14:41:15 smsl-n100 sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 26 14:41:15 smsl-n100 sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 14:41:15 smsl-n100 volumio[961]: error: Cannot start Volumio Streaming Daemon Oct 26 14:41:15 smsl-n100 volumio[961]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 26 14:41:15 smsl-n100 volumio[961]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 26 14:41:15 smsl-n100 sudo[1608]: pam_unix(sudo:session): session closed for user root Oct 26 14:41:15 smsl-n100 volumio[961]: info: Remote SSH Stopped Oct 26 14:41:21 smsl-n100 volumio[961]: info: Setting Geolocation for MyVolumio to eu3 Oct 26 14:41:21 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:21 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:21 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:21 smsl-n100 volumio[961]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 26 14:41:22 smsl-n100 volumio[961]: info: Updating MyVolumio device info Oct 26 14:41:22 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:22 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:22 smsl-n100 volumio[961]: error: MyVolumio Plugin failed to start in a timely fashion Oct 26 14:41:22 smsl-n100 volumio[961]: [Metrics] CommandRouter: 63s 564.49ms Oct 26 14:41:22 smsl-n100 volumio[961]: info: CoreCommandRouter::volumiosetStartupVolume Oct 26 14:41:22 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 14:41:22 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:22 smsl-n100 volumio[961]: info: CoreCommandRouter::Close All Modals sent Oct 26 14:41:22 smsl-n100 volumio[961]: info: CoreCommandRouter::Close All Modals sent Oct 26 14:41:22 smsl-n100 volumio[961]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 26 14:41:23 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 26 14:41:23 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 14:41:23 smsl-n100 volumio[961]: xcb_connection_has_error() returned true Oct 26 14:41:23 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 26 14:41:25 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 14:41:25 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:25 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 14:41:25 smsl-n100 volumio[961]: info: MYVOLUMIO: Adding device Oct 26 14:41:25 smsl-n100 volumio[961]: info: MYVOLUMIO: Evaluating Server Oct 26 14:41:26 smsl-n100 volumio-remote-updater[568]: No test mode Oct 26 14:41:26 smsl-n100 volumio-remote-updater[568]: No alpha test mode Oct 26 14:41:26 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 26 14:41:26 smsl-n100 volumio[961]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 26 14:41:26 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 26 14:41:27 smsl-n100 volumio[961]: info: Setting Geolocation for MyVolumio to eu3 Oct 26 14:41:27 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:27 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:27 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:27 smsl-n100 volumio[961]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 26 14:41:27 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 14:41:28 smsl-n100 volumio[961]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 26 14:41:28 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:28 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:28 smsl-n100 volumio[961]: info: Updating MyVolumio device info Oct 26 14:41:28 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:28 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:28 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 14:41:28 smsl-n100 volumio[961]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 26 14:41:29 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 14:41:29 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 14:41:29 smsl-n100 volumio[961]: info: Discovery: Getting this device information Oct 26 14:41:29 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:29 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:29 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 14:41:29 smsl-n100 volumio[961]: verbose: New Socket.io Connection to 192.168.1.77:3000 from 192.168.1.62 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 26 14:41:29 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:29 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:29 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 26 14:41:29 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 26 14:41:29 smsl-n100 volumio[961]: info: BOOT COMPLETED Oct 26 14:41:30 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 14:41:30 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 14:41:30 smsl-n100 volumio[961]: info: Discovery: Getting this device information Oct 26 14:41:30 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:30 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:30 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 14:41:30 smsl-n100 systemd[1]: systemd-hostnamed.service: Succeeded. Oct 26 14:41:32 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:32 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:32 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 14:41:32 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 14:41:32 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 26 14:41:32 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 26 14:41:32 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 26 14:41:32 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Oct 26 14:41:32 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 14:41:35 smsl-n100 sudo[1669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 14:41:35 smsl-n100 sudo[1669]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 14:41:35 smsl-n100 sudo[1669]: pam_unix(sudo:session): session closed for user root Oct 26 14:41:35 smsl-n100 sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 14:41:35 smsl-n100 sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 14:41:35 smsl-n100 sudo[1671]: pam_unix(sudo:session): session closed for user root Oct 26 14:41:35 smsl-n100 volumio[961]: verbose: New Socket.io Connection to 192.168.1.77 from 192.168.1.62 UA: Mozilla/5.0 (Linux; Android 13; SM-G980F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 26 14:41:35 smsl-n100 volumio[961]: verbose: New Socket.io Connection to 192.168.1.77:3000 from 192.168.1.62 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Oct 26 14:41:35 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:35 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:35 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 26 14:41:35 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 26 14:41:35 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:35 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:36 smsl-n100 sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 14:41:36 smsl-n100 sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 14:41:36 smsl-n100 sudo[1675]: pam_unix(sudo:session): session closed for user root Oct 26 14:41:36 smsl-n100 sudo[1678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 14:41:36 smsl-n100 sudo[1678]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 14:41:36 smsl-n100 sudo[1678]: pam_unix(sudo:session): session closed for user root Oct 26 14:41:36 smsl-n100 volumio[961]: verbose: New Socket.io Connection to 192.168.1.77 from 192.168.1.62 UA: Mozilla/5.0 (Linux; Android 13; SM-G980F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:36 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetQueue Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreStateMachine::getQueue Oct 26 14:41:36 smsl-n100 volumio[961]: info: CorePlayQueue::getQueue Oct 26 14:41:36 smsl-n100 volumio[961]: info: Listing playlists Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 14:41:36 smsl-n100 volumio[961]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 26 14:41:36 smsl-n100 volumio[961]: info: Received Get System Info Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 14:41:36 smsl-n100 volumio[961]: info: Discovery: Getting this device information Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:36 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:36 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 26 14:41:36 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 14:41:37 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 26 14:41:38 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 14:41:38 smsl-n100 volumio[961]: info: Received Get System Info Oct 26 14:41:38 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 14:41:38 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 14:41:38 smsl-n100 volumio[961]: info: Discovery: Getting this device information Oct 26 14:41:38 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:38 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:38 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 14:41:38 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 26 14:41:39 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 14:41:39 smsl-n100 volumio[961]: info: Received Get System Info Oct 26 14:41:39 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 14:41:39 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 14:41:39 smsl-n100 volumio[961]: info: Discovery: Getting this device information Oct 26 14:41:39 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:39 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:39 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 14:41:46 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 14:41:51 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 14:41:51 smsl-n100 volumio[961]: info: CURURI: music-library Oct 26 14:41:51 smsl-n100 volumio[961]: error: Failed LSINFO: null Oct 26 14:41:51 smsl-n100 volumio[961]: info: Preload queue cleared Oct 26 14:41:54 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 14:41:54 smsl-n100 volumio[961]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 26 14:41:54 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 26 14:41:54 smsl-n100 volumio[961]: info: Received Get System Version Oct 26 14:41:54 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 14:41:54 smsl-n100 volumio[961]: info: Received Get System Info Oct 26 14:41:54 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 14:41:54 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 14:41:54 smsl-n100 volumio[961]: info: Discovery: Getting this device information Oct 26 14:41:54 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:54 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:54 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 14:41:56 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 26 14:41:56 smsl-n100 volumio[961]: info: Preload queue cleared Oct 26 14:41:59 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 14:41:59 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 14:41:59 smsl-n100 volumio[961]: info: Discovery: Getting this device information Oct 26 14:41:59 smsl-n100 volumio[961]: info: CoreCommandRouter::volumioGetState Oct 26 14:41:59 smsl-n100 volumio[961]: info: CorePlayQueue::getTrack 0 Oct 26 14:41:59 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 14:42:03 smsl-n100 volumio[961]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 26 14:42:03 smsl-n100 volumio[961]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 14:42:03 smsl-n100 volumio[961]: TypeError: Cannot read property 'length' of undefined Oct 26 14:42:03 smsl-n100 volumio[961]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 26 14:42:03 smsl-n100 volumio[961]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 26 14:42:03 smsl-n100 volumio[961]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 26 14:42:03 smsl-n100 volumio[961]: at Parser.emit (events.js:400:28) Oct 26 14:42:03 smsl-n100 volumio[961]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 26 14:42:03 smsl-n100 volumio[961]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 26 14:42:03 smsl-n100 volumio[961]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 26 14:42:03 smsl-n100 volumio[961]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 26 14:42:03 smsl-n100 volumio[961]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 26 14:42:03 smsl-n100 volumio[961]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 26 14:42:03 smsl-n100 volumio[961]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 26 14:42:03 smsl-n100 volumio[961]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 26 14:42:03 smsl-n100 volumio[961]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 26 14:42:03 smsl-n100 volumio[961]: at IncomingMessage.emit (events.js:412:35) Oct 26 14:42:03 smsl-n100 volumio[961]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 26 14:42:03 smsl-n100 volumio[961]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 26 14:42:03 smsl-n100 volumio[961]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 14:42:04 smsl-n100 sudo[1764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-26 14:41 Oct 26 14:42:04 smsl-n100 sudo[1764]: pam_unix(sudo:session): session opened for user root by (uid=0) 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"