-- Logs begin at Tue 2026-08-25 22:10:38 PDT, end at Tue 2026-08-25 22:21:17 PDT. --
Aug 25 22:20:00 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 3
Aug 25 22:20:00 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Aug 25 22:20:00 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 5
Aug 25 22:20:00 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Aug 25 22:20:01 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 7
Aug 25 22:20:01 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 8
Aug 25 22:20:01 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Aug 25 22:20:01 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 10
Aug 25 22:20:02 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11
Aug 25 22:20:02 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12
Aug 25 22:20:02 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13
Aug 25 22:20:02 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14
Aug 25 22:20:02 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15
Aug 25 22:20:02 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Aug 25 22:20:03 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17
Aug 25 22:20:03 ember volumio[973]: info: CoreStateMachine::pushState
Aug 25 22:20:03 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:03 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 25 22:20:03 ember volumio[973]: info: CoreCommandRouter::volumioPushState
Aug 25 22:20:03 ember volumio[973]: info: CoreStateMachine::updateTrackBlock
Aug 25 22:20:03 ember volumio[973]: info: CorePlayQueue::getTrackBlock
Aug 25 22:20:03 ember volumio[973]: info: CoreCommandRouter::volumioRetrievevolume
Aug 25 22:20:03 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 18
Aug 25 22:20:03 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 19
Aug 25 22:20:04 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 20
Aug 25 22:20:04 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 21
Aug 25 22:20:04 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 22
Aug 25 22:20:04 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 23
Aug 25 22:20:04 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:20:04 ember volumio[973]: info: Reloading queue from file
Aug 25 22:20:04 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 24
Aug 25 22:20:04 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 25
Aug 25 22:20:04 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 26
Aug 25 22:20:05 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 27
Aug 25 22:20:05 ember volumio[973]: info: CoreStateMachine::setRepeat null single undefined
Aug 25 22:20:05 ember volumio[973]: info: CoreStateMachine::pushState
Aug 25 22:20:05 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:05 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 25 22:20:05 ember volumio[973]: info: CoreCommandRouter::volumioPushState
Aug 25 22:20:05 ember volumio[973]: info: CoreStateMachine::setRandom null
Aug 25 22:20:05 ember volumio[973]: info: CoreStateMachine::pushState
Aug 25 22:20:05 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:05 ember volumio[973]: info: CoreCommandRouter::volumioPushState
Aug 25 22:20:05 ember volumio[973]: info: Setting Device type: Raspberry PI
Aug 25 22:20:05 ember volumio[973]: info: Completed loading Core Plugins
Aug 25 22:20:05 ember volumio[973]: info: Preparing to generate the ALSA configuration file
Aug 25 22:20:06 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 28
Aug 25 22:20:06 ember volumio[973]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Aug 25 22:20:06 ember volumio[973]: info: Reading ALSA contributions from plugins.
Aug 25 22:20:07 ember volumio[973]: info: CoreStateMachine::pushState
Aug 25 22:20:07 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:07 ember volumio[973]: info: CoreCommandRouter::volumioPushState
Aug 25 22:20:07 ember sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Aug 25 22:20:07 ember volumio[973]: info: Discovery: adding 738cc484-0c57-4af2-a940-e9ec0917f1fb
Aug 25 22:20:07 ember volumio[973]: info: Discovery: Found device Ember
Aug 25 22:20:07 ember sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:07 ember volumio[973]: info: CoreCommandRouter::volumioGetState
Aug 25 22:20:07 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:07 ember volumio[973]: info: Discovery: this is already registered, 738cc484-0c57-4af2-a940-e9ec0917f1fb
Aug 25 22:20:07 ember volumio[973]: info: Discovery: Found device Ember
Aug 25 22:20:07 ember volumio[973]: info: CoreCommandRouter::volumioGetState
Aug 25 22:20:07 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:08 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54:3000 from 192.168.129.28 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 29
Aug 25 22:20:08 ember volumio[973]: info: Discovery: adding a8a6626a-6439-4efa-93a8-f944a4c25bc1
Aug 25 22:20:08 ember systemd[1]: Started UPnP Renderer front-end to MPD.
Aug 25 22:20:08 ember volumio-remote-updater[451]: [2026-08-25 22:20:08] [connect] Successful connection
Aug 25 22:20:08 ember sudo[1397]: pam_unix(sudo:session): session closed for user root
Aug 25 22:20:08 ember volumio[973]: info: Discovery: Found device nyc
Aug 25 22:20:09 ember volumio[973]: info: Discovery: Connecting to remote: 192.168.129.28
Aug 25 22:20:10 ember volumio[973]: info: Upmpdcli Daemon Started
Aug 25 22:20:11 ember volumio[973]: info: Discovery: Connected to remote: 192.168.129.28
Aug 25 22:20:11 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Aug 25 22:20:11 ember volumio-remote-updater[451]: [2026-08-25 22:20:11] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1787721608 101
Aug 25 22:20:11 ember volumio[973]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 30
Aug 25 22:20:12 ember volumio[973]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Aug 25 22:20:12 ember volumio[973]: info: CoreCommandRouter::volumioGetState
Aug 25 22:20:12 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:13 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 31
Aug 25 22:20:13 ember volumio[973]: info: Asound.conf file unchanged, so no further update is needed
Aug 25 22:20:13 ember volumio[973]: info: Output device has changed, restarting MPD
Aug 25 22:20:13 ember volumio[973]: info: Output device has changed, restarting Shairport Sync
Aug 25 22:20:13 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:13 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:20:13 ember sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 25 22:20:14 ember sudo[1425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 25 22:20:14 ember sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:14 ember sudo[1425]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:14 ember sudo[1423]: pam_unix(sudo:session): session closed for user root
Aug 25 22:20:14 ember volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 25 22:20:14 ember systemd[1]: Listening on mpd.socket.
Aug 25 22:20:14 ember volumio[973]: info: ___________ START PLUGINS ___________
Aug 25 22:20:14 ember systemd[1]: Starting Music Player Daemon...
Aug 25 22:20:14 ember volumio[973]: info: ControllerMpd::onStart: Initializing MPD
Aug 25 22:20:14 ember volumio[973]: info: Creating MPD Configuration file
Aug 25 22:20:15 ember sudo[1434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Aug 25 22:20:15 ember sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:15 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 25 22:20:15 ember volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 25 22:20:15 ember volumio[973]: info: [1787721615635] CoreMusicLibrary::Adding element Media Servers
Aug 25 22:20:15 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 25 22:20:16 ember sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 25 22:20:16 ember sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:16 ember systemd[1]: Started Volumio5 Onboarding Server.
Aug 25 22:20:16 ember sudo[1434]: pam_unix(sudo:session): session closed for user root
Aug 25 22:20:16 ember sudo[1432]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 25 22:20:16 ember sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:16 ember sudo[1432]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Aug 25 22:20:16 ember sudo[1432]: pam_unix(sudo:session): session closed for user root
Aug 25 22:20:16 ember sudo[1436]: pam_unix(sudo:session): session closed for user root
Aug 25 22:20:16 ember sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 25 22:20:16 ember volumio[973]: info: UPNP Browser: Client initialized successfully
Aug 25 22:20:16 ember sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:17 ember systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Aug 25 22:20:17 ember systemd[1]: mpd.service: Succeeded.
Aug 25 22:20:17 ember systemd[1]: Stopped Music Player Daemon.
Aug 25 22:20:17 ember systemd[1]: Starting Music Player Daemon...
Aug 25 22:20:17 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:17 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:20:18 ember volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 25 22:20:18 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:18 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:20:19 ember sudo[1445]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 25 22:20:19 ember sudo[1445]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:19 ember sudo[1445]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Aug 25 22:20:19 ember sudo[1445]: pam_unix(sudo:session): session closed for user root
Aug 25 22:20:20 ember volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 25 22:20:20 ember volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 25 22:20:20 ember volumio[973]: info: [1787721620159] CoreMusicLibrary::Adding element Last_100
Aug 25 22:20:20 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 25 22:20:20 ember volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 25 22:20:20 ember volumio[973]: info: [1787721620275] CoreMusicLibrary::Adding element Webradio
Aug 25 22:20:20 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 25 22:20:20 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 25 22:20:20 ember volumio[973]: info: Initializing BBC Radios
Aug 25 22:20:20 ember volumio[973]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Aug 25 22:20:20 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:20:21 ember volumio5-onboarding[1440]: time=2026-08-25T22:20:21.553-07:00 level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z
Aug 25 22:20:21 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 25 22:20:21 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:20:21 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 25 22:20:21 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 25 22:20:21 ember volumio[973]: info: Discovery: Getting this device information
Aug 25 22:20:21 ember volumio[973]: info: CoreCommandRouter::volumioGetState
Aug 25 22:20:21 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:21 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 25 22:20:22 ember volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 25 22:20:22 ember volumio[973]: info: [1787721622218] CoreMusicLibrary::Adding element Jellyfin
Aug 25 22:20:22 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 25 22:20:22 ember volumio[973]: Cannot find translation for source Jellyfin
Aug 25 22:20:22 ember volumio[973]: info: [jellyfin] Initialized plugin with device info: {"id":"738cc484-0c57-4af2-a940-e9ec0917f1fb","host":"http://192.168.129.54","name":"Ember","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":"10","mute":false,"artist":"","track":"Classical KingFM Evergreen","albumart":"http://192.168.129.54/albumart"}}
Aug 25 22:20:23 ember volumio[973]: info: Scheduling reboots with hours: 0, minutes: 0 in timezone: America/Los_Angeles
Aug 25 22:20:24 ember volumio[973]: info: Volumio Calling Home
Aug 25 22:20:25 ember sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l
Aug 25 22:20:25 ember sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:26 ember sudo[1484]: pam_unix(sudo:session): session closed for user root
Aug 25 22:20:30 ember volumio[973]: info: MPD Permissions set
Aug 25 22:20:30 ember volumio[973]: info: MPD Permissions set
Aug 25 22:20:30 ember sudo[1490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=22 relative_axis=true steps-per-period=4
Aug 25 22:20:30 ember sudo[1490]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:20:31 ember volumio[973]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 29
Aug 25 22:20:32 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 30
Aug 25 22:20:32 ember kernel: rotary-encoder rotary@17: gray
Aug 25 22:20:32 ember kernel: input: rotary@17 as /devices/platform/rotary@17/input/input0
Aug 25 22:20:32 ember sudo[1490]: pam_unix(sudo:session): session closed for user root
Aug 25 22:20:32 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 31
Aug 25 22:20:32 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 32
Aug 25 22:20:32 ember volumio[973]: info: Volumio called home
Aug 25 22:20:33 ember systemd-udevd[1500]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Aug 25 22:20:35 ember volumio[973]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 20
Aug 25 22:20:35 ember volumio[973]: info: Received Get System Info
Aug 25 22:20:35 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 25 22:20:35 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 25 22:20:35 ember volumio[973]: info: Discovery: Getting this device information
Aug 25 22:20:35 ember volumio[973]: info: CoreCommandRouter::volumioGetState
Aug 25 22:20:35 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:35 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 25 22:20:36 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 21
Aug 25 22:20:36 ember volumio5-onboarding[1440]: time=2026-08-25T22:20:35.376-07:00 level=INFO msg="system info for 6390300bbad4d3b25ef642d8db517a79" deviceName=Ember deviceVariant=volumio deviceModel= softwareVersion=3.912
Aug 25 22:20:38 ember volumio[973]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22
Aug 25 22:20:38 ember volumio[973]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 23
Aug 25 22:20:39 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:39 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:39 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:39 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:39 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:45 ember volumio5-onboarding[1440]: failed to configure discovery: failed to get system info: could not get system info: context deadline exceeded
Aug 25 22:20:45 ember systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE
Aug 25 22:20:45 ember systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'.
Aug 25 22:20:45 ember systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart.
Aug 25 22:20:45 ember systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1.
Aug 25 22:20:45 ember systemd[1]: Stopped Volumio5 Onboarding Server.
Aug 25 22:20:46 ember volumio-remote-updater[451]: [2026-08-25 22:20:46] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
Aug 25 22:20:45 ember systemd[1]: Started Volumio5 Onboarding Server.
Aug 25 22:20:51 ember volumio-remote-updater[451]: [2026-08-25 22:20:51] [connect] Successful connection
Aug 25 22:20:54 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:20:54 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:54 ember volumio5-onboarding[1531]: time=2026-08-25T22:20:54.733-07:00 level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z
Aug 25 22:20:54 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:54 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:55 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:20:55 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 25 22:20:55 ember volumio[973]: info: [jellyfin-poller] Polled https://jellyfin.mjmails.net: online
Aug 25 22:20:56 ember volumio[973]: info: Received Get System Info
Aug 25 22:20:56 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 25 22:20:56 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 25 22:20:56 ember volumio[973]: info: Discovery: Getting this device information
Aug 25 22:20:56 ember volumio[973]: info: CoreCommandRouter::volumioGetState
Aug 25 22:20:56 ember volumio[973]: info: CorePlayQueue::getTrack 0
Aug 25 22:20:56 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 25 22:20:57 ember volumio[973]: verbose: New Socket.io Connection to 192.168.129.54 from 192.168.129.217 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 11
Aug 25 22:21:02 ember volumio[973]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Aug 25 22:21:02 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:21:02 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 25 22:21:02 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 25 22:21:02 ember volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 25 22:21:02 ember sudo[1592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=24 active_low=true gpio_pull=up keycode=20
Aug 25 22:21:02 ember sudo[1592]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:21:02 ember volumio[973]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion
Aug 25 22:21:02 ember volumio[973]: error: Plugin system_hardware rotaryencoder2 failed to complete 'onStart' in a timely fashion
Aug 25 22:21:02 ember volumio[973]: info: -------------------------------------------
Aug 25 22:21:02 ember volumio[973]: info: ----- MyVolumio plugins startup ----
Aug 25 22:21:02 ember volumio[973]: info: -------------------------------------------
Aug 25 22:21:02 ember volumio[973]: info: [MyVolumio PluginManager] Fetching plans data....
Aug 25 22:21:03 ember volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 25 22:21:03 ember volumio[973]: Error: Unable to resolve or reject the same promise twice
Aug 25 22:21:03 ember volumio[973]: at Promise.resolve (/data/plugins/system_hardware/rotaryencoder2/node_modules/kew/kew.js:140:43)
Aug 25 22:21:03 ember volumio[973]: at /data/plugins/system_hardware/rotaryencoder2/index.js:999:23
Aug 25 22:21:03 ember volumio[973]: at FSReqCallback.oncomplete (fs.js:171:23)
Aug 25 22:21:03 ember volumio[973]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 25 22:21:03 ember kernel: input: button@18 as /devices/platform/button@18/input/input1
Aug 25 22:21:03 ember sudo[1592]: pam_unix(sudo:session): session closed for user root
Aug 25 22:21:04 ember volumio-remote-updater[451]: [2026-08-25 22:21:04] [connect] Successful connection
Aug 25 22:21:04 ember systemd-udevd[1601]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Aug 25 22:21:04 ember volumio5-onboarding[1531]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:51234->127.0.0.1:3000: i/o timeout
Aug 25 22:21:04 ember systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE
Aug 25 22:21:04 ember systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'.
Aug 25 22:21:05 ember systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart.
Aug 25 22:21:05 ember systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2.
Aug 25 22:21:05 ember systemd[1]: Stopped Volumio5 Onboarding Server.
Aug 25 22:21:05 ember systemd[1]: Started Volumio5 Onboarding Server.
Aug 25 22:21:06 ember volumio5-onboarding[1622]: time=2026-08-25T22:21:06.193-07:00 level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z
Aug 25 22:21:15 ember sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-25 22:20
Aug 25 22:21:15 ember sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 25 22:21:16 ember volumio5-onboarding[1622]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:44086->127.0.0.1:3000: i/o timeout
Aug 25 22:21:16 ember systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE
Aug 25 22:21:16 ember systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'.
Aug 25 22:21:16 ember systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart.
Aug 25 22:21:16 ember systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 3.
Aug 25 22:21:16 ember systemd[1]: Stopped Volumio5 Onboarding Server.
Aug 25 22:21:16 ember systemd[1]: Started Volumio5 Onboarding Server.
Aug 25 22:21:17 ember volumio5-onboarding[1642]: time=2026-08-25T22:21:17.243-07:00 level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z
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="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET"
VOLUMIO_VERSION="3.912"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"