-- Logs begin at Thu 2019-02-14 19:11:58 JST, end at Wed 2026-03-25 19:17:53 JST. -- Mar 25 19:16:00 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:16:00 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:16:00 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:16:00 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:16:00 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:16:00 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 19:16:04 motivo volumio[1024]: No protocol specified Mar 25 19:16:04 motivo volumio[1024]: xcb_connection_has_error() returned true Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 25 19:16:04 motivo volumio[1024]: No protocol specified Mar 25 19:16:04 motivo volumio[1024]: xcb_connection_has_error() returned true Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 19:16:04 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 25 19:16:05 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 25 19:16:05 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Mar 25 19:16:05 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Mar 25 19:16:05 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 25 19:16:05 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 25 19:16:58 motivo volumio[1024]: info: CoreCommandRouter::volumioGetState Mar 25 19:17:00 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:17:00 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:17:00 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:17:00 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:17:00 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:17:00 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:17:08 motivo volumio5-onboarding[1508]: time=2026-03-25T19:17:08.607+09:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.0.167:63010 @ 0x2cd6060" latency=29.875735ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Mar 25 19:17:08 motivo sudo[19450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 19:17:08 motivo sudo[19450]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:08 motivo sudo[19450]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:08 motivo sudo[19452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 19:17:08 motivo sudo[19452]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:08 motivo sudo[19452]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:09 motivo volumio[1024]: verbose: New Socket.io Connection to 192.168.0.8 from 192.168.0.167 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 9 Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 19:17:09 motivo sudo[19456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 19:17:09 motivo sudo[19456]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:09 motivo sudo[19456]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 25 19:17:09 motivo sudo[19459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 19:17:09 motivo sudo[19459]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:09 motivo sudo[19459]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:09 motivo volumio[1024]: verbose: New Socket.io Connection to 192.168.0.8 from 192.168.0.167 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 9 Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::volumioGetState Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::volumioGetQueue Mar 25 19:17:09 motivo volumio[1024]: info: CoreStateMachine::getQueue Mar 25 19:17:09 motivo volumio[1024]: info: CorePlayQueue::getQueue Mar 25 19:17:09 motivo volumio[1024]: info: Listing playlists Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 19:17:09 motivo volumio[1024]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 25 19:17:09 motivo volumio[1024]: info: Received Get System Info Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 19:17:09 motivo volumio[1024]: info: Discovery: Getting this device information Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::volumioGetState Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::volumioGetState Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 19:17:09 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 25 19:17:10 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 25 19:17:11 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 25 19:17:11 motivo volumio[1024]: info: Received Get System Info Mar 25 19:17:11 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 19:17:11 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 19:17:11 motivo volumio[1024]: info: Discovery: Getting this device information Mar 25 19:17:11 motivo volumio[1024]: info: CoreCommandRouter::volumioGetState Mar 25 19:17:11 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 19:17:12 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 25 19:17:12 motivo volumio[1024]: info: Received Get System Info Mar 25 19:17:12 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 19:17:12 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 19:17:12 motivo volumio[1024]: info: Discovery: Getting this device information Mar 25 19:17:12 motivo volumio[1024]: info: CoreCommandRouter::volumioGetState Mar 25 19:17:12 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 19:17:15 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Mar 25 19:17:15 motivo volumio[1024]: info: MRS: Starting browser stream Mar 25 19:17:15 motivo volumio[1024]: info: MRS: Setting this device as single Mar 25 19:17:15 motivo volumio[1024]: info: Mar 25 19:17:15 motivo volumio[1024]: [1774433835107] ---------------------------- Setting Multiroom Single Mar 25 19:17:15 motivo volumio[1024]: info: MRS: disable multiroom output Mar 25 19:17:15 motivo volumio[1024]: info: MRS: Set multiroom target PCM to volumioDiscard Mar 25 19:17:15 motivo volumio[1024]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Mar 25 19:17:15 motivo volumio[1024]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Mar 25 19:17:15 motivo volumio[1024]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Mar 25 19:17:16 motivo volumio[1024]: info: MRS: STOPPING volumioStreaming Mar 25 19:17:16 motivo sudo[19466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 25 19:17:16 motivo sudo[19466]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:16 motivo sudo[19469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream84.ts /tmp/hls/stream85.ts /tmp/hls/stream86.ts /tmp/hls/stream87.ts /tmp/hls/stream88.ts Mar 25 19:17:16 motivo sudo[19469]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:16 motivo systemd[1]: Stopping VolumioStreamingService... Mar 25 19:17:16 motivo sudo[19469]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:16 motivo systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Mar 25 19:17:16 motivo volumio[1024]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 25 19:17:16 motivo volumio[1024]: info: MRS: Removed streaming files Mar 25 19:17:16 motivo systemd[1]: volumioStreaming.service: Succeeded. Mar 25 19:17:16 motivo systemd[1]: Stopped VolumioStreamingService. Mar 25 19:17:16 motivo sudo[19466]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:16 motivo volumio[1024]: info: MRS: volumioStreaming STOPPED Mar 25 19:17:19 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 25 19:17:21 motivo volumio[1024]: info: CoreCommandRouter::volumioGetState Mar 25 19:17:23 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:17:23 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:17:23 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:17:23 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:17:23 motivo volumio[1024]: info: Executing endpoint metavolumio Mar 25 19:17:23 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 19:17:27 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 19:17:27 motivo volumio[1024]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 25 19:17:27 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 25 19:17:27 motivo volumio[1024]: info: Received Get System Version Mar 25 19:17:27 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 25 19:17:27 motivo volumio[1024]: info: Received Get System Info Mar 25 19:17:27 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 19:17:27 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 19:17:27 motivo volumio[1024]: info: Discovery: Getting this device information Mar 25 19:17:27 motivo volumio[1024]: info: CoreCommandRouter::volumioGetState Mar 25 19:17:27 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 19:17:53 motivo volumio[1024]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Mar 25 19:17:53 motivo volumio[1024]: info: MRS: Starting cast device: A1000-054c4380dbd37da0b99bb26e87c2a122 Mar 25 19:17:53 motivo volumio[1024]: info: Enabled audio output: A1000-054c4380dbd37da0b99bb26e87c2a122 Mar 25 19:17:53 motivo volumio[1024]: info: MRS: Setting this device as Streaming Server Mar 25 19:17:53 motivo volumio[1024]: info: Mar 25 19:17:53 motivo volumio[1024]: [1774433873180] ---------------------------- MRS: Setting Streaming Server Mar 25 19:17:53 motivo volumio[1024]: info: MRS: enable multiroom server output Mar 25 19:17:53 motivo volumio[1024]: info: MRS: Set multiroom target PCM to volumioMultiRoom Mar 25 19:17:53 motivo volumio[1024]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Mar 25 19:17:53 motivo volumio[1024]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Mar 25 19:17:53 motivo volumio[1024]: info: MRS: Connected to cast device: A1000-054c4380dbd37da0b99bb26e87c2a122 Mar 25 19:17:53 motivo volumio[1024]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Mar 25 19:17:53 motivo volumio[1024]: info: MRS: STARTING volumioStreaming Mar 25 19:17:53 motivo sudo[19576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 25 19:17:53 motivo sudo[19576]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:53 motivo volumio[1024]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 19:17:53 motivo volumio[1024]: TypeError: Cannot read property 'on' of undefined Mar 25 19:17:53 motivo volumio[1024]: at /volumio/app/plugins/audio_interface/multiroom/multiroom_real:1:29834 Mar 25 19:17:53 motivo volumio[1024]: at /volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:95:20 Mar 25 19:17:53 motivo volumio[1024]: at /volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/receiver.js:51:14 Mar 25 19:17:53 motivo volumio[1024]: at fn.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:27:7) Mar 25 19:17:53 motivo volumio[1024]: at fn.emit (events.js:327:22) Mar 25 19:17:53 motivo volumio[1024]: at Channel.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:16:10) Mar 25 19:17:53 motivo volumio[1024]: at Channel.emit (events.js:315:20) Mar 25 19:17:53 motivo volumio[1024]: at Client.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:23:10) Mar 25 19:17:53 motivo volumio[1024]: at Client.emit (events.js:327:22) Mar 25 19:17:53 motivo volumio[1024]: at PacketStreamWrapper.onpacket (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:81:10) Mar 25 19:17:53 motivo volumio[1024]: at PacketStreamWrapper.emit (events.js:315:20) Mar 25 19:17:53 motivo volumio[1024]: at TLSSocket. (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/packet-stream-wrapper.js:28:16) Mar 25 19:17:53 motivo volumio[1024]: at TLSSocket.emit (events.js:315:20) Mar 25 19:17:53 motivo volumio[1024]: at emitReadable_ (internal/streams/readable.js:569:12) Mar 25 19:17:53 motivo volumio[1024]: at processTicksAndRejections (internal/process/task_queues.js:79:21) Mar 25 19:17:53 motivo volumio[1024]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 19:17:53 motivo sudo[19576]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:53 motivo sudo[19578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Mar 25 19:17:53 motivo sudo[19578]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:53 motivo systemd[1]: Started VolumioStreamingService. Mar 25 19:17:53 motivo sudo[19578]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:53 motivo sudo[19589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 25 19:17:53 motivo sudo[19589]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 19:17:53 motivo sudo[19589]: pam_unix(sudo:session): session closed for user root Mar 25 19:17:53 motivo sudo[19594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-25 19:16 Mar 25 19:17:53 motivo sudo[19594]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="motivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 02:37:02 PM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="cm4" VOLUMIO_DEVICENAME="CM4" VOLUMIO_VENDOR_MODEL="Volumio Motivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Motivo" VOLUMIO_HASH="b74c3af44d427b3f5795469c952e44b4"