-- Logs begin at Sat 2024-10-26 11:02:26 WEST, end at Sat 2024-10-26 11:04:42 WEST. --
Oct 26 11:03:00 volumio sudo[1589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Oct 26 11:03:00 volumio sudo[1589]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:03:00 volumio systemd[1]: Started Volumio Bluetooth Module.
Oct 26 11:03:00 volumio sudo[1589]: pam_unix(sudo:session): session closed for user root
Oct 26 11:03:00 volumio volumio[1229]: info: Volumio BT Module successfully started
Oct 26 11:03:00 volumio sudo[1592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Oct 26 11:03:00 volumio sudo[1592]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:03:00 volumio volumiobt[1591]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Oct 26 11:03:00 volumio sudo[1592]: pam_unix(sudo:session): session closed for user root
Oct 26 11:03:01 volumio volumio[1229]: info: TidalConnect service stoped!
Oct 26 11:03:01 volumio volumio[1229]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Oct 26 11:03:01 volumio volumio[1229]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Oct 26 11:03:01 volumio sudo[1604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Oct 26 11:03:01 volumio sudo[1604]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:03:01 volumio systemd[1]: Started Volumio Tidal Connect Service.
Oct 26 11:03:01 volumio sudo[1604]: pam_unix(sudo:session): session closed for user root
Oct 26 11:03:01 volumio volumio[1229]: info: Executing endpoint tc_getconfig
Oct 26 11:03:01 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Oct 26 11:03:01 volumio vtcs[1606]: STARTING TidalConnect services, version: 1.4.0.34
Oct 26 11:03:01 volumio vtcs[1606]: STARTED TidalConnect services.
Oct 26 11:03:01 volumio volumio[1229]: info: Executing endpoint tc_connect
Oct 26 11:03:01 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Oct 26 11:03:01 volumio volumio[1229]: info: Connecting to TidalConnect
Oct 26 11:03:01 volumio volumio[1229]: info: CoreCommandRouter::servicePushState
Oct 26 11:03:01 volumio volumio[1229]: info: CoreStateMachine::pushState
Oct 26 11:03:01 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:01 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState
Oct 26 11:03:01 volumio volumio[1229]: info: MRS: Pushing multiroomSync output update for this device
Oct 26 11:03:01 volumio volumio[1229]: info: MRS: Pushing multiroomSync output
Oct 26 11:03:01 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:01 volumio volumio[1229]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect
Oct 26 11:03:01 volumio volumio[1229]: info: CoreCommandRouter::servicePushState
Oct 26 11:03:01 volumio volumio[1229]: info: CoreStateMachine::pushState
Oct 26 11:03:01 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:01 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState
Oct 26 11:03:01 volumio volumio[1229]: info: MRS: Pushing multiroomSync output update for this device
Oct 26 11:03:01 volumio volumio[1229]: info: MRS: Pushing multiroomSync output
Oct 26 11:03:01 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:01 volumio volumio[1229]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect
Oct 26 11:03:01 volumio sudo[1630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Oct 26 11:03:01 volumio sudo[1630]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:03:02 volumio sudo[1633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Oct 26 11:03:02 volumio systemd[1]: Started MyVolumio SSH Tunnel.
Oct 26 11:03:02 volumio sudo[1633]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:03:02 volumio sudo[1630]: pam_unix(sudo:session): session closed for user root
Oct 26 11:03:02 volumio volumio[1229]: info: Remote SSH Started
Oct 26 11:03:02 volumio volumiobt[1591]: pulseaudio: no process found
Oct 26 11:03:02 volumio sudo[1633]: pam_unix(sudo:session): session closed for user root
Oct 26 11:03:02 volumio autossh[1635]: port set to 0, monitoring disabled
Oct 26 11:03:02 volumio autossh[1635]: starting ssh (count 1)
Oct 26 11:03:02 volumio autossh[1635]: ssh child pid is 1639
Oct 26 11:03:02 volumio volumio[1229]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 43
Oct 26 11:03:02 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:03:02 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:02 volumio dbus-daemon[852]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.26' (uid=1000 pid=1641 comm="/usr/bin/pulseaudio --high-priority=true ")
Oct 26 11:03:02 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Oct 26 11:03:02 volumio volumio[1229]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 26 11:03:02 volumio dbus-daemon[852]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Oct 26 11:03:02 volumio rtkit-daemon[1642]: Successfully called chroot.
Oct 26 11:03:02 volumio rtkit-daemon[1642]: Successfully dropped privileges.
Oct 26 11:03:02 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service.
Oct 26 11:03:02 volumio rtkit-daemon[1642]: Successfully limited resources.
Oct 26 11:03:02 volumio rtkit-daemon[1642]: Running.
Oct 26 11:03:02 volumio rtkit-daemon[1642]: Canary thread running.
Oct 26 11:03:02 volumio dbus-daemon[852]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.27' (uid=0 pid=1642 comm="/usr/lib/rtkit/rtkit-daemon ")
Oct 26 11:03:02 volumio rtkit-daemon[1642]: Watchdog thread running.
Oct 26 11:03:02 volumio systemd[1]: Starting Authorization Manager...
Oct 26 11:03:02 volumio volumio[1229]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 26 11:03:02 volumio polkitd[1645]: started daemon version 0.105 using authority implementation `local' version `0.105'
Oct 26 11:03:02 volumio dbus-daemon[852]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Oct 26 11:03:02 volumio systemd[1]: Started Authorization Manager.
Oct 26 11:03:02 volumio pulseaudio[1641]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Oct 26 11:03:02 volumio pulseaudio[1641]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Oct 26 11:03:02 volumio volumiobt[1591]: Applying permissions
Oct 26 11:03:02 volumio volumiobt[1591]: Setting BT discoverable and pairable
Oct 26 11:03:02 volumio bluetoothd[939]: Endpoint registered: sender=:1.47 path=/MediaEndpoint/A2DPSource
Oct 26 11:03:02 volumio bluetoothd[939]: Endpoint registered: sender=:1.47 path=/MediaEndpoint/A2DPSink
Oct 26 11:03:02 volumio pulseaudio[1641]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files
Oct 26 11:03:02 volumio volumiobt[1591]: [CHG] Controller D8:3A:DD:F4:B8:92 Class: 0x0008041c
Oct 26 11:03:02 volumio volumiobt[1591]: [55B blob data]
Oct 26 11:03:02 volumio volumiobt[1591]: [bluetooth]# -e power on
Oct 26 11:03:02 volumio volumiobt[1591]: Invalid command in menu main: -e
Oct 26 11:03:02 volumio volumiobt[1591]:
Oct 26 11:03:02 volumio volumiobt[1591]: Use "help" for a list of available commands in a menu.
Oct 26 11:03:02 volumio volumiobt[1591]: Use "menu " if you want to enter any submenu.
Oct 26 11:03:02 volumio volumiobt[1591]: Use "back" if you want to return to menu main.
Oct 26 11:03:02 volumio volumiobt[1591]: [bluetooth]# agent on
Oct 26 11:03:02 volumio volumiobt[1591]: Agent is already registered
Oct 26 11:03:02 volumio volumiobt[1591]: [bluetooth]# discoverable on
Oct 26 11:03:02 volumio kernel: Bluetooth: RFCOMM TTY layer initialized
Oct 26 11:03:02 volumio kernel: Bluetooth: RFCOMM socket layer initialized
Oct 26 11:03:02 volumio kernel: Bluetooth: RFCOMM ver 1.11
Oct 26 11:03:02 volumio volumiobt[1591]: [bluetooth]# pairable on
Oct 26 11:03:02 volumio volumiobt[1591]: [bluetooth]# agent NoInputNoOutput
Oct 26 11:03:02 volumio volumiobt[1591]: Agent is already registered
Oct 26 11:03:02 volumio volumiobt[1591]: [bluetooth]# default-agent
Oct 26 11:03:02 volumio volumiobt[1591]: [bluetooth]# quit
Oct 26 11:03:02 volumio volumiobt[1591]: [59B blob data]
Oct 26 11:03:02 volumio volumiossh-tunnel[1632]: Warning: Permanently added '[eu3.myvolumio.org]:2222,[167.71.136.233]:2222' (RSA) to the list of known hosts.
Oct 26 11:03:02 volumio volumio[1229]: info: MRS: Getting audio outputs on start
Oct 26 11:03:02 volumio volumio[1229]: info: MRS: Requesting all other devices output
Oct 26 11:03:04 volumio volumio[1229]: info: TidalConnect service started!
Oct 26 11:03:04 volumio volumio[1229]: info: BOOT COMPLETED
Oct 26 11:03:04 volumio volumio[1229]: [Metrics] CommandRouter: 20s 242.11ms
Oct 26 11:03:04 volumio volumio[1229]: info: CoreCommandRouter::volumiosetStartupVolume
Oct 26 11:03:04 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 11:03:04 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 11:03:04 volumio volumio[1229]: info: CoreCommandRouter::Close All Modals sent
Oct 26 11:03:04 volumio volumio[1229]: info: CoreCommandRouter::Close All Modals sent
Oct 26 11:03:04 volumio volumio[1229]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Oct 26 11:03:04 volumio volumio[1229]: xcb_connection_has_error() returned true
Oct 26 11:03:04 volumio volumio[1229]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback
Oct 26 11:03:04 volumio volumio[1229]: aplay: main:828: audio open error: Unknown error 524
Oct 26 11:03:05 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Oct 26 11:03:05 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 11:03:05 volumio volumio[1229]: xcb_connection_has_error() returned true
Oct 26 11:03:05 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 44
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:03:10 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 45
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 46
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 47
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 48
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 49
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 50
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 51
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 52
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 53
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 54
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 55
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 56
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 57
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 58
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 59
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 60
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 61
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 62
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 63
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 64
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 65
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 66
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 67
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 68
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 69
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 70
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 71
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 72
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 73
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 74
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 75
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 76
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 77
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 78
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 79
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 80
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 81
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 82
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 83
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 84
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 85
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 86
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 87
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 88
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 89
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 90
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 91
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 92
Oct 26 11:03:10 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 93
Oct 26 11:03:10 volumio volumio[1229]: info: Received Get System Info
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 11:03:10 volumio volumio[1229]: info: Discovery: Getting this device information
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:03:10 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:03:10 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:03:10 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 26 11:03:10 volumio volumio[1229]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Oct 26 11:03:10 volumio volumio[1229]: info: Received Get System Info
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 11:03:10 volumio volumio[1229]: info: Discovery: Getting this device information
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:03:10 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:03:10 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:10 volumio volumio[1229]: info: Listing playlists
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetQueue
Oct 26 11:03:10 volumio volumio[1229]: info: CoreStateMachine::getQueue
Oct 26 11:03:10 volumio volumio[1229]: info: CorePlayQueue::getQueue
Oct 26 11:03:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 26 11:03:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 11:03:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 11:03:11 volumio volumio[1229]: info: Discovery: Getting this device information
Oct 26 11:03:11 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:03:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 11:03:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:12 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:12 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:13 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:13 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:14 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:14 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 26 11:03:15 volumio volumio-remote-updater[858]: No test mode
Oct 26 11:03:15 volumio volumio-remote-updater[858]: No alpha test mode
Oct 26 11:03:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 26 11:03:16 volumio volumio[1229]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
- Fix for Wizard not showing on second start
- Fix for Playback Queue not advancing
NEW ADDITIONS
- Add DSD Quirk for Marantz SA-12 on Rivo and Primo v2
","title":"Update v3.757","updateavailable":true}
Oct 26 11:03:16 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 26 11:03:17 volumio volumio[1229]: info: Executing endpoint metavolumio
Oct 26 11:03:17 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Oct 26 11:03:17 volumio volumio[1229]: info: Executing endpoint metavolumio
Oct 26 11:03:17 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Oct 26 11:03:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 26 11:03:23 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput
Oct 26 11:03:23 volumio volumio[1229]: info: MRS: Starting cast device: Onkyo-TX-RZ50-a8fb360e0c5ec7225390016bf2db1bf0
Oct 26 11:03:23 volumio volumio[1229]: info: Enabled audio output: Onkyo-TX-RZ50-a8fb360e0c5ec7225390016bf2db1bf0
Oct 26 11:03:23 volumio volumio[1229]: info: MRS: Setting this device as Streaming Server
Oct 26 11:03:23 volumio volumio[1229]: info:
Oct 26 11:03:23 volumio volumio[1229]: [1729937003181] ---------------------------- MRS: Setting Streaming Server
Oct 26 11:03:23 volumio volumio[1229]: info: MRS: enable multiroom server output
Oct 26 11:03:23 volumio volumio[1229]: info: MRS: Set multiroom target PCM to volumioMultiRoom
Oct 26 11:03:23 volumio volumio[1229]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom
Oct 26 11:03:23 volumio volumio[1229]: info: MRS: Set multiroom target PCM to volumioLocalPlayback
Oct 26 11:03:23 volumio volumio[1229]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback
Oct 26 11:03:23 volumio volumio[1229]: info: MRS: STARTING volumioStreaming
Oct 26 11:03:23 volumio sudo[1666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Oct 26 11:03:23 volumio sudo[1666]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:03:23 volumio sudo[1666]: pam_unix(sudo:session): session closed for user root
Oct 26 11:03:23 volumio sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming
Oct 26 11:03:23 volumio sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:03:23 volumio systemd[1]: Started VolumioStreamingService.
Oct 26 11:03:23 volumio sudo[1668]: pam_unix(sudo:session): session closed for user root
Oct 26 11:03:23 volumio sudo[1672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Oct 26 11:03:23 volumio sudo[1672]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:03:23 volumio volumio[1229]: info: MRS: volumioStreaming STARTED
Oct 26 11:03:23 volumio sudo[1672]: pam_unix(sudo:session): session closed for user root
Oct 26 11:03:24 volumio volumio[1229]: error: Failed request for metavolumio API
Oct 26 11:03:24 volumio volumio[1229]: error: Failed request for metavolumio API
Oct 26 11:03:26 volumio volumio[1229]: info: CoreCommandRouter::volumioPlay
Oct 26 11:03:26 volumio volumio[1229]: info: CoreStateMachine::play index undefined
Oct 26 11:03:26 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 11:03:26 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:26 volumio volumio[1229]: info: CoreStateMachine::startPlaybackTimer
Oct 26 11:03:26 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:26 volumio volumio[1229]: info: [1729937006798] ControllerQobuz::clearAddPlayTrack
Oct 26 11:03:26 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand stop
Oct 26 11:03:26 volumio volumio[1229]: info: sendMpdCommand stop took 1 milliseconds
Oct 26 11:03:26 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand clear
Oct 26 11:03:26 volumio volumio[1229]: info:
Oct 26 11:03:26 volumio volumio[1229]: ---------------------------- MPD announces system playlist update
Oct 26 11:03:26 volumio volumio[1229]: info: Ignoring MPD Status Update
Oct 26 11:03:26 volumio volumio[1229]: info: sendMpdCommand clear took 1 milliseconds
Oct 26 11:03:26 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/48282246"
Oct 26 11:03:26 volumio volumio[1229]: error: updateQueue error: null
Oct 26 11:03:26 volumio volumio[1229]: info: ------------------------------ 2ms
Oct 26 11:03:26 volumio volumio[1229]: STREAMING PROXY: Handling url /?data=qobuz://song/48282246
Oct 26 11:03:26 volumio volumio[1229]: info: Executing endpoint getStreamUrlqobuz
Oct 26 11:03:26 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Oct 26 11:03:27 volumio volumio[1229]: info: getStreamUrl took 773 milliseconds
Oct 26 11:03:27 volumio volumio[1229]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=2386042&eid=48282246&fmt=7&profile=raw&app_id=539451548&cid=2392600&etsp=1729940607&hmac=PMEhOWL3zyXwDdyTXHvXyYCzsMg
Oct 26 11:03:27 volumio volumio[1229]: STREAMING PROXY: Response: 200, length: 88822666
Oct 26 11:03:27 volumio volumio[1229]: STREAMING PROXY: Client dropped request, destroying
Oct 26 11:03:27 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/48282246"
Oct 26 11:03:27 volumio volumio[1229]: info:
Oct 26 11:03:27 volumio volumio[1229]: ---------------------------- MPD announces system playlist update
Oct 26 11:03:27 volumio volumio[1229]: info: Ignoring MPD Status Update
Oct 26 11:03:27 volumio volumio[1229]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/48282246" took 1 milliseconds
Oct 26 11:03:27 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 26 11:03:27 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand play
Oct 26 11:03:27 volumio volumio[1229]: info: ------------------------------ 2ms
Oct 26 11:03:27 volumio volumio[1229]: info: sendMpdCommand play took 1 milliseconds
Oct 26 11:03:27 volumio volumio[1229]: STREAMING PROXY: Handling url /?data=qobuz://song/48282246
Oct 26 11:03:27 volumio volumio[1229]: info: Executing endpoint getStreamUrlqobuz
Oct 26 11:03:27 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Oct 26 11:03:28 volumio volumio[1229]: info: getStreamUrl took 739 milliseconds
Oct 26 11:03:28 volumio volumio[1229]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=2386042&eid=48282246&fmt=7&profile=raw&app_id=539451548&cid=2392600&etsp=1729940608&hmac=6axlWmK5UjNDMMuNznc_j778FRg
Oct 26 11:03:28 volumio volumio[1229]: STREAMING PROXY: Response: 200, length: 88822666
Oct 26 11:03:28 volumio volumio[1229]: info:
Oct 26 11:03:28 volumio volumio[1229]: ---------------------------- MPD announces state update: player
Oct 26 11:03:28 volumio volumio[1229]: info: ControllerMpd::getState
Oct 26 11:03:28 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 11:03:28 volumio volumio[1229]: info: sendMpdCommand status took 9 milliseconds
Oct 26 11:03:28 volumio volumio[1229]: verbose: ControllerMpd::parseState
Oct 26 11:03:28 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 11:03:28 volumio volumio[1229]: info:
Oct 26 11:03:28 volumio volumio[1229]: ---------------------------- MPD announces state update: player
Oct 26 11:03:28 volumio volumio[1229]: info: ControllerMpd::getState
Oct 26 11:03:28 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 11:03:28 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 26 11:03:28 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo
Oct 26 11:03:28 volumio volumio[1229]: info: ControllerMpd::pushState
Oct 26 11:03:28 volumio volumio[1229]: info: CoreCommandRouter::servicePushState
Oct 26 11:03:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:28 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":308,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"290 Kbps","isStreaming":false,"title":"48282246","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/48282246","trackType":"qobuz"}
Oct 26 11:03:28 volumio volumio[1229]: verbose: CURRENT POSITION 0
Oct 26 11:03:28 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play
Oct 26 11:03:28 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus stop
Oct 26 11:03:28 volumio volumio[1229]: info: ------------------------------ 19ms
Oct 26 11:03:28 volumio volumio[1229]: info: sendMpdCommand status took 2 milliseconds
Oct 26 11:03:28 volumio volumio[1229]: verbose: ControllerMpd::parseState
Oct 26 11:03:28 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 11:03:28 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 26 11:03:28 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo
Oct 26 11:03:28 volumio volumio[1229]: info: ControllerMpd::pushState
Oct 26 11:03:28 volumio volumio[1229]: info: CoreCommandRouter::servicePushState
Oct 26 11:03:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:28 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":308,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1527 Kbps","isStreaming":false,"title":"48282246","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/48282246","trackType":"qobuz"}
Oct 26 11:03:28 volumio volumio[1229]: verbose: CURRENT POSITION 0
Oct 26 11:03:28 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play
Oct 26 11:03:28 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus play
Oct 26 11:03:28 volumio volumio[1229]: info: Received an update from plugin. extracting info from payload
Oct 26 11:03:28 volumio volumio[1229]: info: CoreStateMachine::pushState
Oct 26 11:03:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 11:03:28 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState
Oct 26 11:03:28 volumio volumio[1229]: info: MRS: Pushing multiroomSync output update for this device
Oct 26 11:03:28 volumio volumio[1229]: info: MRS: Pushing multiroomSync output
Oct 26 11:03:28 volumio volumio[1229]: info: CoreStateMachine::pushState
Oct 26 11:03:28 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState
Oct 26 11:03:28 volumio volumio[1229]: info: MRS: Pushing multiroomSync output update for this device
Oct 26 11:03:28 volumio volumio[1229]: info: MRS: Pushing multiroomSync output
Oct 26 11:03:28 volumio volumio[1229]: info: ------------------------------ 22ms
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::volumioPause
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::pause
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::servicePause
Oct 26 11:03:29 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::servicePause
Oct 26 11:03:29 volumio volumio[1229]: info: [1729937009242] ControllerQobuz::pause
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 26 11:03:29 volumio volumio[1229]: info: ControllerMpd::pause
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand pause
Oct 26 11:03:29 volumio volumio[1229]: info:
Oct 26 11:03:29 volumio volumio[1229]: ---------------------------- MPD announces state update: player
Oct 26 11:03:29 volumio volumio[1229]: info: sendMpdCommand pause took 2 milliseconds
Oct 26 11:03:29 volumio volumio[1229]: info: ControllerMpd::getState
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 11:03:29 volumio volumio[1229]: info: sendMpdCommand status took 1 milliseconds
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::parseState
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 11:03:29 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo
Oct 26 11:03:29 volumio volumio[1229]: info: ControllerMpd::pushState
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::servicePushState
Oct 26 11:03:29 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:29 volumio volumio[1229]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2365,"duration":308,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1760 Kbps","isStreaming":false,"title":"48282246","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/48282246","trackType":"qobuz"}
Oct 26 11:03:29 volumio volumio[1229]: verbose: CURRENT POSITION 0
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::syncState stateService pause
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus pause
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::pushState
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState
Oct 26 11:03:29 volumio volumio[1229]: info: MRS: Pushing multiroomSync output update for this device
Oct 26 11:03:29 volumio volumio[1229]: info: MRS: Pushing multiroomSync output
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer
Oct 26 11:03:29 volumio volumio[1229]: info: ------------------------------ 22ms
Oct 26 11:03:29 volumio volumio[1229]: STREAMING PROXY: Client dropped request, destroying
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::volumioPlay
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::play index undefined
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 11:03:29 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::startPlaybackTimer
Oct 26 11:03:29 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:29 volumio volumio[1229]: info: [1729937009979] ControllerQobuz::resume
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 26 11:03:29 volumio volumio[1229]: info: ControllerMpd::resume
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand play
Oct 26 11:03:29 volumio volumio[1229]: info:
Oct 26 11:03:29 volumio volumio[1229]: ---------------------------- MPD announces state update: player
Oct 26 11:03:29 volumio volumio[1229]: info: sendMpdCommand play took 4 milliseconds
Oct 26 11:03:29 volumio volumio[1229]: info: ControllerMpd::getState
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 11:03:29 volumio volumio[1229]: info: sendMpdCommand status took 0 milliseconds
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::parseState
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 11:03:29 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 26 11:03:29 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo
Oct 26 11:03:29 volumio volumio[1229]: info: ControllerMpd::pushState
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::servicePushState
Oct 26 11:03:29 volumio volumio[1229]: info: CorePlayQueue::getTrack 0
Oct 26 11:03:29 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2811,"duration":308,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1765 Kbps","isStreaming":false,"title":"48282246","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/48282246","trackType":"qobuz"}
Oct 26 11:03:29 volumio volumio[1229]: verbose: CURRENT POSITION 0
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus pause
Oct 26 11:03:29 volumio volumio[1229]: info: CoreStateMachine::pushState
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 11:03:29 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState
Oct 26 11:03:29 volumio volumio[1229]: info: MRS: Pushing multiroomSync output update for this device
Oct 26 11:03:29 volumio volumio[1229]: info: MRS: Pushing multiroomSync output
Oct 26 11:03:29 volumio volumio[1229]: info: ------------------------------ 13ms
Oct 26 11:03:34 volumio ntpd[998]: Soliciting pool server 193.136.164.4
Oct 26 11:03:34 volumio ntpd[998]: Soliciting pool server 193.136.152.71
Oct 26 11:03:35 volumio ntpd[998]: Soliciting pool server 162.159.200.1
Oct 26 11:03:35 volumio ntpd[998]: Soliciting pool server 85.138.124.211
Oct 26 11:03:36 volumio ntpd[998]: Soliciting pool server 23.147.168.177
Oct 26 11:03:36 volumio ntpd[998]: Soliciting pool server 194.117.47.42
Oct 26 11:03:37 volumio ntpd[998]: Soliciting pool server 194.117.47.44
Oct 26 11:03:37 volumio ntpd[998]: Soliciting pool server 193.136.152.72
Oct 26 11:03:38 volumio ntpd[998]: Soliciting pool server 23.147.168.132
Oct 26 11:03:38 volumio ntpd[998]: Soliciting pool server 23.147.168.176
Oct 26 11:03:39 volumio ntpd[998]: Soliciting pool server 2606:4700:f1::1
Oct 26 11:03:42 volumio ntpd[998]: receive: Unexpected origin timestamp 0xeac73cfd.b69d1a25 does not match aorg 0000000000.00000000 from server@193.136.152.71 xmt 0xeac73cfe.378ac5e0
Oct 26 11:03:42 volumio ntpd[998]: receive: Unexpected origin timestamp 0xeac73cfd.b69b54ba does not match aorg 0000000000.00000000 from server@23.147.168.177 xmt 0xeac73cfe.37938633
Oct 26 11:04:35 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.100.125 from 192.168.100.142 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6
Oct 26 11:04:35 volumio volumio[1229]: info: Received Get System Info
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 11:04:35 volumio volumio[1229]: info: Discovery: Getting this device information
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 26 11:04:35 volumio volumio[1229]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Oct 26 11:04:35 volumio volumio[1229]: info: Received Get System Info
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 11:04:35 volumio volumio[1229]: info: Discovery: Getting this device information
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState
Oct 26 11:04:35 volumio volumio[1229]: info: Listing playlists
Oct 26 11:04:35 volumio volumio[1229]: info: CoreCommandRouter::volumioGetQueue
Oct 26 11:04:35 volumio volumio[1229]: info: CoreStateMachine::getQueue
Oct 26 11:04:35 volumio volumio[1229]: info: CorePlayQueue::getQueue
Oct 26 11:04:36 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 26 11:04:42 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput
Oct 26 11:04:42 volumio volumio[1229]: info: MRS: Starting cast device: WiiM-Ultra-04e1c4acf9eea318f94a68a680a30073
Oct 26 11:04:42 volumio volumio[1229]: info: Enabled audio output: WiiM-Ultra-04e1c4acf9eea318f94a68a680a30073
Oct 26 11:04:42 volumio volumio[1229]: info: MRS: Setting this device as Streaming Server
Oct 26 11:04:42 volumio volumio[1229]: info:
Oct 26 11:04:42 volumio volumio[1229]: [1729937082388] ---------------------------- MRS: Setting Streaming Server
Oct 26 11:04:42 volumio volumio[1229]: info: MRS: enable multiroom server output
Oct 26 11:04:42 volumio volumio[1229]: info: MRS: Set multiroom target PCM to volumioMultiRoom
Oct 26 11:04:42 volumio volumio[1229]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom
Oct 26 11:04:42 volumio volumio[1229]: info: MRS: Set multiroom target PCM to volumioLocalPlayback
Oct 26 11:04:42 volumio volumio[1229]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback
Oct 26 11:04:42 volumio volumio[1229]: info: MRS: STARTING volumioStreaming
Oct 26 11:04:42 volumio sudo[1770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream0.ts /tmp/hls/stream1.ts /tmp/hls/stream10.ts /tmp/hls/stream11.ts /tmp/hls/stream12.ts /tmp/hls/stream13.ts /tmp/hls/stream14.ts /tmp/hls/stream15.ts /tmp/hls/stream16.ts /tmp/hls/stream17.ts /tmp/hls/stream18.ts /tmp/hls/stream19.ts /tmp/hls/stream2.ts /tmp/hls/stream20.ts /tmp/hls/stream21.ts /tmp/hls/stream22.ts /tmp/hls/stream23.ts /tmp/hls/stream24.ts /tmp/hls/stream25.ts /tmp/hls/stream26.ts /tmp/hls/stream27.ts /tmp/hls/stream28.ts /tmp/hls/stream29.ts /tmp/hls/stream3.ts /tmp/hls/stream30.ts /tmp/hls/stream31.ts /tmp/hls/stream32.ts /tmp/hls/stream33.ts /tmp/hls/stream34.ts /tmp/hls/stream35.ts /tmp/hls/stream36.ts /tmp/hls/stream37.ts /tmp/hls/stream38.ts /tmp/hls/stream39.ts /tmp/hls/stream4.ts /tmp/hls/stream40.ts /tmp/hls/stream41.ts /tmp/hls/stream42.ts /tmp/hls/stream43.ts /tmp/hls/stream44.ts /tmp/hls/stream45.ts
Oct 26 11:04:42 volumio sudo[1770]: volumio : (command continued) /tmp/hls/stream46.ts /tmp/hls/stream47.ts /tmp/hls/stream48.ts /tmp/hls/stream49.ts /tmp/hls/stream5.ts /tmp/hls/stream50.ts /tmp/hls/stream51.ts /tmp/hls/stream52.ts /tmp/hls/stream53.ts /tmp/hls/stream54.ts /tmp/hls/stream55.ts /tmp/hls/stream56.ts /tmp/hls/stream57.ts /tmp/hls/stream58.ts /tmp/hls/stream59.ts /tmp/hls/stream6.ts /tmp/hls/stream60.ts /tmp/hls/stream61.ts /tmp/hls/stream62.ts /tmp/hls/stream63.ts /tmp/hls/stream64.ts /tmp/hls/stream65.ts /tmp/hls/stream66.ts /tmp/hls/stream67.ts /tmp/hls/stream68.ts /tmp/hls/stream69.ts /tmp/hls/stream7.ts /tmp/hls/stream70.ts /tmp/hls/stream71.ts /tmp/hls/stream72.ts /tmp/hls/stream8.ts /tmp/hls/stream9.ts
Oct 26 11:04:42 volumio sudo[1770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:04:42 volumio sudo[1770]: pam_unix(sudo:session): session closed for user root
Oct 26 11:04:42 volumio sudo[1772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming
Oct 26 11:04:42 volumio sudo[1772]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:04:42 volumio volumio[1229]: info: MRS: Connected to cast device: WiiM-Ultra-04e1c4acf9eea318f94a68a680a30073
Oct 26 11:04:42 volumio systemd[1]: Stopping VolumioStreamingService...
Oct 26 11:04:42 volumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM
Oct 26 11:04:42 volumio volumio[1229]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 26 11:04:42 volumio systemd[1]: volumioStreaming.service: Succeeded.
Oct 26 11:04:42 volumio systemd[1]: Stopped VolumioStreamingService.
Oct 26 11:04:42 volumio volumio[1229]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 11:04:42 volumio volumio[1229]: TypeError: Cannot read property 'on' of undefined
Oct 26 11:04:42 volumio volumio[1229]: at /myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:29162
Oct 26 11:04:42 volumio volumio[1229]: at /myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:95:20
Oct 26 11:04:42 volumio volumio[1229]: at /myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/receiver.js:51:14
Oct 26 11:04:42 volumio volumio[1229]: at fn.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:27:7)
Oct 26 11:04:42 volumio volumio[1229]: at fn.emit (events.js:327:22)
Oct 26 11:04:42 volumio volumio[1229]: at Channel.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:16:10)
Oct 26 11:04:42 volumio volumio[1229]: at Channel.emit (events.js:315:20)
Oct 26 11:04:42 volumio volumio[1229]: at Client.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:23:10)
Oct 26 11:04:42 volumio volumio[1229]: at Client.emit (events.js:327:22)
Oct 26 11:04:42 volumio volumio[1229]: at PacketStreamWrapper.onpacket (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:81:10)
Oct 26 11:04:42 volumio volumio[1229]: at PacketStreamWrapper.emit (events.js:315:20)
Oct 26 11:04:42 volumio volumio[1229]: at TLSSocket. (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/packet-stream-wrapper.js:28:16)
Oct 26 11:04:42 volumio volumio[1229]: at TLSSocket.emit (events.js:315:20)
Oct 26 11:04:42 volumio volumio[1229]: at emitReadable_ (internal/streams/readable.js:569:12)
Oct 26 11:04:42 volumio volumio[1229]: at processTicksAndRejections (internal/process/task_queues.js:79:21)
Oct 26 11:04:42 volumio volumio[1229]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 11:04:42 volumio systemd[1]: Started VolumioStreamingService.
Oct 26 11:04:42 volumio sudo[1772]: pam_unix(sudo:session): session closed for user root
Oct 26 11:04:42 volumio sudo[1778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Oct 26 11:04:42 volumio sudo[1778]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 11:04:42 volumio sudo[1778]: pam_unix(sudo:session): session closed for user root
Oct 26 11:04:42 volumio sudo[1788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 11:03
Oct 26 11:04:42 volumio sudo[1788]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST"
VOLUMIO_VERSION="3.742"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"