-- Logs begin at Thu 2024-10-24 15:52:38 AEDT, end at Thu 2024-10-24 16:12:18 AEDT. -- Oct 24 16:11:00 volumiovm volumio[685]: info: TidalConnect service started! Oct 24 16:11:00 volumiovm volumio[685]: info: TidalConnect service started! Oct 24 16:11:04 volumiovm volumio[685]: info: CoreCommandRouter::volumioPause Oct 24 16:11:04 volumiovm volumio[685]: info: CoreStateMachine::pause Oct 24 16:11:04 volumiovm volumio[685]: info: CoreStateMachine::stPlaybackTimer Oct 24 16:11:04 volumiovm volumio[685]: info: CoreStateMachine::servicePause Oct 24 16:11:04 volumiovm volumio[685]: info: CorePlayQueue::getTrack 0 Oct 24 16:11:04 volumiovm volumio[685]: info: CoreCommandRouter::servicePause Oct 24 16:11:04 volumiovm volumio[685]: info: [1729746664323] ControllerTidal::pause Oct 24 16:11:04 volumiovm volumio[685]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 24 16:11:04 volumiovm volumio[685]: info: ControllerMpd::pause Oct 24 16:11:04 volumiovm volumio[685]: verbose: ControllerMpd::sendMpdCommand pause Oct 24 16:11:04 volumiovm volumio[685]: info: sendMpdCommand pause took 0 milliseconds Oct 24 16:11:07 volumiovm volumio[685]: info: CoreCommandRouter::volumioPrevious Oct 24 16:11:07 volumiovm volumio[685]: info: CoreStateMachine::previous Oct 24 16:11:07 volumiovm volumio[685]: info: CoreStateMachine::updateTrackBlock Oct 24 16:11:07 volumiovm volumio[685]: info: CorePlayQueue::getTrackBlock Oct 24 16:11:07 volumiovm volumio[685]: info: CoreStateMachine::serviceClearAddPlay Oct 24 16:11:07 volumiovm volumio[685]: info: CoreCommandRouter::serviceClearAddPlayTracks Oct 24 16:11:07 volumiovm volumio[685]: error: WARNING: No clearAddPlayTracks method for service tidal Oct 24 16:11:07 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 16:11:07 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 16:11:07 volumiovm volumio[685]: info: Discovery: Getting this device information Oct 24 16:11:07 volumiovm volumio[685]: info: CoreCommandRouter::volumioGetState Oct 24 16:11:07 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 16:11:10 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 16:11:10 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 24 16:11:19 volumiovm volumio[685]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/music_services_shield/volumio/buster/amd64 Oct 24 16:11:21 volumiovm volumio[685]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/music_services_shield/volumio/buster/amd64 Oct 24 16:11:21 volumiovm volumio[685]: info: Folder /tmp/plugins removed Oct 24 16:11:21 volumiovm volumio[685]: info: Check plugin dependencies Oct 24 16:11:21 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 24 16:11:21 volumiovm volumio[685]: info: Checking if plugin already exists Oct 24 16:11:21 volumiovm volumio[685]: info: Rename folder Oct 24 16:11:21 volumiovm volumio[685]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 16:11:21 volumiovm volumio[685]: info: Move to category Oct 24 16:11:22 volumiovm volumio[685]: info: Checking if install.sh is present Oct 24 16:11:22 volumiovm volumio[685]: info: Executing install.sh Oct 24 16:11:22 volumiovm sudo[2430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/music_services_shield/install.sh Oct 24 16:11:22 volumiovm sudo[2430]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:22 volumiovm volumio[685]: info: Installing Music Services Shield Dependencies Oct 24 16:11:22 volumiovm volumio[685]: info: Detected cpu architecture as x86_64 Oct 24 16:11:22 volumiovm sudo[2435]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update Oct 24 16:11:22 volumiovm sudo[2435]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:22 volumiovm volumio[685]: info: Get:1 http://deb.debian.org/debian buster InRelease [122 kB] Oct 24 16:11:22 volumiovm volumio[685]: info: Get:2 https://deb.nodesource.com/node_14.x buster InRelease [4584 B] Oct 24 16:11:23 volumiovm volumio[685]: info: Get:3 http://deb.debian.org/debian buster/main amd64 Packages [7909 kB] Oct 24 16:11:24 volumiovm volumio[685]: info: Get:4 https://deb.nodesource.com/node_14.x buster/main amd64 Packages [776 B] Oct 24 16:11:24 volumiovm volumio[685]: info: Get:5 http://deb.debian.org/debian buster/main i386 Packages [7866 kB] Oct 24 16:11:27 volumiovm volumio[685]: info: Get:6 http://deb.debian.org/debian buster/main Translation-en [5969 kB] Oct 24 16:11:27 volumiovm ntpd[2232]: ntpd exiting on signal 15 (Terminated) Oct 24 16:11:27 volumiovm ntpd[2232]: 194.195.249.28 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 139.180.160.82 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 119.18.6.37 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 172.105.168.117 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 162.159.200.123 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 220.158.215.21 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 103.76.40.123 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 159.196.3.239 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 103.165.180.123 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 27.124.125.252 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 110.232.114.22 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 129.250.35.250 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 159.196.44.158 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 162.159.200.1 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 203.52.62.212 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm ntpd[2232]: 103.152.64.212 local addr 10.93.93.248 -> Oct 24 16:11:27 volumiovm systemd[1]: Stopping Network Time Service... Oct 24 16:11:28 volumiovm systemd[1]: ntp.service: Succeeded. Oct 24 16:11:28 volumiovm volumio[685]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 24 16:11:28 volumiovm systemd[1]: Stopped Network Time Service. Oct 24 16:11:28 volumiovm volumio[685]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 24 16:11:28 volumiovm systemd[1]: Starting Network Time Service... Oct 24 16:11:28 volumiovm volumio[685]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 24 16:11:28 volumiovm ntpd[2668]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 24 16:11:28 volumiovm ntpd[2668]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 24 16:11:28 volumiovm systemd[1]: Started Network Time Service. Oct 24 16:11:28 volumiovm ntpd[2674]: proto: precision = 0.029 usec (-25) Oct 24 16:11:28 volumiovm ntpd[2674]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 24 16:11:28 volumiovm ntpd[2674]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 24 16:11:28 volumiovm ntpd[2674]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 667 days ago Oct 24 16:11:28 volumiovm ntpd[2674]: Listen and drop on 0 v6wildcard [::]:123 Oct 24 16:11:28 volumiovm ntpd[2674]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 24 16:11:28 volumiovm ntpd[2674]: Listen normally on 2 lo 127.0.0.1:123 Oct 24 16:11:28 volumiovm ntpd[2674]: Listen normally on 3 eth0 10.93.93.248:123 Oct 24 16:11:28 volumiovm ntpd[2674]: Listening on routing socket on fd #20 for interface updates Oct 24 16:11:28 volumiovm ntpd[2674]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 24 16:11:28 volumiovm ntpd[2674]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 24 16:11:29 volumiovm ntpd[2674]: Soliciting pool server 27.124.125.252 Oct 24 16:11:29 volumiovm volumio[685]: info: Get:7 http://deb.debian.org/debian buster/contrib amd64 Packages [50.1 kB] Oct 24 16:11:29 volumiovm volumio[685]: info: Get:8 http://deb.debian.org/debian buster/contrib i386 Packages [46.0 kB] Oct 24 16:11:29 volumiovm volumio[685]: info: Get:9 http://deb.debian.org/debian buster/contrib Translation-en [44.2 kB] Oct 24 16:11:29 volumiovm volumio[685]: info: Get:10 http://deb.debian.org/debian buster/non-free i386 Packages [76.3 kB] Oct 24 16:11:29 volumiovm volumio[685]: info: Get:11 http://deb.debian.org/debian buster/non-free amd64 Packages [87.8 kB] Oct 24 16:11:29 volumiovm volumio[685]: info: Get:12 http://deb.debian.org/debian buster/non-free Translation-en [88.9 kB] Oct 24 16:11:30 volumiovm ntpd[2674]: Soliciting pool server 194.195.249.28 Oct 24 16:11:30 volumiovm ntpd[2674]: Soliciting pool server 67.219.100.202 Oct 24 16:11:31 volumiovm ntpd[2674]: Soliciting pool server 203.14.0.251 Oct 24 16:11:31 volumiovm ntpd[2674]: Soliciting pool server 139.180.160.82 Oct 24 16:11:31 volumiovm ntpd[2674]: Soliciting pool server 159.196.3.239 Oct 24 16:11:31 volumiovm volumio[685]: info: Ign:6 http://deb.debian.org/debian buster/main Translation-en Oct 24 16:11:32 volumiovm ntpd[2674]: Soliciting pool server 103.126.53.123 Oct 24 16:11:32 volumiovm ntpd[2674]: Soliciting pool server 220.158.215.21 Oct 24 16:11:32 volumiovm ntpd[2674]: Soliciting pool server 162.159.200.123 Oct 24 16:11:32 volumiovm ntpd[2674]: Soliciting pool server 103.76.40.123 Oct 24 16:11:32 volumiovm volumio[685]: info: Ign:6 http://deb.debian.org/debian buster/main Translation-en Oct 24 16:11:32 volumiovm volumio[685]: info: Err:6 http://deb.debian.org/debian buster/main Translation-en Oct 24 16:11:32 volumiovm volumio[685]: info: Write error - write (28: No space left on device) Oct 24 16:11:32 volumiovm volumio[685]: info: Fetched 22.3 MB in 10s (2145 kB/s) Oct 24 16:11:32 volumiovm volumio[685]: info: Reading package lists... Oct 24 16:11:32 volumiovm sudo[2435]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:32 volumiovm sudo[2678]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -y install cpuset Oct 24 16:11:32 volumiovm sudo[2678]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:32 volumiovm volumio[685]: info: Reading package lists... Oct 24 16:11:32 volumiovm volumio[685]: info: Building dependency tree... Oct 24 16:11:32 volumiovm volumio[685]: info: Reading state information... Oct 24 16:11:32 volumiovm sudo[2678]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:32 volumiovm sudo[2682]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/moveprocess.sh Oct 24 16:11:32 volumiovm sudo[2682]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:32 volumiovm sudo[2682]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:32 volumiovm sudo[2684]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Oct 24 16:11:32 volumiovm sudo[2684]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:32 volumiovm sudo[2684]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:33 volumiovm sudo[2686]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/usertaskstable.sh Oct 24 16:11:33 volumiovm sudo[2686]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:33 volumiovm sudo[2686]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:33 volumiovm sudo[2688]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/builduiconfig.sh Oct 24 16:11:33 volumiovm sudo[2688]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:33 volumiovm sudo[2688]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:33 volumiovm sudo[2690]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/setconfigparameter.sh Oct 24 16:11:33 volumiovm sudo[2690]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:33 volumiovm sudo[2690]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:33 volumiovm sudo[2692]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/setrtpriority.sh Oct 24 16:11:33 volumiovm sudo[2692]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:33 volumiovm sudo[2692]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:33 volumiovm sudo[2694]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/addservice.sh Oct 24 16:11:33 volumiovm sudo[2694]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:33 volumiovm sudo[2694]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:33 volumiovm sudo[2696]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/removeservice.sh Oct 24 16:11:33 volumiovm sudo[2696]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:33 volumiovm ntpd[2674]: Soliciting pool server 14.202.65.230 Oct 24 16:11:33 volumiovm ntpd[2674]: Soliciting pool server 159.196.44.158 Oct 24 16:11:33 volumiovm ntpd[2674]: Soliciting pool server 27.124.125.250 Oct 24 16:11:33 volumiovm sudo[2696]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:33 volumiovm sudo[2430]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:33 volumiovm volumio[685]: info: Install script completed Oct 24 16:11:33 volumiovm volumio[685]: info: Adding reference to registry Oct 24 16:11:33 volumiovm volumio[685]: info: Done installing plugin. Oct 24 16:11:33 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 16:11:33 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 24 16:11:33 volumiovm volumio[685]: Plugin install end detected on script Oct 24 16:11:33 volumiovm volumio[685]: info: Folder /tmp/plugins removed Oct 24 16:11:33 volumiovm volumio[685]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 16:11:33 volumiovm volumio[685]: info: Folder /data/temp removed Oct 24 16:11:34 volumiovm ntpd[2674]: Soliciting pool server 172.105.168.117 Oct 24 16:11:34 volumiovm ntpd[2674]: Soliciting pool server 119.18.6.37 Oct 24 16:11:35 volumiovm ntpd[2674]: Soliciting pool server 103.165.180.123 Oct 24 16:11:35 volumiovm ntpd[2674]: Soliciting pool server 2606:4700:f1::1 Oct 24 16:11:35 volumiovm volumio[685]: info: Enabling plugin music_services_shield Oct 24 16:11:35 volumiovm volumio[685]: info: Loading plugin "music_services_shield"... Oct 24 16:11:35 volumiovm volumio[685]: info: PLUGIN START: music_services_shield Oct 24 16:11:35 volumiovm sudo[2742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Oct 24 16:11:35 volumiovm sudo[2742]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:36 volumiovm sudo[2742]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:36 volumiovm volumio[685]: info: Done. Oct 24 16:11:36 volumiovm sudo[2757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh Oct 24 16:11:36 volumiovm sudo[2757]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:36 volumiovm systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Oct 24 16:11:36 volumiovm volumio[685]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 24 16:11:36 volumiovm volumio[2761]: /data/plugins/system_hardware/music_services_shield/moveallprocesses.sh: line 36: cset: command not found Oct 24 16:11:36 volumiovm volumio[2761]: /data/plugins/system_hardware/music_services_shield/moveprocess.sh: 5: /data/plugins/system_hardware/music_services_shield/moveprocess.sh: cset: not found Oct 24 16:11:36 volumiovm volumio[2761]: /data/plugins/system_hardware/music_services_shield/moveallprocesses.sh: line 49: cset: command not found Oct 24 16:11:36 volumiovm systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Oct 24 16:11:36 volumiovm systemd[1]: Reloading. Oct 24 16:11:36 volumiovm systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 24 16:11:36 volumiovm systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 24 16:11:36 volumiovm sudo[2757]: pam_unix(sudo:session): session closed for user root Oct 24 16:11:36 volumiovm volumio[685]: info: succeeded Oct 24 16:11:37 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 16:11:37 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 16:11:37 volumiovm volumio[685]: info: Discovery: Getting this device information Oct 24 16:11:37 volumiovm volumio[685]: info: CoreCommandRouter::volumioGetState Oct 24 16:11:37 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 16:11:44 volumiovm volumio[685]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/amd64 Oct 24 16:11:48 volumiovm volumio[685]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/amd64 Oct 24 16:11:48 volumiovm volumio[685]: info: Folder /tmp/plugins removed Oct 24 16:11:48 volumiovm volumio[685]: info: Check plugin dependencies Oct 24 16:11:48 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 24 16:11:48 volumiovm volumio[685]: info: Checking if plugin already exists Oct 24 16:11:48 volumiovm volumio[685]: info: Rename folder Oct 24 16:11:48 volumiovm volumio[685]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 16:11:48 volumiovm volumio[685]: info: Move to category Oct 24 16:11:49 volumiovm volumio[685]: info: Checking if install.sh is present Oct 24 16:11:49 volumiovm volumio[685]: info: Executing install.sh Oct 24 16:11:49 volumiovm sudo[2803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/now_playing/install.sh Oct 24 16:11:49 volumiovm sudo[2803]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 16:11:49 volumiovm volumio[685]: info: Installing geo-tz node dependency Oct 24 16:12:07 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 16:12:07 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 16:12:07 volumiovm volumio[685]: info: Discovery: Getting this device information Oct 24 16:12:07 volumiovm volumio[685]: info: CoreCommandRouter::volumioGetState Oct 24 16:12:07 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 16:12:10 volumiovm volumio[685]: info: Creating user directories (if not exist) Oct 24 16:12:10 volumiovm sudo[2803]: pam_unix(sudo:session): session closed for user root Oct 24 16:12:10 volumiovm volumio[685]: info: Install script completed Oct 24 16:12:10 volumiovm volumio[685]: info: Adding reference to registry Oct 24 16:12:11 volumiovm volumio[685]: info: Done installing plugin. Oct 24 16:12:11 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 16:12:11 volumiovm volumio[685]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 24 16:12:11 volumiovm volumio[685]: info: Now Playing plugin installed Oct 24 16:12:11 volumiovm volumio[685]: Plugin install end detected on script Oct 24 16:12:11 volumiovm volumio[685]: info: Folder /tmp/plugins removed Oct 24 16:12:11 volumiovm volumio[685]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 16:12:11 volumiovm volumio[685]: info: Folder /data/temp removed Oct 24 16:12:13 volumiovm volumio[685]: info: Enabling plugin now_playing Oct 24 16:12:13 volumiovm volumio[685]: info: Loading plugin "now_playing"... Oct 24 16:12:13 volumiovm volumio[685]: error: !!!! WARNING !!!! Oct 24 16:12:13 volumiovm volumio[685]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Oct 24 16:12:13 volumiovm volumio[685]: Require stack: Oct 24 16:12:13 volumiovm volumio[685]: - /data/plugins/user_interface/now_playing/dist/index.js Oct 24 16:12:13 volumiovm volumio[685]: - /volumio/app/pluginmanager.js Oct 24 16:12:13 volumiovm volumio[685]: - /volumio/app/index.js Oct 24 16:12:13 volumiovm volumio[685]: - /volumio/index.js Oct 24 16:12:13 volumiovm volumio[685]: error: Stack trace: Error: Cannot find module 'geo-tz' Oct 24 16:12:13 volumiovm volumio[685]: Require stack: Oct 24 16:12:13 volumiovm volumio[685]: - /data/plugins/user_interface/now_playing/dist/index.js Oct 24 16:12:13 volumiovm volumio[685]: - /volumio/app/pluginmanager.js Oct 24 16:12:13 volumiovm volumio[685]: - /volumio/app/index.js Oct 24 16:12:13 volumiovm volumio[685]: - /volumio/index.js Oct 24 16:12:13 volumiovm volumio[685]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:931:15) Oct 24 16:12:13 volumiovm volumio[685]: at Function.Module._load (internal/modules/cjs/loader.js:774:27) Oct 24 16:12:13 volumiovm volumio[685]: at Module.require (internal/modules/cjs/loader.js:1003:19) Oct 24 16:12:13 volumiovm volumio[685]: at require (internal/modules/cjs/helpers.js:107:18) Oct 24 16:12:13 volumiovm volumio[685]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Oct 24 16:12:13 volumiovm volumio[685]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Oct 24 16:12:13 volumiovm volumio[685]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Oct 24 16:12:13 volumiovm volumio[685]: at Module.load (internal/modules/cjs/loader.js:979:32) Oct 24 16:12:13 volumiovm volumio[685]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Oct 24 16:12:13 volumiovm volumio[685]: at Module.require (internal/modules/cjs/loader.js:1003:19) Oct 24 16:12:13 volumiovm volumio[685]: at require (internal/modules/cjs/helpers.js:107:18) Oct 24 16:12:13 volumiovm volumio[685]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Oct 24 16:12:13 volumiovm volumio[685]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 24 16:12:13 volumiovm volumio[685]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 24 16:12:13 volumiovm volumio[685]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 24 16:12:13 volumiovm volumio[685]: error: !!!! WARNING !!!! Oct 24 16:12:13 volumiovm volumio[685]: info: Done. Oct 24 16:12:18 volumiovm volumio-remote-updater[396]: No test mode Oct 24 16:12:18 volumiovm volumio-remote-updater[396]: No alpha test mode Oct 24 16:12:18 volumiovm volumio[685]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 16:12:18 volumiovm volumio[685]: TypeError: Cannot read property 'broadcastMessage' of null Oct 24 16:12:18 volumiovm volumio[685]: at /volumio/app/index.js:1508:32 Oct 24 16:12:18 volumiovm volumio[685]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Oct 24 16:12:18 volumiovm volumio[685]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Oct 24 16:12:18 volumiovm volumio[685]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1506:13) Oct 24 16:12:18 volumiovm volumio[685]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:894:26) Oct 24 16:12:18 volumiovm volumio[685]: at Socket.emit (events.js:400:28) Oct 24 16:12:18 volumiovm volumio[685]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 24 16:12:18 volumiovm volumio[685]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 24 16:12:18 volumiovm volumio[685]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 16:12:18 volumiovm sudo[2838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-24 16:11 Oct 24 16:12:18 volumiovm sudo[2838]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 04:09:51 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="2fe933ffb50e198f3245fc325fd10b17"