-- Logs begin at Sat 2025-05-03 23:06:19 UTC, end at Sun 2025-05-04 18:23:39 UTC. --
May 04 18:22:02 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:05 volumio sudo[1829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 04 18:22:05 volumio sudo[1829]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 04 18:22:05 volumio sudo[1829]: pam_unix(sudo:session): session closed for user root
May 04 18:22:05 volumio sudo[1832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 04 18:22:05 volumio sudo[1832]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 04 18:22:05 volumio sudo[1832]: pam_unix(sudo:session): session closed for user root
May 04 18:22:06 volumio volumio[19915]: verbose: New Socket.io Connection to 10.0.1.13 from 10.0.1.49 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::volumioGetVisibleSources
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 04 18:22:06 volumio volumio[19915]: info: Received Get System Info
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 04 18:22:06 volumio volumio[19915]: info: Discovery: Getting this device information
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:06 volumio volumio[19915]: info: Listing playlists
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 04 18:22:06 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 04 18:22:07 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 04 18:22:07 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 04 18:22:07 volumio volumio[19915]: info: Received Get System Info
May 04 18:22:07 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 04 18:22:07 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 04 18:22:07 volumio volumio[19915]: info: Discovery: Getting this device information
May 04 18:22:07 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:07 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 04 18:22:08 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 04 18:22:08 volumio volumio[19915]: info: Received Get System Info
May 04 18:22:08 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 04 18:22:08 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 04 18:22:08 volumio volumio[19915]: info: Discovery: Getting this device information
May 04 18:22:08 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:08 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 04 18:22:12 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:12 volumio volumio[19915]: info: Listing playlists
May 04 18:22:12 volumio volumio[19915]: info: Listing playlists
May 04 18:22:16 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 04 18:22:19 volumio volumio[19915]: info: [jellyfin-poller-worker] _doPoll(): Polling http://10.0.1.10:8096
May 04 18:22:19 volumio volumio[19915]: info: [jellyfin-connect] refreshServerInfo(http://10.0.1.10:8096): Connecting...
May 04 18:22:19 volumio volumio[19915]: begin connectToServer
May 04 18:22:19 volumio volumio[19915]: tryReconnect: http://10.0.1.10:8096
May 04 18:22:20 volumio volumio[19915]: getTryConnectPromise http://10.0.1.10:8096
May 04 18:22:20 volumio volumio[19915]: ConnectionManager requesting url: http://10.0.1.10:8096/system/info/public
May 04 18:22:20 volumio volumio[19915]: fetchWithTimeout: timeoutMs: 20000, url: http://10.0.1.10:8096/system/info/public
May 04 18:22:22 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:23 volumio volumio[19915]: fetchWithTimeout: timed out connecting to url: http://10.0.1.10:8096/system/info/public
May 04 18:22:23 volumio volumio[19915]: ConnectionManager request failed to url: http://10.0.1.10:8096/system/info/public
May 04 18:22:23 volumio volumio[19915]: Reconnect failed to http://10.0.1.10:8096
May 04 18:22:23 volumio volumio[19915]: info: [jellyfin-connect] refreshServerInfo(http://10.0.1.10:8096): Server info updated. Server state is 'Unavailable'.
May 04 18:22:23 volumio volumio[19915]: info: [jellyfin-poller-worked] _doPoll(): Polled http://10.0.1.10:8096. Server state is 'Unavailable'.
May 04 18:22:23 volumio volumio[19915]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms.
May 04 18:22:24 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 04 18:22:24 volumio volumio[19915]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 04 18:22:24 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 04 18:22:24 volumio volumio[19915]: info: Received Get System Version
May 04 18:22:24 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 04 18:22:24 volumio volumio[19915]: info: Received Get System Info
May 04 18:22:24 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 04 18:22:24 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 04 18:22:24 volumio volumio[19915]: info: Discovery: Getting this device information
May 04 18:22:24 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:24 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 04 18:22:32 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:32 volumio volumio[19915]: info: Listing playlists
May 04 18:22:32 volumio volumio[19915]: info: Listing playlists
May 04 18:22:37 volumio volumio[19915]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/armhf
May 04 18:22:40 volumio volumio[19915]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/armhf
May 04 18:22:40 volumio volumio[19915]: info: Folder /tmp/plugins removed
May 04 18:22:42 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:22:44 volumio volumio[19915]: info: Check plugin dependencies
May 04 18:22:44 volumio volumio[19915]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 04 18:22:44 volumio volumio[19915]: info: Checking if plugin already exists
May 04 18:22:44 volumio volumio[19915]: info: An error occurred installing the plugin. Rolling back config
May 04 18:22:44 volumio volumio[19915]: info: Plugin folders cleanup
May 04 18:22:44 volumio volumio[19915]: info: Scanning into folder /volumio/app/plugins/
May 04 18:22:44 volumio volumio[19915]: info: Scanning category audio_interface
May 04 18:22:44 volumio volumio[19915]: info: Scanning category miscellanea
May 04 18:22:44 volumio volumio[19915]: info: Scanning category music_service
May 04 18:22:44 volumio volumio[19915]: info: Scanning category plugins.json
May 04 18:22:44 volumio volumio[19915]: info: Scanning category system_controller
May 04 18:22:44 volumio volumio[19915]: info: Scanning category user_interface
May 04 18:22:44 volumio volumio[19915]: info: Scanning into folder /data/plugins/
May 04 18:22:44 volumio volumio[19915]: info: Scanning category music_service
May 04 18:22:44 volumio volumio[19915]: info: Scanning category user_interface
May 04 18:22:44 volumio volumio[19915]: info: Plugin folders cleanup completed
May 04 18:22:44 volumio volumio[19915]: info: Error: Error
May 04 18:22:44 volumio volumio[19915]: info: Folder /tmp/plugins removed
May 04 18:22:44 volumio volumio[19915]: info: Folder /tmp/downloaded_plugin.zip removed
May 04 18:22:44 volumio volumio[19915]: info: Folder /tmp/downloaded_plugin.zip removed
May 04 18:22:50 volumio volumio[19915]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf
May 04 18:22:53 volumio volumio[19915]: info: [jellyfin-poller-worker] _doPoll(): Polling http://10.0.1.10:8096
May 04 18:22:53 volumio volumio[19915]: info: [jellyfin-connect] refreshServerInfo(http://10.0.1.10:8096): Connecting...
May 04 18:22:53 volumio volumio[19915]: begin connectToServer
May 04 18:22:53 volumio volumio[19915]: tryReconnect: http://10.0.1.10:8096
May 04 18:22:53 volumio volumio[19915]: getTryConnectPromise http://10.0.1.10:8096
May 04 18:22:53 volumio volumio[19915]: ConnectionManager requesting url: http://10.0.1.10:8096/system/info/public
May 04 18:22:53 volumio volumio[19915]: fetchWithTimeout: timeoutMs: 20000, url: http://10.0.1.10:8096/system/info/public
May 04 18:22:56 volumio volumio[19915]: fetchWithTimeout: timed out connecting to url: http://10.0.1.10:8096/system/info/public
May 04 18:22:56 volumio volumio[19915]: ConnectionManager request failed to url: http://10.0.1.10:8096/system/info/public
May 04 18:22:56 volumio volumio[19915]: Reconnect failed to http://10.0.1.10:8096
May 04 18:22:56 volumio volumio[19915]: info: [jellyfin-connect] refreshServerInfo(http://10.0.1.10:8096): Server info updated. Server state is 'Unavailable'.
May 04 18:22:56 volumio volumio[19915]: info: [jellyfin-poller-worked] _doPoll(): Polled http://10.0.1.10:8096. Server state is 'Unavailable'.
May 04 18:22:56 volumio volumio[19915]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms.
May 04 18:22:58 volumio volumio[19915]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf
May 04 18:23:26 volumio volumio[19915]: info: [jellyfin-poller-worker] _doPoll(): Polling http://10.0.1.10:8096
May 04 18:23:26 volumio volumio[19915]: info: [jellyfin-connect] refreshServerInfo(http://10.0.1.10:8096): Connecting...
May 04 18:23:26 volumio volumio[19915]: begin connectToServer
May 04 18:23:26 volumio volumio[19915]: tryReconnect: http://10.0.1.10:8096
May 04 18:23:26 volumio volumio[19915]: getTryConnectPromise http://10.0.1.10:8096
May 04 18:23:26 volumio volumio[19915]: ConnectionManager requesting url: http://10.0.1.10:8096/system/info/public
May 04 18:23:26 volumio volumio[19915]: fetchWithTimeout: timeoutMs: 20000, url: http://10.0.1.10:8096/system/info/public
May 04 18:23:29 volumio volumio[19915]: fetchWithTimeout: timed out connecting to url: http://10.0.1.10:8096/system/info/public
May 04 18:23:29 volumio volumio[19915]: ConnectionManager request failed to url: http://10.0.1.10:8096/system/info/public
May 04 18:23:29 volumio volumio[19915]: Reconnect failed to http://10.0.1.10:8096
May 04 18:23:29 volumio volumio[19915]: info: [jellyfin-connect] refreshServerInfo(http://10.0.1.10:8096): Server info updated. Server state is 'Unavailable'.
May 04 18:23:29 volumio volumio[19915]: info: [jellyfin-poller-worked] _doPoll(): Polled http://10.0.1.10:8096. Server state is 'Unavailable'.
May 04 18:23:29 volumio volumio[19915]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms.
May 04 18:23:32 volumio volumio[19915]: info: CoreCommandRouter::volumioGetState
May 04 18:23:32 volumio volumio[19915]: info: Folder /tmp/plugins removed
May 04 18:23:32 volumio volumio[19915]: info: Listing playlists
May 04 18:23:32 volumio volumio[19915]: info: Listing playlists
May 04 18:23:33 volumio volumio[19915]: info: Folder /data/temp removed
May 04 18:23:33 volumio volumio[19915]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 04 18:23:33 volumio volumio[19915]: Error: Unable to resolve or reject the same promise twice
May 04 18:23:33 volumio volumio[19915]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
May 04 18:23:33 volumio volumio[19915]: at /volumio/app/pluginmanager.js:1087:11
May 04 18:23:33 volumio volumio[19915]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
May 04 18:23:33 volumio volumio[19915]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24
May 04 18:23:33 volumio volumio[19915]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
May 04 18:23:33 volumio volumio[19915]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24
May 04 18:23:33 volumio volumio[19915]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
May 04 18:23:33 volumio volumio[19915]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24
May 04 18:23:33 volumio volumio[19915]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
May 04 18:23:33 volumio volumio[19915]: at FSReqCallback.oncomplete (fs.js:171:23)
May 04 18:23:33 volumio volumio[19915]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 04 18:23:39 volumio sudo[2106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 18:22
May 04 18:23:39 volumio sudo[2106]: 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="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST"
VOLUMIO_VERSION="3.804"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"