-- Logs begin at Mon 2024-07-22 19:51:27 +12, end at Mon 2024-07-22 19:59:33 +12. -- Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:21 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:21 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:25 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:25 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:27 volumio volumio[882]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%8E%E5%81%A5/%E4%BE%9D%E7%84%B6/bce14fab-a46d-4ad3-aadb-f4adf30f14d0.jpg' Jul 22 19:58:27 volumio volumio[882]: verbose: New Socket.io Connection to 192.168.200.2 from 192.168.200.154 UA: unknown Engine version: 3 Transport: websocket Total Clients: 6 Jul 22 19:58:27 volumio volumio[882]: info: CoreCommandRouter::volumioGetState Jul 22 19:58:27 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 22 19:58:27 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 22 19:58:27 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 22 19:58:27 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 22 19:58:27 volumio volumio[882]: info: Discovery: Getting this device information Jul 22 19:58:27 volumio volumio[882]: info: CoreCommandRouter::volumioGetState Jul 22 19:58:27 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:28 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:28 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:28 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:28 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:58:28 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:28 volumio shairport-sync[1998]: {"time":1721635036871,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jul 22 19:58:28 volumio shairport-sync[1998]: Dload Upload Total Spent Left Speed Jul 22 19:58:28 volumio volumio[882]: info: Jul 22 19:58:28 volumio volumio[882]: ---------------------------- Client requests Stop Airplay Playback Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Jul 22 19:58:28 volumio volumio[882]: info: Airplay playback stop Jul 22 19:58:28 volumio volumio[882]: info: Airplay Playback Stopped, clearing state Jul 22 19:58:28 volumio volumio[882]: info: CoreStateMachine::resetVolumioState Jul 22 19:58:28 volumio volumio[882]: info: CoreStateMachine::getcurrentVolume Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::volumioRetrievevolume Jul 22 19:58:28 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:58:28 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:58:28 volumio shairport-sync[1998]: [158B blob data] Jul 22 19:58:28 volumio volumio[882]: verbose: New Socket.io Connection to 192.168.200.2 from 192.168.200.154 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Jul 22 19:58:30 volumio sudo[2236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 22 19:58:30 volumio sudo[2236]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 19:58:30 volumio sudo[2236]: pam_unix(sudo:session): session closed for user root Jul 22 19:58:30 volumio sudo[2238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 19:58:30 volumio sudo[2238]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 19:58:30 volumio sudo[2238]: pam_unix(sudo:session): session closed for user root Jul 22 19:58:30 volumio volumio[882]: verbose: New Socket.io Connection to 192.168.200.2 from 192.168.200.154 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Jul 22 19:58:30 volumio volumio[882]: info: CoreCommandRouter::volumioGetState Jul 22 19:58:30 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 22 19:58:30 volumio volumio[882]: info: Listing playlists Jul 22 19:58:30 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 22 19:58:30 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 22 19:58:30 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 22 19:58:30 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 22 19:59:15 volumio volumio[882]: info: Airplay started streaming, receiving metadatas Jul 22 19:59:15 volumio shairport-sync[1998]: {"time":1721635108123,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jul 22 19:59:15 volumio shairport-sync[1998]: Dload Upload Total Spent Left Speed Jul 22 19:59:15 volumio volumio[882]: info: Jul 22 19:59:15 volumio volumio[882]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jul 22 19:59:15 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jul 22 19:59:15 volumio volumio[882]: info: Airplay playback start Jul 22 19:59:15 volumio shairport-sync[1998]: [158B blob data] Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:16 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:16 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:16 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:16 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:16 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:16 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:16 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:17 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:17 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:23 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:23 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:23 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:23 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::servicePushState Jul 22 19:59:23 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:23 volumio shairport-sync[1998]: {"time":1721635155799,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jul 22 19:59:23 volumio shairport-sync[1998]: Dload Upload Total Spent Left Speed Jul 22 19:59:23 volumio volumio[882]: info: Jul 22 19:59:23 volumio volumio[882]: ---------------------------- Client requests Stop Airplay Playback Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Jul 22 19:59:23 volumio volumio[882]: info: Airplay playback stop Jul 22 19:59:23 volumio volumio[882]: info: Airplay Playback Stopped, clearing state Jul 22 19:59:23 volumio volumio[882]: info: CoreStateMachine::resetVolumioState Jul 22 19:59:23 volumio volumio[882]: info: CoreStateMachine::getcurrentVolume Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::volumioRetrievevolume Jul 22 19:59:23 volumio shairport-sync[1998]: [158B blob data] Jul 22 19:59:23 volumio volumio[882]: info: CoreStateMachine::pushState Jul 22 19:59:23 volumio volumio[882]: info: CoreCommandRouter::volumioPushState Jul 22 19:59:33 volumio volumio[882]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 19:59:33 volumio volumio[882]: Error: connect ETIMEDOUT 199.59.149.136:443 Jul 22 19:59:33 volumio volumio[882]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 22 19:59:33 volumio volumio[882]: errno: -110, Jul 22 19:59:33 volumio volumio[882]: code: 'ETIMEDOUT', Jul 22 19:59:33 volumio volumio[882]: syscall: 'connect', Jul 22 19:59:33 volumio volumio[882]: address: '199.59.149.136', Jul 22 19:59:33 volumio volumio[882]: port: 443 Jul 22 19:59:33 volumio volumio[882]: } Jul 22 19:59:33 volumio volumio[882]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 19:59:33 volumio sudo[2355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 19:58 Jul 22 19:59:33 volumio sudo[2355]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"