-- Logs begin at Thu 2019-02-14 19:12:01 JST, end at Tue 2024-10-01 12:04:38 JST. -- Oct 01 12:03:05 volumio-02 nmbd[30877]: [2024/10/01 12:03:05.253053, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 01 12:03:05 volumio-02 nmbd[30877]: wins_write_database: Can't open /var/lib/samba/wins.dat.30877: Read-only file system Oct 01 12:03:25 volumio-02 nmbd[30919]: [2024/10/01 12:03:25.277983, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 01 12:03:25 volumio-02 nmbd[30919]: wins_write_database: Can't open /var/lib/samba/wins.dat.30919: Read-only file system Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPlay Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::play index undefined Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::startPlaybackTimer Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: ControllerMpd::resume Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand play Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand play took 3 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: info: Oct 01 12:03:26 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:03:26 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:03:26 volumio-02 volumio[976]: info: Oct 01 12:03:26 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:03:26 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:03:26 volumio-02 volumio[976]: info: Oct 01 12:03:26 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:03:26 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand status took 2 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand status took 1 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand status took 1 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:03:26 volumio-02 volumio[976]: error: Upnp client error: Error: This socket has been ended by the other party Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:03:26 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":361249,"duration":363,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"162 Kbps","isStreaming":false,"title":"Share My Dreams","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/01 Gerry Niewood - Share My Dreams.flac","trackType":"flac"} Oct 01 12:03:26 volumio-02 volumio[976]: verbose: CURRENT POSITION 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService play Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus pause Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:26 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":361249,"duration":363,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"162 Kbps","isStreaming":false,"title":"Share My Dreams","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/01 Gerry Niewood - Share My Dreams.flac","trackType":"flac"} Oct 01 12:03:26 volumio-02 volumio[976]: verbose: CURRENT POSITION 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService play Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus play Oct 01 12:03:26 volumio-02 volumio[976]: info: Received an update from plugin. extracting info from payload Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:26 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":361249,"duration":363,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"162 Kbps","isStreaming":false,"title":"Share My Dreams","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/01 Gerry Niewood - Share My Dreams.flac","trackType":"flac"} Oct 01 12:03:26 volumio-02 volumio[976]: verbose: CURRENT POSITION 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService play Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus play Oct 01 12:03:26 volumio-02 volumio[976]: info: Received an update from plugin. extracting info from payload Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:26 volumio-02 volumio[976]: info: ------------------------------ 18ms Oct 01 12:03:26 volumio-02 volumio[976]: info: ------------------------------ 17ms Oct 01 12:03:26 volumio-02 volumio[976]: info: ------------------------------ 18ms Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 0 Oct 01 12:03:26 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:26 volumio-02 volumio[976]: info: Prefetching next song Oct 01 12:03:26 volumio-02 volumio[976]: info: DOING PREFETCH IN MPD Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand add "NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/02 Gerry Niewood - After All This Time.flac" Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand add "NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/02 Gerry Niewood - After All This Time.flac" took 0 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 01 12:03:26 volumio-02 volumio[976]: info: Oct 01 12:03:26 volumio-02 volumio[976]: ---------------------------- MPD announces system playlist update Oct 01 12:03:26 volumio-02 volumio[976]: info: Ignoring MPD Status Update Oct 01 12:03:26 volumio-02 volumio[976]: info: sendMpdCommand consume 1 took 1 milliseconds Oct 01 12:03:26 volumio-02 volumio[976]: info: Oct 01 12:03:26 volumio-02 volumio[976]: ---------------------------- MPD announces system playlist update Oct 01 12:03:26 volumio-02 volumio[976]: info: Ignoring MPD Status Update Oct 01 12:03:26 volumio-02 volumio[976]: info: Oct 01 12:03:26 volumio-02 volumio[976]: ---------------------------- MPD announces system playlist update Oct 01 12:03:26 volumio-02 volumio[976]: info: Ignoring MPD Status Update Oct 01 12:03:26 volumio-02 volumio[976]: info: ------------------------------ 2ms Oct 01 12:03:26 volumio-02 volumio[976]: info: ------------------------------ 2ms Oct 01 12:03:26 volumio-02 volumio[976]: info: ------------------------------ 1ms Oct 01 12:03:27 volumio-02 volumio[976]: info: CoreStateMachine::startPlaybackTimer Oct 01 12:03:27 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:28 volumio-02 volumio[976]: Error saving last played file: Error: EROFS: read-only file system, open '/data/laststates.json' Oct 01 12:03:28 volumio-02 volumio[976]: info: Oct 01 12:03:28 volumio-02 volumio[976]: ---------------------------- MPD announces system playlist update Oct 01 12:03:28 volumio-02 volumio[976]: info: Ignoring MPD Status Update Oct 01 12:03:28 volumio-02 volumio[976]: info: Oct 01 12:03:28 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:03:28 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:03:28 volumio-02 volumio[976]: info: Oct 01 12:03:28 volumio-02 volumio[976]: ---------------------------- MPD announces system playlist update Oct 01 12:03:28 volumio-02 volumio[976]: info: Ignoring MPD Status Update Oct 01 12:03:28 volumio-02 volumio[976]: info: Oct 01 12:03:28 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:03:28 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:03:28 volumio-02 volumio[976]: info: ------------------------------ 2ms Oct 01 12:03:28 volumio-02 volumio[976]: info: sendMpdCommand status took 2 milliseconds Oct 01 12:03:28 volumio-02 volumio[976]: info: ------------------------------ 2ms Oct 01 12:03:28 volumio-02 volumio[976]: info: sendMpdCommand status took 1 milliseconds Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:03:28 volumio-02 volumio[976]: info: Oct 01 12:03:28 volumio-02 volumio[976]: ---------------------------- MPD announces system playlist update Oct 01 12:03:28 volumio-02 volumio[976]: info: Ignoring MPD Status Update Oct 01 12:03:28 volumio-02 volumio[976]: info: Oct 01 12:03:28 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:03:28 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:03:28 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 01 12:03:28 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 01 12:03:28 volumio-02 volumio[976]: info: ------------------------------ 1ms Oct 01 12:03:28 volumio-02 volumio[976]: info: sendMpdCommand status took 1 milliseconds Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:03:28 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"After All This Time","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/02 Gerry Niewood - After All This Time.flac","trackType":"flac"} Oct 01 12:03:28 volumio-02 volumio[976]: verbose: CURRENT POSITION 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService play Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus play Oct 01 12:03:28 volumio-02 volumio[976]: info: Received an update from plugin. extracting info from payload Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:28 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"After All This Time","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/02 Gerry Niewood - After All This Time.flac","trackType":"flac"} Oct 01 12:03:28 volumio-02 volumio[976]: verbose: CURRENT POSITION 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService play Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus play Oct 01 12:03:28 volumio-02 volumio[976]: info: Received an update from plugin. extracting info from payload Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:28 volumio-02 volumio[976]: info: ------------------------------ 14ms Oct 01 12:03:28 volumio-02 volumio[976]: info: ------------------------------ 14ms Oct 01 12:03:28 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 01 12:03:28 volumio-02 volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:03:28 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"After All This Time","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/02 Gerry Niewood - After All This Time.flac","trackType":"flac"} Oct 01 12:03:28 volumio-02 volumio[976]: verbose: CURRENT POSITION 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService play Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus play Oct 01 12:03:28 volumio-02 volumio[976]: info: Received an update from plugin. extracting info from payload Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:03:28 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:03:28 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:03:28 volumio-02 volumio[976]: info: ------------------------------ 22ms Oct 01 12:03:35 volumio-02 nmbd[30939]: [2024/10/01 12:03:35.772044, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 01 12:03:35 volumio-02 nmbd[30939]: wins_write_database: Can't open /var/lib/samba/wins.dat.30939: Read-only file system Oct 01 12:03:57 volumio-02 smbd[30982]: [2024/10/01 12:03:57.039746, 0] ../source3/lib/util.c:493(reinit_after_fork) Oct 01 12:03:57 volumio-02 smbd[30982]: messaging_reinit() failed: NT_STATUS_IO_DEVICE_ERROR Oct 01 12:03:57 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm smbd: error -5 reading directory block Oct 01 12:03:57 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm smbd: error -5 reading directory block Oct 01 12:03:57 volumio-02 nmbd[30983]: [2024/10/01 12:03:57.069296, 0] ../source3/lib/util.c:493(reinit_after_fork) Oct 01 12:03:57 volumio-02 nmbd[30983]: messaging_reinit() failed: NT_STATUS_IO_DEVICE_ERROR Oct 01 12:03:57 volumio-02 nmbd[30984]: [2024/10/01 12:03:57.071494, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 01 12:03:57 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm nmbd: error -5 reading directory block Oct 01 12:03:57 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm nmbd: error -5 reading directory block Oct 01 12:03:57 volumio-02 nmbd[30984]: wins_write_database: Can't open /var/lib/samba/wins.dat.30984: Read-only file system Oct 01 12:03:57 volumio-02 nmbd[748]: [2024/10/01 12:03:57.073980, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 01 12:03:57 volumio-02 nmbd[748]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.2 for name WORKGROUP<1d>. Oct 01 12:03:57 volumio-02 nmbd[748]: This response was from IP 192.168.0.1, reporting an IP address of 192.168.0.1. Oct 01 12:03:57 volumio-02 winbindd[30987]: [2024/10/01 12:03:57.772640, 0] ../source3/lib/util.c:493(reinit_after_fork) Oct 01 12:03:57 volumio-02 winbindd[30987]: messaging_reinit() failed: NT_STATUS_IO_DEVICE_ERROR Oct 01 12:03:57 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm winbindd: error -5 reading directory block Oct 01 12:03:57 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm winbindd: error -5 reading directory block Oct 01 12:04:19 volumio-02 nmbd[31072]: [2024/10/01 12:04:19.099633, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 01 12:04:19 volumio-02 nmbd[31072]: wins_write_database: Can't open /var/lib/samba/wins.dat.31072: Read-only file system Oct 01 12:04:21 volumio-02 smbd[31079]: [2024/10/01 12:04:21.113025, 0] ../source3/lib/util.c:493(reinit_after_fork) Oct 01 12:04:21 volumio-02 smbd[31079]: messaging_reinit() failed: NT_STATUS_IO_DEVICE_ERROR Oct 01 12:04:21 volumio-02 smbd[31079]: [2024/10/01 12:04:21.113481, 0] ../source3/smbd/server.c:1027(smbd_accept_connection) Oct 01 12:04:21 volumio-02 smbd[31079]: reinit_after_fork() failed Oct 01 12:04:21 volumio-02 smbd[31079]: [2024/10/01 12:04:21.113560, 0] ../source3/lib/util.c:816(smb_panic_s3) Oct 01 12:04:21 volumio-02 smbd[31079]: PANIC (pid 31079): reinit_after_fork() failed Oct 01 12:04:21 volumio-02 smbd[31079]: [2024/10/01 12:04:21.115947, 0] ../lib/util/fault.c:261(log_stack_trace) Oct 01 12:04:21 volumio-02 smbd[31079]: BACKTRACE: 0 stack frames: Oct 01 12:04:21 volumio-02 smbd[31079]: [2024/10/01 12:04:21.116104, 0] ../source3/lib/dumpcore.c:315(dump_core) Oct 01 12:04:21 volumio-02 smbd[31079]: dumping core in /var/log/samba/cores/smbd Oct 01 12:04:21 volumio-02 smbd[31079]: Oct 01 12:04:21 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm smbd: error -5 reading directory block Oct 01 12:04:21 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm smbd: error -5 reading directory block Oct 01 12:04:21 volumio-02 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #39585070: lblock 0: comm cleanupd: error -5 reading directory block Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPause Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::pause Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::stPlaybackTimer Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::servicePause Oct 01 12:04:25 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::servicePause Oct 01 12:04:25 volumio-02 volumio[976]: info: ControllerMpd::pause Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand pause Oct 01 12:04:25 volumio-02 volumio[976]: info: sendMpdCommand pause took 1 milliseconds Oct 01 12:04:25 volumio-02 volumio[976]: info: Oct 01 12:04:25 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:04:25 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:04:25 volumio-02 volumio[976]: info: Oct 01 12:04:25 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:04:25 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:04:25 volumio-02 volumio[976]: info: Oct 01 12:04:25 volumio-02 volumio[976]: ---------------------------- MPD announces state update: player Oct 01 12:04:25 volumio-02 volumio[976]: info: ControllerMpd::getState Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 01 12:04:25 volumio-02 volumio[976]: info: sendMpdCommand status took 2 milliseconds Oct 01 12:04:25 volumio-02 volumio[976]: info: sendMpdCommand status took 2 milliseconds Oct 01 12:04:25 volumio-02 volumio[976]: info: sendMpdCommand status took 1 milliseconds Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::parseState Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 12:04:25 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 12:04:25 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 01 12:04:25 volumio-02 volumio[976]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 01 12:04:25 volumio-02 volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 01 12:04:25 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:04:25 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":56810,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"758 Kbps","isStreaming":false,"title":"After All This Time","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/02 Gerry Niewood - After All This Time.flac","trackType":"flac"} Oct 01 12:04:25 volumio-02 volumio[976]: verbose: CURRENT POSITION 1 Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService pause Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus pause Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::stPlaybackTimer Oct 01 12:04:25 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:04:25 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":56810,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"758 Kbps","isStreaming":false,"title":"After All This Time","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/02 Gerry Niewood - After All This Time.flac","trackType":"flac"} Oct 01 12:04:25 volumio-02 volumio[976]: verbose: CURRENT POSITION 1 Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService pause Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus pause Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::stPlaybackTimer Oct 01 12:04:25 volumio-02 volumio[976]: info: ControllerMpd::pushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::servicePushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:04:25 volumio-02 volumio[976]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":56810,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"758 Kbps","isStreaming":false,"title":"After All This Time","artist":"Gerry Niewood","album":"Share My Dream","uri":"NAS/truenas.local/Jazz/Gerry Niewood/Share My Dream/02 Gerry Niewood - After All This Time.flac","trackType":"flac"} Oct 01 12:04:25 volumio-02 volumio[976]: verbose: CURRENT POSITION 1 Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::syncState stateService pause Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::syncState currentStatus pause Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::pushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CorePlayQueue::getTrack 1 Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreCommandRouter::volumioPushState Oct 01 12:04:25 volumio-02 volumio[976]: info: CoreStateMachine::stPlaybackTimer Oct 01 12:04:25 volumio-02 volumio[976]: info: ------------------------------ 12ms Oct 01 12:04:25 volumio-02 volumio[976]: info: ------------------------------ 11ms Oct 01 12:04:25 volumio-02 volumio[976]: info: ------------------------------ 11ms Oct 01 12:04:37 volumio-02 volumio[976]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 12:04:37 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 01 12:04:37 volumio-02 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #39585096: comm node: reading directory lblock 0 Oct 01 12:04:37 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 01 12:04:37 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 01 12:04:37 volumio-02 volumio[976]: info: Received Get System Version Oct 01 12:04:37 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 01 12:04:37 volumio-02 volumio[976]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Oct 01 12:04:37 volumio-02 volumio[976]: error: Failed to read Background files: Error: EIO: i/o error, scandir '/data/backgrounds' Oct 01 12:04:37 volumio-02 kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #39585143: lblock 0: comm node: error -5 reading directory block Oct 01 12:04:37 volumio-02 volumio[976]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 12:04:37 volumio-02 volumio[976]: TypeError: Cannot read property 'forEach' of undefined Oct 01 12:04:37 volumio-02 volumio[976]: at /volumio/app/plugins/miscellanea/appearance/index.js:188:11 Oct 01 12:04:37 volumio-02 volumio[976]: at go$readdir$cb (/volumio/node_modules/graceful-fs/graceful-fs.js:195:14) Oct 01 12:04:37 volumio-02 volumio[976]: at FSReqCallback.oncomplete (fs.js:171:23) Oct 01 12:04:37 volumio-02 volumio[976]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 12:04:38 volumio-02 sudo[31109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 12:03 Oct 01 12:04:38 volumio-02 sudo[31109]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"