-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Thu 2024-10-10 10:47:49 CST. -- Oct 10 10:46:19 ft4385-9f55 sudo[5542]: volumio : TTY=pts/0 ; PWD=/mnt/NAS ; USER=root ; COMMAND=/usr/sbin/service demo stop Oct 10 10:46:19 ft4385-9f55 sudo[5542]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Oct 10 10:46:19 ft4385-9f55 systemd[1]: Configuration file /etc/systemd/system/volspotconnect2.service is marked executable. Please remove executable permission bits. Proceeding anyway. Oct 10 10:46:19 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 192.168.23.250 on eth0. Oct 10 10:46:19 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 127.0.0.1 on lo. Oct 10 10:46:19 ft4385-9f55 avahi-daemon[2148]: Host name conflict, retrying with ft4385-6507 Oct 10 10:46:19 ft4385-9f55 avahi-daemon[2148]: Registering new address record for fe80::4813:e4ff:fef9:7975 on eth0.*. Oct 10 10:46:19 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 192.168.23.250 on eth0.IPv4. Oct 10 10:46:19 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 127.0.0.1 on lo.IPv4. Oct 10 10:46:23 ft4385-9f55 systemd[1]: Stopping Demo Service... Oct 10 10:46:23 ft4385-9f55 systemd[1]: demo.service: Succeeded. Oct 10 10:46:23 ft4385-9f55 systemd[1]: Stopped Demo Service. Oct 10 10:46:23 ft4385-9f55 sudo[5542]: pam_unix(sudo:session): session closed for user root Oct 10 10:46:39 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 192.168.23.250 on eth0. Oct 10 10:46:39 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 127.0.0.1 on lo. Oct 10 10:46:39 ft4385-9f55 avahi-daemon[2148]: Host name conflict, retrying with ft4385-6508 Oct 10 10:46:39 ft4385-9f55 avahi-daemon[2148]: Registering new address record for fe80::4813:e4ff:fef9:7975 on eth0.*. Oct 10 10:46:39 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 192.168.23.250 on eth0.IPv4. Oct 10 10:46:39 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 127.0.0.1 on lo.IPv4. Oct 10 10:46:50 ft4385-9f55 systemd[1]: Starting Cleanup of Temporary Directories... Oct 10 10:46:50 ft4385-9f55 systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Oct 10 10:46:50 ft4385-9f55 systemd[1]: Finished Cleanup of Temporary Directories. Oct 10 10:46:59 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 192.168.23.250 on eth0. Oct 10 10:46:59 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 127.0.0.1 on lo. Oct 10 10:46:59 ft4385-9f55 avahi-daemon[2148]: Host name conflict, retrying with ft4385-6509 Oct 10 10:46:59 ft4385-9f55 avahi-daemon[2148]: Registering new address record for fe80::4813:e4ff:fef9:7975 on eth0.*. Oct 10 10:46:59 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 192.168.23.250 on eth0.IPv4. Oct 10 10:46:59 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 127.0.0.1 on lo.IPv4. Oct 10 10:47:00 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 10 10:47:00 ft4385-9f55 volumio[3315]: error: Could not retrieve plugin audio_interface multiroom Oct 10 10:47:00 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::volumioGetVisibleSources Oct 10 10:47:00 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 10 10:47:00 ft4385-9f55 volumio[3315]: info: Listing playlists Oct 10 10:47:01 ft4385-9f55 su[5584]: (to root) volumio on pts/0 Oct 10 10:47:01 ft4385-9f55 su[5584]: pam_unix(su:session): session opened for user root by volumio(uid=1000) Oct 10 10:47:06 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 10 10:47:06 ft4385-9f55 volumio[3315]: error: Could not retrieve plugin audio_interface multiroom Oct 10 10:47:06 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::volumioGetVisibleSources Oct 10 10:47:06 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 10 10:47:06 ft4385-9f55 volumio[3315]: info: Listing playlists Oct 10 10:47:19 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 192.168.23.250 on eth0. Oct 10 10:47:19 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 127.0.0.1 on lo. Oct 10 10:47:19 ft4385-9f55 avahi-daemon[2148]: Host name conflict, retrying with ft4385-6510 Oct 10 10:47:19 ft4385-9f55 avahi-daemon[2148]: Registering new address record for fe80::4813:e4ff:fef9:7975 on eth0.*. Oct 10 10:47:19 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 192.168.23.250 on eth0.IPv4. Oct 10 10:47:19 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 127.0.0.1 on lo.IPv4. Oct 10 10:47:39 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 192.168.23.250 on eth0. Oct 10 10:47:39 ft4385-9f55 avahi-daemon[2148]: Withdrawing address record for 127.0.0.1 on lo. Oct 10 10:47:39 ft4385-9f55 avahi-daemon[2148]: Host name conflict, retrying with ft4385-6511 Oct 10 10:47:39 ft4385-9f55 avahi-daemon[2148]: Registering new address record for fe80::4813:e4ff:fef9:7975 on eth0.*. Oct 10 10:47:39 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 192.168.23.250 on eth0.IPv4. Oct 10 10:47:39 ft4385-9f55 avahi-daemon[2148]: Registering new address record for 127.0.0.1 on lo.IPv4. Oct 10 10:47:45 ft4385-9f55 socketio[2350]: socket disconnet Oct 10 10:47:45 ft4385-9f55 socketio[2350]: IP is 127.0.0.1 Oct 10 10:47:45 ft4385-9f55 socketio[2350]: Port is 49856 Oct 10 10:47:45 ft4385-9f55 socketio[2350]: 10 Oct 10 10:47:45 ft4385-9f55 socketio[2350]: command_len 507 Oct 10 10:47:45 ft4385-9f55 socketio[2350]: pushSrctotal Oct 10 10:47:45 ft4385-9f55 socketio[2350]: { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "total": 11, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "cur": 0, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "source": [{ Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 0, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "Media Player" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 4, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "Bluetooth" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 2, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "DAB" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 3, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "FM" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 1, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "CD" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 5, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "USB Audio" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 6, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "Aux 1" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 6, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "Aux 2" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 5, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "Optical" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 5, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "Coaxial" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }, { Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "type": 0, Oct 10 10:47:45 ft4385-9f55 socketio[2350]: "name": "HDMI ARC" Oct 10 10:47:45 ft4385-9f55 socketio[2350]: }] Oct 10 10:47:45 ft4385-9f55 socketio[2350]: } Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 9 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: getState Oct 10 10:47:46 ft4385-9f55 socketio[2350]: Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 31 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: pushSourceInfo Oct 10 10:47:46 ft4385-9f55 socketio[2350]: { Oct 10 10:47:46 ft4385-9f55 socketio[2350]: "source": 0 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: } Oct 10 10:47:46 ft4385-9f55 socketio[2350]: socket send Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 36 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 14 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 9 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 14 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 17 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: setDeviceName Oct 10 10:47:46 ft4385-9f55 socketio[2350]: {"name":"FT4385-6450"} Oct 10 10:47:46 ft4385-9f55 socketio[2350]: getDeviceName Oct 10 10:47:46 ft4385-9f55 socketio[2350]: Oct 10 10:47:46 ft4385-9f55 socketio[2350]: getQueue Oct 10 10:47:46 ft4385-9f55 socketio[2350]: Oct 10 10:47:46 ft4385-9f55 socketio[2350]: getDeviceName Oct 10 10:47:46 ft4385-9f55 socketio[2350]: Oct 10 10:47:46 ft4385-9f55 socketio[2350]: getSystemVersion Oct 10 10:47:46 ft4385-9f55 socketio[2350]: Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 36 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: setDeviceName Oct 10 10:47:46 ft4385-9f55 socketio[2350]: {"name":"FT4385-6450"} Oct 10 10:47:46 ft4385-9f55 socketio[2350]: command_len 14 Oct 10 10:47:46 ft4385-9f55 socketio[2350]: getDeviceName Oct 10 10:47:46 ft4385-9f55 socketio[2350]: Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: System name has changed, restarting Shairport Sync Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 10 10:47:46 ft4385-9f55 volumio[3315]: [SpotifyConnect2] Creating VLS config file Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 10 10:47:46 ft4385-9f55 volumio[3315]: [SpotifyConnect2] <> or Mixer found, using softvol Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: Stopping playback through UPNP Oct 10 10:47:46 ft4385-9f55 volumio[3315]: /usr/bin/sudo /usr/bin/killall upmpdcli Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::volumioGetQueue Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreStateMachine::getQueue Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CorePlayQueue::getQueue Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: Received Get System Version Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 10 10:47:46 ft4385-9f55 socketio[2350]: socket send Oct 10 10:47:46 ft4385-9f55 socketio[2350]: socket send Oct 10 10:47:46 ft4385-9f55 socketio[2350]: socket send Oct 10 10:47:46 ft4385-9f55 socketio[2350]: socket send Oct 10 10:47:46 ft4385-9f55 sudo[5742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Oct 10 10:47:46 ft4385-9f55 socketio[2350]: socket send Oct 10 10:47:46 ft4385-9f55 sudo[5742]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 10 10:47:46 ft4385-9f55 sudo[5742]: pam_unix(sudo:session): session closed for user root Oct 10 10:47:46 ft4385-9f55 sudo[5753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Oct 10 10:47:46 ft4385-9f55 volumio[3315]: info: Starting Shairport Sync Oct 10 10:47:46 ft4385-9f55 volumio[3315]: [SpotifyConnect2] Restarting Vollibrespot Daemon Oct 10 10:47:47 ft4385-9f55 sudo[5753]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 10 10:47:47 ft4385-9f55 sudo[5760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 10 10:47:47 ft4385-9f55 sudo[5753]: pam_unix(sudo:session): session closed for user root Oct 10 10:47:47 ft4385-9f55 sudo[5760]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 10 10:47:47 ft4385-9f55 volumio[3315]: info: Permissions for /etc/hosts set Oct 10 10:47:47 ft4385-9f55 sudo[5767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Oct 10 10:47:47 ft4385-9f55 sudo[5767]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 10 10:47:47 ft4385-9f55 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 10 10:47:47 ft4385-9f55 systemd[1]: shairport-sync.service: Succeeded. Oct 10 10:47:47 ft4385-9f55 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 10 10:47:47 ft4385-9f55 volumio[3315]: info: Hostname now is ft4385-6450 Oct 10 10:47:47 ft4385-9f55 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 10 10:47:47 ft4385-9f55 sudo[5760]: pam_unix(sudo:session): session closed for user root Oct 10 10:47:47 ft4385-9f55 systemd[1]: upmpdcli.service: Succeeded. Oct 10 10:47:47 ft4385-9f55 volumio[3315]: info: Shairport-Sync Started Oct 10 10:47:47 ft4385-9f55 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 10 10:47:47 ft4385-9f55 systemd[1]: volspotconnect2.service: Succeeded. Oct 10 10:47:47 ft4385-9f55 systemd[1]: Stopped Volspotconnect2 Daemon. Oct 10 10:47:47 ft4385-9f55 systemd[1]: Started Volspotconnect2 Daemon. Oct 10 10:47:47 ft4385-9f55 sudo[5767]: pam_unix(sudo:session): session closed for user root Oct 10 10:47:47 ft4385-9f55 volumio[3315]: [SpotifyConnect2] Vollibrespot Daemon service restarted! Oct 10 10:47:47 ft4385-9f55 volumio[3315]: 捕捉到端口信息: 34213 Oct 10 10:47:47 ft4385-9f55 volumio[3315]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 10 10:47:47 ft4385-9f55 volumio[3315]: Error: Could not parse XML string Oct 10 10:47:47 ft4385-9f55 volumio[3315]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:204:19 Oct 10 10:47:47 ft4385-9f55 volumio[3315]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49) Oct 10 10:47:47 ft4385-9f55 volumio[3315]: at fs.readFile (/volumio/app/plugins/music_service/volspotconnect2/index.js:865:29) Oct 10 10:47:47 ft4385-9f55 volumio[3315]: at /volumio/node_modules/graceful-fs/graceful-fs.js:123:16 Oct 10 10:47:47 ft4385-9f55 volumio[3315]: at FSReqWrap.readFileAfterClose [as oncomplete] (internal/fs/read_file_context.js:53:3) Oct 10 10:47:47 ft4385-9f55 volumio[3315]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 10 10:47:49 ft4385-9f55 sudo[5820]: volumio : unable to resolve host ft4385-9f55 Oct 10 10:47:49 ft4385-9f55 sudo[5820]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 10 10:47:49 ft4385-9f55 sudo[5820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-10 10:46 Oct 10 10:47:49 ft4385-9f55 sudo[5820]: pam_unix(sudo:session): session opened for user root by (uid=0) NAME="Ubuntu" VERSION="20.04.5 LTS (Focal Fossa)" ID=ubuntu ID_LIKE=debian PRETTY_NAME="Ubuntu 20.04.5 LTS" VERSION_ID="20.04" HOME_URL="https://www.ubuntu.com/" SUPPORT_URL="https://help.ubuntu.com/" BUG_REPORT_URL="https://bugs.launchpad.net/ubuntu/" PRIVACY_POLICY_URL="https://www.ubuntu.com/legal/terms-and-policies/privacy-policy" VERSION_CODENAME=focal UBUNTU_CODENAME=focal VOLUMIO_BUILD_VERSION="" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VERSION=2024.09.20.96 VOLUMIO_BUILD_DATE=2024-09-20 16:24:53 VOLUMIO_VARIANT=volumio VOLUMIO_HARDWARE=Generic DT based system