-- Logs begin at Mon 2022-11-28 22:39:59 UTC, end at Tue 2025-05-27 10:33:01 UTC. --
May 27 10:32:53 volt ntpd[609]: receive: Unexpected origin timestamp 0xe72fb790.809bf940 does not match aorg 0000000000.00000000 from server@185.57.191.229 xmt 0xebe01355.01c171fd
May 27 10:32:53 volt ntpd[609]: receive: Unexpected origin timestamp 0xe72fb790.80a1cdd1 does not match aorg 0000000000.00000000 from server@131.111.8.60 xmt 0xebe01355.0208ea32
May 27 10:32:53 volt systemd[1]: Starting Daily apt download activities...
May 27 10:32:53 volt ntpd[609]: receive: Unexpected origin timestamp 0xe72fb790.809d7ca0 does not match aorg 0000000000.00000000 from server@178.62.250.107 xmt 0xebe01355.02db1d7e
May 27 10:32:53 volt volumio[998]: info: Discovery: A device disappeared from network
May 27 10:32:53 volt volumio[998]: info: Discovery: Device volcabin disappeared from network
May 27 10:32:53 volt volumio[998]: info: Discovery: Disconnected from remote: 192.168.68.134
May 27 10:32:53 volt volumio[998]: info: Discovery: A device disappeared from network
May 27 10:32:53 volt volumio[998]: info: Discovery: Device volt disappeared from network
May 27 10:32:53 volt volumio[998]: info: Discovery: adding 5759f155-fbc6-4bae-a90e-4ac95f73c6ba
May 27 10:32:53 volt volumio[998]: info: Discovery: Found device volt
May 27 10:32:53 volt volumio[998]: info: CoreCommandRouter::volumioGetState
May 27 10:32:53 volt volumio[998]: info: CorePlayQueue::getTrack 0
May 27 10:32:53 volt volumio[998]: info: Discovery: adding 40d165a6-07cf-4a5c-a3b4-bfd6639e3046
May 27 10:32:53 volt volumio[998]: info: Discovery: Found device Volcabin
May 27 10:32:53 volt volumio[998]: info: Discovery: Connecting to remote: 192.168.68.135
May 27 10:32:53 volt volumio[998]: info: Discovery: Connected to remote: 192.168.68.135
May 27 10:32:54 volt systemd[1]: apt-daily.service: Succeeded.
May 27 10:32:54 volt systemd[1]: Started Daily apt download activities.
May 27 10:32:54 volt systemd[1]: Starting Daily apt upgrade and clean activities...
May 27 10:32:55 volt wpa_supplicant[851]: RRM: Ignoring radio measurement request: Not RRM network
May 27 10:32:56 volt systemd[1]: apt-daily-upgrade.service: Succeeded.
May 27 10:32:56 volt systemd[1]: Started Daily apt upgrade and clean activities.
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 27 10:32:56 volt volumio[998]: info: Adding plugin bluetooth to MyMusic Plugins
May 27 10:32:56 volt volumio[998]: info: Adding plugin multiroom to MyMusic Plugins
May 27 10:32:56 volt volumio[998]: info: Adding plugin metavolumio to MyMusic Plugins
May 27 10:32:56 volt volumio[998]: info: Adding plugin cd_controller to MyMusic Plugins
May 27 10:32:56 volt volumio[998]: info: Adding plugin smart_inputs to MyMusic Plugins
May 27 10:32:56 volt volumio[998]: info: Adding plugin tidalconnect to MyMusic Plugins
May 27 10:32:56 volt volumio[998]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 27 10:32:57 volt volumio[998]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 27 10:32:57 volt volumio[998]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 27 10:32:57 volt volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 27 10:32:57 volt volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 27 10:32:57 volt volumio[998]: info: Starting MyVolumio Remote Streaming Endpoints
May 27 10:32:57 volt volumio[998]: info: MyVolumio login type: Token
May 27 10:32:57 volt volumio[998]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 27 10:32:57 volt volumio[998]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 27 10:32:57 volt volumio[998]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 27 10:32:57 volt volumio[998]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 27 10:32:57 volt volumio[998]: info: Streaming services startup
May 27 10:32:57 volt volumio[998]: info: Starting Streaming Daemon
May 27 10:32:57 volt sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 27 10:32:57 volt sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 10:32:57 volt volumio[998]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 27 10:32:57 volt systemd[1]: Started Volumio Streaming Daemon.
May 27 10:32:57 volt sudo[1439]: pam_unix(sudo:session): session closed for user root
May 27 10:32:57 volt volumio-streaming-daemon[1445]: ############################
May 27 10:32:57 volt volumio-streaming-daemon[1445]: # Volumio Streaming Daemon #
May 27 10:32:57 volt volumio-streaming-daemon[1445]: # Running on port 7777 #
May 27 10:32:57 volt volumio-streaming-daemon[1445]: ############################
May 27 10:32:57 volt volumio-streaming-daemon[1445]: 2025/05/27 10:32:57 unknown property: VOLUMIO_VARIANT
May 27 10:32:57 volt systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 27 10:32:57 volt systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'.
May 27 10:32:57 volt volumio[998]: error: MyVolumio Custom Token format not valid, refreshing it
May 27 10:32:57 volt systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart.
May 27 10:32:57 volt systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 1.
May 27 10:32:57 volt systemd[1]: Stopped Volumio Streaming Daemon.
May 27 10:32:57 volt systemd[1]: Started Volumio Streaming Daemon.
May 27 10:32:57 volt volumio-streaming-daemon[1451]: ############################
May 27 10:32:57 volt volumio-streaming-daemon[1451]: # Volumio Streaming Daemon #
May 27 10:32:57 volt volumio-streaming-daemon[1451]: # Running on port 7777 #
May 27 10:32:57 volt volumio-streaming-daemon[1451]: ############################
May 27 10:32:57 volt volumio-streaming-daemon[1451]: 2025/05/27 10:32:57 unknown property: VOLUMIO_VARIANT
May 27 10:32:57 volt systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 27 10:32:57 volt systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'.
May 27 10:32:57 volt kernel: device wlan0 entered promiscuous mode
May 27 10:32:58 volt kernel: device wlan0 left promiscuous mode
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart.
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 2.
May 27 10:32:58 volt systemd[1]: Stopped Volumio Streaming Daemon.
May 27 10:32:58 volt systemd[1]: Started Volumio Streaming Daemon.
May 27 10:32:58 volt volumio-streaming-daemon[1457]: ############################
May 27 10:32:58 volt volumio-streaming-daemon[1457]: # Volumio Streaming Daemon #
May 27 10:32:58 volt volumio-streaming-daemon[1457]: # Running on port 7777 #
May 27 10:32:58 volt volumio-streaming-daemon[1457]: ############################
May 27 10:32:58 volt volumio-streaming-daemon[1457]: 2025/05/27 10:32:58 unknown property: VOLUMIO_VARIANT
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'.
May 27 10:32:58 volt kernel: device lo entered promiscuous mode
May 27 10:32:58 volt kernel: device lo left promiscuous mode
May 27 10:32:58 volt volumio[998]: info: MyVolumio login type: Token
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart.
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 3.
May 27 10:32:58 volt systemd[1]: Stopped Volumio Streaming Daemon.
May 27 10:32:58 volt systemd[1]: Started Volumio Streaming Daemon.
May 27 10:32:58 volt volumio-streaming-daemon[1463]: ############################
May 27 10:32:58 volt volumio-streaming-daemon[1463]: # Volumio Streaming Daemon #
May 27 10:32:58 volt volumio-streaming-daemon[1463]: # Running on port 7777 #
May 27 10:32:58 volt volumio-streaming-daemon[1463]: ############################
May 27 10:32:58 volt volumio-streaming-daemon[1463]: 2025/05/27 10:32:58 unknown property: VOLUMIO_VARIANT
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'.
May 27 10:32:58 volt kernel: device eth0 entered promiscuous mode
May 27 10:32:58 volt kernel: device eth0 left promiscuous mode
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart.
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 4.
May 27 10:32:58 volt systemd[1]: Stopped Volumio Streaming Daemon.
May 27 10:32:58 volt systemd[1]: Started Volumio Streaming Daemon.
May 27 10:32:58 volt volumio-streaming-daemon[1470]: ############################
May 27 10:32:58 volt volumio-streaming-daemon[1470]: # Volumio Streaming Daemon #
May 27 10:32:58 volt volumio-streaming-daemon[1470]: # Running on port 7777 #
May 27 10:32:58 volt volumio-streaming-daemon[1470]: ############################
May 27 10:32:58 volt volumio-streaming-daemon[1470]: 2025/05/27 10:32:58 unknown property: VOLUMIO_VARIANT
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'.
May 27 10:32:58 volt kernel: device wlan0 entered promiscuous mode
May 27 10:32:58 volt volumio[998]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 27 10:32:58 volt volumio[998]: info: MYVOLUMIO: Adding device
May 27 10:32:58 volt volumio[998]: info: MYVOLUMIO: Evaluating Server
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart.
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 5.
May 27 10:32:58 volt systemd[1]: Stopped Volumio Streaming Daemon.
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Start request repeated too quickly.
May 27 10:32:58 volt systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'.
May 27 10:32:58 volt systemd[1]: Failed to start Volumio Streaming Daemon.
May 27 10:33:01 volt volumio[998]: info: MyVolumio Plan changed: superstar
May 27 10:33:01 volt volumio[998]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar
May 27 10:33:01 volt volumio[998]: info: Adding audio output:
May 27 10:33:01 volt volumio[998]: info: MYVOLUMIO: Adding device
May 27 10:33:01 volt volumio[998]: info: MYVOLUMIO: Evaluating Server
May 27 10:33:01 volt volumio[998]: info: Remote config written successfully
May 27 10:33:01 volt volumio[998]: info: Starting Tunnel 1
May 27 10:33:01 volt volumio[998]: info: Starting Tunnel Connection Checker
May 27 10:33:01 volt volumio[998]: info: MYVolumio Device enabled
May 27 10:33:01 volt volumio[998]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
May 27 10:33:01 volt volumio[998]: [2025-05-27T10:33:01.624Z] @firebase/database: FIREBASE WARNING: Exception was thrown by user callback. TypeError: Cannot read property 'replace' of null
May 27 10:33:01 volt volumio[998]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044)
May 27 10:33:01 volt volumio[998]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563)
May 27 10:33:01 volt volumio[998]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527)
May 27 10:33:01 volt volumio[998]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807
May 27 10:33:01 volt volumio[998]: at /volumio/node_modules/v-conf/index.js:165:13
May 27 10:33:01 volt volumio[998]: at /volumio/node_modules/multimap/index.js:150:9
May 27 10:33:01 volt volumio[998]: at Array.forEach ()
May 27 10:33:01 volt volumio[998]: at /volumio/node_modules/multimap/index.js:149:13
May 27 10:33:01 volt volumio[998]: at mapEach (/volumio/node_modules/multimap/index.js:9:5)
May 27 10:33:01 volt volumio[998]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5)
May 27 10:33:01 volt volumio[998]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10)
May 27 10:33:01 volt volumio[998]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20)
May 27 10:33:01 volt volumio[998]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:35225)
May 27 10:33:01 volt volumio[998]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17331
May 27 10:33:01 volt volumio[998]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22
May 27 10:33:01 volt volumio[998]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9)
May 27 10:33:01 volt volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 27 10:33:01 volt volumio[998]: TypeError: Cannot read property 'replace' of null
May 27 10:33:01 volt volumio[998]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044)
May 27 10:33:01 volt volumio[998]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563)
May 27 10:33:01 volt volumio[998]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527)
May 27 10:33:01 volt volumio[998]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807
May 27 10:33:01 volt volumio[998]: at /volumio/node_modules/v-conf/index.js:165:13
May 27 10:33:01 volt volumio[998]: at /volumio/node_modules/multimap/index.js:150:9
May 27 10:33:01 volt volumio[998]: at Array.forEach ()
May 27 10:33:01 volt volumio[998]: at /volumio/node_modules/multimap/index.js:149:13
May 27 10:33:01 volt volumio[998]: at mapEach (/volumio/node_modules/multimap/index.js:9:5)
May 27 10:33:01 volt volumio[998]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5)
May 27 10:33:01 volt volumio[998]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10)
May 27 10:33:01 volt volumio[998]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20)
May 27 10:33:01 volt volumio[998]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:35225)
May 27 10:33:01 volt volumio[998]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17331
May 27 10:33:01 volt volumio[998]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22
May 27 10:33:01 volt volumio[998]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9)
May 27 10:33:01 volt volumio[998]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 27 10:33:01 volt wpa_supplicant[851]: RRM: Ignoring radio measurement request: Not RRM network
May 27 10:33:01 volt sudo[1555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-27 10:32
May 27 10:33:01 volt sudo[1555]: 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"