-- Logs begin at Mon 2024-07-22 06:10:32 SAST, end at Mon 2024-07-22 16:20:41 SAST. --
Jul 22 16:19:00 volumio-usbridge nmbd[547]: [2024/07/22 16:19:00.517332, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:19:00 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:19:00 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:19:00 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917542: comm nmbd: reading directory lblock 0
Jul 22 16:19:00 volumio-usbridge nmbd[10100]: [2024/07/22 16:19:00.537102, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
Jul 22 16:19:00 volumio-usbridge nmbd[10100]: wins_write_database: Can't open /var/lib/samba/wins.dat.10100: Input/output error
Jul 22 16:19:00 volumio-usbridge nmbd[547]: [2024/07/22 16:19:00.557360, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:19:00 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:19:00 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:19:06 volumio-usbridge kernel: usb 1-1.2: new high-speed USB device number 35 using dwc_otg
Jul 22 16:19:06 volumio-usbridge kernel: usb 1-1.2: New USB device found, idVendor=17ae, idProduct=0005, bcdDevice= 5.31
Jul 22 16:19:06 volumio-usbridge kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jul 22 16:19:06 volumio-usbridge kernel: usb 1-1.2: Product: NAD USB Audio 2.0
Jul 22 16:19:06 volumio-usbridge kernel: usb 1-1.2: Manufacturer: NAD
Jul 22 16:19:06 volumio-usbridge kernel: usb 1-1.2: SerialNumber: 0000
Jul 22 16:19:07 volumio-usbridge volumio[599]: info:
Jul 22 16:19:07 volumio-usbridge volumio[599]: ---------------------------- USB Audio Device Attached
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::Close All Modals sent
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: Setting mixer NAD Audio 2.0 Output for card NAD USB Audio 2.0
Jul 22 16:19:07 volumio-usbridge vtcs[8510]: [2024-07-22 16:19:07.321] [tisoc] [error] [SpkconServer.cpp:368] recv error. socket disconnected
Jul 22 16:19:07 volumio-usbridge vtcs[8510]: [2024-07-22 16:19:07.328] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Jul 22 16:19:07 volumio-usbridge sudo[10117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 22 16:19:07 volumio-usbridge sudo[10117]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:07 volumio-usbridge systemd[1]: Stopping Volumio Tidal Connect Service...
Jul 22 16:19:07 volumio-usbridge systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Jul 22 16:19:07 volumio-usbridge systemd[1]: vtcs.service: Succeeded.
Jul 22 16:19:07 volumio-usbridge systemd[1]: Stopped Volumio Tidal Connect Service.
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: Updating Volume Controller Parameters: Device: 5 Name: NAD USB Audio 2.0 Mixer: NAD Audio 2.0 Output Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: Disabling external Volume Control
Jul 22 16:19:07 volumio-usbridge sudo[10117]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: Preparing to generate the ALSA configuration file
Jul 22 16:19:07 volumio-usbridge kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1003: inode #917778: lblock 0: comm node: error -5 reading directory block
Jul 22 16:19:07 volumio-usbridge volumio[599]: warn: Unable to scan plugin multiroom for ALSA configuration: Error: EIO: i/o error, scandir '/data/configuration/audio_interface/multiroom/asound'
Jul 22 16:19:07 volumio-usbridge volumio[599]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 22 16:19:07 volumio-usbridge sudo[10124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 22 16:19:07 volumio-usbridge sudo[10124]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:07 volumio-usbridge sudo[10124]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: VolumeController:: Volume=100 Mute =false
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:07 volumio-usbridge volumio[599]: error: Cannot write /etc/asound.conf: Error: EROFS: read-only file system, open '/home/volumio/.asoundrc'
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: Output device has changed, restarting MPD
Jul 22 16:19:07 volumio-usbridge sudo[10133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 22 16:19:07 volumio-usbridge sudo[10133]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: Output device has changed, restarting Shairport Sync
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 22 16:19:07 volumio-usbridge sudo[10133]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:07 volumio-usbridge sudo[10136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 22 16:19:07 volumio-usbridge sudo[10136]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:07 volumio-usbridge systemd[1]: Stopping Music Player Daemon...
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 22 16:19:07 volumio-usbridge volumio[599]: xcb_connection_has_error() returned true
Jul 22 16:19:07 volumio-usbridge systemd[1]: mpd.service: Succeeded.
Jul 22 16:19:07 volumio-usbridge systemd[1]: Stopped Music Player Daemon.
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 16:19:07 volumio-usbridge systemd[1]: Starting Music Player Daemon...
Jul 22 16:19:07 volumio-usbridge sudo[10145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 22 16:19:07 volumio-usbridge sudo[10145]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:07 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Jul 22 16:19:07 volumio-usbridge volumio[599]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 22 16:19:08 volumio-usbridge volumio[599]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 22 16:19:08 volumio-usbridge volumio[599]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 22 16:19:08 volumio-usbridge volumio[599]: info: Error setting mpd conf file perms: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf
Jul 22 16:19:08 volumio-usbridge volumio[599]: /bin/chmod: changing permissions of '/etc/mpd.conf': Read-only file system
Jul 22 16:19:08 volumio-usbridge sudo[10147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 22 16:19:08 volumio-usbridge sudo[10147]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:08 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 16:19:08 volumio-usbridge sudo[10145]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:08 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 22 16:19:08 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 16:19:08 volumio-usbridge sudo[10147]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:08 volumio-usbridge volumio[599]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf'
Jul 22 16:19:08 volumio-usbridge volumio[599]: info: Starting Shairport Sync
Jul 22 16:19:08 volumio-usbridge volumio[599]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jul 22 16:19:08 volumio-usbridge sudo[10158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 22 16:19:08 volumio-usbridge sudo[10158]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:08 volumio-usbridge systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 22 16:19:08 volumio-usbridge volumio[599]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 22 16:19:08 volumio-usbridge systemd[1]: shairport-sync.service: Succeeded.
Jul 22 16:19:08 volumio-usbridge systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 22 16:19:08 volumio-usbridge volumio[599]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 22 16:19:08 volumio-usbridge systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 22 16:19:08 volumio-usbridge sudo[10158]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:08 volumio-usbridge volumio[599]: info: Shairport-Sync Started
Jul 22 16:19:09 volumio-usbridge mpd[10160]: Jul 22 16:19 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 22 16:19:09 volumio-usbridge mpd[10160]: Jul 22 16:19 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Jul 22 16:19:09 volumio-usbridge mpd[10160]: Jul 22 16:19 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Jul 22 16:19:09 volumio-usbridge systemd[1]: Started Music Player Daemon.
Jul 22 16:19:09 volumio-usbridge sudo[10136]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:09 volumio-usbridge volumio[599]: error: updateQueue error: null
Jul 22 16:19:10 volumio-usbridge volumio[599]: info: TidalConnect service stoped!
Jul 22 16:19:10 volumio-usbridge volumio[599]: info: TidalConnect service stoped!
Jul 22 16:19:10 volumio-usbridge volumio[599]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Jul 22 16:19:10 volumio-usbridge volumio[599]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Jul 22 16:19:10 volumio-usbridge sudo[10175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Jul 22 16:19:10 volumio-usbridge sudo[10175]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:10 volumio-usbridge systemd[1]: Started Volumio Tidal Connect Service.
Jul 22 16:19:10 volumio-usbridge sudo[10175]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: Executing endpoint tc_getconfig
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Jul 22 16:19:11 volumio-usbridge vtcs[10177]: STARTING TidalConnect services, version: 1.1.7.5
Jul 22 16:19:11 volumio-usbridge vtcs[10177]: STARTED TidalConnect services.
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: Executing endpoint tc_connect
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: Connecting to TidalConnect
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::servicePushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Jul 22 16:19:11 volumio-usbridge volumio[599]: verbose: CURRENT POSITION 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::syncState stateService stop
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::syncState currentStatus stop
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: No code
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::servicePushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Jul 22 16:19:11 volumio-usbridge volumio[599]: verbose: CURRENT POSITION 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::syncState stateService stop
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::syncState currentStatus stop
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: No code
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: TidalConnect service stoped!
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: TidalConnect service stoped!
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Jul 22 16:19:11 volumio-usbridge sudo[10204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Jul 22 16:19:11 volumio-usbridge sudo[10204]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:19:11 volumio-usbridge sudo[10204]: pam_unix(sudo:session): session closed for user root
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::getcurrentVolume
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioRetrievevolume
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: VolumeController:: Volume=100 Mute =false
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::updateTrackBlock
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrackBlock
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioRetrievevolume
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: VolumeController:: Volume=100 Mute =false
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreStateMachine::pushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioPushState
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output update for this device
Jul 22 16:19:11 volumio-usbridge volumio[599]: info: MRS: Pushing multiroomSync output
Jul 22 16:19:13 volumio-usbridge volumio[599]: info: TidalConnect service started!
Jul 22 16:19:14 volumio-usbridge volumio[599]: info: TidalConnect service started!
Jul 22 16:19:20 volumio-usbridge nmbd[547]: [2024/07/22 16:19:20.594445, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:19:20 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:19:20 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:19:20 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917542: comm nmbd: reading directory lblock 0
Jul 22 16:19:20 volumio-usbridge nmbd[10211]: [2024/07/22 16:19:20.614245, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
Jul 22 16:19:20 volumio-usbridge nmbd[10211]: wins_write_database: Can't open /var/lib/samba/wins.dat.10211: Input/output error
Jul 22 16:19:20 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:19:20 volumio-usbridge nmbd[547]: [2024/07/22 16:19:20.634465, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:19:20 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:19:20 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917544: comm lpqd: reading directory lblock 0
Jul 22 16:19:20 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917544: comm lpqd: reading directory lblock 0
Jul 22 16:19:20 volumio-usbridge smbd[10212]: [2024/07/22 16:19:20.698462, 0] ../source3/lib/util.c:493(reinit_after_fork)
Jul 22 16:19:20 volumio-usbridge smbd[10212]: messaging_reinit() failed: NT_STATUS_IO_DEVICE_ERROR
Jul 22 16:19:20 volumio-usbridge smbd[10212]: [2024/07/22 16:19:20.698969, 0] ../source3/printing/print_cups.c:486(cups_pcap_load_async)
Jul 22 16:19:20 volumio-usbridge smbd[10212]: cups_pcap_load_async: reinit_after_fork() failed
Jul 22 16:19:20 volumio-usbridge smbd[10212]: [2024/07/22 16:19:20.699098, 0] ../source3/lib/util.c:816(smb_panic_s3)
Jul 22 16:19:20 volumio-usbridge smbd[10212]: PANIC (pid 10212): cups_pcap_load_async: reinit_after_fork() failed
Jul 22 16:19:20 volumio-usbridge smbd[10212]: [2024/07/22 16:19:20.702664, 0] ../lib/util/fault.c:261(log_stack_trace)
Jul 22 16:19:20 volumio-usbridge smbd[10212]: BACKTRACE: 0 stack frames:
Jul 22 16:19:20 volumio-usbridge smbd[10212]: [2024/07/22 16:19:20.702957, 0] ../source3/lib/dumpcore.c:315(dump_core)
Jul 22 16:19:20 volumio-usbridge smbd[10212]: dumping core in /var/log/samba/cores/smbd
Jul 22 16:19:20 volumio-usbridge smbd[10212]:
Jul 22 16:19:20 volumio-usbridge smbd[737]: [2024/07/22 16:19:20.717969, 0] ../source3/printing/print_cups.c:524(cups_async_callback)
Jul 22 16:19:20 volumio-usbridge smbd[737]: failed to recv pcap blob
Jul 22 16:19:40 volumio-usbridge nmbd[547]: [2024/07/22 16:19:40.671553, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:19:40 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:19:40 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:19:40 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917542: comm nmbd: reading directory lblock 0
Jul 22 16:19:40 volumio-usbridge nmbd[10223]: [2024/07/22 16:19:40.691348, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
Jul 22 16:19:40 volumio-usbridge nmbd[10223]: wins_write_database: Can't open /var/lib/samba/wins.dat.10223: Input/output error
Jul 22 16:19:40 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:19:40 volumio-usbridge nmbd[547]: [2024/07/22 16:19:40.711525, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:19:40 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: Discovery: Getting this device information
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioGetState
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 22 16:19:48 volumio-usbridge volumio[599]: verbose: New Socket.io Connection to 10.0.0.130 from 10.0.0.124 UA: okhttp/4.9.2 Total Clients: 5
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioGetState
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jul 22 16:19:48 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jul 22 16:20:00 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:20:00 volumio-usbridge nmbd[547]: [2024/07/22 16:20:00.750469, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:20:00 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:20:00 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917542: comm nmbd: reading directory lblock 0
Jul 22 16:20:00 volumio-usbridge nmbd[10224]: [2024/07/22 16:20:00.770308, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
Jul 22 16:20:00 volumio-usbridge nmbd[10224]: wins_write_database: Can't open /var/lib/samba/wins.dat.10224: Input/output error
Jul 22 16:20:00 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:20:00 volumio-usbridge nmbd[547]: [2024/07/22 16:20:00.790488, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:20:00 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:20:20 volumio-usbridge nmbd[547]: [2024/07/22 16:20:20.827599, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:20:20 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:20:20 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917542: comm nmbd: reading directory lblock 0
Jul 22 16:20:20 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:20:20 volumio-usbridge nmbd[10225]: [2024/07/22 16:20:20.847456, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
Jul 22 16:20:20 volumio-usbridge nmbd[10225]: wins_write_database: Can't open /var/lib/samba/wins.dat.10225: Input/output error
Jul 22 16:20:20 volumio-usbridge nmbd[547]: [2024/07/22 16:20:20.867703, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:20:20 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:20:20 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:20:40 volumio-usbridge sudo[10227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 22 16:20:40 volumio-usbridge sudo[10227]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:20:40 volumio-usbridge sudo[10227]: pam_unix(sudo:session): session closed for user root
Jul 22 16:20:40 volumio-usbridge sudo[10229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 22 16:20:40 volumio-usbridge sudo[10229]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 16:20:40 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p2): ext4_journal_check_start:83: Detected aborted journal
Jul 22 16:20:40 volumio-usbridge kernel: EXT4-fs (mmcblk0p2): Remounting filesystem read-only
Jul 22 16:20:40 volumio-usbridge sudo[10229]: pam_unix(sudo:session): session closed for user root
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: Discovery: Getting this device information
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioGetState
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 22 16:20:40 volumio-usbridge volumio[599]: verbose: New Socket.io Connection to 10.0.0.130 from 10.0.0.124 UA: okhttp/4.9.2 Total Clients: 6
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioGetState
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: Received Get System Info
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: Discovery: Getting this device information
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioGetState
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CoreCommandRouter::volumioGetState
Jul 22 16:20:40 volumio-usbridge volumio[599]: info: CorePlayQueue::getTrack 43
Jul 22 16:20:40 volumio-usbridge nmbd[547]: [2024/07/22 16:20:40.904989, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:20:40 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:20:40 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:20:40 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917542: comm nmbd: reading directory lblock 0
Jul 22 16:20:40 volumio-usbridge kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1003: inode #917599: lblock 0: comm node: error -5 reading directory block
Jul 22 16:20:40 volumio-usbridge nmbd[10234]: [2024/07/22 16:20:40.925298, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
Jul 22 16:20:40 volumio-usbridge nmbd[10234]: wins_write_database: Can't open /var/lib/samba/wins.dat.10234: Input/output error
Jul 22 16:20:40 volumio-usbridge volumio[599]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 22 16:20:40 volumio-usbridge kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #917584: comm nmbd: reading directory lblock 0
Jul 22 16:20:40 volumio-usbridge volumio[599]: Error: EIO: i/o error, scandir '/data/plugins/'
Jul 22 16:20:40 volumio-usbridge volumio[599]: at Object.readdirSync (fs.js:1021:3)
Jul 22 16:20:40 volumio-usbridge volumio[599]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30)
Jul 22 16:20:40 volumio-usbridge volumio[599]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1509:29)
Jul 22 16:20:40 volumio-usbridge volumio[599]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1300:45)
Jul 22 16:20:40 volumio-usbridge volumio[599]: at Socket.emit (events.js:315:20)
Jul 22 16:20:40 volumio-usbridge volumio[599]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Jul 22 16:20:40 volumio-usbridge volumio[599]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Jul 22 16:20:40 volumio-usbridge volumio[599]: errno: -5,
Jul 22 16:20:40 volumio-usbridge volumio[599]: syscall: 'scandir',
Jul 22 16:20:40 volumio-usbridge volumio[599]: code: 'EIO',
Jul 22 16:20:40 volumio-usbridge volumio[599]: path: '/data/plugins/'
Jul 22 16:20:40 volumio-usbridge volumio[599]: }
Jul 22 16:20:40 volumio-usbridge volumio[599]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 22 16:20:40 volumio-usbridge nmbd[547]: [2024/07/22 16:20:40.945981, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list)
Jul 22 16:20:40 volumio-usbridge nmbd[547]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error
Jul 22 16:20:41 volumio-usbridge sudo[10244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 16:19
Jul 22 16:20:41 volumio-usbridge sudo[10244]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST"
VOLUMIO_VERSION="3.512"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"