-- Logs begin at Fri 2024-10-04 16:11:37 CEST, end at Sat 2024-10-05 10:40:27 CEST. -- Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fcb6d8c does not match aorg 0000000000.00000000 from server@62.113.219.231 xmt 0xeaab79df.bb0a262e Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fd888b6 does not match aorg 0000000000.00000000 from server@194.50.19.117 xmt 0xeaab79df.bb4c8ebe Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fd49e2a does not match aorg 0000000000.00000000 from server@167.235.69.67 xmt 0xeaab79df.bbbef468 Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fd79e9e does not match aorg 0000000000.00000000 from server@188.245.97.96 xmt 0xeaab79df.bbc7614a Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fd5a5d7 does not match aorg 0000000000.00000000 from server@159.69.64.189 xmt 0xeaab79df.bbd8151f Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fd23a17 does not match aorg 0000000000.00000000 from server@136.243.177.133 xmt 0xeaab79df.bc191856 Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fd35505 does not match aorg 0000000000.00000000 from server@46.4.57.135 xmt 0xeaab79df.bc76b864 Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fd116ac does not match aorg 0000000000.00000000 from server@131.188.3.222 xmt 0xeaab79df.bcb6e869 Oct 05 10:39:59 volumio-wz ntpd[989]: receive: Unexpected origin timestamp 0xeaaa7632.2fd69be1 does not match aorg 0000000000.00000000 from server@131.188.3.223 xmt 0xeaab79df.bcfef739 Oct 05 10:39:59 volumio-wz systemd[1]: Starting Daily apt download activities... Oct 05 10:39:59 volumio-wz systemd[1]: Starting Daily man-db regeneration... Oct 05 10:40:01 volumio-wz volumio[903]: info: Initializing connection to go-librespot Websocket Oct 05 10:40:01 volumio-wz go-librespot[1237]: time="2024-10-05T10:40:01+02:00" level=debug msg="new websocket client" Oct 05 10:40:01 volumio-wz volumio[903]: info: Connection to go-librespot Websocket established Oct 05 10:40:01 volumio-wz systemd[1]: man-db.service: Succeeded. Oct 05 10:40:01 volumio-wz systemd[1]: Started Daily man-db regeneration. Oct 05 10:40:02 volumio-wz systemd[1]: apt-daily.service: Succeeded. Oct 05 10:40:02 volumio-wz systemd[1]: Started Daily apt download activities. Oct 05 10:40:02 volumio-wz volumio[903]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 05 10:40:02 volumio-wz systemd[1]: Starting Daily apt upgrade and clean activities... Oct 05 10:40:02 volumio-wz volumio[903]: info: Discovery: A device disappeared from network Oct 05 10:40:02 volumio-wz volumio[903]: info: Discovery: Device volumio-wz disappeared from network Oct 05 10:40:02 volumio-wz volumio[903]: info: Discovery: adding 2f549aa4-d6ab-4355-b989-724d354d437e Oct 05 10:40:02 volumio-wz volumio[903]: info: Discovery: Found device Volumio-wz Oct 05 10:40:02 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:02 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:03 volumio-wz systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 05 10:40:03 volumio-wz systemd[1]: Started Daily apt upgrade and clean activities. Oct 05 10:40:04 volumio-wz volumio[903]: info: Getting Spotify volume Oct 05 10:40:04 volumio-wz volumio[903]: info: Spotify volume: 100 Oct 05 10:40:04 volumio-wz volumio[903]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 05 10:40:04 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:04 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 05 10:40:05 volumio-wz volumio[903]: info: Adding plugin bluetooth to MyMusic Plugins Oct 05 10:40:05 volumio-wz volumio[903]: info: Adding plugin multiroom to MyMusic Plugins Oct 05 10:40:05 volumio-wz volumio[903]: info: Adding plugin metavolumio to MyMusic Plugins Oct 05 10:40:05 volumio-wz volumio[903]: info: Adding plugin cd_controller to MyMusic Plugins Oct 05 10:40:05 volumio-wz volumio[903]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 05 10:40:05 volumio-wz volumio[903]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 05 10:40:05 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 05 10:40:06 volumio-wz volumio[903]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 05 10:40:06 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 05 10:40:06 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:06 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:06 volumio-wz volumio[903]: info: Starting MyVolumio Remote Streaming Endpoints Oct 05 10:40:06 volumio-wz volumio[903]: info: MyVolumio login type: Token Oct 05 10:40:06 volumio-wz volumio[903]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 05 10:40:06 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 05 10:40:07 volumio-wz volumio[903]: info: Starting Streaming Service Transparent Proxy Oct 05 10:40:07 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 05 10:40:07 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 05 10:40:07 volumio-wz volumio[903]: info: Streaming services startup Oct 05 10:40:07 volumio-wz volumio[903]: info: Starting Streaming Daemon Oct 05 10:40:07 volumio-wz sudo[1625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 05 10:40:07 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 05 10:40:07 volumio-wz sudo[1625]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:07 volumio-wz sudo[1625]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:08 volumio-wz volumio[903]: error: Cannot start Volumio Streaming Daemon Oct 05 10:40:08 volumio-wz volumio[903]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 05 10:40:08 volumio-wz volumio[903]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 05 10:40:08 volumio-wz volumio[903]: error: MyVolumio Custom Token format not valid, refreshing it Oct 05 10:40:08 volumio-wz volumio[903]: STREAMING PROXY: Starting server on port 3245 Oct 05 10:40:08 volumio-wz volumio[903]: Node JS runtime: 14 Oct 05 10:40:08 volumio-wz systemd[1]: systemd-fsckd.service: Succeeded. Oct 05 10:40:08 volumio-wz volumio[903]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 05 10:40:09 volumio-wz volumio[903]: info: MyVolumio login type: Token Oct 05 10:40:09 volumio-wz nmbd[802]: [2024/10/05 10:40:09.161844, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 05 10:40:09 volumio-wz nmbd[802]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.155.66 for name WORKGROUP<1d>. Oct 05 10:40:09 volumio-wz nmbd[802]: This response was from IP 192.168.155.25, reporting an IP address of 192.168.155.25. Oct 05 10:40:09 volumio-wz volumio[903]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 05 10:40:09 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 05 10:40:09 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 05 10:40:10 volumio-wz volumio[903]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 05 10:40:11 volumio-wz kernel: I/O error, dev mmcblk0, sector 154793258 op 0x1:(WRITE) flags 0x0 phys_seg 7 prio class 2 Oct 05 10:40:11 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18013965 starting block 77396629) Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661889 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661890 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661891 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661892 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661893 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661894 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661895 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661896 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661897 Oct 05 10:40:11 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74661898 Oct 05 10:40:11 volumio-wz kernel: JBD2: Detected IO errors while flushing file data on mmcblk0p3-8 Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 05 10:40:12 volumio-wz volumio[903]: info: MyVolumio token set successfully Oct 05 10:40:12 volumio-wz volumio[903]: info: MYVOLUMIO: Adding device Oct 05 10:40:12 volumio-wz volumio[903]: info: MYVOLUMIO: Evaluating Server Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 05 10:40:12 volumio-wz volumio[903]: info: MyVolumio Plan changed: premium Oct 05 10:40:12 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Oct 05 10:40:12 volumio-wz volumio[903]: info: Removing browser output: myVolumio user plan is not superstar Oct 05 10:40:12 volumio-wz volumio[903]: info: Removing audio output: Oct 05 10:40:12 volumio-wz volumio[903]: info: MYVOLUMIO: Adding device Oct 05 10:40:12 volumio-wz volumio[903]: info: MYVOLUMIO: Evaluating Server Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetVisibleSources Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:12 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 05 10:40:12 volumio-wz volumio[903]: info: Received Get System Info Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 05 10:40:12 volumio-wz volumio[903]: info: Discovery: Getting this device information Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:12 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:12 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:12 volumio-wz volumio[903]: info: Listing playlists Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 05 10:40:12 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 05 10:40:12 volumio-wz volumio[903]: info: Remote config written successfully Oct 05 10:40:12 volumio-wz volumio[903]: info: Starting Tunnel 1 Oct 05 10:40:12 volumio-wz volumio[903]: info: Starting Tunnel Connection Checker Oct 05 10:40:12 volumio-wz volumio[903]: info: Completed starting MyVolumio Plugin Oct 05 10:40:12 volumio-wz systemd[1]: systemd-hostnamed.service: Succeeded. Oct 05 10:40:12 volumio-wz volumio[903]: info: MYVolumio Device enabled Oct 05 10:40:12 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Oct 05 10:40:12 volumio-wz volumio[903]: info: MyVolumio status changed Oct 05 10:40:12 volumio-wz volumio[903]: info: Streaming services startup Oct 05 10:40:12 volumio-wz volumio[903]: info: Starting Streaming Daemon Oct 05 10:40:13 volumio-wz volumio[903]: info: Setting Geolocation for MyVolumio to eu4 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Oct 05 10:40:13 volumio-wz sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 05 10:40:13 volumio-wz sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:13 volumio-wz volumio[903]: error: [MyVolumio PluginManager] Cache data is invalid! Oct 05 10:40:13 volumio-wz sudo[1668]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:13 volumio-wz volumio[903]: error: Cannot start Volumio Streaming Daemon Oct 05 10:40:13 volumio-wz volumio[903]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 05 10:40:13 volumio-wz volumio[903]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 05 10:40:13 volumio-wz volumio[903]: info: Received Get System Info Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 05 10:40:13 volumio-wz volumio[903]: info: Discovery: Getting this device information Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 05 10:40:13 volumio-wz volumio[903]: info: Setting Geolocation for MyVolumio to eu6 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:13 volumio-wz volumio[903]: info: Successfully Added MyVolumio device Oct 05 10:40:13 volumio-wz volumio[903]: info: AutoStart - Plugin is starting Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetQueue Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::getQueue Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getQueue Oct 05 10:40:13 volumio-wz volumio[903]: info: AutoStart - start playing Oct 05 10:40:13 volumio-wz volumio[903]: info: AutoStart - start playing with no specific position Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPlay Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::play index 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::play index undefined Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::startPlaybackTimer Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::clearAddPlayTracks cdda:///1 Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand stop Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand stop took 4 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand clear Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces system playlist update Oct 05 10:40:13 volumio-wz volumio[903]: info: Ignoring MPD Status Update Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand clear took 6 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand add "cdda:///1" Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces system playlist update Oct 05 10:40:13 volumio-wz volumio[903]: info: Ignoring MPD Status Update Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces system playlist update Oct 05 10:40:13 volumio-wz volumio[903]: info: Ignoring MPD Status Update Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces system playlist update Oct 05 10:40:13 volumio-wz volumio[903]: info: Ignoring MPD Status Update Oct 05 10:40:13 volumio-wz volumio[903]: error: updateQueue error: null Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces system playlist update Oct 05 10:40:13 volumio-wz volumio[903]: info: Ignoring MPD Status Update Oct 05 10:40:13 volumio-wz volumio[903]: info: ------------------------------ 22ms Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand add "cdda:///1" took 19 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: ------------------------------ 17ms Oct 05 10:40:13 volumio-wz volumio[903]: info: ------------------------------ 17ms Oct 05 10:40:13 volumio-wz volumio[903]: info: ------------------------------ 15ms Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand play Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces system playlist update Oct 05 10:40:13 volumio-wz volumio[903]: info: Ignoring MPD Status Update Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces system playlist update Oct 05 10:40:13 volumio-wz volumio[903]: info: Ignoring MPD Status Update Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces system playlist update Oct 05 10:40:13 volumio-wz volumio[903]: info: Ignoring MPD Status Update Oct 05 10:40:13 volumio-wz volumio[903]: info: ------------------------------ 21ms Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand play took 7 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: ------------------------------ 5ms Oct 05 10:40:13 volumio-wz volumio[903]: info: ------------------------------ 3ms Oct 05 10:40:13 volumio-wz volumio[903]: info: ------------------------------ 3ms Oct 05 10:40:13 volumio-wz volumio[903]: info: Successfully Added MyVolumio device Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces state update: player Oct 05 10:40:13 volumio-wz volumio[903]: info: ControllerMpd::getState Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand status Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces state update: player Oct 05 10:40:13 volumio-wz volumio[903]: info: ControllerMpd::getState Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand status Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces state update: player Oct 05 10:40:13 volumio-wz volumio[903]: info: ControllerMpd::getState Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand status Oct 05 10:40:13 volumio-wz volumio[903]: info: Oct 05 10:40:13 volumio-wz volumio[903]: ---------------------------- MPD announces state update: player Oct 05 10:40:13 volumio-wz volumio[903]: info: ControllerMpd::getState Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand status Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand status took 17 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::parseState Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand status took 22 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand status took 22 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand status took 22 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand clearerror took 13 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::parseState Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::parseState Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::parseState Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand playlistinfo took 32 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand clearerror took 25 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand clearerror took 24 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand clearerror took 23 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::parseTrackInfo Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::parseTrackInfo Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::parseTrackInfo Oct 05 10:40:13 volumio-wz volumio[903]: verbose: ControllerMpd::parseTrackInfo Oct 05 10:40:13 volumio-wz volumio[903]: info: ControllerMpd::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::servicePushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Oct 05 10:40:13 volumio-wz volumio[903]: verbose: CURRENT POSITION 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::syncState stateService stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::syncState currentStatus stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: No code Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: ControllerMpd::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::servicePushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Oct 05 10:40:13 volumio-wz volumio[903]: verbose: CURRENT POSITION 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::syncState stateService stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::syncState currentStatus stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: No code Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: ControllerMpd::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::servicePushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Oct 05 10:40:13 volumio-wz volumio[903]: verbose: CURRENT POSITION 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::syncState stateService stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::syncState currentStatus stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: No code Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: ControllerMpd::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::servicePushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Oct 05 10:40:13 volumio-wz volumio[903]: verbose: CURRENT POSITION 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::syncState stateService stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::syncState currentStatus stop Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:13 volumio-wz volumio[903]: info: No code Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreStateMachine::pushState Oct 05 10:40:13 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:13 volumio-wz volumio[903]: info: CoreCommandRouter::volumioPushState Oct 05 10:40:14 volumio-wz volumio[903]: info: ------------------------------ 197ms Oct 05 10:40:14 volumio-wz volumio[903]: info: ------------------------------ 190ms Oct 05 10:40:14 volumio-wz volumio[903]: info: ------------------------------ 190ms Oct 05 10:40:14 volumio-wz volumio[903]: info: ------------------------------ 189ms Oct 05 10:40:14 volumio-wz volumio[903]: info: Updating MyVolumio device info Oct 05 10:40:14 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:14 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:14 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1675]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1684]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1677]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz sudo[1680]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1687]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1690]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1684]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz sudo[1693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1693]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1687]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1695]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1693]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz sudo[1690]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1695]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: PeppySpectrum ---peppyspectrum status stop Oct 05 10:40:14 volumio-wz sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1701]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1707]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 05 10:40:14 volumio-wz sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:14 volumio-wz volumio[903]: info: Updating MyVolumio device info Oct 05 10:40:14 volumio-wz sudo[1707]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:14 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:14 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:14 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 05 10:40:14 volumio-wz sudo[1699]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:14 volumio-wz sudo[1701]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Oct 05 10:40:14 volumio-wz sudo[1704]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:14 volumio-wz volumio[903]: info: [1728117614894] Starting BluetoothController Oct 05 10:40:14 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Oct 05 10:40:16 volumio-wz volumio[1384]: .......................................................................................................................................................................................++++ Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Oct 05 10:40:16 volumio-wz sudo[1711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Oct 05 10:40:16 volumio-wz sudo[1711]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz sudo[1711]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: MultiRoom plugin initialized Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: STOPPING SNAPCLIENT Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: Snap server stop Oct 05 10:40:16 volumio-wz sudo[1727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Oct 05 10:40:16 volumio-wz sudo[1727]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: STOPPING volumioStreaming Oct 05 10:40:16 volumio-wz sudo[1730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Oct 05 10:40:16 volumio-wz sudo[1730]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz sudo[1727]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Oct 05 10:40:16 volumio-wz sudo[1735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Oct 05 10:40:16 volumio-wz sudo[1735]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Oct 05 10:40:16 volumio-wz sudo[1730]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:16 volumio-wz sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Oct 05 10:40:16 volumio-wz sudo[1735]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:16 volumio-wz sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Oct 05 10:40:16 volumio-wz sudo[1734]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Oct 05 10:40:16 volumio-wz volumio[1384]: ...++++ Oct 05 10:40:16 volumio-wz volumio[1384]: e is 65537 (0x010001) Oct 05 10:40:16 volumio-wz volumio[903]: info: Preparing to generate the ALSA configuration file Oct 05 10:40:16 volumio-wz volumio[1384]: writing RSA key Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Oct 05 10:40:16 volumio-wz volumio[903]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Oct 05 10:40:16 volumio-wz volumio[903]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 05 10:40:16 volumio-wz volumio[903]: info: Reading ALSA contributions from plugins. Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: Removed streaming files Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: volumioStreaming STOPPED Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: SNAPSERVER STOPPED Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: SNAPCLIENT STOPPED Oct 05 10:40:16 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:16 volumio-wz volumio[903]: info: peppyspectrum Daemon Stop Oct 05 10:40:16 volumio-wz volumio[903]: info: Asound.conf file written Oct 05 10:40:16 volumio-wz sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 05 10:40:16 volumio-wz sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz sudo[1754]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:16 volumio-wz volumio[903]: info: Output device has changed, restarting MPD Oct 05 10:40:16 volumio-wz sudo[1770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 05 10:40:16 volumio-wz sudo[1770]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:16 volumio-wz sudo[1770]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:16 volumio-wz sudo[1773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 05 10:40:16 volumio-wz sudo[1773]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Plugin bluetooth disabled by user. Not starting Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: Pushing multiroomSync output for this device Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: Pushing multiroomSync output Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding audio output: Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding audio output: Oct 05 10:40:16 volumio-wz systemd[1]: Stopping Music Player Daemon... Oct 05 10:40:16 volumio-wz kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 05 10:40:16 volumio-wz volumio[903]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:16 volumio-wz systemd[1]: mpd.service: Succeeded. Oct 05 10:40:16 volumio-wz systemd[1]: Stopped Music Player Daemon. Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding METAVOLUMIO REST API Endpoints Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Oct 05 10:40:16 volumio-wz volumio[903]: info: Preparing CD Folders Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding CD REST API Endpoints Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Oct 05 10:40:16 volumio-wz volumio[903]: info: Starting UDEV Watcher for CD Oct 05 10:40:16 volumio-wz volumio[903]: info: Detecting CD presence with UDEV Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Oct 05 10:40:16 volumio-wz kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Oct 05 10:40:16 volumio-wz volumio[903]: error: Hi Res Audio Failed Login: Missing Login Data Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Oct 05 10:40:16 volumio-wz volumio[903]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Oct 05 10:40:16 volumio-wz volumio[903]: info: Stopping AccessToken refresher cron Oct 05 10:40:16 volumio-wz systemd[1]: Starting Music Player Daemon... Oct 05 10:40:16 volumio-wz volumio[903]: info: AccessToken refresher cron started Oct 05 10:40:16 volumio-wz volumio[903]: info: Stopping AccessToken refresher cron for QOBUZ Oct 05 10:40:16 volumio-wz volumio[903]: info: AccessToken refresher cron started for QOBUZ Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding TIDAL REST API Endpoints Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding QOBUZ REST API Endpoints Oct 05 10:40:16 volumio-wz volumio[903]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Oct 05 10:40:16 volumio-wz sudo[1780]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 05 10:40:16 volumio-wz sudo[1780]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:16 volumio-wz sudo[1780]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 05 10:40:16 volumio-wz volumio[903]: info: Received Get System Info Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 05 10:40:16 volumio-wz volumio[903]: info: Discovery: Getting this device information Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:16 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:16 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 05 10:40:16 volumio-wz volumio[903]: info: MPD Permissions set Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: BOOT COMPLETED Oct 05 10:40:17 volumio-wz volumio[903]: [Metrics] CommandRouter: 30s 329.06ms Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::volumiosetStartupVolume Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::Close All Modals sent Oct 05 10:40:17 volumio-wz kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 05 10:40:17 volumio-wz volumio[903]: info: CoreCommandRouter::Close All Modals sent Oct 05 10:40:17 volumio-wz volumio[903]: info: Successfully Updated MyVolumio device Oct 05 10:40:17 volumio-wz volumio[903]: info: Successfully Updated MyVolumio device Oct 05 10:40:17 volumio-wz mpd[1784]: Oct 05 10:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 05 10:40:17 volumio-wz systemd[1]: Started Music Player Daemon. Oct 05 10:40:17 volumio-wz sudo[1773]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:19 volumio-wz kernel: mmc0: tried to HW reset card, got error -110 Oct 05 10:40:19 volumio-wz kernel: I/O error, dev mmcblk0, sector 154863745 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 2 Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18011240 starting block 77431872) Oct 05 10:40:19 volumio-wz kernel: buffer_io_error: 951 callbacks suppressed Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74697791 Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74697792 Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 74697793 Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18013790 starting block 3761660) Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 1027562 Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 1027563 Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 1027564 Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 1027565 Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 1027566 Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 1027567 Oct 05 10:40:19 volumio-wz kernel: Buffer I/O error on device mmcblk0p3, logical block 1027568 Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18008209 starting block 3670855) Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18008222 starting block 3670901) Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18007808 starting block 77440571) Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18008229 starting block 77440576) Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18008236 starting block 77440578) Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18008237 starting block 77440579) Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18008251 starting block 77440580) Oct 05 10:40:19 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): ext4_end_bio:347: I/O error 10 writing to inode 18008253 starting block 77440581) Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): ext4_check_bdev_write_error:218: comm node: Error while async write back metadata Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): ext4_check_bdev_write_error:218: comm node: Error while async write back metadata Oct 05 10:40:19 volumio-wz kernel: mmc0: card 59b4 removed Oct 05 10:40:19 volumio-wz kernel: I/O error, dev mmcblk0, sector 0 op 0x1:(WRITE) flags 0x800 phys_seg 0 prio class 2 Oct 05 10:40:19 volumio-wz kernel: JBD2: Detected IO errors while flushing file data on mmcblk0p3-8 Oct 05 10:40:19 volumio-wz kernel: Aborting journal on device mmcblk0p3-8. Oct 05 10:40:19 volumio-wz kernel: JBD2: I/O error when updating journal superblock for mmcblk0p3-8. Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): ext4_journal_check_start:83: comm ThreadPoolForeg: Detected aborted journal Oct 05 10:40:19 volumio-wz kernel: EXT4-fs (mmcblk0p3): I/O error while writing superblock Oct 05 10:40:19 volumio-wz kernel: EXT4-fs (mmcblk0p3): Remounting filesystem read-only Oct 05 10:40:19 volumio-wz kernel: I/O error, dev mmcblk0, sector 0 op 0x1:(WRITE) flags 0x800 phys_seg 0 prio class 2 Oct 05 10:40:19 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 05 10:40:19 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 05 10:40:19 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #18167117: comm ThreadPoolForeg: reading directory lblock 0 Oct 05 10:40:19 volumio-wz kernel: EXT4-fs (mmcblk0p3): I/O error while writing superblock Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #17978666: comm xdg-settings: reading directory lblock 0 Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #17912300: comm xdg-settings: reading directory lblock 0 Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #17912300: comm xdg-settings: reading directory lblock 0 Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #17978666: comm (umount): reading directory lblock 0 Oct 05 10:40:19 volumio-wz systemd[1]: Stopped target Local File Systems. Oct 05 10:40:19 volumio-wz volumio[903]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:59b4/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fe340000.mmc-part1 /dev/disk/by-uuid/6B37-2179 /dev/disk/by-partuuid/c4d0cd2d-01 /dev/disk/by-label/boot /dev/disk/by-id/mmc-LX128_0x41a64150-part1","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:59b4/block/mmcblk0/mmcblk0p1","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"6B37-2179","ID_FS_UUID_ENC":"6B37-2179","ID_FS_VERSION":"FAT16","ID_NAME":"LX128","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"c4d0cd2d-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"c4d0cd2d","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x41a64150","MAJOR":"179","MINOR":"1","PARTN":"1","SEQNUM":"2393","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3175618"} Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz volumio[903]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:59b4/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/7462f9ec-50f6-4f55-9f22-79cca1bee42a /dev/disk/by-path/platform-fe340000.mmc-part2 /dev/disk/by-partuuid/c4d0cd2d-02 /dev/disk/by-label/volumio /dev/disk/by-id/mmc-LX128_0x41a64150-part2","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:59b4/block/mmcblk0/mmcblk0p2","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"7462f9ec-50f6-4f55-9f22-79cca1bee42a","ID_FS_UUID_ENC":"7462f9ec-50f6-4f55-9f22-79cca1bee42a","ID_FS_VERSION":"1.0","ID_NAME":"LX128","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"c4d0cd2d-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"c4d0cd2d","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x41a64150","MAJOR":"179","MINOR":"2","PARTN":"2","SEQNUM":"2394","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3180697"} Oct 05 10:40:19 volumio-wz systemd[1820]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #17978666: comm (umount): reading directory lblock 0 Oct 05 10:40:19 volumio-wz volumio[903]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:59b4/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/c4d0cd2d-03 /dev/disk/by-label/volumio_data /dev/disk/by-id/mmc-LX128_0x41a64150-part3 /dev/disk/by-uuid/05aa9627-e829-40c7-ad33-94111ba2ebbc /dev/disk/by-path/platform-fe340000.mmc-part3","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:59b4/block/mmcblk0/mmcblk0p3","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"05aa9627-e829-40c7-ad33-94111ba2ebbc","ID_FS_UUID_ENC":"05aa9627-e829-40c7-ad33-94111ba2ebbc","ID_FS_VERSION":"1.0","ID_NAME":"LX128","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"241479106","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"c4d0cd2d-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"c4d0cd2d","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0x41a64150","MAJOR":"179","MINOR":"3","PARTN":"3","SEQNUM":"2395","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3159877"} Oct 05 10:40:19 volumio-wz volumio[903]: error: updateQueue error: null Oct 05 10:40:19 volumio-wz sudo[1823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Oct 05 10:40:19 volumio-wz systemd[1820]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz sudo[1823]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1825]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1825]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1826]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1826]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #17978666: comm (umount): reading directory lblock 0 Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1827]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1827]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz sudo[1823]: pam_unix(sudo:session): session closed for user root Oct 05 10:40:19 volumio-wz volumio[903]: error: Cannot start Remote SSH: Error: Command failed: /usr/bin/sudo /bin/systemctl restart sshtunnel.service Oct 05 10:40:19 volumio-wz volumio[903]: Failed to restart sshtunnel.service: Unit sshtunnel.service not found. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1828]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1828]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1829]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1829]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1830]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1830]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1831]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1831]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1832]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1832]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1833]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1833]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1834]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1834]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1835]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1835]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1836]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1836]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1837]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1837]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1838]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1838]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1839]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1839]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device. Stopping, too. Oct 05 10:40:19 volumio-wz systemd[1]: Unmounting /boot... Oct 05 10:40:19 volumio-wz systemd[1840]: boot.mount: Failed to execute command: Input/output error Oct 05 10:40:19 volumio-wz systemd[1840]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Oct 05 10:40:19 volumio-wz systemd[1]: Failed unmounting /boot. Oct 05 10:40:19 volumio-wz systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-6B37\x2d2179.device, but not stopping since we tried this too often recently. Oct 05 10:40:19 volumio-wz systemd[1]: systemd-fsck@dev-disk-by\x2duuid-6B37\x2d2179.service: Succeeded. Oct 05 10:40:19 volumio-wz systemd[1]: Stopped File System Check on /dev/disk/by-uuid/6B37-2179. Oct 05 10:40:19 volumio-wz kernel: mmc0: error -110 whilst initialising SD card Oct 05 10:40:20 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 05 10:40:20 volumio-wz volumio[903]: info: Received Get System Info Oct 05 10:40:20 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 05 10:40:20 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 05 10:40:20 volumio-wz volumio[903]: info: Discovery: Getting this device information Oct 05 10:40:20 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:20 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:20 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 05 10:40:20 volumio-wz kernel: mmc0: error -84 whilst initialising SD card Oct 05 10:40:20 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 05 10:40:20 volumio-wz volumio[903]: error: Upnp client error: Error: This socket has been ended by the other party Oct 05 10:40:20 volumio-wz kernel: mmc0: error -110 whilst initialising SD card Oct 05 10:40:20 volumio-wz kernel: mmc0: error -110 whilst initialising SD card Oct 05 10:40:21 volumio-wz kernel: mmc0: error -110 whilst initialising SD card Oct 05 10:40:21 volumio-wz kernel: mmc0: error -110 whilst initialising SD card Oct 05 10:40:21 volumio-wz volumio[903]: info: MRS: Getting audio outputs on start Oct 05 10:40:21 volumio-wz volumio[903]: info: MRS: Requesting all other devices output Oct 05 10:40:21 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 05 10:40:21 volumio-wz volumio[903]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 05 10:40:21 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetState Oct 05 10:40:21 volumio-wz volumio[903]: info: CorePlayQueue::getTrack 0 Oct 05 10:40:23 volumio-wz kernel: mmc0: new ultra high speed DDR50 SDXC card at address 59b4 Oct 05 10:40:23 volumio-wz kernel: mmcblk0: mmc0:59b4 LX128 118 GiB Oct 05 10:40:23 volumio-wz kernel: mmcblk0: p1 p2 p3 Oct 05 10:40:23 volumio-wz kernel: mmcblk0: mmc0:59b4 LX128 118 GiB Oct 05 10:40:23 volumio-wz volumio[903]: info: Ignoring mount for partition: boot Oct 05 10:40:23 volumio-wz volumio[903]: info: Ignoring mount for partition: volumio Oct 05 10:40:23 volumio-wz volumio[903]: info: Ignoring mount for partition: volumio_data Oct 05 10:40:23 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 05 10:40:23 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 05 10:40:23 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 05 10:40:23 volumio-wz volumio-remote-updater[679]: No test mode Oct 05 10:40:23 volumio-wz volumio-remote-updater[679]: No alpha test mode Oct 05 10:40:23 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 05 10:40:24 volumio-wz volumio[903]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 05 10:40:24 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning: 2818 callbacks suppressed Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:24 volumio-wz kernel: EXT4-fs warning (device mmcblk0p3): dx_probe:822: inode #18011035: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Oct 05 10:40:26 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 05 10:40:26 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 05 10:40:26 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 05 10:40:26 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 05 10:40:26 volumio-wz volumio[903]: info: CoreCommandRouter::volumioGetBrowseSources Oct 05 10:40:26 volumio-wz volumio[903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 05 10:40:26 volumio-wz volumio[903]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 05 10:40:26 volumio-wz volumio[903]: Error: EIO: i/o error, scandir '/data/plugins/' Oct 05 10:40:26 volumio-wz volumio[903]: at Object.readdirSync (fs.js:1021:3) Oct 05 10:40:26 volumio-wz volumio[903]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30) Oct 05 10:40:26 volumio-wz volumio[903]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1521:29) Oct 05 10:40:26 volumio-wz volumio[903]: at myVolumio.identifyUserProperties (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:42317) Oct 05 10:40:26 volumio-wz volumio[903]: at Timeout._onTimeout (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:2508) Oct 05 10:40:26 volumio-wz volumio[903]: at listOnTimeout (internal/timers.js:554:17) Oct 05 10:40:26 volumio-wz volumio[903]: at processTimers (internal/timers.js:497:7) { Oct 05 10:40:26 volumio-wz volumio[903]: errno: -5, Oct 05 10:40:26 volumio-wz volumio[903]: syscall: 'scandir', Oct 05 10:40:26 volumio-wz volumio[903]: code: 'EIO', Oct 05 10:40:26 volumio-wz volumio[903]: path: '/data/plugins/' Oct 05 10:40:26 volumio-wz volumio[903]: } Oct 05 10:40:26 volumio-wz volumio[903]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 05 10:40:27 volumio-wz sudo[1857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-05 10:39 Oct 05 10:40:27 volumio-wz sudo[1857]: 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"