-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-10-06 10:56:29 CEST. -- Oct 06 10:55:08 volumio nmbd[735]: [2024/10/06 10:55:08.509837, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:55:08 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:55:08 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:55:08 volumio nmbd[3006]: [2024/10/06 10:55:08.515909, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 06 10:55:08 volumio nmbd[3006]: wins_write_database: Can't open /var/lib/samba/wins.dat.3006: Input/output error Oct 06 10:55:08 volumio nmbd[735]: [2024/10/06 10:55:08.521522, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:55:08 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:55:08 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913965: comm nmbd: reading directory lblock 0 Oct 06 10:55:08 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:55:28 volumio nmbd[735]: [2024/10/06 10:55:28.535620, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:55:28 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:55:28 volumio nmbd[3051]: [2024/10/06 10:55:28.541648, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 06 10:55:28 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:55:28 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913965: comm nmbd: reading directory lblock 0 Oct 06 10:55:28 volumio nmbd[3051]: wins_write_database: Can't open /var/lib/samba/wins.dat.3051: Input/output error Oct 06 10:55:28 volumio nmbd[735]: [2024/10/06 10:55:28.547339, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:55:28 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:55:28 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:55:29 volumio volumio[956]: info: CorePlayQueue::getTrack 5 Oct 06 10:55:29 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:55:29 volumio volumio[956]: info: Prefetching next song Oct 06 10:55:29 volumio volumio[956]: info: [1728204929592] ControllerQobuz::prefetch Oct 06 10:55:29 volumio volumio[956]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/274905800" Oct 06 10:55:29 volumio volumio[956]: STREAMING PROXY: Handling url /?data=qobuz://song/274905800 Oct 06 10:55:29 volumio volumio[956]: info: Executing endpoint getStreamUrlqobuz Oct 06 10:55:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Oct 06 10:55:30 volumio volumio[956]: info: getStreamUrl took 583 milliseconds Oct 06 10:55:30 volumio volumio[956]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1112734&eid=274905800&fmt=7&profile=raw&app_id=539451548&cid=2342948&etsp=1728208530&hmac=8QeQeHh-84-zJNucTc0jNRuGJvA Oct 06 10:55:30 volumio volumio[956]: STREAMING PROXY: Response: 200, length: 44189441 Oct 06 10:55:30 volumio volumio[956]: STREAMING PROXY: Client dropped request, destroying Oct 06 10:55:30 volumio volumio[956]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/274905800" Oct 06 10:55:30 volumio volumio[956]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/274905800" took 0 milliseconds Oct 06 10:55:30 volumio volumio[956]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 06 10:55:30 volumio volumio[956]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 06 10:55:30 volumio volumio[956]: STREAMING PROXY: Handling url /?data=qobuz://song/274905800 Oct 06 10:55:30 volumio volumio[956]: info: Oct 06 10:55:30 volumio volumio[956]: ---------------------------- MPD announces system playlist update Oct 06 10:55:30 volumio volumio[956]: info: Ignoring MPD Status Update Oct 06 10:55:30 volumio volumio[956]: info: sendMpdCommand consume 1 took 1 milliseconds Oct 06 10:55:30 volumio volumio[956]: info: ------------------------------ 1ms Oct 06 10:55:30 volumio volumio[956]: info: Executing endpoint getStreamUrlqobuz Oct 06 10:55:30 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Oct 06 10:55:30 volumio volumio[956]: info: getStreamUrl took 558 milliseconds Oct 06 10:55:30 volumio volumio[956]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1112734&eid=274905800&fmt=7&profile=raw&app_id=539451548&cid=2342948&etsp=1728208530&hmac=8QeQeHh-84-zJNucTc0jNRuGJvA Oct 06 10:55:30 volumio volumio[956]: STREAMING PROXY: Response: 200, length: 44189441 Oct 06 10:55:34 volumio volumio[956]: info: CoreStateMachine::startPlaybackTimer Oct 06 10:55:34 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:55:34 volumio volumio[956]: STREAMING PROXY: Client dropped request, destroying Oct 06 10:55:34 volumio volumio[956]: info: CoreStateMachine::pushState Oct 06 10:55:34 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:55:34 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 10:55:34 volumio volumio[956]: info: CoreCommandRouter::volumioPushState Oct 06 10:55:34 volumio volumio[956]: Error saving last played file: Error: EROFS: read-only file system, open '/data/laststates.json' Oct 06 10:55:35 volumio volumio[956]: info: Oct 06 10:55:35 volumio volumio[956]: ---------------------------- MPD announces system playlist update Oct 06 10:55:35 volumio volumio[956]: info: Ignoring MPD Status Update Oct 06 10:55:35 volumio volumio[956]: info: Oct 06 10:55:35 volumio volumio[956]: ---------------------------- MPD announces state update: player Oct 06 10:55:35 volumio volumio[956]: info: ControllerMpd::getState Oct 06 10:55:35 volumio volumio[956]: verbose: ControllerMpd::sendMpdCommand status Oct 06 10:55:35 volumio volumio[956]: info: ------------------------------ 2ms Oct 06 10:55:35 volumio volumio[956]: info: sendMpdCommand status took 1 milliseconds Oct 06 10:55:35 volumio volumio[956]: verbose: ControllerMpd::parseState Oct 06 10:55:35 volumio volumio[956]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 10:55:35 volumio volumio[956]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 06 10:55:35 volumio volumio[956]: verbose: ControllerMpd::parseTrackInfo Oct 06 10:55:35 volumio volumio[956]: info: ControllerMpd::pushState Oct 06 10:55:35 volumio volumio[956]: info: CoreCommandRouter::servicePushState Oct 06 10:55:35 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:55:35 volumio volumio[956]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":225,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1254 Kbps","isStreaming":false,"title":"274905800","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/274905800","trackType":"qobuz"} Oct 06 10:55:35 volumio volumio[956]: verbose: CURRENT POSITION 6 Oct 06 10:55:35 volumio volumio[956]: info: CoreStateMachine::syncState stateService play Oct 06 10:55:35 volumio volumio[956]: info: CoreStateMachine::syncState currentStatus play Oct 06 10:55:35 volumio volumio[956]: info: Received an update from plugin. extracting info from payload Oct 06 10:55:35 volumio volumio[956]: info: CoreStateMachine::pushState Oct 06 10:55:35 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:55:35 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 10:55:35 volumio volumio[956]: info: CoreCommandRouter::volumioPushState Oct 06 10:55:35 volumio volumio[956]: info: CoreStateMachine::pushState Oct 06 10:55:35 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:55:35 volumio volumio[956]: info: CoreCommandRouter::volumioPushState Oct 06 10:55:35 volumio volumio[956]: info: ------------------------------ 21ms Oct 06 10:55:48 volumio nmbd[735]: [2024/10/06 10:55:48.570779, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:55:48 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:55:48 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:55:48 volumio nmbd[3055]: [2024/10/06 10:55:48.576883, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 06 10:55:48 volumio nmbd[3055]: wins_write_database: Can't open /var/lib/samba/wins.dat.3055: Input/output error Oct 06 10:55:48 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913965: comm nmbd: reading directory lblock 0 Oct 06 10:55:48 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:55:48 volumio nmbd[735]: [2024/10/06 10:55:48.582592, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:55:48 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:56:08 volumio nmbd[735]: [2024/10/06 10:56:08.605636, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:56:08 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:56:08 volumio nmbd[3056]: [2024/10/06 10:56:08.611641, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 06 10:56:08 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:56:08 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913965: comm nmbd: reading directory lblock 0 Oct 06 10:56:08 volumio nmbd[3056]: wins_write_database: Can't open /var/lib/samba/wins.dat.3056: Input/output error Oct 06 10:56:08 volumio nmbd[735]: [2024/10/06 10:56:08.617324, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:56:08 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:56:08 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:56:15 volumio nmbd[735]: [2024/10/06 10:56:15.878482, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Oct 06 10:56:15 volumio nmbd[735]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Oct 06 10:56:15 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #913975: comm nmbd: reading directory lblock 0 Oct 06 10:56:26 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Oct 06 10:56:26 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:56:28 volumio sudo[3102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 10:56:28 volumio sudo[3102]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:56:28 volumio sudo[3102]: pam_unix(sudo:session): session closed for user root Oct 06 10:56:29 volumio sudo[3105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 10:56:29 volumio sudo[3105]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:56:29 volumio sudo[3105]: pam_unix(sudo:session): session closed for user root Oct 06 10:56:29 volumio volumio[956]: verbose: New Socket.io Connection to 192.168.1.207 from 192.168.1.238 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 OPR/113.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::volumioGetVisibleSources Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Oct 06 10:56:29 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 06 10:56:29 volumio volumio[956]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 06 10:56:29 volumio volumio[956]: info: Received Get System Info Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 10:56:29 volumio volumio[956]: info: Discovery: Getting this device information Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Oct 06 10:56:29 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 10:56:29 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Oct 06 10:56:29 volumio volumio[956]: info: CorePlayQueue::getTrack 6 Oct 06 10:56:29 volumio kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #914018: lblock 0: comm node: error -5 reading directory block Oct 06 10:56:29 volumio volumio[956]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 10:56:29 volumio volumio[956]: Error: EIO: i/o error, scandir '/data/plugins/' Oct 06 10:56:29 volumio volumio[956]: at Object.readdirSync (fs.js:1021:3) Oct 06 10:56:29 volumio volumio[956]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30) Oct 06 10:56:29 volumio volumio[956]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1521:29) Oct 06 10:56:29 volumio volumio[956]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1328:45) Oct 06 10:56:29 volumio volumio[956]: at Socket.emit (events.js:315:20) Oct 06 10:56:29 volumio volumio[956]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 06 10:56:29 volumio volumio[956]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 06 10:56:29 volumio volumio[956]: errno: -5, Oct 06 10:56:29 volumio volumio[956]: syscall: 'scandir', Oct 06 10:56:29 volumio volumio[956]: code: 'EIO', Oct 06 10:56:29 volumio volumio[956]: path: '/data/plugins/' Oct 06 10:56:29 volumio volumio[956]: } Oct 06 10:56:29 volumio volumio[956]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 10:56:29 volumio sudo[3116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 10:55 Oct 06 10:56:29 volumio sudo[3116]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"