-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sat 2025-08-30 06:03:34 CST. -- Aug 30 06:02:00 smsl-n100 volumio[1232]: Forking 3 albumart workers Aug 30 06:02:00 smsl-n100 volumio-remote-updater[528]: [2025-08-30 06:02:00] [connect] Successful connection Aug 30 06:02:02 smsl-n100 volumio[1232]: Starting albumart workers Aug 30 06:02:02 smsl-n100 volumio[1232]: Starting albumart workers Aug 30 06:02:02 smsl-n100 volumio[1232]: Starting albumart workers Aug 30 06:02:03 smsl-n100 volumio[1232]: info: Applying required configuration parameters for plugin hi_res_audio Aug 30 06:02:03 smsl-n100 volumio[1232]: info: Loading plugin "inputs"... Aug 30 06:02:05 smsl-n100 volumio[1232]: info: Loading plugin "qobuz"... Aug 30 06:02:07 smsl-n100 volumio[1232]: info: Loading plugin "smart_inputs"... Aug 30 06:02:08 smsl-n100 volumio[1232]: info: Loading plugin "tidal"... Aug 30 06:02:11 smsl-n100 volumio[1232]: info: Loading plugin "oem_helper"... Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Applying required configuration parameters for plugin oem_helper Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Loading plugin "smslcontrol"... Aug 30 06:02:13 smsl-n100 kernel: gpio gpiochip0: Persistence not supported for GPIO 5 Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Adding this device properties Aug 30 06:02:13 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Setting Additional Device Volumio Properties: [object Object] Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Loading plugin "updater_comm"... Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Plugin mpdemulation is not enabled Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Loading plugin "rest_api"... Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Loading plugin "websocket"... Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Starting Socket.io Server version 2.3.0 Aug 30 06:02:13 smsl-n100 volumio[1232]: info: Loading i18n strings for locale zh Aug 30 06:02:13 smsl-n100 volumio[1232]: Updating browse sources language Aug 30 06:02:13 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::initPlayerControls Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 06:02:14 smsl-n100 volumio[1232]: Express server listening on port 3000 Aug 30 06:02:14 smsl-n100 volumio[1232]: [Metrics] WebUI: 36s 11.89ms Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreStateMachine::resetVolumioState Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreStateMachine::getcurrentVolume Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:14 smsl-n100 sudo[1480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 06:02:14 smsl-n100 sudo[1480]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:14 smsl-n100 sudo[1480]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:14 smsl-n100 sudo[1482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 06:02:14 smsl-n100 sudo[1482]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:14 smsl-n100 sudo[1482]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:14 smsl-n100 volumio[1232]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 30 06:02:14 smsl-n100 volumio[1232]: info: Completed loading Core Plugins Aug 30 06:02:14 smsl-n100 volumio[1232]: info: Preparing to generate the ALSA configuration file Aug 30 06:02:14 smsl-n100 volumio[1232]: info: Volumio Network Manager: Network status updated: 1 Aug 30 06:02:14 smsl-n100 volumio[1232]: info: MRS: Removed streaming files Aug 30 06:02:14 smsl-n100 volumio[1232]: info: MRS: volumioStreaming STOPPED Aug 30 06:02:14 smsl-n100 volumio[1232]: info: MRS: SNAPSERVER STOPPED Aug 30 06:02:14 smsl-n100 volumio[1232]: info: MRS: SNAPCLIENT STOPPED Aug 30 06:02:14 smsl-n100 volumio[1232]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Aug 30 06:02:14 smsl-n100 volumio[1232]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 30 06:02:14 smsl-n100 volumio[1232]: info: Reading ALSA contributions from plugins. Aug 30 06:02:14 smsl-n100 kernel: usb 2-1.4: USB disconnect, device number 4 Aug 30 06:02:14 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 0 op 0x1:(WRITE) flags 0x800 phys_seg 0 prio class 0 Aug 30 06:02:14 smsl-n100 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Partition removed: {"syspath":"/sys/devices/platform/ff5c0000.usb/usb2/2-1/2-1.4/2-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/8b67197d-d9c6-43df-8f7e-bfc873d372f0 /dev/disk/by-partuuid/47f9c805-32ef-4515-914e-0fc8718ccd64 /dev/disk/by-partlabel/Musique /dev/disk/by-path/platform-ff5c0000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/usb-Micron_CT2000X9SSD9_2332E8D6058B-0:0-part1 /dev/disk/by-label/Musique","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/ff5c0000.usb/usb2/2-1/2-1.4/2-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"Musique","ID_FS_LABEL_ENC":"Musique","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"8b67197d-d9c6-43df-8f7e-bfc873d372f0","ID_FS_UUID_ENC":"8b67197d-d9c6-43df-8f7e-bfc873d372f0","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"CT2000X9SSD9","ID_MODEL_ENC":"CT2000X9SSD9\\x20\\x20\\x20\\x20","ID_MODEL_ID":"5605","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"Musique","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"3907026944","ID_PART_ENTRY_TYPE":"0fc63daf-8483-4772-8e79-3d69d8477de4","ID_PART_ENTRY_UUID":"47f9c805-32ef-4515-914e-0fc8718ccd64","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"f6b569eb-9cb1-4c80-8d49-b50ecfca259e","ID_PATH":"platform-ff5c0000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff5c0000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"PMAP","ID_SERIAL":"Micron_CT2000X9SSD9_2332E8D6058B-0:0","ID_SERIAL_SHORT":"2332E8D6058B","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Micron","ID_VENDOR_ENC":"Micron\\x20\\x20","ID_VENDOR_ID":"0634","MAJOR":"8","MINOR":"1","PARTN":"1","PARTNAME":"Musique","SEQNUM":"2303","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3075379"} Aug 30 06:02:15 smsl-n100 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=0x00 Aug 30 06:02:15 smsl-n100 sudo[1488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Aug 30 06:02:15 smsl-n100 sudo[1488]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:15 smsl-n100 systemd[1]: media-Musique.mount: Succeeded. Aug 30 06:02:15 smsl-n100 sudo[1488]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Scanning new location : "USB/Musique" Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Reloading queue from file Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreStateMachine::setRepeat null single undefined Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreStateMachine::setRandom null Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Setting Device type: NanoPi NEO 3 Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Asound.conf file unchanged, so no further update is needed Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Output device has changed, restarting MPD Aug 30 06:02:15 smsl-n100 sudo[1499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 30 06:02:15 smsl-n100 sudo[1499]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:15 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD. Aug 30 06:02:15 smsl-n100 sudo[1502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Output device has changed, restarting Shairport Sync Aug 30 06:02:15 smsl-n100 sudo[1502]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:15 smsl-n100 volumio-remote-updater[528]: [2025-08-30 06:02:15] [connect] Successful connection Aug 30 06:02:15 smsl-n100 sudo[1502]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:15 smsl-n100 sudo[1499]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:15 smsl-n100 sudo[1506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 06:02:15 smsl-n100 sudo[1506]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:15 smsl-n100 systemd[1]: Stopping Music Player Daemon... Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 06:02:15 smsl-n100 volumio[1232]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:15 smsl-n100 volumio[1232]: info: ___________ START PLUGINS ___________ Aug 30 06:02:15 smsl-n100 volumio[1232]: info: ControllerMpd::onStart: Initializing MPD Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Creating MPD Configuration file Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 06:02:15 smsl-n100 sudo[1514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 06:02:15 smsl-n100 sudo[1514]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:15 smsl-n100 volumio[1232]: info: [1756504935874] CoreMusicLibrary::Adding element 媒体服务器 Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 06:02:15 smsl-n100 sudo[1514]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:15 smsl-n100 sudo[1516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 06:02:15 smsl-n100 sudo[1516]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Adding METAVOLUMIO REST API Endpoints Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 30 06:02:15 smsl-n100 volumio[1232]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:15 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:16 smsl-n100 sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name SMSL N100 Aug 30 06:02:16 smsl-n100 sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:16 smsl-n100 sudo[1520]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Preparing CD Folders Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Adding CD REST API Endpoints Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Starting UDEV Watcher for CD Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Detecting CD presence with UDEV Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 06:02:16 smsl-n100 volumio[1232]: info: [1756504936246] CoreMusicLibrary::Adding element Last_100 Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Starting RAAT Plugin Aug 30 06:02:16 smsl-n100 systemd[1]: mpd.service: Succeeded. Aug 30 06:02:16 smsl-n100 systemd[1]: Stopped Music Player Daemon. Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Additional UI Settings Added for plugin music_service/raat Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Registering DSP Elements listener and retrieving current ones Aug 30 06:02:16 smsl-n100 systemd[1]: Starting Music Player Daemon... Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Additional DSP elements updated Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Updating RAAT Signal Path Aug 30 06:02:16 smsl-n100 volumio[1232]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Streaming services startup Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Starting Streaming Daemon Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 06:02:16 smsl-n100 volumio[1232]: info: [1756504936521] CoreMusicLibrary::Adding element Webradio Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Initializing BBC Radios Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Aug 30 06:02:16 smsl-n100 volumio[1232]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 30 06:02:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:16 smsl-n100 volumio[1232]: error: Hi Res Audio Failed Login: Missing Login Data Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Initializing Serial Communication on port /dev/ttyS1 Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Touch Event Listener Process Starting Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Adding inputs REST Endpoints Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Scanning Audio Inputs Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Checking against Known Cards name Aug 30 06:02:16 smsl-n100 volumio[1232]: info: Adding Server instance for streaming Aug 30 06:02:17 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 06:02:17 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Initializing GPIOs Aug 30 06:02:17 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 1 Aug 30 06:02:17 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 15 Aug 30 06:02:17 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 0 Aug 30 06:02:17 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 2 Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Starting Button Listener Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Turning off Green LED Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Tuning on Blue LED Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Signaling System Ready Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Volumio Calling Home Aug 30 06:02:17 smsl-n100 sudo[1529]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 06:02:17 smsl-n100 sudo[1532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 30 06:02:17 smsl-n100 sudo[1529]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:17 smsl-n100 sudo[1557]: pam_unix(sudo:auth): conversation failed Aug 30 06:02:17 smsl-n100 sudo[1557]: pam_unix(sudo:auth): auth could not identify password for [volumio] Aug 30 06:02:17 smsl-n100 sudo[1538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 30 06:02:17 smsl-n100 sudo[1532]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:17 smsl-n100 sudo[1538]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:17 smsl-n100 sudo[1529]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:17 smsl-n100 sudo[1532]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:17 smsl-n100 sudo[1538]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:17 smsl-n100 volumio[1232]: (node:1232) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Aug 30 06:02:17 smsl-n100 volumio[1232]: (Use `node --trace-deprecation ...` to show where the warning was created) Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Stopping AccessToken refresher cron for QOBUZ Aug 30 06:02:17 smsl-n100 volumio[1232]: info: AccessToken refresher cron started for QOBUZ Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Stopping AccessToken refresher cron Aug 30 06:02:17 smsl-n100 volumio[1232]: info: AccessToken refresher cron started Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Adding TIDAL REST API Endpoints Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Adding QOBUZ REST API Endpoints Aug 30 06:02:17 smsl-n100 volumio[1232]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Discovery: adding c3c97753-bca2-42f8-9ff6-d5c74be0b1b0 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Discovery: Found device SMSL N100 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output for this device Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Adding audio output: Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Adding audio output: Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Serial port opened successfully Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Sending serial start messages Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Reporting MCU Network Status: 1 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Touch Event Listener Process Closed Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Cannot start Volumio Streaming Daemon Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 30 06:02:18 smsl-n100 volumio[1232]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 30 06:02:18 smsl-n100 volumio[1232]: info: RAAT Albumart path created successfully Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'SMSL N100' Aug 30 06:02:18 smsl-n100 volumio[1232]: Can't get device info: No such device Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MPD Permissions set Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MPD Permissions set Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Upmpdcli Daemon Started Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Setting Device Volume Override Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Updating Volume Controller Parameters: Device: 5 Name: LOXJIE AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Disabling external Volume Control Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:18 smsl-n100 volumio-remote-updater[528]: [2025-08-30 06:02:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756504935 101 Aug 30 06:02:18 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: Volumio called home Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:18 smsl-n100 kernel: usb 2-1.4: new high-speed USB device number 5 using ehci-platform Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:02:18 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 1, message: undefined Aug 30 06:02:18 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 30 06:02:18 smsl-n100 kernel: usb 2-1.4: New USB device found, idVendor=0634, idProduct=5605, bcdDevice= 1.10 Aug 30 06:02:18 smsl-n100 kernel: usb 2-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Aug 30 06:02:18 smsl-n100 kernel: usb 2-1.4: Product: CT2000X9SSD9 Aug 30 06:02:18 smsl-n100 kernel: usb 2-1.4: Manufacturer: Micron Aug 30 06:02:18 smsl-n100 kernel: usb 2-1.4: SerialNumber: 2332E8D6058B Aug 30 06:02:18 smsl-n100 kernel: scsi host0: uas Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 30 06:02:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:02:19 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:19 smsl-n100 volumio[1232]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Musique Aug 30 06:02:19 smsl-n100 sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Aug 30 06:02:19 smsl-n100 sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:19 smsl-n100 systemd[1]: Started Volumio Bluetooth Module. Aug 30 06:02:19 smsl-n100 sudo[1617]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:19 smsl-n100 sudo[1620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Aug 30 06:02:19 smsl-n100 sudo[1620]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:19 smsl-n100 volumiobt[1619]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Aug 30 06:02:19 smsl-n100 sudo[1620]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:19 smsl-n100 volumio[1232]: info: Volumio BT Module successfully started Aug 30 06:02:19 smsl-n100 volumio[1232]: info: Starting Shairport Sync Aug 30 06:02:19 smsl-n100 volumio[1232]: info: Starting Shairport Sync Aug 30 06:02:19 smsl-n100 sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 06:02:19 smsl-n100 sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:19 smsl-n100 volumio[1232]: info: Starting Shairport Sync Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:19 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:19 smsl-n100 sudo[1626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:19 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Aug 30 06:02:19 smsl-n100 sudo[1626]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:19 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:19 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:19 smsl-n100 sudo[1629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 06:02:19 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:19 smsl-n100 sudo[1629]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:02:19 smsl-n100 sudo[1624]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:19 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:02:19 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:02:19 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:19 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 30 06:02:19 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 06:02:20 smsl-n100 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 30 06:02:20 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Aug 30 06:02:20 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 06:02:20 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 06:02:20 smsl-n100 sudo[1626]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:20 smsl-n100 sudo[1629]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:20 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:20 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:20 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 30 06:02:20 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:20 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 30 06:02:20 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:20 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:20 smsl-n100 volumio[1232]: info: Shairport-Sync Started Aug 30 06:02:20 smsl-n100 volumio[1232]: Error adding Membership: Error: addMembership EINVAL Aug 30 06:02:20 smsl-n100 volumio[1232]: info: Shairport-Sync Started Aug 30 06:02:20 smsl-n100 volumio[1232]: info: Shairport-Sync Started Aug 30 06:02:20 smsl-n100 sudo[1639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Aug 30 06:02:20 smsl-n100 sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:20 smsl-n100 volumio[1232]: info: TidalConnect service stoped! Aug 30 06:02:20 smsl-n100 volumiobt[1619]: pulseaudio: no process found Aug 30 06:02:20 smsl-n100 sudo[1639]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:20 smsl-n100 dbus-daemon[530]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.15' (uid=1000 pid=1649 comm="/usr/bin/pulseaudio --high-priority=true ") Aug 30 06:02:20 smsl-n100 systemd[1]: Starting RealtimeKit Scheduling Policy Service... Aug 30 06:02:20 smsl-n100 dbus-daemon[530]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Aug 30 06:02:20 smsl-n100 systemd[1]: Started RealtimeKit Scheduling Policy Service. Aug 30 06:02:20 smsl-n100 rtkit-daemon[1650]: Successfully called chroot. Aug 30 06:02:20 smsl-n100 rtkit-daemon[1650]: Successfully dropped privileges. Aug 30 06:02:20 smsl-n100 rtkit-daemon[1650]: Successfully limited resources. Aug 30 06:02:20 smsl-n100 rtkit-daemon[1650]: Running. Aug 30 06:02:20 smsl-n100 rtkit-daemon[1650]: Watchdog thread running. Aug 30 06:02:20 smsl-n100 rtkit-daemon[1650]: Canary thread running. Aug 30 06:02:20 smsl-n100 dbus-daemon[530]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.16' (uid=0 pid=1650 comm="/usr/lib/rtkit/rtkit-daemon ") Aug 30 06:02:20 smsl-n100 systemd[1]: Starting Authorization Manager... Aug 30 06:02:20 smsl-n100 polkitd[1653]: started daemon version 0.105 using authority implementation `local' version `0.105' Aug 30 06:02:20 smsl-n100 dbus-daemon[530]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Aug 30 06:02:20 smsl-n100 systemd[1]: Started Authorization Manager. Aug 30 06:02:21 smsl-n100 dbus-daemon[530]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.36' (uid=1000 pid=1649 comm="/usr/bin/pulseaudio --high-priority=true ") Aug 30 06:02:21 smsl-n100 systemd[1]: Starting Bluetooth service... Aug 30 06:02:21 smsl-n100 pulseaudio[1649]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Aug 30 06:02:21 smsl-n100 pulseaudio[1649]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Applying permissions Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Setting BT discoverable and pairable Aug 30 06:02:21 smsl-n100 bluetoothd[1658]: Bluetooth daemon 5.50 Aug 30 06:02:21 smsl-n100 bluetoothd[1658]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Aug 30 06:02:21 smsl-n100 dbus-daemon[530]: [system] Successfully activated service 'org.bluez' Aug 30 06:02:21 smsl-n100 systemd[1]: Started Bluetooth service. Aug 30 06:02:21 smsl-n100 bluetoothd[1658]: Starting SDP server Aug 30 06:02:21 smsl-n100 bluetoothd[1658]: Excluding (cli) sap Aug 30 06:02:21 smsl-n100 bluetoothd[1658]: kernel lacks bnep-protocol support Aug 30 06:02:21 smsl-n100 bluetoothd[1658]: System does not support network plugin Aug 30 06:02:21 smsl-n100 dbus-daemon[530]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.37' (uid=0 pid=1658 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Aug 30 06:02:21 smsl-n100 bluetoothd[1658]: Bluetooth management interface 1.14 initialized Aug 30 06:02:21 smsl-n100 volumiobt[1619]: [bluetooth]# -e power on Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Invalid command in menu main: -e Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Use "help" for a list of available commands in a menu. Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Use "menu " if you want to enter any submenu. Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Use "back" if you want to return to menu main. Aug 30 06:02:21 smsl-n100 pulseaudio[1649]: 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 Aug 30 06:02:21 smsl-n100 volumiobt[1619]: [bluetooth]# agent on Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Failed to register agent object Aug 30 06:02:21 smsl-n100 volumiobt[1619]: [bluetooth]# discoverable on Aug 30 06:02:21 smsl-n100 volumiobt[1619]: No default controller available Aug 30 06:02:21 smsl-n100 volumiobt[1619]: [bluetooth]# pairable on Aug 30 06:02:21 smsl-n100 volumiobt[1619]: No default controller available Aug 30 06:02:21 smsl-n100 volumiobt[1619]: [bluetooth]# agent NoInputNoOutput Aug 30 06:02:21 smsl-n100 volumiobt[1619]: Failed to register agent object Aug 30 06:02:21 smsl-n100 volumiobt[1619]: [bluetooth]# default-agent Aug 30 06:02:21 smsl-n100 volumiobt[1619]: No agent is registered Aug 30 06:02:21 smsl-n100 volumiobt[1619]: [bluetooth]# quit Aug 30 06:02:21 smsl-n100 volumiobt[1619]: [59B blob data] Aug 30 06:02:21 smsl-n100 systemd[1]: Starting Hostname Service... Aug 30 06:02:22 smsl-n100 dbus-daemon[530]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 30 06:02:22 smsl-n100 systemd[1]: Started Hostname Service. Aug 30 06:02:22 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 06:02:22 smsl-n100 systemd[1]: mpd.service: Failed with result 'protocol'. Aug 30 06:02:22 smsl-n100 systemd[1]: Failed to start Music Player Daemon. Aug 30 06:02:22 smsl-n100 sudo[1516]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:22 smsl-n100 sudo[1506]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:22 smsl-n100 systemd[1]: Starting Music Player Daemon... Aug 30 06:02:22 smsl-n100 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 06:02:22 smsl-n100 systemd[1]: mpd.service: Succeeded. Aug 30 06:02:22 smsl-n100 systemd[1]: Stopped Music Player Daemon. Aug 30 06:02:22 smsl-n100 systemd[1]: Starting Music Player Daemon... Aug 30 06:02:22 smsl-n100 sudo[1667]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 06:02:22 smsl-n100 sudo[1667]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:22 smsl-n100 sudo[1667]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:22 smsl-n100 kernel: scsi 0:0:0:0: Direct-Access Micron CT2000X9SSD9 PMAP PQ: 0 ANSI: 6 Aug 30 06:02:23 smsl-n100 kernel: sd 0:0:0:0: [sda] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB) Aug 30 06:02:23 smsl-n100 kernel: sd 0:0:0:0: [sda] Write Protect is off Aug 30 06:02:23 smsl-n100 kernel: sd 0:0:0:0: [sda] Mode Sense: 57 00 00 00 Aug 30 06:02:23 smsl-n100 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Aug 30 06:02:23 smsl-n100 kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes Aug 30 06:02:23 smsl-n100 kernel: sda: sda1 Aug 30 06:02:23 smsl-n100 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Aug 30 06:02:25 smsl-n100 mpd[1669]: Aug 30 06:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 06:02:25 smsl-n100 systemd[1]: Started Music Player Daemon. Aug 30 06:02:25 smsl-n100 mpd_monitor.sh[523]: MPD restarted due to no mpc output. Aug 30 06:02:25 smsl-n100 volumio[1232]: info: Scanning removed location : "USB/Musique" Aug 30 06:02:25 smsl-n100 volumio[1232]: info: MRS: Getting audio outputs on start Aug 30 06:02:25 smsl-n100 volumio[1232]: info: MRS: Requesting all other devices output Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 30 06:02:25 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:02:25 smsl-n100 volumio[1232]: Upnp client error: Error: This socket has been ended by the other party Aug 30 06:02:25 smsl-n100 volumio[1232]: Upnp client error: Error: This socket has been ended by the other party Aug 30 06:02:25 smsl-n100 volumio[1232]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Aug 30 06:02:25 smsl-n100 volumio[1232]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Aug 30 06:02:25 smsl-n100 volumio[1232]: See "systemctl status mpd.service" and "journalctl -xe" for details. Aug 30 06:02:25 smsl-n100 volumio[1232]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Aug 30 06:02:25 smsl-n100 volumio[1232]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Aug 30 06:02:25 smsl-n100 volumio[1232]: See "systemctl status mpd.service" and "journalctl -xe" for details. Aug 30 06:02:26 smsl-n100 volumio[1232]: info: Mounting Device Musique Aug 30 06:02:26 smsl-n100 sudo[1687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Musique -o noatime Aug 30 06:02:26 smsl-n100 sudo[1687]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:26 smsl-n100 kernel: EXT4-fs (sda1): recovery complete Aug 30 06:02:26 smsl-n100 kernel: EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) Aug 30 06:02:26 smsl-n100 sudo[1687]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:26 smsl-n100 volumio[1232]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 30 06:02:26 smsl-n100 volumio[1232]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 30 06:02:26 smsl-n100 sudo[1692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 30 06:02:26 smsl-n100 sudo[1692]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:26 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Aug 30 06:02:26 smsl-n100 sudo[1692]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:26 smsl-n100 volumio[1232]: error: MPD error: The expression evaluated to a falsy value: Aug 30 06:02:26 smsl-n100 volumio[1232]: assert.ok(self.idling) Aug 30 06:02:26 smsl-n100 volumio[1232]: error: The expression evaluated to a falsy value: Aug 30 06:02:26 smsl-n100 volumio[1232]: assert.ok(self.idling) Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:26 smsl-n100 volumio[1232]: error: updateQueue error: null Aug 30 06:02:26 smsl-n100 volumio[1232]: info: Scanning new location : "USB/Musique" Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:26 smsl-n100 volumio[1232]: info: Aug 30 06:02:26 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:26 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:26 smsl-n100 volumio[1232]: info: Aug 30 06:02:26 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:26 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:26 smsl-n100 volumio[1232]: info: sendMpdCommand status took 57 milliseconds Aug 30 06:02:26 smsl-n100 volumio[1232]: info: sendMpdCommand status took 48 milliseconds Aug 30 06:02:26 smsl-n100 volumio[1232]: info: sendMpdCommand status took 47 milliseconds Aug 30 06:02:26 smsl-n100 volumio[1232]: info: sendMpdCommand status took 42 milliseconds Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatetrue Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatetrue Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:26 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:26 smsl-n100 volumio[1232]: error: Help! Some callbacks for volumioPushState are crashing! Aug 30 06:02:26 smsl-n100 volumio[1232]: error: Cannot read property 'sendVolumeMute' of undefined Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:26 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:26 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:26 smsl-n100 volumio[1232]: error: Help! Some callbacks for volumioPushState are crashing! Aug 30 06:02:26 smsl-n100 volumio[1232]: error: Cannot read property 'sendVolumeMute' of undefined Aug 30 06:02:26 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:26 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:26 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:27 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:27 smsl-n100 volumio[1232]: error: Help! Some callbacks for volumioPushState are crashing! Aug 30 06:02:27 smsl-n100 volumio[1232]: error: Cannot read property 'sendVolumeMute' of undefined Aug 30 06:02:27 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:27 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:27 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:27 smsl-n100 volumio[1232]: error: Help! Some callbacks for volumioPushState are crashing! Aug 30 06:02:27 smsl-n100 volumio[1232]: error: Cannot read property 'sendVolumeMute' of undefined Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:27 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:27 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:27 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:27 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:27 smsl-n100 volumio[1232]: error: Help! Some callbacks for volumioPushState are crashing! Aug 30 06:02:27 smsl-n100 volumio[1232]: error: Cannot read property 'sendVolumeMute' of undefined Aug 30 06:02:27 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:27 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:27 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:27 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:27 smsl-n100 volumio[1232]: error: Help! Some callbacks for volumioPushState are crashing! Aug 30 06:02:27 smsl-n100 volumio[1232]: error: Cannot read property 'sendVolumeMute' of undefined Aug 30 06:02:27 smsl-n100 volumio[1232]: info: ------------------------------ 419ms Aug 30 06:02:27 smsl-n100 volumio[1232]: info: ------------------------------ 412ms Aug 30 06:02:28 smsl-n100 volumio[1232]: info: Executing endpoint tc_getconfig Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Aug 30 06:02:28 smsl-n100 vtcs[1694]: STARTING TidalConnect services, version: 1.4.0.34 Aug 30 06:02:28 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:28 smsl-n100 volumio[1504]: Generating RSA private key, 4096 bit long modulus (2 primes) Aug 30 06:02:28 smsl-n100 vtcs[1694]: STARTED TidalConnect services. Aug 30 06:02:28 smsl-n100 volumio[1232]: info: Executing endpoint tc_connect Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Aug 30 06:02:28 smsl-n100 volumio[1232]: info: Connecting to TidalConnect Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:28 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:28 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:28 smsl-n100 volumio[1232]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:28 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:28 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:28 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:28 smsl-n100 volumio[1232]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Aug 30 06:02:29 smsl-n100 volumio[1232]: info: TidalConnect service started! Aug 30 06:02:29 smsl-n100 volumio[1232]: info: Completed starting Core Plugins Aug 30 06:02:29 smsl-n100 volumio[1232]: info: ------------------------------------------- Aug 30 06:02:29 smsl-n100 volumio[1232]: info: ----- MyVolumio plugins startup ---- Aug 30 06:02:29 smsl-n100 volumio[1232]: info: ------------------------------------------- Aug 30 06:02:29 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 30 06:02:29 smsl-n100 kernel: usb 2-1.4: cmd cmplt err -71 Aug 30 06:02:29 smsl-n100 kernel: usb 2-1.4: stat urb: status -71 Aug 30 06:02:29 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:29 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:29 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 kernel: usb 2-1.4: USB disconnect, device number 5 Aug 30 06:02:30 smsl-n100 kernel: sd 0:0:0:0: [sda] tag#12 uas_zap_pending 0 uas-tag 1 inflight: CMD Aug 30 06:02:30 smsl-n100 kernel: sd 0:0:0:0: [sda] tag#12 CDB: opcode=0x28 28 00 70 c9 03 40 00 00 58 00 Aug 30 06:02:30 smsl-n100 kernel: sd 0:0:0:0: [sda] tag#12 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00 Aug 30 06:02:30 smsl-n100 kernel: sd 0:0:0:0: [sda] tag#12 CDB: opcode=0x28 28 00 70 c9 03 40 00 00 58 00 Aug 30 06:02:30 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 1892221760 op 0x0:(READ) flags 0x80700 phys_seg 11 prio class 0 Aug 30 06:02:30 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 1892221760 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0 Aug 30 06:02:30 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 0 op 0x1:(WRITE) flags 0x800 phys_seg 0 prio class 0 Aug 30 06:02:30 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 1892221760 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0 Aug 30 06:02:30 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 1892221840 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0 Aug 30 06:02:30 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 1892310704 op 0x0:(READ) flags 0x80700 phys_seg 8 prio class 0 Aug 30 06:02:30 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 1892310704 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0 Aug 30 06:02:30 smsl-n100 kernel: blk_update_request: I/O error, dev sda, sector 1892310704 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0 Aug 30 06:02:30 smsl-n100 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113597: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: Partition removed: {"syspath":"/sys/devices/platform/ff5c0000.usb/usb2/2-1/2-1.4/2-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/8b67197d-d9c6-43df-8f7e-bfc873d372f0 /dev/disk/by-partuuid/47f9c805-32ef-4515-914e-0fc8718ccd64 /dev/disk/by-partlabel/Musique /dev/disk/by-path/platform-ff5c0000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/usb-Micron_CT2000X9SSD9_2332E8D6058B-0:0-part1 /dev/disk/by-label/Musique","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/ff5c0000.usb/usb2/2-1/2-1.4/2-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"Musique","ID_FS_LABEL_ENC":"Musique","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"8b67197d-d9c6-43df-8f7e-bfc873d372f0","ID_FS_UUID_ENC":"8b67197d-d9c6-43df-8f7e-bfc873d372f0","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"CT2000X9SSD9","ID_MODEL_ENC":"CT2000X9SSD9\\x20\\x20\\x20\\x20","ID_MODEL_ID":"5605","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"Musique","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"3907026944","ID_PART_ENTRY_TYPE":"0fc63daf-8483-4772-8e79-3d69d8477de4","ID_PART_ENTRY_UUID":"47f9c805-32ef-4515-914e-0fc8718ccd64","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"f6b569eb-9cb1-4c80-8d49-b50ecfca259e","ID_PATH":"platform-ff5c0000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff5c0000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"PMAP","ID_SERIAL":"Micron_CT2000X9SSD9_2332E8D6058B-0:0","ID_SERIAL_SHORT":"2332E8D6058B","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Micron","ID_VENDOR_ENC":"Micron\\x20\\x20","ID_VENDOR_ID":"0634","MAJOR":"8","MINOR":"1","PARTN":"1","PARTNAME":"Musique","SEQNUM":"2343","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"96319583"} Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113597: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113597: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113597: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113597: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113597: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113597: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113577: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #59113577: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs warning (device sda1): dx_probe:761: inode #58982401: lblock 0: comm update: error -5 reading directory block Aug 30 06:02:30 smsl-n100 kernel: EXT4-fs error (device sda1): __ext4_find_entry:1531: inode #2: comm update: reading directory lblock 0 Aug 30 06:02:30 smsl-n100 sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Aug 30 06:02:30 smsl-n100 sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:30 smsl-n100 kernel: Buffer I/O error on dev sda1, logical block 243826688, lost sync page write Aug 30 06:02:30 smsl-n100 kernel: JBD2: Error -5 detected when updating journal superblock for sda1-8. Aug 30 06:02:30 smsl-n100 kernel: Aborting journal on device sda1-8. Aug 30 06:02:30 smsl-n100 kernel: Buffer I/O error on dev sda1, logical block 243826688, lost sync page write Aug 30 06:02:30 smsl-n100 kernel: JBD2: Error -5 detected when updating journal superblock for sda1-8. Aug 30 06:02:30 smsl-n100 systemd[1]: media-Musique.mount: Succeeded. Aug 30 06:02:30 smsl-n100 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=0x00 Aug 30 06:02:30 smsl-n100 sudo[1754]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MPD Database updated - AlbumList cache refreshed Aug 30 06:02:30 smsl-n100 volumio[1232]: info: Aug 30 06:02:30 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: database Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:30 smsl-n100 volumio[1232]: info: Aug 30 06:02:30 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MPD Database updated - AlbumList cache refreshed Aug 30 06:02:30 smsl-n100 volumio[1232]: info: Aug 30 06:02:30 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: database Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:30 smsl-n100 volumio[1232]: info: Aug 30 06:02:30 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:30 smsl-n100 volumio[1232]: info: sendMpdCommand status took 78 milliseconds Aug 30 06:02:30 smsl-n100 volumio[1232]: info: sendMpdCommand status took 73 milliseconds Aug 30 06:02:30 smsl-n100 volumio[1232]: info: sendMpdCommand status took 72 milliseconds Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatefalse Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ------------------------------ 283ms Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ------------------------------ 284ms Aug 30 06:02:30 smsl-n100 volumio[1232]: info: sendMpdCommand status took 318 milliseconds Aug 30 06:02:30 smsl-n100 volumio[1232]: info: sendMpdCommand status took 315 milliseconds Aug 30 06:02:30 smsl-n100 volumio[1232]: info: sendMpdCommand status took 313 milliseconds Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatefalse Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:30 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:30 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:30 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ------------------------------ 486ms Aug 30 06:02:30 smsl-n100 volumio[1232]: info: ------------------------------ 488ms Aug 30 06:02:31 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:31 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:31 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:31 smsl-n100 volumio[1232]: info: listAlbums - loading Albums from cache Aug 30 06:02:32 smsl-n100 kernel: usb 2-1.4: new high-speed USB device number 6 using ehci-platform Aug 30 06:02:32 smsl-n100 kernel: usb 2-1.4: New USB device found, idVendor=0634, idProduct=5605, bcdDevice= 1.10 Aug 30 06:02:32 smsl-n100 kernel: usb 2-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Aug 30 06:02:32 smsl-n100 kernel: usb 2-1.4: Product: CT2000X9SSD9 Aug 30 06:02:32 smsl-n100 kernel: usb 2-1.4: Manufacturer: Micron Aug 30 06:02:32 smsl-n100 kernel: usb 2-1.4: SerialNumber: 2332E8D6058B Aug 30 06:02:32 smsl-n100 kernel: scsi host0: uas Aug 30 06:02:32 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:32 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:32 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:33 smsl-n100 volumio[1504]: ............................................................++++ Aug 30 06:02:33 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:33 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:33 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:34 smsl-n100 volumio[1232]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Musique Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Scanning removed location : "USB/Musique" Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Aug 30 06:02:35 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Aug 30 06:02:35 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 25 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 22 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 11 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 8 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatetrue Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatetrue Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ------------------------------ 272ms Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ------------------------------ 259ms Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MPD Database updated - AlbumList cache refreshed Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Aug 30 06:02:35 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: database Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Aug 30 06:02:35 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MPD Database updated - AlbumList cache refreshed Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Aug 30 06:02:35 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: database Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Aug 30 06:02:35 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 55 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 52 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 51 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 46 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 43 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: info: sendMpdCommand status took 42 milliseconds Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatefalse Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatefalse Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:35 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:35 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:35 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ------------------------------ 372ms Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ------------------------------ 373ms Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ------------------------------ 366ms Aug 30 06:02:35 smsl-n100 volumio[1232]: info: ------------------------------ 367ms Aug 30 06:02:36 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:36 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:36 smsl-n100 kernel: scsi 0:0:0:0: Direct-Access Micron CT2000X9SSD9 PMAP PQ: 0 ANSI: 6 Aug 30 06:02:36 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:36 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:36 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:37 smsl-n100 kernel: sd 0:0:0:0: [sda] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB) Aug 30 06:02:37 smsl-n100 kernel: sd 0:0:0:0: [sda] Write Protect is off Aug 30 06:02:37 smsl-n100 kernel: sd 0:0:0:0: [sda] Mode Sense: 57 00 00 00 Aug 30 06:02:37 smsl-n100 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Aug 30 06:02:37 smsl-n100 kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes Aug 30 06:02:37 smsl-n100 kernel: sda: sda1 Aug 30 06:02:37 smsl-n100 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 30 06:02:37 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 30 06:02:39 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 30 06:02:39 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 30 06:02:39 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:39 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:39 smsl-n100 volumio[1232]: info: Starting MyVolumio Remote Streaming Endpoints Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MyVolumio not started Aug 30 06:02:40 smsl-n100 volumio[1232]: info: Initializing device activation check Aug 30 06:02:40 smsl-n100 volumio[1232]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 30 06:02:40 smsl-n100 volumio[1232]: 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' Aug 30 06:02:40 smsl-n100 volumio[1232]: info: Mounting Device Musique Aug 30 06:02:40 smsl-n100 sudo[1799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Musique -o noatime Aug 30 06:02:40 smsl-n100 sudo[1799]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:40 smsl-n100 kernel: EXT4-fs (sda1): recovery complete Aug 30 06:02:40 smsl-n100 kernel: EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) Aug 30 06:02:40 smsl-n100 sudo[1799]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: Scanning new location : "USB/Musique" Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:40 smsl-n100 volumio[1232]: info: Aug 30 06:02:40 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:40 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:40 smsl-n100 volumio[1232]: info: Aug 30 06:02:40 smsl-n100 volumio[1232]: ---------------------------- MPD announces state update: update Aug 30 06:02:40 smsl-n100 volumio[1232]: info: ControllerMpd::getState Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: ControllerMpd::sendMpdCommand status Aug 30 06:02:40 smsl-n100 volumio[1232]: info: sendMpdCommand status took 38 milliseconds Aug 30 06:02:40 smsl-n100 volumio[1232]: info: sendMpdCommand status took 34 milliseconds Aug 30 06:02:40 smsl-n100 volumio[1232]: info: sendMpdCommand status took 32 milliseconds Aug 30 06:02:40 smsl-n100 volumio[1232]: info: sendMpdCommand status took 28 milliseconds Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatetrue Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: Command Router : Notfying DB Updatetrue Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: ControllerMpd::parseState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:40 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:40 smsl-n100 volumio[1232]: info: ControllerMpd::pushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::servicePushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 30 06:02:40 smsl-n100 volumio[1232]: verbose: CURRENT POSITION 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState stateService stop Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::syncState currentStatus stop Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:40 smsl-n100 volumio[1232]: info: No code Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:40 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:02:40 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:02:41 smsl-n100 volumio[1232]: info: ------------------------------ 315ms Aug 30 06:02:41 smsl-n100 volumio[1232]: info: ------------------------------ 310ms Aug 30 06:02:41 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:41 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:41 smsl-n100 volumio[1504]: .....................................................................................................................++++ Aug 30 06:02:41 smsl-n100 volumio[1504]: e is 65537 (0x010001) Aug 30 06:02:41 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:41 smsl-n100 volumio[1504]: writing RSA key Aug 30 06:02:41 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:41 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:42 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:42 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:42 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:43 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:43 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:43 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:45 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:45 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:45 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:45 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:46 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:46 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:47 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 06:02:47 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:47 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 06:02:47 smsl-n100 volumio-remote-updater[528]: No test mode Aug 30 06:02:47 smsl-n100 volumio-remote-updater[528]: No alpha test mode Aug 30 06:02:47 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 30 06:02:47 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:47 smsl-n100 volumio[1232]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 30 06:02:47 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 30 06:02:47 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:47 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:49 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:49 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:49 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:49 smsl-n100 volumio[1232]: error: MyVolumio Plugin failed to start in a timely fashion Aug 30 06:02:49 smsl-n100 volumio[1232]: [Metrics] CommandRouter: 69s 649.06ms Aug 30 06:02:49 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumiosetStartupVolume Aug 30 06:02:49 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:49 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 06:02:49 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:49 smsl-n100 volumio[1232]: info: CoreCommandRouter::Close All Modals sent Aug 30 06:02:49 smsl-n100 volumio[1232]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Aug 30 06:02:49 smsl-n100 volumio[1232]: xcb_connection_has_error() returned true Aug 30 06:02:49 smsl-n100 volumio[1232]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Aug 30 06:02:49 smsl-n100 volumio[1232]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Aug 30 06:02:49 smsl-n100 volumio[1232]: aplay: main:828: audio open error: No such device Aug 30 06:02:50 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:50 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:50 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:50 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 30 06:02:50 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 30 06:02:50 smsl-n100 volumio[1232]: xcb_connection_has_error() returned true Aug 30 06:02:50 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 30 06:02:51 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:51 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:51 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:52 smsl-n100 systemd[1]: systemd-hostnamed.service: Succeeded. Aug 30 06:02:53 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:53 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:53 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:54 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:54 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:54 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:54 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 06:02:55 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 06:02:55 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:55 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:55 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 30 06:02:55 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:55 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:56 smsl-n100 volumio[1232]: info: BOOT COMPLETED Aug 30 06:02:56 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 30 06:02:56 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:56 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:57 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 30 06:02:57 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:57 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 06:02:58 smsl-n100 volumio[1232]: info: Not Reporting Auto name since its the default one Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Aug 30 06:02:58 smsl-n100 volumio[1232]: xcb_connection_has_error() returned true Aug 30 06:02:58 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 30 06:02:58 smsl-n100 sudo[1867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Aug 30 06:02:58 smsl-n100 sudo[1867]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:58 smsl-n100 sudo[1867]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:02:58 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:58 smsl-n100 sudo[1869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Aug 30 06:02:58 smsl-n100 sudo[1869]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 06:02:58 smsl-n100 systemd[1]: Started RAAT DAEMON. Aug 30 06:02:58 smsl-n100 sudo[1869]: pam_unix(sudo:session): session closed for user root Aug 30 06:02:58 smsl-n100 volumio[1232]: info: Raat Daemon started successfully Aug 30 06:02:59 smsl-n100 volumio[1232]: info: Executing endpoint restartRAATSocket Aug 30 06:02:59 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Aug 30 06:02:59 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:02:59 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:59 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 06:02:59 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 30 06:02:59 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 30 06:02:59 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 30 06:02:59 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetBrowseSources Aug 30 06:03:00 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 06:03:00 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 30 06:03:00 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:00 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:00 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:01 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Down Aug 30 06:03:01 smsl-n100 dhcpcd[619]: eth0: carrier lost Aug 30 06:03:01 smsl-n100 dhcpcd[1034]: eth0: carrier lost Aug 30 06:03:01 smsl-n100 avahi-daemon[535]: Withdrawing address record for 192.168.1.28 on eth0. Aug 30 06:03:01 smsl-n100 avahi-daemon[535]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.28. Aug 30 06:03:01 smsl-n100 avahi-daemon[535]: Interface eth0.IPv4 no longer relevant for mDNS. Aug 30 06:03:01 smsl-n100 volumio[1232]: info: Discovery: A device disappeared from network Aug 30 06:03:01 smsl-n100 dhcpcd[619]: eth0: deleting route to 192.168.1.0/24 Aug 30 06:03:01 smsl-n100 dhcpcd[619]: eth0: deleting default route via 192.168.1.1 Aug 30 06:03:01 smsl-n100 dhcpcd[1034]: eth0: deleting route to 192.168.1.0/24 Aug 30 06:03:01 smsl-n100 dhcpcd[1034]: eth0: deleting default route via 192.168.1.1 Aug 30 06:03:01 smsl-n100 volumio[1232]: info: RAAT: Requesting Headphone Status Aug 30 06:03:01 smsl-n100 volumio[1232]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Aug 30 06:03:01 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:01 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:03:01 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:01 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:03:01 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:03:01 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:03:01 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:03:01 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:03:01 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:03:01 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:03:01 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:01 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:01 smsl-n100 ifplugd(eth0)[775]: Link beat lost. Aug 30 06:03:02 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:02 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:02 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:03 smsl-n100 ntpd[1033]: Deleting interface #3 eth0, 192.168.1.28#123, interface stats: received=152, sent=152, dropped=0, active_time=107 secs Aug 30 06:03:03 smsl-n100 ntpd[1033]: 5.39.80.51 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 176.142.80.77 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 212.83.158.83 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 82.64.42.185 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 51.159.15.176 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 5.42.158.119 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 82.67.62.62 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 195.154.185.215 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 45.132.96.81 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 54.36.61.42 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 178.32.23.17 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 45.90.162.253 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 5.196.76.84 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 162.159.200.123 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 141.95.171.142 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 162.159.200.1 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 ntpd[1033]: 217.182.137.208 local addr 192.168.1.28 -> Aug 30 06:03:03 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:03 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:03 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:04 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:04 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:04 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:05 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:05 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:05 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:07 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:07 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:07 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:08 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:08 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:08 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:08 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:08 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:08 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:10 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:10 smsl-n100 volumio[1232]: info: Reporting MCU Network Status: 0 Aug 30 06:03:10 smsl-n100 volumio[1232]: info: Volumio Network Manager: Network status updated: 0 Aug 30 06:03:10 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:10 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:10 smsl-n100 volumio[1232]: info: CoreStateMachine::pushState Aug 30 06:03:10 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:10 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioPushState Aug 30 06:03:10 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output update for this device Aug 30 06:03:10 smsl-n100 volumio[1232]: info: MRS: Pushing multiroomSync output Aug 30 06:03:10 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:03:10 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 30 06:03:10 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 100, message: undefined Aug 30 06:03:10 smsl-n100 volumio[1232]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 30 06:03:10 smsl-n100 volumio[1232]: error: Serial API: Failed to decode command: 0, message: undefined Aug 30 06:03:11 smsl-n100 ifplugd(eth0)[775]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Aug 30 06:03:11 smsl-n100 ifplugd(eth0)[775]: client: sending commands to master dhcpcd process Aug 30 06:03:11 smsl-n100 dhcpcd[2015]: sending commands to master dhcpcd process Aug 30 06:03:11 smsl-n100 dhcpcd[619]: control command: /sbin/dhcpcd -k eth0 Aug 30 06:03:11 smsl-n100 dhcpcd[619]: eth0: removing interface Aug 30 06:03:11 smsl-n100 ifplugd(eth0)[775]: Program executed successfully. Aug 30 06:03:11 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: PHY [stmmac-0:01] driver [Generic PHY] Aug 30 06:03:11 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: No Safety Features support found Aug 30 06:03:11 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: PTP not supported by HW Aug 30 06:03:11 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: configuring for phy/rgmii link mode Aug 30 06:03:11 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:11 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:11 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:13 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:13 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:13 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:14 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:14 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:14 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:16 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:16 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:16 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:17 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:17 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:17 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:18 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:18 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:18 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:19 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:19 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:19 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:20 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:21 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:21 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:21 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:21 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:21 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:22 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:22 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:22 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:23 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:23 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:23 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:24 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:24 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:24 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:25 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:25 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:25 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:26 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:26 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:26 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:26 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Aug 30 06:03:26 smsl-n100 dhcpcd[1034]: eth0: carrier acquired Aug 30 06:03:26 smsl-n100 dhcpcd[1034]: eth0: IAID 21:72:23:71 Aug 30 06:03:26 smsl-n100 ifplugd(eth0)[775]: Link beat detected. Aug 30 06:03:27 smsl-n100 ifplugd(eth0)[775]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Aug 30 06:03:27 smsl-n100 ifplugd(eth0)[775]: client: sending commands to master dhcpcd process Aug 30 06:03:27 smsl-n100 dhcpcd[2078]: sending commands to master dhcpcd process Aug 30 06:03:27 smsl-n100 dhcpcd[619]: control command: /sbin/dhcpcd eth0 Aug 30 06:03:27 smsl-n100 dhcpcd[619]: eth0: carrier acquired Aug 30 06:03:27 smsl-n100 dhcpcd[619]: eth0: IAID 21:72:23:71 Aug 30 06:03:27 smsl-n100 dhcpcd[619]: eth0: soliciting an IPv6 router Aug 30 06:03:27 smsl-n100 ifplugd(eth0)[775]: Program executed successfully. Aug 30 06:03:27 smsl-n100 dhcpcd[1034]: eth0: soliciting an IPv6 router Aug 30 06:03:27 smsl-n100 dhcpcd[1034]: eth0: soliciting a DHCP lease Aug 30 06:03:27 smsl-n100 dhcpcd[1034]: eth0: offered 192.168.1.28 from 192.168.1.1 Aug 30 06:03:27 smsl-n100 dhcpcd[1034]: eth0: probing address 192.168.1.28/24 Aug 30 06:03:27 smsl-n100 dhcpcd[619]: eth0: soliciting a DHCP lease Aug 30 06:03:27 smsl-n100 dhcpcd[619]: eth0: offered 192.168.1.28 from 192.168.1.1 Aug 30 06:03:27 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:27 smsl-n100 dhcpcd[619]: eth0: probing address 192.168.1.28/24 Aug 30 06:03:27 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:27 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:28 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:28 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:28 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:29 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:29 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:29 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:31 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:31 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:31 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:32 smsl-n100 nmbd[744]: [2025/08/30 06:03:32.450743, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 30 06:03:32 smsl-n100 nmbd[744]: Packet send failed to 192.168.1.255(138) ERRNO=Network is unreachable Aug 30 06:03:32 smsl-n100 nmbd[744]: [2025/08/30 06:03:32.457741, 0] ../source3/nmbd/nmbd.c:361(reload_interfaces) Aug 30 06:03:32 smsl-n100 nmbd[744]: reload_interfaces: No subnets to listen to. Waiting.. Aug 30 06:03:32 smsl-n100 dhcpcd[619]: eth0: leased 192.168.1.28 for 86400 seconds Aug 30 06:03:32 smsl-n100 dhcpcd[619]: eth0: adding route to 192.168.1.0/24 Aug 30 06:03:32 smsl-n100 dhcpcd[619]: eth0: adding default route via 192.168.1.1 Aug 30 06:03:32 smsl-n100 avahi-daemon[535]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.28. Aug 30 06:03:32 smsl-n100 avahi-daemon[535]: New relevant interface eth0.IPv4 for mDNS. Aug 30 06:03:32 smsl-n100 avahi-daemon[535]: Registering new address record for 192.168.1.28 on eth0.IPv4. Aug 30 06:03:32 smsl-n100 dhcpcd[1034]: eth0: leased 192.168.1.28 for 86400 seconds Aug 30 06:03:32 smsl-n100 dhcpcd[1034]: eth0: adding route to 192.168.1.0/24 Aug 30 06:03:32 smsl-n100 volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 06:03:32 smsl-n100 dhcpcd[1034]: eth0: adding default route via 192.168.1.1 Aug 30 06:03:32 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:32 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:32 smsl-n100 ntpd[1033]: ntpd exiting on signal 15 (Terminated) Aug 30 06:03:32 smsl-n100 systemd[1]: Stopping Network Time Service... Aug 30 06:03:32 smsl-n100 systemd[1]: ntp.service: Succeeded. Aug 30 06:03:32 smsl-n100 systemd[1]: Stopped Network Time Service. Aug 30 06:03:32 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:03:32 smsl-n100 systemd[1]: Starting Network Time Service... Aug 30 06:03:32 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 30 06:03:32 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:03:33 smsl-n100 ntpd[2180]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 30 06:03:33 smsl-n100 ntpd[2180]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Aug 30 06:03:33 smsl-n100 ntpd[2188]: proto: precision = 1.166 usec (-20) Aug 30 06:03:33 smsl-n100 systemd[1]: Started Network Time Service. Aug 30 06:03:33 smsl-n100 ntpd[2188]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 30 06:03:33 smsl-n100 ntpd[2188]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 30 06:03:33 smsl-n100 ntpd[2188]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 976 days ago Aug 30 06:03:33 smsl-n100 ntpd[2188]: Listen and drop on 0 v6wildcard [::]:123 Aug 30 06:03:33 smsl-n100 ntpd[2188]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 30 06:03:33 smsl-n100 ntpd[2188]: Listen normally on 2 lo 127.0.0.1:123 Aug 30 06:03:33 smsl-n100 ntpd[2188]: Listen normally on 3 eth0 192.168.1.28:123 Aug 30 06:03:33 smsl-n100 ntpd[2188]: Listening on routing socket on fd #20 for interface updates Aug 30 06:03:33 smsl-n100 ntpd[2188]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Aug 30 06:03:33 smsl-n100 ntpd[2188]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Aug 30 06:03:33 smsl-n100 ntpd[2188]: ntpd exiting on signal 15 (Terminated) Aug 30 06:03:33 smsl-n100 systemd[1]: Stopping Network Time Service... Aug 30 06:03:33 smsl-n100 systemd[1]: ntp.service: Succeeded. Aug 30 06:03:33 smsl-n100 systemd[1]: Stopped Network Time Service. Aug 30 06:03:33 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:03:33 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 30 06:03:33 smsl-n100 systemd[1]: Starting Network Time Service... Aug 30 06:03:33 smsl-n100 volumio[1232]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 30 06:03:33 smsl-n100 ntpd[2194]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 30 06:03:33 smsl-n100 ntpd[2194]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Aug 30 06:03:33 smsl-n100 systemd[1]: Started Network Time Service. Aug 30 06:03:33 smsl-n100 ntpd[2200]: proto: precision = 1.166 usec (-20) Aug 30 06:03:33 smsl-n100 ntpd[2200]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 30 06:03:33 smsl-n100 ntpd[2200]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 30 06:03:33 smsl-n100 ntpd[2200]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 976 days ago Aug 30 06:03:33 smsl-n100 ntpd[2200]: Listen and drop on 0 v6wildcard [::]:123 Aug 30 06:03:33 smsl-n100 ntpd[2200]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 30 06:03:33 smsl-n100 ntpd[2200]: Listen normally on 2 lo 127.0.0.1:123 Aug 30 06:03:33 smsl-n100 ntpd[2200]: Listen normally on 3 eth0 192.168.1.28:123 Aug 30 06:03:33 smsl-n100 ntpd[2200]: Listening on routing socket on fd #20 for interface updates Aug 30 06:03:33 smsl-n100 ntpd[2200]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 30 06:03:33 smsl-n100 ntpd[2200]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 30 06:03:33 smsl-n100 volumio[1232]: info: Discovery: adding c3c97753-bca2-42f8-9ff6-d5c74be0b1b0 Aug 30 06:03:33 smsl-n100 volumio[1232]: info: Discovery: Found device SMSL N100 Aug 30 06:03:33 smsl-n100 volumio[1232]: info: CoreCommandRouter::volumioGetState Aug 30 06:03:33 smsl-n100 volumio[1232]: info: CorePlayQueue::getTrack 0 Aug 30 06:03:33 smsl-n100 volumio[1232]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 06:03:33 smsl-n100 volumio[1232]: Error: The value NaN is not a number Aug 30 06:03:33 smsl-n100 volumio[1232]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Aug 30 06:03:33 smsl-n100 volumio[1232]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Aug 30 06:03:33 smsl-n100 volumio[1232]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Aug 30 06:03:33 smsl-n100 volumio[1232]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Aug 30 06:03:33 smsl-n100 volumio[1232]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Aug 30 06:03:33 smsl-n100 volumio[1232]: at Browser.emit (events.js:400:28) Aug 30 06:03:33 smsl-n100 volumio[1232]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Aug 30 06:03:33 smsl-n100 volumio[1232]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Aug 30 06:03:33 smsl-n100 volumio[1232]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Aug 30 06:03:33 smsl-n100 volumio[1232]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Aug 30 06:03:33 smsl-n100 volumio[1232]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Aug 30 06:03:33 smsl-n100 volumio[1232]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Aug 30 06:03:33 smsl-n100 volumio[1232]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Aug 30 06:03:33 smsl-n100 volumio[1232]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 06:03:34 smsl-n100 ntpd[2200]: Soliciting pool server 212.227.232.161 Aug 30 06:03:34 smsl-n100 sudo[2211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 06:02 Aug 30 06:03:34 smsl-n100 sudo[2211]: 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"