-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-07-12 18:10:08 CEST. --
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 18:09:52 motivo volumio[917]: info: Discovery: Getting this device information
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:09:52 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 18:09:52 motivo volumio[917]: info: Discovery: Getting this device information
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:09:52 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 18:09:52 motivo volumio[917]: info: Discovery: Getting this device information
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:09:52 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 18:09:56 motivo volumio[917]: verbose: New Socket.io Connection to 192.168.1.152:3000 from 192.168.1.53 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11
Jul 12 18:09:57 motivo sudo[29894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 12 18:09:57 motivo sudo[29894]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 12 18:09:57 motivo sudo[29894]: pam_unix(sudo:session): session closed for user root
Jul 12 18:09:57 motivo sudo[29897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 12 18:09:57 motivo sudo[29897]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 12 18:09:57 motivo sudo[29897]: pam_unix(sudo:session): session closed for user root
Jul 12 18:09:57 motivo volumio[917]: verbose: New Socket.io Connection to 192.168.1.152 from 192.168.1.53 UA: Mozilla/5.0 (Linux; Android 14; A065 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/126.0.6478.134 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Jul 12 18:09:57 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 12 18:09:57 motivo sudo[29900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 12 18:09:57 motivo sudo[29900]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 12 18:09:57 motivo sudo[29900]: pam_unix(sudo:session): session closed for user root
Jul 12 18:09:57 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 12 18:09:57 motivo sudo[29903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 12 18:09:57 motivo sudo[29903]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 12 18:09:57 motivo sudo[29903]: pam_unix(sudo:session): session closed for user root
Jul 12 18:09:58 motivo volumio[917]: verbose: New Socket.io Connection to 192.168.1.152 from 192.168.1.53 UA: Mozilla/5.0 (Linux; Android 14; A065 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/126.0.6478.134 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:09:58 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetQueue
Jul 12 18:09:58 motivo volumio[917]: info: CoreStateMachine::getQueue
Jul 12 18:09:58 motivo volumio[917]: info: CorePlayQueue::getQueue
Jul 12 18:09:58 motivo volumio[917]: info: Listing playlists
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 12 18:09:58 motivo volumio[917]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 12 18:09:58 motivo volumio[917]: info: Received Get System Info
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 18:09:58 motivo volumio[917]: info: Discovery: Getting this device information
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:09:58 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:09:58 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 12 18:10:00 motivo volumio[917]: info: Received Get System Info
Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 18:10:00 motivo volumio[917]: info: Discovery: Getting this device information
Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:10:00 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 12 18:10:05 motivo volumio[917]: info: Received Get System Info
Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 18:10:05 motivo volumio[917]: info: Discovery: Getting this device information
Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:10:05 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Jul 12 18:10:05 motivo volumio[917]: info: MyVolumio login type: Token
Jul 12 18:10:06 motivo volumio[917]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jul 12 18:10:07 motivo volumio[917]: info: MyVolumio token set successfully
Jul 12 18:10:07 motivo volumio[917]: info: MYVOLUMIO: Adding device
Jul 12 18:10:07 motivo volumio[917]: info: MYVOLUMIO: Evaluating Server
Jul 12 18:10:07 motivo volumio[917]: info: MyVolumio Plan changed: superstar
Jul 12 18:10:07 motivo volumio[917]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar
Jul 12 18:10:07 motivo volumio[917]: info: Adding audio output:
Jul 12 18:10:07 motivo volumio[917]: error: Can't add:
Jul 12 18:10:07 motivo volumio[917]: info: MYVOLUMIO: Adding device
Jul 12 18:10:07 motivo volumio[917]: info: MYVOLUMIO: Evaluating Server
Jul 12 18:10:07 motivo volumio[917]: info: Remote config written successfully
Jul 12 18:10:07 motivo volumio[917]: info: Starting Tunnel 1
Jul 12 18:10:07 motivo volumio[917]: info: Starting Tunnel Connection Checker
Jul 12 18:10:07 motivo sudo[29969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Jul 12 18:10:07 motivo sudo[29969]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 12 18:10:07 motivo autossh[20493]: received signal to exit (15)
Jul 12 18:10:07 motivo systemd[1]: Stopping MyVolumio SSH Tunnel...
Jul 12 18:10:07 motivo systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Jul 12 18:10:07 motivo systemd[1]: sshtunnel.service: Succeeded.
Jul 12 18:10:07 motivo systemd[1]: Stopped MyVolumio SSH Tunnel.
Jul 12 18:10:07 motivo volumio[917]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 12 18:10:07 motivo volumio[917]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 12 18:10:07 motivo systemd[1]: Started MyVolumio SSH Tunnel.
Jul 12 18:10:07 motivo sudo[29969]: pam_unix(sudo:session): session closed for user root
Jul 12 18:10:07 motivo autossh[29973]: port set to 0, monitoring disabled
Jul 12 18:10:07 motivo autossh[29973]: starting ssh (count 1)
Jul 12 18:10:07 motivo autossh[29973]: ssh child pid is 29976
Jul 12 18:10:07 motivo volumiossh-tunnel[29972]: Warning: Permanently added '[eu6.myvolumio.org]:2222,[207.154.233.230]:2222' (RSA) to the list of known hosts.
Jul 12 18:10:07 motivo volumio[917]: info: MYVolumio Device enabled
Jul 12 18:10:07 motivo volumio[917]: info: MyVolumio status changed
Jul 12 18:10:07 motivo volumio[917]: info: Streaming services startup
Jul 12 18:10:07 motivo volumio[917]: info: Starting Streaming Daemon
Jul 12 18:10:07 motivo volumio[917]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Jul 12 18:10:07 motivo volumio[917]: info: Setting Geolocation for MyVolumio to eu6
Jul 12 18:10:07 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 12 18:10:07 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 12 18:10:07 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 12 18:10:07 motivo sudo[29993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 12 18:10:07 motivo sudo[29993]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 12 18:10:07 motivo volumio[917]: info: Remote SSH Started
Jul 12 18:10:07 motivo sudo[29993]: pam_unix(sudo:session): session closed for user root
Jul 12 18:10:08 motivo volumio[917]: error: Cannot start Volumio Streaming Daemon
Jul 12 18:10:08 motivo volumio[917]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jul 12 18:10:08 motivo volumio[917]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jul 12 18:10:08 motivo volumio[917]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14
Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Jul 12 18:10:08 motivo volumio[917]: error: [MyVolumio PluginManager] Cache data is invalid!
Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::volumioGetState
Jul 12 18:10:08 motivo volumio[917]: info: CorePlayQueue::getTrack 0
Jul 12 18:10:08 motivo volumio[917]: info: Setting Geolocation for MyVolumio to eu6
Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 12 18:10:08 motivo volumio[917]: info: Successfully Added MyVolumio device
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin audio_interface/bluetooth is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin audio_interface/multiroom is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin miscellanea/metavolumio is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin miscellanea/manifestui is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/cd_controller is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/smart_inputs is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/hi_res_audio is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/tidal is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/qobuz is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/tidalconnect is enabled for this plan, but could not be found on the local filesystem!
Jul 12 18:10:08 motivo volumio[917]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 12 18:10:08 motivo volumio[917]: Error: Unable to resolve or reject the same promise twice
Jul 12 18:10:08 motivo volumio[917]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Jul 12 18:10:08 motivo volumio[917]: at Array. (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5676)
Jul 12 18:10:08 motivo volumio[917]: at Promise.reject (/volumio/node_modules/kew/kew.js:204:26)
Jul 12 18:10:08 motivo volumio[917]: at nextTickCallback (/volumio/node_modules/kew/kew.js:49:11)
Jul 12 18:10:08 motivo volumio[917]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jul 12 18:10:08 motivo volumio[917]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 12 18:10:08 motivo sudo[30004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-12 18:09
Jul 12 18:10:08 motivo sudo[30004]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="905ee02fb5387537cfa16b84ebd7f14b7640848e"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="motivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 10 Jul 2024 02:28:54 PM CEST"
VOLUMIO_VERSION="3.736"
VOLUMIO_HARDWARE="cm4"
VOLUMIO_DEVICENAME="CM4"
VOLUMIO_VENDOR_MODEL="Volumio Motivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Motivo"
VOLUMIO_HASH="28d513e532d28202d6c8000674492903"