-- Logs begin at Fri 2024-10-25 16:34:43 CEST, end at Fri 2024-10-25 16:54:19 CEST. -- Oct 25 16:53:00 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 16:53:00 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 16:53:00 sabrev3 volumio[923]: info: Discovery: Getting this device information Oct 25 16:53:00 sabrev3 volumio[923]: info: CoreCommandRouter::volumioGetState Oct 25 16:53:00 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 16:53:29 sabrev3 sudo[1878]: pam_unix(sudo:session): session closed for user root Oct 25 16:53:30 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 16:53:30 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 16:53:30 sabrev3 volumio[923]: info: Discovery: Getting this device information Oct 25 16:53:30 sabrev3 volumio[923]: info: CoreCommandRouter::volumioGetState Oct 25 16:53:30 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 16:53:47 sabrev3 sshd[1746]: pam_unix(sshd:session): session closed for user volumio Oct 25 16:53:47 sabrev3 systemd[1]: session-1.scope: Succeeded. Oct 25 16:53:47 sabrev3 systemd-logind[639]: Removed session 1. Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreCommandRouter::volumioStop Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreStateMachine::stop Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreStateMachine::stPlaybackTimer Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreStateMachine::updateTrackBlock Oct 25 16:53:49 sabrev3 volumio[923]: info: CorePlayQueue::getTrackBlock Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreStateMachine::pushState Oct 25 16:53:49 sabrev3 volumio[923]: info: CorePlayQueue::getTrack 0 Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreCommandRouter::volumioPushState Oct 25 16:53:49 sabrev3 volumio[923]: info: MRS: Pushing multiroomSync output update for this device Oct 25 16:53:49 sabrev3 volumio[923]: info: MRS: Pushing multiroomSync output Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreStateMachine::serviceStop Oct 25 16:53:49 sabrev3 volumio[923]: info: CorePlayQueue::getTrack 0 Oct 25 16:53:49 sabrev3 volumio[923]: info: CoreCommandRouter::serviceStop Oct 25 16:53:49 sabrev3 volumio[923]: info: [1729868029526] ControllerWebradio::stop Oct 25 16:53:49 sabrev3 volumio[923]: verbose: ControllerMpd::sendMpdCommand stop Oct 25 16:53:50 sabrev3 volumio[923]: info: sendMpdCommand stop took 1339 milliseconds Oct 25 16:53:50 sabrev3 volumio[923]: info: Oct 25 16:53:50 sabrev3 volumio[923]: ---------------------------- MPD announces state update: player Oct 25 16:53:50 sabrev3 volumio[923]: info: ControllerMpd::getState Oct 25 16:53:50 sabrev3 volumio[923]: verbose: ControllerMpd::sendMpdCommand status Oct 25 16:53:50 sabrev3 volumio[923]: info: sendMpdCommand status took 2 milliseconds Oct 25 16:53:50 sabrev3 volumio[923]: verbose: ControllerMpd::parseState Oct 25 16:53:50 sabrev3 volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 25 16:53:50 sabrev3 volumio[923]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 25 16:53:50 sabrev3 volumio[923]: verbose: ControllerMpd::parseTrackInfo Oct 25 16:53:50 sabrev3 volumio[923]: info: ControllerMpd::pushState Oct 25 16:53:50 sabrev3 volumio[923]: info: CoreCommandRouter::servicePushState Oct 25 16:53:50 sabrev3 volumio[923]: info: CoreStateMachine::pushState Oct 25 16:53:50 sabrev3 volumio[923]: info: CorePlayQueue::getTrack 0 Oct 25 16:53:50 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 16:53:50 sabrev3 volumio[923]: info: CoreCommandRouter::volumioPushState Oct 25 16:53:50 sabrev3 volumio[923]: info: MRS: Pushing multiroomSync output update for this device Oct 25 16:53:50 sabrev3 volumio[923]: info: MRS: Pushing multiroomSync output Oct 25 16:53:50 sabrev3 volumio[923]: info: CorePlayQueue::getTrack 0 Oct 25 16:53:50 sabrev3 volumio[923]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 25 16:53:50 sabrev3 volumio[923]: info: ------------------------------ 59ms Oct 25 16:53:51 sabrev3 kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Oct 25 16:53:51 sabrev3 volumio[923]: info: camilladsp spawned new process with pid 2770, instance 1, run: true Oct 25 16:53:52 sabrev3 kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Oct 25 16:54:00 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 16:54:00 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 16:54:00 sabrev3 volumio[923]: info: Discovery: Getting this device information Oct 25 16:54:00 sabrev3 volumio[923]: info: CoreCommandRouter::volumioGetState Oct 25 16:54:00 sabrev3 volumio[923]: info: CorePlayQueue::getTrack 0 Oct 25 16:54:00 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 16:54:01 sabrev3 systemd[1]: Stopping User Manager for UID 1000... Oct 25 16:54:01 sabrev3 volumio[923]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 25 16:54:01 sabrev3 systemd[1794]: Stopped target Default. Oct 25 16:54:01 sabrev3 systemd[1794]: Stopped target Basic System. Oct 25 16:54:01 sabrev3 systemd[1794]: Stopped target Paths. Oct 25 16:54:01 sabrev3 systemd[1794]: Stopped target Timers. Oct 25 16:54:01 sabrev3 systemd[1794]: Stopped target Sockets. Oct 25 16:54:01 sabrev3 systemd[1794]: dirmngr.socket: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1794]: Closed GnuPG network certificate management daemon. Oct 25 16:54:01 sabrev3 systemd[1794]: dbus.socket: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1794]: Closed D-Bus User Message Bus Socket. Oct 25 16:54:01 sabrev3 systemd[1794]: gpg-agent.socket: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1794]: Closed GnuPG cryptographic agent and passphrase cache. Oct 25 16:54:01 sabrev3 systemd[1794]: gpg-agent-browser.socket: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1794]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers). Oct 25 16:54:01 sabrev3 systemd[1794]: gpg-agent-ssh.socket: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1794]: Closed GnuPG cryptographic agent (ssh-agent emulation). Oct 25 16:54:01 sabrev3 systemd[1794]: pulseaudio.socket: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1794]: Closed Sound System. Oct 25 16:54:01 sabrev3 systemd[1794]: gpg-agent-extra.socket: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1794]: Closed GnuPG cryptographic agent and passphrase cache (restricted). Oct 25 16:54:01 sabrev3 systemd[1794]: Reached target Shutdown. Oct 25 16:54:01 sabrev3 systemd[1794]: systemd-exit.service: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1794]: Started Exit the Session. Oct 25 16:54:01 sabrev3 systemd[1794]: Reached target Exit the Session. Oct 25 16:54:01 sabrev3 systemd[1]: user@1000.service: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1]: Stopped User Manager for UID 1000. Oct 25 16:54:01 sabrev3 systemd[1]: Stopping User Runtime Directory /run/user/1000... Oct 25 16:54:01 sabrev3 volumio[923]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 25 16:54:01 sabrev3 systemd[1]: run-user-1000.mount: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1]: user-runtime-dir@1000.service: Succeeded. Oct 25 16:54:01 sabrev3 systemd[1]: Stopped User Runtime Directory /run/user/1000. Oct 25 16:54:01 sabrev3 systemd[1]: Removed slice User Slice of UID 1000. Oct 25 16:54:06 sabrev3 volumio[923]: info: CoreCommandRouter::volumioGetState Oct 25 16:54:06 sabrev3 volumio[923]: info: CorePlayQueue::getTrack 0 Oct 25 16:54:09 sabrev3 volumio[923]: info: Executing endpoint metavolumio Oct 25 16:54:09 sabrev3 volumio[923]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 25 16:54:11 sabrev3 volumio[923]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Oct 25 16:54:11 sabrev3 volumio[923]: info: PLUGIN onShutdown : networkfs Oct 25 16:54:11 sabrev3 sudo[2781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /mnt/NAS/jasmijn Oct 25 16:54:11 sabrev3 sudo[2781]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 16:54:12 sabrev3 sudo[2781]: pam_unix(sudo:session): session closed for user root Oct 25 16:54:12 sabrev3 systemd[1]: mnt-NAS-jasmijn.mount: Succeeded. Oct 25 16:54:12 sabrev3 volumio[923]: info: PLUGIN onShutdown : audiophonicsonoff Oct 25 16:54:12 sabrev3 volumio[923]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 16:54:12 sabrev3 volumio[923]: TypeError: Cannot read property 'writeSync' of undefined Oct 25 16:54:12 sabrev3 volumio[923]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_controller/audiophonicsonoff/index.js:43:25) Oct 25 16:54:12 sabrev3 volumio[923]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) Oct 25 16:54:12 sabrev3 volumio[923]: at HashMap. (/volumio/app/pluginmanager.js:621:31) Oct 25 16:54:12 sabrev3 volumio[923]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 25 16:54:12 sabrev3 volumio[923]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 25 16:54:12 sabrev3 volumio[923]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) Oct 25 16:54:12 sabrev3 volumio[923]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1319:24) Oct 25 16:54:12 sabrev3 volumio[923]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) Oct 25 16:54:12 sabrev3 volumio[923]: at Socket.emit (events.js:315:20) Oct 25 16:54:12 sabrev3 volumio[923]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 25 16:54:12 sabrev3 volumio[923]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 25 16:54:12 sabrev3 volumio[923]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 16:54:19 sabrev3 sudo[2793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-25 16:53 Oct 25 16:54:19 sabrev3 sudo[2793]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"