-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Sat 2025-06-14 11:50:42 EDT. -- Jun 14 11:49:01 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:49:01 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:49:01 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:49:02 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:08 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:11 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:49:14 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:20 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:21 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:49:21 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:49:21 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:49:26 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:31 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:49:33 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:39 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:41 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:49:41 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:49:41 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:49:45 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:51 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:49:51 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:49:58 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:50:01 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:01 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:50:01 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:50:04 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:50:05 volumio-living volumio[5399]: info: [squeezelite_mc] 'client' notification received from pCP-LMS (192.168.3.61); type is 'disconnect' Jun 14 11:50:10 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:50:10 volumio-living volumio[5399]: info: [squeezelite_mc] 'client' notification received from pCP-LMS (192.168.3.61); type is 'connect' Jun 14 11:50:10 volumio-living volumio[5399]: info: [squeezelite_mc] Getting players connected to pCP-LMS (192.168.3.61) Jun 14 11:50:10 volumio-living volumio[5399]: info: [squeezelite_mc] Players connected to pCP-LMS (192.168.3.61): [{"id":"00:04:20:2a:6e:11","uuid":"8ba1918f8623eeee2ca52da24a4c5d74","ip":"192.168.0.11","name":"Squeezebox Radio","server":{"ip":"192.168.3.61","name":"pCP-LMS","ver":"7.999.999","uuid":"3a9627f6-390a-4012-9749-e98428a5ceae","jsonPort":"9000","cliPort":"9090"}},{"id":"b8:27:eb:80:5a:79","uuid":null,"ip":"192.168.3.65","name":"lms-living","server":{"ip":"192.168.3.61","name":"pCP-LMS","ver":"7.999.999","uuid":"3a9627f6-390a-4012-9749-e98428a5ceae","jsonPort":"9000","cliPort":"9090"}},{"id":"b8:27:eb:53:22:24","uuid":null,"ip":"192.168.3.66","name":"lms-office","server":{"ip":"192.168.3.61","name":"pCP-LMS","ver":"7.999.999","uuid":"3a9627f6-390a-4012-9749-e98428a5ceae","jsonPort":"9000","cliPort":"9090"}},{"id":"b8:27:eb:35:96:7a","uuid":null,"ip":"192.168.3.67","name":"lms-bedroom","server":{"ip":"192.168.3.61","name":"pCP-LMS","ver":"7.999.999","uuid":"3a9627f6-390a-4012-9749-e98428a5ceae","jsonPort":"9000","cliPort":"9090"}}] Jun 14 11:50:11 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:11 volumio-living volumio[5399]: info: [squeezelite_mc] #pushState(): {"status":"play","service":"squeezelite_mc","title":"現正收聽 - 高清雷霆881","albumart":"http://192.168.3.65:38249/?server_name=pCP-LMS&url=http%3A%2F%2F192.168.3.61%3A9000%2Fimageproxy%2Fhttp%253A%252F%252F192.168.3.61%253A35817%252F8ff31d7444b86080f300ee031e0fbf66%252Fcover.jpeg%2Fimage.jpg&fallback=http%3A%2F%2F192.168.3.65%2Falbumart","uri":"","trackType":"ShairTunes Stream, wav","duration":0,"samplerate":"44100 Hz","isStreaming":true,"volume":100,"repeat":false,"repeatSingle":false,"random":false} Jun 14 11:50:11 volumio-living volumio[5399]: info: CoreCommandRouter::servicePushState Jun 14 11:50:11 volumio-living volumio[5399]: info: CoreStateMachine::pushState Jun 14 11:50:11 volumio-living volumio[5399]: info: CoreCommandRouter::volumioPushState Jun 14 11:50:11 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:16 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:50:21 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:21 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:50:21 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:50:22 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:50:28 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:50:31 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:32 volumio-living sudo[10288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 14 11:50:32 volumio-living sudo[10288]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 11:50:32 volumio-living sudo[10288]: pam_unix(sudo:session): session closed for user root Jun 14 11:50:32 volumio-living sudo[10291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 11:50:32 volumio-living sudo[10291]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 11:50:32 volumio-living sudo[10291]: pam_unix(sudo:session): session closed for user root Jun 14 11:50:32 volumio-living volumio[5399]: verbose: New Socket.io Connection to 192.168.3.65 from 192.168.0.29 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 14 11:50:32 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 14 11:50:32 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 14 11:50:33 volumio-living sudo[10294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 14 11:50:33 volumio-living sudo[10294]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 11:50:33 volumio-living sudo[10294]: pam_unix(sudo:session): session closed for user root Jun 14 11:50:33 volumio-living sudo[10296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 11:50:33 volumio-living sudo[10296]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 11:50:33 volumio-living sudo[10296]: pam_unix(sudo:session): session closed for user root Jun 14 11:50:33 volumio-living volumio[5399]: verbose: New Socket.io Connection to 192.168.3.65 from 192.168.0.29 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetVisibleSources Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 14 11:50:33 volumio-living volumio[5399]: info: Received Get System Info Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 14 11:50:33 volumio-living volumio[5399]: info: Discovery: Getting this device information Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:33 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 14 11:50:33 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 14 11:50:33 volumio-living volumio[5399]: error: [squeezelite_mc] Proxy: invalid URL (http%3A%2F%2F192.168.3.61%3A9000%2Fimageproxy%2Fhttp%253A%252F%252F192.168.3.61%253A35817%252F8ff31d7444b86080f300ee031e0fbf66%252Fcover.jpeg%2Fimage.jpg) Jun 14 11:50:33 volumio-living volumio[5399]: info: [squeezelite_mc] Proxy request for pCP-LMS, URL: http://192.168.3.61:9000/imageproxy/http%3A%2F%2F192.168.3.61%3A35817%2F8ff31d7444b86080f300ee031e0fbf66%2Fcover.jpeg/image.jpg Jun 14 11:50:34 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:34 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:50:34 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 14 11:50:35 volumio-living volumio[5399]: info: Received Get System Info Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 14 11:50:35 volumio-living volumio[5399]: info: Discovery: Getting this device information Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 14 11:50:35 volumio-living volumio[5399]: info: Received Get System Info Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 14 11:50:35 volumio-living volumio[5399]: info: Discovery: Getting this device information Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:35 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 14 11:50:36 volumio-living volumio[5399]: info: [squeezelite_mc] Proxy request for pCP-LMS, URL: http://192.168.3.61:9000/imageproxy/http%3A%2F%2F192.168.3.61%3A35817%2F8ff31d7444b86080f300ee031e0fbf66%2Fcover.jpeg/image.jpg Jun 14 11:50:36 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 14 11:50:36 volumio-living volumio[5399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 14 11:50:39 volumio-living volumio[5399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Jun 14 11:50:39 volumio-living sudo[10339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Jun 14 11:50:39 volumio-living sudo[10339]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 11:50:39 volumio-living systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Jun 14 11:50:40 volumio-living systemd[1]: squeezelite.service: Succeeded. Jun 14 11:50:40 volumio-living systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Jun 14 11:50:40 volumio-living sudo[10339]: pam_unix(sudo:session): session closed for user root Jun 14 11:50:40 volumio-living wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network Jun 14 11:50:40 volumio-living volumio[5399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jun 14 11:50:40 volumio-living sudo[10356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jun 14 11:50:40 volumio-living sudo[10356]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 11:50:40 volumio-living sudo[10356]: pam_unix(sudo:session): session closed for user root Jun 14 11:50:40 volumio-living volumio[5399]: info: Disabling plugin squeezelite_mc Jun 14 11:50:40 volumio-living volumio[5399]: info: Done. Jun 14 11:50:41 volumio-living volumio[5399]: info: CoreCommandRouter::volumioGetState Jun 14 11:50:41 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:50:41 volumio-living volumio[5399]: info: Listing playlists Jun 14 11:50:41 volumio-living volumio[5399]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 11:50:41 volumio-living volumio[5399]: TypeError: Cannot read property 'logger' of null Jun 14 11:50:41 volumio-living volumio[5399]: at SqueezeliteMCContext.getLogger (/data/plugins/music_service/squeezelite_mc/dist/lib/SqueezeliteMCContext.js:64:86) Jun 14 11:50:41 volumio-living volumio[5399]: at Server. (/data/plugins/music_service/squeezelite_mc/dist/lib/Proxy.js:73:48) Jun 14 11:50:41 volumio-living volumio[5399]: at Object.onceWrapper (events.js:421:28) Jun 14 11:50:41 volumio-living volumio[5399]: at Server.emit (events.js:315:20) Jun 14 11:50:41 volumio-living volumio[5399]: at emitCloseNT (net.js:1659:8) Jun 14 11:50:41 volumio-living volumio[5399]: at processTicksAndRejections (internal/process/task_queues.js:79:21) Jun 14 11:50:41 volumio-living volumio[5399]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 11:50:42 volumio-living sudo[10367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 11:49 Jun 14 11:50:42 volumio-living sudo[10367]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"