-- Logs begin at Mon 2024-07-22 19:47:26 BST, end at Wed 2024-07-24 21:58:59 BST. --
Jul 24 21:58:52 volumio systemd[1]: Starting Daily apt download activities...
Jul 24 21:58:52 volumio systemd[1]: Starting Daily man-db regeneration...
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jul 24 21:58:53 volumio volumio[947]: info: Adding plugin bluetooth to MyMusic Plugins
Jul 24 21:58:53 volumio volumio[947]: info: Adding plugin multiroom to MyMusic Plugins
Jul 24 21:58:53 volumio volumio[947]: info: Adding plugin metavolumio to MyMusic Plugins
Jul 24 21:58:53 volumio volumio[947]: info: Adding plugin cd_controller to MyMusic Plugins
Jul 24 21:58:53 volumio volumio[947]: info: Adding plugin smart_inputs to MyMusic Plugins
Jul 24 21:58:53 volumio volumio[947]: info: Adding plugin tidalconnect to MyMusic Plugins
Jul 24 21:58:53 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jul 24 21:58:53 volumio systemd[1]: man-db.service: Succeeded.
Jul 24 21:58:53 volumio systemd[1]: Started Daily man-db regeneration.
Jul 24 21:58:54 volumio volumio[947]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jul 24 21:58:54 volumio volumio[947]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jul 24 21:58:54 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:54 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:54 volumio volumio[947]: info: Starting MyVolumio Remote Streaming Endpoints
Jul 24 21:58:54 volumio volumio[947]: info: MyVolumio login type: Token
Jul 24 21:58:54 volumio volumio[947]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jul 24 21:58:54 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jul 24 21:58:54 volumio systemd[1]: apt-daily.service: Succeeded.
Jul 24 21:58:54 volumio systemd[1]: Started Daily apt download activities.
Jul 24 21:58:54 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Jul 24 21:58:55 volumio volumio[947]: info: Starting Streaming Service Transparent Proxy
Jul 24 21:58:55 volumio volumio[947]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jul 24 21:58:55 volumio volumio[947]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jul 24 21:58:55 volumio volumio[947]: info: Streaming services startup
Jul 24 21:58:55 volumio volumio[947]: info: Starting Streaming Daemon
Jul 24 21:58:55 volumio sudo[1812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 24 21:58:55 volumio sudo[1812]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 24 21:58:55 volumio sudo[1812]: pam_unix(sudo:session): session closed for user root
Jul 24 21:58:55 volumio volumio[947]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Jul 24 21:58:55 volumio volumio[947]: error: Cannot start Volumio Streaming Daemon
Jul 24 21:58:55 volumio volumio[947]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jul 24 21:58:55 volumio volumio[947]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jul 24 21:58:55 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
Jul 24 21:58:55 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Jul 24 21:58:56 volumio volumio[947]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jul 24 21:58:56 volumio volumio[947]: STREAMING PROXY: Starting server on port 3245
Jul 24 21:58:56 volumio volumio[947]: Node JS runtime: 14
Jul 24 21:58:56 volumio volumio[947]: info: MyVolumio token set successfully
Jul 24 21:58:56 volumio volumio[947]: info: MYVOLUMIO: Adding device
Jul 24 21:58:56 volumio volumio[947]: info: MYVOLUMIO: Evaluating Server
Jul 24 21:58:57 volumio volumio[947]: info: MyVolumio Plan changed: premium
Jul 24 21:58:57 volumio volumio[947]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Jul 24 21:58:57 volumio volumio[947]: info: Removing browser output: myVolumio user plan is not superstar
Jul 24 21:58:57 volumio volumio[947]: info: Removing audio output:
Jul 24 21:58:57 volumio volumio[947]: info: MYVOLUMIO: Adding device
Jul 24 21:58:57 volumio volumio[947]: info: MYVOLUMIO: Evaluating Server
Jul 24 21:58:57 volumio volumio[947]: info: Remote config written successfully
Jul 24 21:58:57 volumio volumio[947]: info: Starting Tunnel 1
Jul 24 21:58:57 volumio volumio[947]: info: Starting Tunnel Connection Checker
Jul 24 21:58:57 volumio volumio[947]: info: Discovery: A device disappeared from network
Jul 24 21:58:57 volumio volumio[947]: info: Discovery: A device disappeared from network
Jul 24 21:58:57 volumio volumio[947]: info: Discovery: Device volumio disappeared from network
Jul 24 21:58:57 volumio volumio[947]: info: Discovery: A device disappeared from network
Jul 24 21:58:57 volumio volumio[947]: info: MYVolumio Device enabled
Jul 24 21:58:57 volumio volumio[947]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Jul 24 21:58:57 volumio volumio[947]: info: MyVolumio status changed
Jul 24 21:58:57 volumio volumio[947]: info: Streaming services startup
Jul 24 21:58:57 volumio volumio[947]: info: Starting Streaming Daemon
Jul 24 21:58:57 volumio sudo[1863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 24 21:58:57 volumio sudo[1863]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 24 21:58:57 volumio volumio[947]: info: Setting Geolocation for MyVolumio to eu3
Jul 24 21:58:57 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:57 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:57 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:57 volumio sudo[1863]: pam_unix(sudo:session): session closed for user root
Jul 24 21:58:57 volumio volumio[947]: error: Cannot start Volumio Streaming Daemon
Jul 24 21:58:57 volumio volumio[947]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jul 24 21:58:57 volumio volumio[947]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jul 24 21:58:57 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Jul 24 21:58:57 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Jul 24 21:58:57 volumio volumio[947]: info: [1721854737873] Starting BluetoothController
Jul 24 21:58:57 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Jul 24 21:58:58 volumio volumio[947]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Jul 24 21:58:58 volumio sudo[1869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Jul 24 21:58:58 volumio sudo[1869]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 24 21:58:58 volumio sudo[1869]: pam_unix(sudo:session): session closed for user root
Jul 24 21:58:59 volumio volumio[947]: info: MRS: MultiRoom plugin initialized
Jul 24 21:58:59 volumio volumio[947]: info: MRS: STOPPING SNAPCLIENT
Jul 24 21:58:59 volumio volumio[947]: info: MRS: Snap server stop
Jul 24 21:58:59 volumio sudo[1885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Jul 24 21:58:59 volumio sudo[1885]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 24 21:58:59 volumio volumio[947]: info: MRS: STOPPING volumioStreaming
Jul 24 21:58:59 volumio sudo[1888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Jul 24 21:58:59 volumio sudo[1888]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 24 21:58:59 volumio sudo[1885]: pam_unix(sudo:session): session closed for user root
Jul 24 21:58:59 volumio sudo[1891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Jul 24 21:58:59 volumio sudo[1891]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 24 21:58:59 volumio sudo[1888]: pam_unix(sudo:session): session closed for user root
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Jul 24 21:58:59 volumio sudo[1894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Jul 24 21:58:59 volumio sudo[1894]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 24 21:58:59 volumio sudo[1894]: pam_unix(sudo:session): session closed for user root
Jul 24 21:58:59 volumio sudo[1891]: pam_unix(sudo:session): session closed for user root
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Jul 24 21:58:59 volumio nmbd[731]: [2024/07/24 21:58:59.239439, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jul 24 21:58:59 volumio nmbd[731]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.97 for name WORKGROUP<1d>.
Jul 24 21:58:59 volumio nmbd[731]: This response was from IP 192.168.0.68, reporting an IP address of 192.168.0.68.
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Jul 24 21:58:59 volumio volumio[947]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Jul 24 21:58:59 volumio volumio[947]: info: Preparing to generate the ALSA configuration file
Jul 24 21:58:59 volumio volumio[947]: info: Updating MyVolumio device info
Jul 24 21:58:59 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:59 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:59 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:59 volumio volumio[947]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jul 24 21:58:59 volumio volumio[947]: info: Reading ALSA contributions from plugins.
Jul 24 21:58:59 volumio volumio[947]: info: Setting Geolocation for MyVolumio to eu3
Jul 24 21:58:59 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:59 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:59 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 24 21:58:59 volumio volumio[947]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 24 21:58:59 volumio volumio[947]: TypeError: Cannot read property 'id' of null
Jul 24 21:58:59 volumio volumio[947]: at multiroom.enableMultiroomSyncOutput (/myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:16029)
Jul 24 21:58:59 volumio volumio[947]: at CoreCommandRouter.enableMultiroomSyncOutput (/volumio/app/index.js:1276:23)
Jul 24 21:58:59 volumio volumio[947]: at Socket. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:282:28)
Jul 24 21:58:59 volumio volumio[947]: at Socket.Emitter.emit (/volumio/node_modules/socket.io-client/node_modules/component-emitter/index.js:133:20)
Jul 24 21:58:59 volumio volumio[947]: at Socket.onevent (/volumio/node_modules/socket.io-client/lib/socket.js:278:10)
Jul 24 21:58:59 volumio volumio[947]: at Socket.onpacket (/volumio/node_modules/socket.io-client/lib/socket.js:236:12)
Jul 24 21:58:59 volumio volumio[947]: at Manager. (/volumio/node_modules/component-bind/index.js:21:15)
Jul 24 21:58:59 volumio volumio[947]: at Manager.Emitter.emit (/volumio/node_modules/socket.io-client/node_modules/component-emitter/index.js:133:20)
Jul 24 21:58:59 volumio volumio[947]: at Manager.ondecoded (/volumio/node_modules/socket.io-client/lib/manager.js:345:8)
Jul 24 21:58:59 volumio volumio[947]: at Decoder. (/volumio/node_modules/component-bind/index.js:21:15)
Jul 24 21:58:59 volumio volumio[947]: at Decoder.Emitter.emit (/volumio/node_modules/socket.io-client/node_modules/socket.io-parser/node_modules/component-emitter/index.js:145:20)
Jul 24 21:58:59 volumio volumio[947]: at Decoder.add (/volumio/node_modules/socket.io-client/node_modules/socket.io-parser/index.js:254:12)
Jul 24 21:58:59 volumio volumio[947]: at Manager.ondata (/volumio/node_modules/socket.io-client/lib/manager.js:335:16)
Jul 24 21:58:59 volumio volumio[947]: at Socket. (/volumio/node_modules/component-bind/index.js:21:15)
Jul 24 21:58:59 volumio volumio[947]: at Socket.Emitter.emit (/volumio/node_modules/engine.io-client/node_modules/component-emitter/index.js:145:20)
Jul 24 21:58:59 volumio volumio[947]: at Socket.onPacket (/volumio/node_modules/engine.io-client/lib/socket.js:461:14)
Jul 24 21:58:59 volumio volumio[947]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 24 21:58:59 volumio sudo[1908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-24 21:57
Jul 24 21:58:59 volumio sudo[1908]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"