-- Logs begin at Thu 2019-02-14 12:11:58 EET, end at Mon 2026-02-23 01:40:14 EET. -- Feb 23 01:39:00 media ntpd[658]: Soliciting pool server 212.1.104.9 Feb 23 01:39:00 media volumio[884]: info: VolumeController::SetAlsaVolume74 Feb 23 01:39:00 media volumio[884]: info: CoreStateMachine::pushState Feb 23 01:39:00 media volumio[884]: info: CorePlayQueue::getTrack 0 Feb 23 01:39:00 media volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 01:39:00 media volumio[884]: info: CoreCommandRouter::volumioPushState Feb 23 01:39:00 media volumio[884]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Feb 23 01:39:00 media volumio[884]: info: VolumeController::SetAlsaVolume26 Feb 23 01:39:00 media volumio[884]: info: CoreStateMachine::pushState Feb 23 01:39:00 media volumio[884]: info: CorePlayQueue::getTrack 0 Feb 23 01:39:00 media volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 01:39:00 media volumio[884]: info: CoreCommandRouter::volumioPushState Feb 23 01:39:00 media volumio[884]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Feb 23 01:39:00 media ntpd[658]: Soliciting pool server 46.173.175.211 Feb 23 01:39:00 media ntpd[658]: Soliciting pool server 109.110.82.19 Feb 23 01:39:00 media ntpd[658]: Soliciting pool server 188.191.239.24 Feb 23 01:39:01 media volumio[884]: info: VolumeController::SetAlsaVolume15 Feb 23 01:39:01 media volumio[884]: info: CoreStateMachine::pushState Feb 23 01:39:01 media volumio[884]: info: CorePlayQueue::getTrack 0 Feb 23 01:39:01 media volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 01:39:01 media volumio[884]: info: CoreCommandRouter::volumioPushState Feb 23 01:39:01 media volumio[884]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Feb 23 01:39:01 media volumio[884]: info: VolumeController::SetAlsaVolume12 Feb 23 01:39:01 media volumio[884]: info: CoreStateMachine::pushState Feb 23 01:39:01 media volumio[884]: info: CorePlayQueue::getTrack 0 Feb 23 01:39:01 media volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 01:39:01 media volumio[884]: info: CoreCommandRouter::volumioPushState Feb 23 01:39:01 media volumio[884]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Feb 23 01:39:01 media ntpd[658]: Soliciting pool server 162.159.200.1 Feb 23 01:39:01 media ntpd[658]: Soliciting pool server 94.158.46.150 Feb 23 01:39:02 media ntpd[658]: Soliciting pool server 91.236.251.24 Feb 23 01:39:02 media ntpd[658]: Soliciting pool server 62.149.0.30 Feb 23 01:39:03 media ntpd[658]: Soliciting pool server 2606:4700:f1::123 Feb 23 01:39:05 media ntpd[658]: Soliciting pool server 162.159.200.123 Feb 23 01:39:05 media ntpd[658]: Soliciting pool server 79.142.192.130 Feb 23 01:39:06 media ntpd[658]: Soliciting pool server 109.110.82.19 Feb 23 01:39:09 media ntpd[658]: receive: Unexpected origin timestamp 0xed46121c.e86fe7e8 does not match aorg 0000000000.00000000 from server@188.191.239.24 xmt 0xed46121d.3ee147ae Feb 23 01:39:09 media ntpd[658]: receive: Unexpected origin timestamp 0xed46121c.e87211a3 does not match aorg 0000000000.00000000 from server@212.1.104.9 xmt 0xed46121d.3de24fec Feb 23 01:39:20 media sshd[2157]: Did not receive identification string from 192.168.50.48 port 42188 Feb 23 01:39:50 media sshd[2203]: Accepted password for volumio from 192.168.50.48 port 42560 ssh2 Feb 23 01:39:50 media sshd[2203]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Feb 23 01:39:50 media systemd[1]: Created slice User Slice of UID 1000. Feb 23 01:39:50 media systemd[1]: Starting User Runtime Directory /run/user/1000... Feb 23 01:39:50 media systemd-logind[487]: New session 1 of user volumio. Feb 23 01:39:50 media volumio[884]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 01:39:50 media volumio[884]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 01:39:50 media volumio[884]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 01:39:50 media systemd[1]: Started User Runtime Directory /run/user/1000. Feb 23 01:39:50 media systemd[1]: Starting User Manager for UID 1000... Feb 23 01:39:50 media volumio[884]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 01:39:50 media systemd[2206]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0) Feb 23 01:39:50 media systemd[2206]: Reached target Paths. Feb 23 01:39:50 media systemd[2206]: Reached target Timers. Feb 23 01:39:50 media systemd[2206]: Listening on GnuPG cryptographic agent and passphrase cache. Feb 23 01:39:50 media systemd[2206]: Listening on Sound System. Feb 23 01:39:50 media systemd[2206]: Starting D-Bus User Message Bus Socket. Feb 23 01:39:50 media systemd[2206]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Feb 23 01:39:50 media systemd[2206]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Feb 23 01:39:50 media systemd[2206]: Listening on GnuPG network certificate management daemon. Feb 23 01:39:50 media systemd[2206]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Feb 23 01:39:50 media systemd[2206]: Listening on D-Bus User Message Bus Socket. Feb 23 01:39:50 media systemd[2206]: Reached target Sockets. Feb 23 01:39:50 media systemd[2206]: Reached target Basic System. Feb 23 01:39:50 media systemd[2206]: Reached target Default. Feb 23 01:39:50 media systemd[2206]: Startup finished in 234ms. Feb 23 01:39:50 media systemd[1]: Started User Manager for UID 1000. Feb 23 01:39:50 media systemd[1]: Started Session 1 of user volumio. Feb 23 01:40:08 media volumio[884]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Feb 23 01:40:08 media volumio[884]: info: MRS: Starting browser stream Feb 23 01:40:08 media volumio[884]: info: MRS: Setting this device as single Feb 23 01:40:08 media volumio[884]: info: Feb 23 01:40:08 media volumio[884]: [1771803608011] ---------------------------- Setting Multiroom Single Feb 23 01:40:08 media volumio[884]: info: MRS: disable multiroom output Feb 23 01:40:08 media volumio[884]: info: MRS: Set multiroom target PCM to volumioDiscard Feb 23 01:40:08 media volumio[884]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Feb 23 01:40:08 media volumio[884]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Feb 23 01:40:08 media volumio[884]: info: MRS: Starting browser stream Feb 23 01:40:08 media volumio[884]: info: Enabled audio output: browserPlayback Feb 23 01:40:08 media volumio[884]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Feb 23 01:40:08 media volumio[884]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Feb 23 01:40:09 media volumio[884]: info: MRS: STOPPING volumioStreaming Feb 23 01:40:09 media sudo[2300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Feb 23 01:40:09 media sudo[2300]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 01:40:09 media sudo[2303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Feb 23 01:40:09 media sudo[2303]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 01:40:09 media systemd[1]: Stopping VolumioStreamingService... Feb 23 01:40:09 media systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Feb 23 01:40:09 media sudo[2303]: pam_unix(sudo:session): session closed for user root Feb 23 01:40:09 media volumio[884]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 01:40:09 media systemd[1]: volumioStreaming.service: Succeeded. Feb 23 01:40:09 media volumio[884]: info: MRS: Removed streaming files Feb 23 01:40:09 media systemd[1]: Stopped VolumioStreamingService. Feb 23 01:40:09 media sudo[2300]: pam_unix(sudo:session): session closed for user root Feb 23 01:40:09 media volumio[884]: info: MRS: volumioStreaming STOPPED Feb 23 01:40:10 media volumio[884]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Feb 23 01:40:10 media volumio[884]: info: MRS: Starting browser stream Feb 23 01:40:10 media volumio[884]: info: MRS: Setting this device as Streaming Server Feb 23 01:40:10 media volumio[884]: info: Feb 23 01:40:10 media volumio[884]: [1771803610895] ---------------------------- MRS: Setting Streaming Server Feb 23 01:40:10 media volumio[884]: info: Enabled audio output: browserPlayback Feb 23 01:40:10 media volumio[884]: info: MRS: enable multiroom server output Feb 23 01:40:10 media volumio[884]: info: MRS: Set multiroom target PCM to volumioMultiRoom Feb 23 01:40:10 media volumio[884]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Feb 23 01:40:10 media volumio[884]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Feb 23 01:40:11 media volumio[884]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Feb 23 01:40:11 media volumio[884]: info: MRS: STARTING volumioStreaming Feb 23 01:40:11 media sudo[2308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Feb 23 01:40:11 media sudo[2308]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 01:40:11 media sudo[2308]: pam_unix(sudo:session): session closed for user root Feb 23 01:40:11 media sudo[2311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Feb 23 01:40:11 media sudo[2311]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 01:40:11 media systemd[1]: Started VolumioStreamingService. Feb 23 01:40:11 media sudo[2311]: pam_unix(sudo:session): session closed for user root Feb 23 01:40:11 media volumio[884]: info: MRS: volumioStreaming STARTED Feb 23 01:40:11 media sudo[2314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Feb 23 01:40:11 media sudo[2314]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 01:40:11 media sudo[2314]: pam_unix(sudo:session): session closed for user root Feb 23 01:40:14 media volumio[884]: info: CoreCommandRouter::volumioNext Feb 23 01:40:14 media volumio[884]: info: CoreStateMachine::next Feb 23 01:40:14 media volumio[884]: info: CoreStateMachine::stop Feb 23 01:40:14 media volumio[884]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 01:40:14 media volumio[884]: info: CoreStateMachine::stPlaybackTimer Feb 23 01:40:14 media volumio[884]: info: CoreStateMachine::updateTrackBlock Feb 23 01:40:14 media volumio[884]: info: CorePlayQueue::getTrackBlock Feb 23 01:40:14 media volumio[884]: info: CoreStateMachine::pushState Feb 23 01:40:14 media volumio[884]: info: CorePlayQueue::getTrack 0 Feb 23 01:40:14 media volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 01:40:14 media volumio[884]: info: CoreCommandRouter::volumioPushState Feb 23 01:40:14 media volumio[884]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 01:40:14 media volumio[884]: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Feb 23 01:40:14 media volumio[884]: at FerrumStreamingControlTechnology.updateStateOnPlayer (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:72:12) Feb 23 01:40:14 media volumio[884]: at FerrumStreamingControlTechnology.pushState (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:182:10) Feb 23 01:40:14 media volumio[884]: at /volumio/app/index.js:326:81 Feb 23 01:40:14 media volumio[884]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Feb 23 01:40:14 media volumio[884]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Feb 23 01:40:14 media volumio[884]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) Feb 23 01:40:14 media volumio[884]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:534:22) Feb 23 01:40:14 media volumio[884]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1247:12) Feb 23 01:40:14 media volumio[884]: at CoreStateMachine.next (/volumio/app/statemachine.js:1180:12) Feb 23 01:40:14 media volumio[884]: at CoreCommandRouter.volumioNext (/volumio/app/index.js:103:28) Feb 23 01:40:14 media volumio[884]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:274:26) Feb 23 01:40:14 media volumio[884]: at Socket.emit (events.js:315:20) Feb 23 01:40:14 media volumio[884]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 23 01:40:14 media volumio[884]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Feb 23 01:40:14 media volumio[884]: code: 'NumberExpected' Feb 23 01:40:14 media volumio[884]: } Feb 23 01:40:14 media volumio[884]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 01:40:14 media sudo[2327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-23 01:39 Feb 23 01:40:14 media sudo[2327]: 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="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="Tue 17 Feb 2026 11:59:18 AM CET" VOLUMIO_VERSION="3.911" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="edb2bf2a377e11a135c77ce9e163dd4e"