-- Logs begin at Thu 2019-02-14 17:12:00 +07, end at Tue 2024-08-20 14:46:18 +07. -- Aug 20 14:45:00 music volumio[1086]: info: Starting Streaming Service Transparent Proxy Aug 20 14:45:00 music volumio[1086]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 20 14:45:00 music volumio[1086]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 20 14:45:00 music volumio[1086]: info: Streaming services startup Aug 20 14:45:00 music volumio[1086]: info: Starting Streaming Daemon Aug 20 14:45:00 music sudo[1492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 20 14:45:00 music sudo[1492]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:00 music volumio[1086]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 20 14:45:00 music sudo[1492]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:00 music volumio[1086]: info: AutoStart - Plugin is starting Aug 20 14:45:00 music volumio[1086]: info: CoreCommandRouter::volumioGetQueue Aug 20 14:45:00 music volumio[1086]: info: CoreStateMachine::getQueue Aug 20 14:45:00 music volumio[1086]: info: CorePlayQueue::getQueue Aug 20 14:45:00 music volumio[1086]: info: AutoStart - start playing Aug 20 14:45:00 music volumio[1086]: info: AutoStart - start playing with no specific position Aug 20 14:45:00 music volumio[1086]: info: CoreCommandRouter::volumioPlay Aug 20 14:45:00 music volumio[1086]: info: CoreStateMachine::play index 0 Aug 20 14:45:00 music volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 14:45:00 music volumio[1086]: info: CoreStateMachine::stop Aug 20 14:45:00 music volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 14:45:00 music volumio[1086]: info: CoreStateMachine::play index undefined Aug 20 14:45:00 music volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 14:45:00 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:00 music volumio[1086]: info: CoreStateMachine::startPlaybackTimer Aug 20 14:45:00 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:00 music volumio[1086]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2229EVifaVvao%22%2C%22params%22%3A%22qgMMbmjhuqFjIGNoaWxsugMREg9SRFFNVTNXbGx5aDBWbE26AwoIzcz1q7bemZlnugMLCOS__7nrsdnkzQG6AwsInOa9iqf-0NbrAboDCwispPL9v76GloEBugMKCIzentXZ7YvLaLoDCgiI25Ke5uG0khO6AwsI7Jun4LLf5oeLAboDCwjB-cbKs8mE5e8BugMKCKDUmpX22ezIS7oDCwiM8OiVgKufkswBugMKCJLAgaj9qOzCSboDCwic3_zdypa0wpABugMKCOfdzKX7gdrhVLoDCwjqrtil2bXZlqsBugMKCJ_os4nj862BM7oDCwiisPO83puh_tUBugMLCPHEysiznb_2tgG6AwoIur-cibKD354n%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Nh%E1%BA%A1c%20Chill%20Qu%C3%A1n%20Cafe%20-%20Nh%E1%BB%AFng%20Ca%20Kh%C3%BAc%20Lofi%20Nh%E1%BA%B9%20Nh%C3%A0ng%20Hay%20Nh%E1%BA%A5t%20D%C3%A0nh%20Cho%20Qu%C3%A1n%20Cafe%20-%20Nh%E1%BA%A1c%20Lofi%20Chill%22%2C%22artist%22%3A%22K%E1%BA%BB%20L%E1%BB%A5y%20T%C3%ACnh%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F29EVifaVvao%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCMqlD0AFegU_dnLmMJObMEKl6xRA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2229EVifaVvao%22%2C%22params%22%3A%22qgMMbmjhuqFjIGNoaWxsugMREg9SRFFNVTNXbGx5aDBWbE26AwoIzcz1q7bemZlnugMLCOS__7nrsdnkzQG6AwsInOa9iqf-0NbrAboDCwispPL9v76GloEBugMKCIzentXZ7YvLaLoDCgiI25Ke5uG0khO6AwsI7Jun4LLf5oeLAboDCwjB-cbKs8mE5e8BugMKCKDUmpX22ezIS7oDCwiM8OiVgKufkswBugMKCJLAgaj9qOzCSboDCwic3_zdypa0wpABugMKCOfdzKX7gdrhVLoDCwjqrtil2bXZlqsBugMKCJ_os4nj862BM7oDCwiisPO83puh_tUBugMLCPHEysiznb_2tgG6AwoIur-cibKD354n%22%7D%7D%7D Aug 20 14:45:00 music volumio[1086]: info: [youtube2] InnertubeLoader: creating Innertube instance... Aug 20 14:45:00 music volumio[1086]: error: Cannot start Volumio Streaming Daemon Aug 20 14:45:00 music volumio[1086]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 20 14:45:00 music volumio[1086]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 20 14:45:01 music volumio[1086]: error: MyVolumio Custom Token format not valid, refreshing it Aug 20 14:45:02 music volumio[1086]: STREAMING PROXY: Starting server on port 3245 Aug 20 14:45:02 music volumio[1086]: Node JS runtime: 14 Aug 20 14:45:05 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:10 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:14 music volumio[1086]: info: [youtube2] InnertubeLoader: creating Auth instance... Aug 20 14:45:14 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:14 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 14:45:14 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:14 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 14:45:14 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 14:45:14 music volumio[1086]: info: MyVolumio login type: Token Aug 20 14:45:14 music volumio[1086]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 20 14:45:15 music volumio-remote-updater[653]: No test mode Aug 20 14:45:15 music volumio-remote-updater[653]: No alpha test mode Aug 20 14:45:15 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 20 14:45:15 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:15 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:15 music volumio[1086]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 20 14:45:15 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 20 14:45:15 music sudo[1504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 14:45:15 music sudo[1504]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:15 music sudo[1504]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:15 music volumio[1086]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 20 14:45:15 music sudo[1507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 14:45:15 music sudo[1507]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:15 music sudo[1507]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:15 music volumio[1086]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 20 14:45:16 music volumio[1086]: verbose: New Socket.io Connection to 192.168.1.245 from 192.168.1.72 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Aug 20 14:45:16 music volumio[1086]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 20 14:45:16 music volumio[1086]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:16 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 14:45:16 music volumio[1086]: info: Received Get System Info Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:16 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:16 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:16 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:16 music volumio[1086]: info: Listing playlists Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 14:45:16 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:16 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 14:45:17 music volumio[1086]: info: MyVolumio token set successfully Aug 20 14:45:17 music volumio[1086]: info: MYVOLUMIO: Adding device Aug 20 14:45:17 music volumio[1086]: info: MYVOLUMIO: Evaluating Server Aug 20 14:45:17 music sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 14:45:17 music sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:17 music sudo[1512]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:17 music sudo[1514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 14:45:17 music sudo[1514]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:17 music sudo[1514]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::volumioGetBrowseSources Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 14:45:18 music volumio[1086]: info: MyVolumio status changed Aug 20 14:45:18 music volumio[1086]: info: Streaming services startup Aug 20 14:45:18 music volumio[1086]: info: Starting Streaming Daemon Aug 20 14:45:18 music volumio[1086]: info: Removing browser output: myVolumio user plan is not superstar Aug 20 14:45:18 music volumio[1086]: info: Removing audio output: Aug 20 14:45:18 music volumio[1086]: info: Stoppping Tunnel 1 Aug 20 14:45:18 music sudo[1533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 20 14:45:18 music sudo[1533]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:18 music sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 20 14:45:18 music sudo[1533]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:18 music sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:18 music volumio[1086]: info: Setting Geolocation for MyVolumio to as1 Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:18 music volumio[1086]: error: Cannot start Volumio Streaming Daemon Aug 20 14:45:18 music volumio[1086]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 20 14:45:18 music volumio[1086]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 20 14:45:18 music volumio[1086]: verbose: New Socket.io Connection to 192.168.1.245 from 192.168.1.72 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 20 14:45:18 music sudo[1536]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:18 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 14:45:18 music volumio[1086]: info: Received Get System Info Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:18 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:18 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:18 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:18 music volumio[1086]: info: Listing playlists Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 14:45:18 music volumio[1086]: info: Remote SSH Stopped Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:18 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 14:45:19 music volumio[1086]: info: Updating MyVolumio device info Aug 20 14:45:19 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:19 music volumio[1086]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 20 14:45:19 music volumio[1086]: info: [youtube2] Auth success Aug 20 14:45:19 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:19 music volumio[1086]: info: [youtube2] InnertubeLoader: Auth instance created (status: signed in) Aug 20 14:45:19 music volumio[1086]: warn: [youtube2] Failed to get account config: Error: You must be signed in to perform this operation. Aug 20 14:45:19 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 14:45:19 music volumio[1086]: info: Received Get System Info Aug 20 14:45:19 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:19 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:19 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:19 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:19 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:19 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:19 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:19 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:20 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:20 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 14:45:20 music volumio[1086]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 20 14:45:20 music volumio[1086]: info: sendMpdCommand stop took 11 milliseconds Aug 20 14:45:20 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand clear Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: sendMpdCommand clear took 6 milliseconds Aug 20 14:45:20 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube" Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: error: updateQueue error: null Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 21ms Aug 20 14:45:20 music volumio[1086]: info: sendMpdCommand addid "https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube" took 17 milliseconds Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 16ms Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 14ms Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 12ms Aug 20 14:45:20 music volumio[1086]: verbose: MPD COMMAND [object Object] Aug 20 14:45:20 music volumio[1086]: verbose: MPD COMMAND [object Object] Aug 20 14:45:20 music volumio[1086]: verbose: MPD COMMAND [object Object] Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 26ms Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 13ms Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 11ms Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 9ms Aug 20 14:45:20 music volumio[1086]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 20 14:45:20 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand play Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: Aug 20 14:45:20 music volumio[1086]: ---------------------------- MPD announces system playlist update Aug 20 14:45:20 music volumio[1086]: info: Ignoring MPD Status Update Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 22ms Aug 20 14:45:20 music volumio[1086]: info: sendMpdCommand play took 17 milliseconds Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 16ms Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 14ms Aug 20 14:45:20 music volumio[1086]: info: ------------------------------ 12ms Aug 20 14:45:20 music volumio[1086]: error: MyVolumio Plugin failed to authenticate in a timely fashion Aug 20 14:45:20 music volumio[1086]: info: Completed starting MyVolumio Plugin Aug 20 14:45:20 music volumio[1086]: info: BOOT COMPLETED Aug 20 14:45:20 music volumio[1086]: [Metrics] CommandRouter: 79s 885.56ms Aug 20 14:45:20 music volumio[1086]: info: CoreCommandRouter::volumiosetStartupVolume Aug 20 14:45:20 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 14:45:20 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:20 music volumio[1086]: info: CoreCommandRouter::Close All Modals sent Aug 20 14:45:20 music volumio[1086]: info: CoreCommandRouter::Close All Modals sent Aug 20 14:45:20 music volumio[1086]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Aug 20 14:45:20 music volumio[1086]: info: FusionDsp - ---- read samplerate from file: 44100 Aug 20 14:45:20 music volumio[1086]: info: camilladsp stopping service pid 1321... Aug 20 14:45:20 music kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=1) Aug 20 14:45:20 music volumio[1086]: info: camilladsp service terminated, instance 1 Aug 20 14:45:20 music volumio[1086]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 20 14:45:20 music volumio[1086]: info: FusionDsp - Effects disabled Aug 20 14:45:20 music volumio[1086]: info: camilladsp service started and running in background, instance 1 Aug 20 14:45:20 music volumio[1086]: info: camilladsp spawned new process with pid 1548, instance 1, run: true Aug 20 14:45:20 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 20 14:45:21 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 14:45:21 music volumio[1086]: info: Received Get System Info Aug 20 14:45:21 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:21 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:21 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:21 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:21 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:21 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 20 14:45:21 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 20 14:45:21 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 20 14:45:22 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: Aug 20 14:45:22 music volumio[1086]: ---------------------------- MPD announces state update: player Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: Aug 20 14:45:22 music volumio[1086]: ---------------------------- MPD announces state update: player Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: Aug 20 14:45:22 music volumio[1086]: ---------------------------- MPD announces state update: player Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: Aug 20 14:45:22 music volumio[1086]: ---------------------------- MPD announces state update: player Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: FusionDsp - ---- read samplerate, raw: Aug 20 14:45:22 music volumio[1086]: error: FusionDsp - invalid sample rate Aug 20 14:45:22 music volumio[1086]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Aug 20 14:45:22 music volumio[1086]: info: FusionDsp - ---- read samplerate from file: 48000 Aug 20 14:45:22 music volumio[1086]: info: camilladsp stopping service pid 1548... Aug 20 14:45:22 music volumio[1086]: info: camilladsp service terminated, instance 1 Aug 20 14:45:22 music volumio[1086]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 20 14:45:22 music volumio[1086]: info: FusionDsp - Effects disabled Aug 20 14:45:22 music volumio[1086]: info: camilladsp service started and running in background, instance 1 Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: Aug 20 14:45:22 music volumio[1086]: ---------------------------- MPD announces state update: player Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 124 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 122 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 120 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 118 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 116 milliseconds Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: info: Aug 20 14:45:22 music volumio[1086]: ---------------------------- MPD announces state update: player Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: Aug 20 14:45:22 music volumio[1086]: ---------------------------- MPD announces state update: player Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: Aug 20 14:45:22 music volumio[1086]: ---------------------------- MPD announces state update: player Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::getState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Aug 20 14:45:22 music volumio[1086]: info: camilladsp spawned new process with pid 1566, instance 1, run: true Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 90 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 82 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 79 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 79 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 78 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 77 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 77 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 73 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 71 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand status took 67 milliseconds Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseState Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::servicePushState Aug 20 14:45:22 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:22 music volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9692,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nhạc Chill Quán Cafe - Những Ca Khúc Lofi Nhẹ Nhàng Hay Nhất Dành Cho Quán Cafe - Nhạc Lofi Chill","artist":"Kẻ Lụy Tình","album":"YouTube","uri":"https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 20 14:45:22 music volumio[1086]: verbose: CURRENT POSITION 0 Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState stateService play Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::servicePushState Aug 20 14:45:22 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:22 music volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9692,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nhạc Chill Quán Cafe - Những Ca Khúc Lofi Nhẹ Nhàng Hay Nhất Dành Cho Quán Cafe - Nhạc Lofi Chill","artist":"Kẻ Lụy Tình","album":"YouTube","uri":"https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 20 14:45:22 music volumio[1086]: verbose: CURRENT POSITION 0 Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState stateService play Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState currentStatus play Aug 20 14:45:22 music volumio[1086]: info: Received an update from plugin. extracting info from payload Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::servicePushState Aug 20 14:45:22 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:22 music volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9692,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nhạc Chill Quán Cafe - Những Ca Khúc Lofi Nhẹ Nhàng Hay Nhất Dành Cho Quán Cafe - Nhạc Lofi Chill","artist":"Kẻ Lụy Tình","album":"YouTube","uri":"https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 20 14:45:22 music volumio[1086]: verbose: CURRENT POSITION 0 Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState stateService play Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState currentStatus play Aug 20 14:45:22 music volumio[1086]: info: Received an update from plugin. extracting info from payload Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::servicePushState Aug 20 14:45:22 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:22 music volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9692,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nhạc Chill Quán Cafe - Những Ca Khúc Lofi Nhẹ Nhàng Hay Nhất Dành Cho Quán Cafe - Nhạc Lofi Chill","artist":"Kẻ Lụy Tình","album":"YouTube","uri":"https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 20 14:45:22 music volumio[1086]: verbose: CURRENT POSITION 0 Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState stateService play Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState currentStatus play Aug 20 14:45:22 music volumio[1086]: info: Received an update from plugin. extracting info from payload Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: ------------------------------ 319ms Aug 20 14:45:22 music volumio[1086]: info: ------------------------------ 458ms Aug 20 14:45:22 music volumio[1086]: info: ------------------------------ 456ms Aug 20 14:45:22 music volumio[1086]: info: ------------------------------ 455ms Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 252 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 251 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 242 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 242 milliseconds Aug 20 14:45:22 music volumio[1086]: info: sendMpdCommand playlistinfo took 241 milliseconds Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: verbose: ControllerMpd::parseTrackInfo Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::servicePushState Aug 20 14:45:22 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:22 music volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9692,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nhạc Chill Quán Cafe - Những Ca Khúc Lofi Nhẹ Nhàng Hay Nhất Dành Cho Quán Cafe - Nhạc Lofi Chill","artist":"Kẻ Lụy Tình","album":"YouTube","uri":"https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 20 14:45:22 music volumio[1086]: verbose: CURRENT POSITION 0 Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState stateService play Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState currentStatus play Aug 20 14:45:22 music volumio[1086]: info: Received an update from plugin. extracting info from payload Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::servicePushState Aug 20 14:45:22 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:22 music volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9692,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nhạc Chill Quán Cafe - Những Ca Khúc Lofi Nhẹ Nhàng Hay Nhất Dành Cho Quán Cafe - Nhạc Lofi Chill","artist":"Kẻ Lụy Tình","album":"YouTube","uri":"https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 20 14:45:22 music volumio[1086]: verbose: CURRENT POSITION 0 Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState stateService play Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState currentStatus play Aug 20 14:45:22 music volumio[1086]: info: Received an update from plugin. extracting info from payload Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::servicePushState Aug 20 14:45:22 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:22 music volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9692,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nhạc Chill Quán Cafe - Những Ca Khúc Lofi Nhẹ Nhàng Hay Nhất Dành Cho Quán Cafe - Nhạc Lofi Chill","artist":"Kẻ Lụy Tình","album":"YouTube","uri":"https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 20 14:45:22 music volumio[1086]: verbose: CURRENT POSITION 0 Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState stateService play Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState currentStatus play Aug 20 14:45:22 music volumio[1086]: info: Received an update from plugin. extracting info from payload Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: ControllerMpd::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::servicePushState Aug 20 14:45:22 music volumio[1086]: info: CorePlayQueue::getTrack 0 Aug 20 14:45:22 music volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9692,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nhạc Chill Quán Cafe - Những Ca Khúc Lofi Nhẹ Nhàng Hay Nhất Dành Cho Quán Cafe - Nhạc Lofi Chill","artist":"Kẻ Lụy Tình","album":"YouTube","uri":"https://rr2---sn-8qj-i5okl.googlevideo.com/videoplayback?expire=1724161519&ei=j0nEZvbrNouX1d8PzoXGmQc&ip=113.160.5.174&id=o-ABuENSeuHMAnXGJx4kZf6fnGQV3A6S7Si_82ZBMjsTbS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=44&mm=31%2C29&mn=sn-8qj-i5okl%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=2&pl=23&initcwndbps=1437500&bui=AQmm2ewgcA3bpCB6uWLeyNFpmiqKcq_WooZC8zSRMuTS8x6xjf6ddM5fstUILijGcILAi3ku_cHBrcdU&spc=Mv1m9opiqtqDZixxRq7hfPW0Ud2eHwCalNDigaYb0ECEFIxw7Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0O9hVbiajvB6RA6tOX6QMxIQ&rqh=1&gir=yes&clen=169103880&dur=9692.261&lmt=1724102835303451&mt=1724139680&fvip=4&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=AukNJDgSoOMqGQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgNMC_gjl_d1QyR0x9no8x-LIMFpXDTnJtxc88r46MB-MCIQCYtQTEx6Q06-miS5dLeeq7zJagh1yKko36qwTHvJJkzw%3D%3D&sig=AJfQdSswRAIgJ4qCgWspHQWvnnwG_FFHFWhcC27c6p9Llb6D0qyuufQCICEKQQ5G_yjbADnwI12L8KLOTm9hbtNQmmKxeHMapKUN&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 20 14:45:22 music volumio[1086]: verbose: CURRENT POSITION 0 Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState stateService play Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::syncState currentStatus play Aug 20 14:45:22 music volumio[1086]: info: Received an update from plugin. extracting info from payload Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:22 music volumio[1086]: info: CoreStateMachine::pushState Aug 20 14:45:22 music volumio[1086]: info: CoreCommandRouter::volumioPushState Aug 20 14:45:23 music volumio[1086]: info: ------------------------------ 567ms Aug 20 14:45:23 music volumio[1086]: info: ------------------------------ 548ms Aug 20 14:45:23 music volumio[1086]: info: ------------------------------ 546ms Aug 20 14:45:23 music volumio[1086]: info: ------------------------------ 545ms Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 20 14:45:23 music volumio[1086]: info: MYVOLUMIO: Adding device Aug 20 14:45:23 music volumio[1086]: info: MYVOLUMIO: Evaluating Server Aug 20 14:45:24 music volumio[1086]: info: Setting Geolocation for MyVolumio to as1 Aug 20 14:45:24 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:24 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:24 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:25 music volumio[1086]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 20 14:45:25 music volumio[1086]: info: Updating MyVolumio device info Aug 20 14:45:25 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 14:45:26 music volumio[1086]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 20 14:45:27 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:28 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 20 14:45:28 music volumio[1240]: ......................................................................................................................................................++++ Aug 20 14:45:31 music sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 14:45:31 music sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:31 music sudo[1646]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:31 music sudo[1648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 14:45:31 music sudo[1648]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:31 music sudo[1648]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:31 music volumio[1086]: verbose: New Socket.io Connection to 192.168.1.245 from 192.168.1.72 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:31 music volumio[1086]: info: Received Get System Info Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:31 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 14:45:31 music volumio[1086]: info: Received Get System Info Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:31 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:31 music volumio[1086]: info: Listing playlists Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:31 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 14:45:33 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:33 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 14:45:33 music volumio[1086]: info: Received Get System Info Aug 20 14:45:33 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:33 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:33 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:33 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:33 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:35 music sudo[1656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 14:45:35 music sudo[1656]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:35 music sudo[1658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 14:45:35 music sudo[1658]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:45:35 music sudo[1656]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:35 music sudo[1658]: pam_unix(sudo:session): session closed for user root Aug 20 14:45:35 music volumio[1086]: verbose: New Socket.io Connection to 192.168.1.245 from 192.168.1.72 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: Received Get System Info Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:35 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 14:45:35 music volumio[1086]: info: Received Get System Info Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:35 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: Listing playlists Aug 20 14:45:35 music volumio[1086]: info: Received Get System Info Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:35 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:35 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:37 music volumio[1240]: ...............................++++ Aug 20 14:45:37 music volumio[1240]: e is 65537 (0x010001) Aug 20 14:45:37 music volumio[1240]: writing RSA key Aug 20 14:45:38 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 14:45:39 music volumio[1086]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 20 14:45:39 music volumio[1086]: info: Received Get System Version Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 14:45:39 music volumio[1086]: info: Received Get System Info Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:45:39 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 20 14:45:39 music volumio[1086]: Upnp client error: Error: This socket has been ended by the other party Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 20 14:45:39 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 20 14:45:40 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Aug 20 14:45:40 music volumio[1086]: info: Received Get System Version Aug 20 14:45:40 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 14:45:41 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 20 14:45:42 music ntpd[820]: Soliciting pool server 2a0c:b847:ffff:79::e53c Aug 20 14:45:44 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:45 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 20 14:45:50 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:45:54 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:45:55 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:46:01 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:46:07 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:46:11 music sudo[1820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 14:46:11 music sudo[1820]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:46:11 music sudo[1820]: pam_unix(sudo:session): session closed for user root Aug 20 14:46:11 music sudo[1823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 14:46:11 music sudo[1823]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:46:11 music sudo[1823]: pam_unix(sudo:session): session closed for user root Aug 20 14:46:11 music volumio[1086]: verbose: New Socket.io Connection to 192.168.1.245 from 192.168.1.72 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 20 14:46:11 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 14:46:11 music sudo[1826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 14:46:11 music sudo[1826]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:46:11 music sudo[1826]: pam_unix(sudo:session): session closed for user root Aug 20 14:46:11 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 14:46:12 music sudo[1829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 14:46:12 music sudo[1829]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:46:12 music sudo[1829]: pam_unix(sudo:session): session closed for user root Aug 20 14:46:12 music volumio[1086]: verbose: New Socket.io Connection to 192.168.1.245 from 192.168.1.72 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 14:46:12 music volumio[1086]: info: Received Get System Info Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:46:12 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:46:12 music volumio[1086]: info: Listing playlists Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 14:46:12 music volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 14:46:12 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan Aug 20 14:46:13 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:46:13 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 20 14:46:13 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 14:46:13 music volumio[1086]: info: Received Get System Info Aug 20 14:46:13 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:46:13 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:46:13 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:46:13 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:46:13 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:46:15 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 14:46:15 music volumio[1086]: info: Received Get System Info Aug 20 14:46:15 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 14:46:15 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 14:46:15 music volumio[1086]: info: Discovery: Getting this device information Aug 20 14:46:15 music volumio[1086]: info: CoreCommandRouter::volumioGetState Aug 20 14:46:15 music volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 14:46:16 music volumio[1086]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Aug 20 14:46:16 music volumio[1086]: info: PLUGIN onShutdown : networkfs Aug 20 14:46:16 music volumio[1086]: info: PLUGIN onShutdown : audiophonicsonoff Aug 20 14:46:16 music volumio[1086]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 14:46:16 music volumio[1086]: TypeError: Cannot read property 'writeSync' of undefined Aug 20 14:46:16 music volumio[1086]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_controller/audiophonicsonoff/index.js:43:25) Aug 20 14:46:16 music volumio[1086]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) Aug 20 14:46:16 music volumio[1086]: at HashMap. (/volumio/app/pluginmanager.js:621:31) Aug 20 14:46:16 music volumio[1086]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 20 14:46:16 music volumio[1086]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 20 14:46:16 music volumio[1086]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) Aug 20 14:46:16 music volumio[1086]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1319:24) Aug 20 14:46:16 music volumio[1086]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) Aug 20 14:46:16 music volumio[1086]: at Socket.emit (events.js:315:20) Aug 20 14:46:16 music volumio[1086]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 20 14:46:16 music volumio[1086]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 20 14:46:16 music volumio[1086]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 14:46:18 music sudo[1853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-20 14:45 Aug 20 14:46:18 music sudo[1853]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 14:46:18 music wpa_supplicant[962]: wlan0: Failed to initiate sched scan 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"