-- Logs begin at Thu 2025-03-20 15:38:23 CST, end at Thu 2025-03-20 15:40:25 CST. -- Mar 20 15:39:00 volumio volumio[1229]: info: Starting Streaming Service Transparent Proxy Mar 20 15:39:00 volumio volumio[1229]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 20 15:39:00 volumio volumio[1229]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 20 15:39:00 volumio volumio[1229]: info: Streaming services startup Mar 20 15:39:00 volumio volumio[1229]: info: Starting Streaming Daemon Mar 20 15:39:00 volumio sudo[2078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 20 15:39:00 volumio sudo[2078]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:39:00 volumio volumio[1229]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 20 15:39:00 volumio sudo[2078]: pam_unix(sudo:session): session closed for user root Mar 20 15:39:00 volumio volumio[1229]: error: Cannot start Volumio Streaming Daemon Mar 20 15:39:00 volumio volumio[1229]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 20 15:39:00 volumio volumio[1229]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 20 15:39:00 volumio jellyfin[1619]: [15:39:00] [INF] [8] Emby.Server.Implementations.ScheduledTasks.TaskManager: Clean up collections and playlists Completed after 0 minute(s) and 0 seconds Mar 20 15:39:00 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:39:00 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:00 volumio volumio[1229]: STREAMING PROXY: Starting server on port 3245 Mar 20 15:39:00 volumio volumio[1229]: Node JS runtime: 14 Mar 20 15:39:00 volumio volumio[1229]: error: MyVolumio Custom Token format not valid, refreshing it Mar 20 15:39:01 volumio volumio[1229]: info: MyVolumio login type: Token Mar 20 15:39:01 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 20 15:39:02 volumio volumio[1229]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 20 15:39:02 volumio jellyfin[1619]: [15:39:02] [INF] [12] Emby.Server.Implementations.ScheduledTasks.TaskManager: Update Plugins Completed after 0 minute(s) and 1 seconds Mar 20 15:39:03 volumio volumio[1229]: info: MyVolumio token set successfully Mar 20 15:39:03 volumio volumio[1229]: info: MYVOLUMIO: Adding device Mar 20 15:39:03 volumio volumio[1229]: info: MYVOLUMIO: Evaluating Server Mar 20 15:39:03 volumio volumio[1229]: info: MyVolumio status changed Mar 20 15:39:03 volumio volumio[1229]: info: Streaming services startup Mar 20 15:39:03 volumio volumio[1229]: info: Starting Streaming Daemon Mar 20 15:39:03 volumio volumio[1229]: info: Removing browser output: myVolumio user plan is not superstar Mar 20 15:39:03 volumio volumio[1229]: info: Removing audio output: Mar 20 15:39:03 volumio volumio[1229]: info: Stoppping Tunnel 1 Mar 20 15:39:03 volumio sudo[2106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 20 15:39:03 volumio sudo[2106]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:39:03 volumio sudo[2106]: pam_unix(sudo:session): session closed for user root Mar 20 15:39:03 volumio volumio[1229]: error: Cannot start Volumio Streaming Daemon Mar 20 15:39:03 volumio volumio[1229]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 20 15:39:03 volumio volumio[1229]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 20 15:39:03 volumio sudo[2109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 20 15:39:03 volumio sudo[2109]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:39:03 volumio sudo[2109]: pam_unix(sudo:session): session closed for user root Mar 20 15:39:03 volumio volumio[1229]: info: Remote SSH Stopped Mar 20 15:39:03 volumio volumio[1229]: info: Setting Geolocation for MyVolumio to as1 Mar 20 15:39:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:04 volumio volumio[1229]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 20 15:39:04 volumio volumio[1229]: info: Updating MyVolumio device info Mar 20 15:39:04 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:04 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:04 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:05 volumio volumio[1229]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 20 15:39:05 volumio volumio[1229]: info: AutoStart - Plugin is starting Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::volumioGetQueue Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::getQueue Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getQueue Mar 20 15:39:05 volumio volumio[1229]: info: AutoStart - start playing Mar 20 15:39:05 volumio volumio[1229]: info: AutoStart - start playing with no specific position Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::volumioPlay Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::play index 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::stop Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::play index undefined Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::startPlaybackTimer Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::clearAddPlayTracks USB/赵鹏 - 乌兰巴托的夜晚.flac Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand stop Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand stop took 1 milliseconds Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand clear Mar 20 15:39:05 volumio volumio[1229]: info: Mar 20 15:39:05 volumio volumio[1229]: ---------------------------- MPD announces system playlist update Mar 20 15:39:05 volumio volumio[1229]: info: Ignoring MPD Status Update Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand clear took 1 milliseconds Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand add "USB/赵鹏 - 乌兰巴托的夜晚.flac" Mar 20 15:39:05 volumio volumio[1229]: info: Mar 20 15:39:05 volumio volumio[1229]: ---------------------------- MPD announces system playlist update Mar 20 15:39:05 volumio volumio[1229]: info: Ignoring MPD Status Update Mar 20 15:39:05 volumio volumio[1229]: error: updateQueue error: null Mar 20 15:39:05 volumio volumio[1229]: info: Mar 20 15:39:05 volumio volumio[1229]: ---------------------------- MPD announces system playlist update Mar 20 15:39:05 volumio volumio[1229]: info: Ignoring MPD Status Update Mar 20 15:39:05 volumio volumio[1229]: info: ------------------------------ 3ms Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand add "USB/赵鹏 - 乌兰巴托的夜晚.flac" took 2 milliseconds Mar 20 15:39:05 volumio volumio[1229]: info: ------------------------------ 1ms Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand play Mar 20 15:39:05 volumio volumio[1229]: info: Mar 20 15:39:05 volumio volumio[1229]: ---------------------------- MPD announces system playlist update Mar 20 15:39:05 volumio volumio[1229]: info: Ignoring MPD Status Update Mar 20 15:39:05 volumio volumio[1229]: info: ------------------------------ 2ms Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand play took 1 milliseconds Mar 20 15:39:05 volumio volumio[1229]: info: ------------------------------ 1ms Mar 20 15:39:05 volumio volumio[1229]: info: Mar 20 15:39:05 volumio volumio[1229]: ---------------------------- MPD announces state update: player Mar 20 15:39:05 volumio volumio[1229]: info: ControllerMpd::getState Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:39:05 volumio volumio[1229]: info: Mar 20 15:39:05 volumio volumio[1229]: ---------------------------- MPD announces state update: player Mar 20 15:39:05 volumio volumio[1229]: info: ControllerMpd::getState Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:39:05 volumio volumio[1229]: info: Mar 20 15:39:05 volumio volumio[1229]: ---------------------------- MPD announces state update: player Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand status took 30 milliseconds Mar 20 15:39:05 volumio volumio[1229]: info: ControllerMpd::getState Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand status took 30 milliseconds Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 20 15:39:05 volumio volumio[1229]: info: Mar 20 15:39:05 volumio volumio[1229]: ---------------------------- MPD announces state update: player Mar 20 15:39:05 volumio volumio[1229]: info: ControllerMpd::getState Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand status took 3 milliseconds Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand status took 3 milliseconds Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Mar 20 15:39:05 volumio volumio[1229]: info: ControllerMpd::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Mar 20 15:39:05 volumio volumio[1229]: verbose: CURRENT POSITION 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus stop Mar 20 15:39:05 volumio volumio[1229]: info: ControllerMpd::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Mar 20 15:39:05 volumio volumio[1229]: verbose: CURRENT POSITION 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus play Mar 20 15:39:05 volumio volumio[1229]: info: Received an update from plugin. extracting info from payload Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:39:05 volumio volumio[1229]: info: ControllerMpd::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Mar 20 15:39:05 volumio volumio[1229]: verbose: CURRENT POSITION 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus play Mar 20 15:39:05 volumio volumio[1229]: info: Received an update from plugin. extracting info from payload Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:39:05 volumio volumio[1229]: info: ------------------------------ 47ms Mar 20 15:39:05 volumio volumio[1229]: info: ------------------------------ 54ms Mar 20 15:39:05 volumio volumio[1229]: info: ------------------------------ 26ms Mar 20 15:39:05 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 20 milliseconds Mar 20 15:39:05 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Mar 20 15:39:05 volumio volumio[1229]: info: ControllerMpd::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Mar 20 15:39:05 volumio volumio[1229]: verbose: CURRENT POSITION 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus play Mar 20 15:39:05 volumio volumio[1229]: info: Received an update from plugin. extracting info from payload Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:39:05 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:39:05 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:05 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:39:05 volumio volumio[1229]: info: ------------------------------ 34ms Mar 20 15:39:08 volumio volumio[1229]: info: MYVOLUMIO: Adding device Mar 20 15:39:08 volumio volumio[1229]: info: MYVOLUMIO: Evaluating Server Mar 20 15:39:09 volumio volumio[1229]: info: Setting Geolocation for MyVolumio to as1 Mar 20 15:39:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:09 volumio volumio[1229]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 20 15:39:10 volumio volumio[1229]: info: Updating MyVolumio device info Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 20 15:39:10 volumio volumio[1229]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 20 15:39:10 volumio volumio[1229]: info: Received Get System Version Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 20 15:39:10 volumio volumio[1229]: info: Received Get System Info Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 20 15:39:10 volumio volumio[1229]: info: Discovery: Getting this device information Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:39:10 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 20 15:39:11 volumio volumio[1229]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 20 15:39:11 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:39:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:11 volumio sudo[2153]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Mar 20 15:39:11 volumio sudo[2153]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:39:12 volumio volumio[1229]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Mar 20 15:39:12 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:39:12 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:13 volumio volumio[1229]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11 Mar 20 15:39:13 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:39:13 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:14 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 20 15:39:14 volumio volumio[1229]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Mar 20 15:39:14 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:39:14 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 20 15:39:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 20 15:39:16 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 20 15:39:16 volumio volumio-remote-updater[718]: No test mode Mar 20 15:39:16 volumio volumio-remote-updater[718]: No alpha test mode Mar 20 15:39:16 volumio volumio[1229]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

 

NEW ADDITIONS

 

","title":"Update v3.795","updateavailable":true} Mar 20 15:39:16 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 20 15:39:19 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 20 15:39:19 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 20 15:39:19 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 20 15:39:19 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 20 15:39:19 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 20 15:39:19 volumio volumio[1229]: info: CoreCommandRouter::volumioGetBrowseSources Mar 20 15:39:19 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 20 15:39:20 volumio volumio[1229]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 20 15:39:20 volumio volumio[1229]: info: Completed starting MyVolumio Plugin Mar 20 15:39:20 volumio volumio[1229]: info: BOOT COMPLETED Mar 20 15:39:20 volumio volumio[1229]: [Metrics] CommandRouter: 40s 658.10ms Mar 20 15:39:20 volumio volumio[1229]: info: CoreCommandRouter::volumiosetStartupVolume Mar 20 15:39:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 20 15:39:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:39:20 volumio volumio[1229]: info: CoreCommandRouter::Close All Modals sent Mar 20 15:39:20 volumio volumio[1229]: info: CoreCommandRouter::Close All Modals sent Mar 20 15:39:20 volumio volumio[1229]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Mar 20 15:39:20 volumio volumio[1229]: aplay: main:828: audio open error: No such file or directory Mar 20 15:39:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 20 15:39:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 20 15:39:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 20 15:39:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 20 15:39:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 20 15:39:24 volumio volumio[1229]: info: Discovery: Getting this device information Mar 20 15:39:24 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:39:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 20 15:39:31 volumio kernel: usb 1-1: new high-speed USB device number 3 using xhci_hcd Mar 20 15:39:32 volumio kernel: usb 1-1: New USB device found, idVendor=16d0, idProduct=0a23, bcdDevice= 1.9b Mar 20 15:39:32 volumio kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Mar 20 15:39:32 volumio kernel: usb 1-1: Product: Combo384 Amanero Mar 20 15:39:32 volumio kernel: usb 1-1: Manufacturer: Amanero Technologies Mar 20 15:39:32 volumio kernel: usb 1-1: SerialNumber: 415-001 Mar 20 15:39:32 volumio kernel: usb 1-1: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Mar 20 15:39:32 volumio kernel: usb 1-1: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Mar 20 15:39:32 volumio kernel: usb 1-1: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Mar 20 15:39:32 volumio kernel: usb 1-1: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Mar 20 15:39:32 volumio kernel: usbcore: registered new interface driver snd-usb-audio Mar 20 15:39:32 volumio systemd-udevd[2301]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Mar 20 15:39:32 volumio volumio[1229]: info: Mar 20 15:39:32 volumio volumio[1229]: ---------------------------- USB Audio Device Attached Mar 20 15:39:32 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 20 15:39:43 volumio volumio[1229]: info: Retrieving Cloud Streaming UI Mar 20 15:39:43 volumio volumio[1229]: info: Getting Tidal Cloud Configuration Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 20 15:39:43 volumio volumio[1229]: info: Getting Qobuz Cloud Configuration Mar 20 15:39:43 volumio volumio[1229]: info: Asking plugin for UI Config Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 20 15:39:43 volumio volumio[1229]: info: Getting Spotify Cloud Configuration Mar 20 15:39:43 volumio volumio[1229]: info: Asking plugin for UI Config Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 20 15:39:43 volumio volumio[1229]: info: Saving Spotify Acccount Mar 20 15:39:43 volumio volumio[1229]: info: Got Tidal Cloud Configuration Mar 20 15:39:43 volumio volumio[1229]: info: Got it Mar 20 15:39:43 volumio volumio[1229]: info: Got it Mar 20 15:39:43 volumio volumio[1229]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 20 15:39:43 volumio volumio[1229]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::volumioGetBrowseSources Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::volumioGetBrowseSources Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::volumioGetBrowseSources Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:39:43 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 20 15:39:44 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 20 15:39:44 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 20 15:39:46 volumio ntpd[1218]: Soliciting pool server 162.159.200.1 Mar 20 15:39:47 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:39:48 volumio ntpd[1218]: Soliciting pool server 45.82.252.178 Mar 20 15:39:49 volumio ntpd[1218]: Soliciting pool server 84.16.67.12 Mar 20 15:39:49 volumio ntpd[1218]: Soliciting pool server 78.46.102.180 Mar 20 15:39:51 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:39:54 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 20 15:39:54 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 20 15:39:54 volumio volumio[1229]: info: Discovery: Getting this device information Mar 20 15:39:54 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:39:54 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:39:54 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 20 15:39:55 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:39:58 volumio jellyfin[1619]: [15:39:58] [INF] [14] Emby.Server.Implementations.ScheduledTasks.TaskManager: Update Plugins Completed after 0 minute(s) and 1 seconds Mar 20 15:39:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:40:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:40:07 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:40:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:40:12 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Mar 20 15:40:12 volumio volumio[1229]: info: Adding a new share Mar 20 15:40:12 volumio volumio[1229]: info: No correspondence found in configuration for share 音乐 on IP 192.168.31.210 Mar 20 15:40:12 volumio sudo[2431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=BG4BWN,password=ZHANGjun19790130,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.31.210/音乐 /mnt/NAS/音乐 Mar 20 15:40:12 volumio sudo[2431]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:40:12 volumio kernel: FS-Cache: Loaded Mar 20 15:40:12 volumio kernel: Key type dns_resolver registered Mar 20 15:40:12 volumio kernel: Key type cifs.spnego registered Mar 20 15:40:12 volumio kernel: Key type cifs.idmap registered Mar 20 15:40:12 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Mar 20 15:40:12 volumio kernel: CIFS: Attempting to mount //192.168.31.210/音乐 Mar 20 15:40:13 volumio sudo[2431]: pam_unix(sudo:session): session closed for user root Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:40:13 volumio volumio[1229]: info: Mar 20 15:40:13 volumio volumio[1229]: ---------------------------- MPD announces state update: update Mar 20 15:40:13 volumio volumio[1229]: info: ControllerMpd::getState Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:40:13 volumio volumio[1229]: info: Mar 20 15:40:13 volumio volumio[1229]: ---------------------------- MPD announces state update: update Mar 20 15:40:13 volumio volumio[1229]: info: ControllerMpd::getState Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:40:13 volumio volumio[1229]: info: sendMpdCommand status took 4 milliseconds Mar 20 15:40:13 volumio volumio[1229]: info: sendMpdCommand status took 2 milliseconds Mar 20 15:40:13 volumio volumio[1229]: info: sendMpdCommand status took 2 milliseconds Mar 20 15:40:13 volumio volumio[1229]: info: sendMpdCommand status took 3 milliseconds Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:40:13 volumio volumio[1229]: info: Command Router : Notfying DB Updatetrue Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:40:13 volumio volumio[1229]: info: Command Router : Notfying DB Updatetrue Mar 20 15:40:13 volumio volumio[1229]: info: CoreCommandRouter::Close All Modals sent Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 20 15:40:13 volumio volumio[1229]: info: [1742456413144] Database update started Mar 20 15:40:13 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 44 milliseconds Mar 20 15:40:13 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Mar 20 15:40:13 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Mar 20 15:40:13 volumio volumio[1229]: info: ControllerMpd::pushState Mar 20 15:40:13 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Mar 20 15:40:13 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:13 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68048,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Mar 20 15:40:13 volumio volumio[1229]: verbose: CURRENT POSITION 0 Mar 20 15:40:13 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Mar 20 15:40:13 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus play Mar 20 15:40:13 volumio volumio[1229]: info: Received an update from plugin. extracting info from payload Mar 20 15:40:13 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:40:13 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:13 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 20 15:40:13 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:40:13 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:40:13 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:13 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:40:13 volumio volumio[1229]: info: ControllerMpd::pushState Mar 20 15:40:13 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Mar 20 15:40:13 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:13 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68048,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Mar 20 15:40:13 volumio volumio[1229]: verbose: CURRENT POSITION 0 Mar 20 15:40:13 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Mar 20 15:40:13 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus play Mar 20 15:40:13 volumio volumio[1229]: info: Received an update from plugin. extracting info from payload Mar 20 15:40:13 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:40:13 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:13 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:40:13 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:40:13 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:13 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:40:13 volumio volumio[1229]: info: ------------------------------ 133ms Mar 20 15:40:13 volumio volumio[1229]: info: ------------------------------ 133ms Mar 20 15:40:14 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 20 15:40:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 20 15:40:21 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 20 15:40:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 20 15:40:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:40:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 20 15:40:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 20 15:40:24 volumio volumio[1229]: info: Discovery: Getting this device information Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:40:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 20 15:40:24 volumio volumio[1229]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 20 15:40:24 volumio volumio[1229]: info: Preparing to save Alsa Options, stopping services first Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Mar 20 15:40:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::volumioPause Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::pause Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::servicePause Mar 20 15:40:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::servicePause Mar 20 15:40:24 volumio volumio[1229]: info: ControllerMpd::pause Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand pause Mar 20 15:40:24 volumio volumio[1229]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Combo384 Amanero"}} Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 20 15:40:24 volumio volumio[1229]: info: Setting mixer PCM for card Combo384 Amanero Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 20 15:40:24 volumio volumio[1229]: info: Updating Volume Controller Parameters: Device: 5 Name: Combo384 Amanero Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 20 15:40:24 volumio volumio[1229]: info: Disabling external Volume Control Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 20 15:40:24 volumio volumio[1229]: info: Preparing to generate the ALSA configuration file Mar 20 15:40:24 volumio volumio[1229]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Mar 20 15:40:24 volumio volumio[1229]: info: Reading ALSA contributions from plugins. Mar 20 15:40:24 volumio volumio[1229]: info: Mar 20 15:40:24 volumio volumio[1229]: ---------------------------- MPD announces state update: player Mar 20 15:40:24 volumio volumio[1229]: info: sendMpdCommand pause took 113 milliseconds Mar 20 15:40:24 volumio volumio[1229]: info: ControllerMpd::getState Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:40:24 volumio volumio[1229]: info: Mar 20 15:40:24 volumio volumio[1229]: ---------------------------- MPD announces state update: player Mar 20 15:40:24 volumio volumio[1229]: info: ControllerMpd::getState Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Mar 20 15:40:24 volumio volumio[1229]: info: sendMpdCommand status took 10 milliseconds Mar 20 15:40:24 volumio volumio[1229]: info: sendMpdCommand status took 9 milliseconds Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::parseState Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 20 15:40:24 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 53 milliseconds Mar 20 15:40:24 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 53 milliseconds Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Mar 20 15:40:24 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Mar 20 15:40:24 volumio volumio[1229]: info: ControllerMpd::pushState Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Mar 20 15:40:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:24 volumio volumio[1229]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":79750,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1000 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Mar 20 15:40:24 volumio volumio[1229]: verbose: CURRENT POSITION 0 Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::syncState stateService pause Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus pause Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:40:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer Mar 20 15:40:24 volumio volumio[1229]: info: ControllerMpd::pushState Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Mar 20 15:40:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:24 volumio volumio[1229]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":79750,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1000 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Mar 20 15:40:24 volumio volumio[1229]: verbose: CURRENT POSITION 0 Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::syncState stateService pause Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus pause Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::pushState Mar 20 15:40:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Mar 20 15:40:24 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Mar 20 15:40:24 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer Mar 20 15:40:24 volumio volumio[1229]: info: ------------------------------ 82ms Mar 20 15:40:24 volumio volumio[1229]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 20 15:40:24 volumio volumio[1229]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Mar 20 15:40:24 volumio volumio[1229]: at Object.readdirSync (fs.js:1048:3) Mar 20 15:40:24 volumio volumio[1229]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Mar 20 15:40:24 volumio volumio[1229]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Mar 20 15:40:24 volumio volumio[1229]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Mar 20 15:40:24 volumio volumio[1229]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Mar 20 15:40:24 volumio volumio[1229]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Mar 20 15:40:24 volumio volumio[1229]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Mar 20 15:40:24 volumio volumio[1229]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Mar 20 15:40:24 volumio volumio[1229]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Mar 20 15:40:24 volumio volumio[1229]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Mar 20 15:40:24 volumio volumio[1229]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Mar 20 15:40:24 volumio volumio[1229]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Mar 20 15:40:24 volumio volumio[1229]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Mar 20 15:40:24 volumio volumio[1229]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Mar 20 15:40:24 volumio volumio[1229]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Mar 20 15:40:24 volumio volumio[1229]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Mar 20 15:40:24 volumio volumio[1229]: errno: -20, Mar 20 15:40:24 volumio volumio[1229]: syscall: 'scandir', Mar 20 15:40:24 volumio volumio[1229]: code: 'ENOTDIR', Mar 20 15:40:24 volumio volumio[1229]: path: '/tmp/peppyrunning' Mar 20 15:40:24 volumio volumio[1229]: } Mar 20 15:40:24 volumio volumio[1229]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 20 15:40:25 volumio sudo[2550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-20 15:39 Mar 20 15:40:25 volumio sudo[2550]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"