-- Logs begin at Mon 2024-04-22 19:32:47 CEST, end at Tue 2024-04-23 09:51:33 CEST. --
Apr 23 09:51:28 motivo sudo[17659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 09:51:28 motivo sudo[17659]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 09:51:28 motivo sudo[17659]: pam_unix(sudo:session): session closed for user root
Apr 23 09:51:28 motivo sudo[17662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 09:51:28 motivo sudo[17662]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 09:51:28 motivo sudo[17662]: pam_unix(sudo:session): session closed for user root
Apr 23 09:51:28 motivo volumio[830]: verbose: New Socket.io Connection to 192.168.1.152 from 192.168.1.169 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 8
Apr 23 09:51:28 motivo sudo[17665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 09:51:28 motivo sudo[17665]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 09:51:28 motivo sudo[17665]: pam_unix(sudo:session): session closed for user root
Apr 23 09:51:28 motivo sudo[17668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 09:51:28 motivo sudo[17668]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 09:51:28 motivo sudo[17668]: pam_unix(sudo:session): session closed for user root
Apr 23 09:51:28 motivo volumio[830]: verbose: New Socket.io Connection to 192.168.1.152 from 192.168.1.169 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 9
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::volumioGetState
Apr 23 09:51:28 motivo volumio[830]: info: CorePlayQueue::getTrack 0
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 09:51:28 motivo volumio[830]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Apr 23 09:51:28 motivo volumio[830]: info: Received Get System Info
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 09:51:28 motivo volumio[830]: info: Discovery: Getting this device information
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::volumioGetState
Apr 23 09:51:28 motivo volumio[830]: info: CorePlayQueue::getTrack 0
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::volumioGetState
Apr 23 09:51:28 motivo volumio[830]: info: CorePlayQueue::getTrack 0
Apr 23 09:51:28 motivo volumio[830]: info: Listing playlists
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 23 09:51:28 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 23 09:51:29 motivo volumio[830]: info: CoreCommandRouter::volumioGetState
Apr 23 09:51:29 motivo volumio[830]: info: CorePlayQueue::getTrack 0
Apr 23 09:51:30 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 23 09:51:30 motivo volumio[830]: info: Received Get System Info
Apr 23 09:51:30 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 09:51:30 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 09:51:30 motivo volumio[830]: info: Discovery: Getting this device information
Apr 23 09:51:30 motivo volumio[830]: info: CoreCommandRouter::volumioGetState
Apr 23 09:51:30 motivo volumio[830]: info: CorePlayQueue::getTrack 0
Apr 23 09:51:30 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 09:51:30 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Apr 23 09:51:30 motivo volumio[830]: info: MyVolumio login type: Token
Apr 23 09:51:31 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 23 09:51:31 motivo volumio[830]: info: Received Get System Info
Apr 23 09:51:31 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 09:51:31 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 09:51:31 motivo volumio[830]: info: Discovery: Getting this device information
Apr 23 09:51:31 motivo volumio[830]: info: CoreCommandRouter::volumioGetState
Apr 23 09:51:31 motivo volumio[830]: info: CorePlayQueue::getTrack 0
Apr 23 09:51:31 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 09:51:31 motivo volumio[830]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Apr 23 09:51:31 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Apr 23 09:51:31 motivo volumio[830]: info: MyVolumio login type: Token
Apr 23 09:51:32 motivo volumio[830]: info: MyVolumio token set successfully
Apr 23 09:51:32 motivo volumio[830]: info: MYVOLUMIO: Adding device
Apr 23 09:51:32 motivo volumio[830]: info: MYVOLUMIO: Evaluating Server
Apr 23 09:51:32 motivo volumio[830]: info: MyVolumio Plan changed: superstar
Apr 23 09:51:32 motivo volumio[830]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar
Apr 23 09:51:32 motivo volumio[830]: info: Adding audio output:
Apr 23 09:51:32 motivo volumio[830]: error: Can't add:
Apr 23 09:51:32 motivo volumio[830]: info: MYVOLUMIO: Adding device
Apr 23 09:51:32 motivo volumio[830]: info: MYVOLUMIO: Evaluating Server
Apr 23 09:51:32 motivo volumio[830]: info: Remote config written successfully
Apr 23 09:51:32 motivo volumio[830]: info: Starting Tunnel 1
Apr 23 09:51:32 motivo volumio[830]: info: Starting Tunnel Connection Checker
Apr 23 09:51:32 motivo sudo[17696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Apr 23 09:51:32 motivo sudo[17696]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 09:51:32 motivo autossh[8962]: received signal to exit (15)
Apr 23 09:51:32 motivo systemd[1]: Stopping MyVolumio SSH Tunnel...
Apr 23 09:51:32 motivo systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Apr 23 09:51:32 motivo systemd[1]: sshtunnel.service: Succeeded.
Apr 23 09:51:32 motivo systemd[1]: Stopped MyVolumio SSH Tunnel.
Apr 23 09:51:32 motivo systemd[1]: Started MyVolumio SSH Tunnel.
Apr 23 09:51:32 motivo sudo[17696]: pam_unix(sudo:session): session closed for user root
Apr 23 09:51:32 motivo volumio[830]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 23 09:51:32 motivo volumio[830]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 23 09:51:32 motivo autossh[17699]: port set to 0, monitoring disabled
Apr 23 09:51:32 motivo autossh[17699]: starting ssh (count 1)
Apr 23 09:51:32 motivo autossh[17699]: ssh child pid is 17702
Apr 23 09:51:32 motivo volumiossh-tunnel[17698]: Warning: Permanently added '[eu5.myvolumio.org]:2222,[185.14.184.111]:2222' (RSA) to the list of known hosts.
Apr 23 09:51:33 motivo volumio[830]: info: MYVolumio Device enabled
Apr 23 09:51:33 motivo volumio[830]: info: MyVolumio status changed
Apr 23 09:51:33 motivo volumio[830]: info: Streaming services startup
Apr 23 09:51:33 motivo volumio[830]: info: Starting Streaming Daemon
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Apr 23 09:51:33 motivo volumio[830]: info: Setting Geolocation for MyVolumio to eu5
Apr 23 09:51:33 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 09:51:33 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 09:51:33 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 09:51:33 motivo sudo[17720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 23 09:51:33 motivo sudo[17720]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 09:51:33 motivo volumio[830]: info: Remote SSH Started
Apr 23 09:51:33 motivo sudo[17720]: pam_unix(sudo:session): session closed for user root
Apr 23 09:51:33 motivo volumio[830]: error: Cannot start Volumio Streaming Daemon
Apr 23 09:51:33 motivo volumio[830]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 23 09:51:33 motivo volumio[830]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 23 09:51:33 motivo volumio[830]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10
Apr 23 09:51:33 motivo volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin audio_interface/bluetooth is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin audio_interface/multiroom is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin miscellanea/metavolumio is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin miscellanea/manifestui is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin music_service/cd_controller is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin music_service/smart_inputs is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin music_service/hi_res_audio is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin music_service/tidal is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin music_service/qobuz is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: info: [MyVolumio PluginManager] Plugin music_service/tidalconnect is enabled for this plan, but could not be found on the local filesystem!
Apr 23 09:51:33 motivo volumio[830]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 09:51:33 motivo volumio[830]: Error: Unable to resolve or reject the same promise twice
Apr 23 09:51:33 motivo volumio[830]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Apr 23 09:51:33 motivo volumio[830]: at Array. (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5676)
Apr 23 09:51:33 motivo volumio[830]: at Promise.reject (/volumio/node_modules/kew/kew.js:204:26)
Apr 23 09:51:33 motivo volumio[830]: at nextTickCallback (/volumio/node_modules/kew/kew.js:49:11)
Apr 23 09:51:33 motivo volumio[830]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 23 09:51:33 motivo volumio[830]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 09:51:33 motivo sudo[17731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-23 09:50
Apr 23 09:51:33 motivo sudo[17731]: 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="b51559ff3f3719e35ff52cb9ccf2ff401b5ecb06"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="f61678c696e00921b9f86a2ceee67cca65b9d5c8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="motivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 22 Apr 2024 07:23:49 PM CEST"
VOLUMIO_VERSION="3.654"
VOLUMIO_HARDWARE="cm4"
VOLUMIO_DEVICENAME="CM4"
VOLUMIO_VENDOR_MODEL="Volumio Motivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Motivo"
VOLUMIO_HASH="5fa8aed88b82db1221cbacf1bdbb9025"