-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2025-02-14 16:08:01 CET. -- Feb 14 16:07:51 office ntpd[1626]: receive: Unexpected origin timestamp 0xeb4b7256.8a66e844 does not match aorg 0000000000.00000000 from server@213.172.105.106 xmt 0xeb59dac7.a892ebfa Feb 14 16:07:51 office ntpd[1626]: receive: Unexpected origin timestamp 0xeb4b7256.8a698c0f does not match aorg 0000000000.00000000 from server@194.50.19.117 xmt 0xeb59dac7.a8858560 Feb 14 16:07:51 office ntpd[1626]: receive: Unexpected origin timestamp 0xeb4b7256.8a68adc2 does not match aorg 0000000000.00000000 from server@51.75.67.47 xmt 0xeb59dac7.a87fb5fe Feb 14 16:07:51 office ntpd[1626]: receive: Unexpected origin timestamp 0xeb4b7256.8a6455f7 does not match aorg 0000000000.00000000 from server@89.58.6.143 xmt 0xeb59dac7.a8d1c421 Feb 14 16:07:51 office ntpd[1626]: receive: Unexpected origin timestamp 0xeb4b7256.8a67c2ac does not match aorg 0000000000.00000000 from server@185.11.138.90 xmt 0xeb59dac7.a8e4a37a Feb 14 16:07:51 office ntpd[1626]: receive: Unexpected origin timestamp 0xeb4b7256.8a6356c7 does not match aorg 0000000000.00000000 from server@168.119.211.223 xmt 0xeb59dac7.a9272521 Feb 14 16:07:51 office ntpd[1626]: receive: Unexpected origin timestamp 0xeb4b7256.8a65fad6 does not match aorg 0000000000.00000000 from server@31.209.85.243 xmt 0xeb59dac7.a941cffd Feb 14 16:07:51 office ntpd[1626]: receive: Unexpected origin timestamp 0xeb4b7256.8a607525 does not match aorg 0000000000.00000000 from server@194.164.164.175 xmt 0xeb59dac7.ad27873a Feb 14 16:07:51 office systemd[1]: Starting Daily apt download activities... Feb 14 16:07:51 office systemd[1]: Starting Daily man-db regeneration... Feb 14 16:07:51 office volumio[851]: info: Discovery: A device disappeared from network Feb 14 16:07:51 office volumio[851]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Feb 14 16:07:52 office sudo[1837]: pam_unix(sudo:session): session closed for user root Feb 14 16:07:52 office volumio[851]: info: Cannot mount NAS joe at system boot, trial number 4 ,retrying in 5 seconds Feb 14 16:07:52 office kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 14 16:07:52 office kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Feb 14 16:07:53 office systemd[1]: man-db.service: Succeeded. Feb 14 16:07:53 office systemd[1]: Started Daily man-db regeneration. Feb 14 16:07:54 office systemd[1]: apt-daily.service: Succeeded. Feb 14 16:07:54 office systemd[1]: Started Daily apt download activities. Feb 14 16:07:54 office systemd[1]: Starting Daily apt upgrade and clean activities... Feb 14 16:07:55 office volumio[851]: info: Discovery: adding 434ce03e-5417-4729-be88-079da9533143 Feb 14 16:07:55 office volumio[851]: info: Discovery: Found device office Feb 14 16:07:55 office volumio[851]: info: CoreCommandRouter::volumioGetState Feb 14 16:07:55 office volumio[851]: info: CorePlayQueue::getTrack 0 Feb 14 16:07:55 office volumio[851]: info: Discovery: this is already registered, 434ce03e-5417-4729-be88-079da9533143 Feb 14 16:07:55 office volumio[851]: info: Discovery: Found device office Feb 14 16:07:55 office volumio[851]: info: CoreCommandRouter::volumioGetState Feb 14 16:07:55 office volumio[851]: info: CorePlayQueue::getTrack 0 Feb 14 16:07:55 office volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 14 16:07:55 office systemd[1]: apt-daily-upgrade.service: Succeeded. Feb 14 16:07:55 office systemd[1]: Started Daily apt upgrade and clean activities. Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 14 16:07:55 office volumio[851]: info: Adding plugin bluetooth to MyMusic Plugins Feb 14 16:07:55 office volumio[851]: info: Adding plugin multiroom to MyMusic Plugins Feb 14 16:07:55 office volumio[851]: info: Adding plugin metavolumio to MyMusic Plugins Feb 14 16:07:55 office volumio[851]: info: Adding plugin cd_controller to MyMusic Plugins Feb 14 16:07:55 office volumio[851]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 14 16:07:55 office volumio[851]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 14 16:07:55 office volumio[851]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 14 16:07:56 office volumio-time-update[671]: volumio-time-update-util: Date not found in response Feb 14 16:07:56 office volumio-time-update[671]: volumio-time-update-util: Retrying in 5 seconds... Feb 14 16:07:56 office volumio[851]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 14 16:07:56 office volumio[851]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 14 16:07:56 office volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 14 16:07:56 office volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 14 16:07:56 office volumio[851]: info: Starting MyVolumio Remote Streaming Endpoints Feb 14 16:07:56 office volumio[851]: info: MyVolumio login type: Token Feb 14 16:07:56 office volumio[851]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 14 16:07:56 office volumio[851]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 14 16:07:57 office volumio[851]: info: Starting Streaming Service Transparent Proxy Feb 14 16:07:57 office volumio[851]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 14 16:07:57 office volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 14 16:07:57 office volumio[851]: info: Streaming services startup Feb 14 16:07:57 office volumio[851]: info: Starting Streaming Daemon Feb 14 16:07:57 office sudo[1978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 14 16:07:57 office sudo[1978]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 14 16:07:57 office volumio[851]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 14 16:07:57 office sudo[1978]: pam_unix(sudo:session): session closed for user root Feb 14 16:07:57 office volumio[851]: error: Cannot start Volumio Streaming Daemon Feb 14 16:07:57 office volumio[851]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 14 16:07:57 office volumio[851]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 14 16:07:57 office sudo[1986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=joe,password=Samba1873,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.42/joe /mnt/NAS/joe Feb 14 16:07:57 office sudo[1986]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 14 16:07:57 office kernel: CIFS: Attempting to mount //192.168.178.42/joe Feb 14 16:07:58 office volumio[851]: error: MyVolumio Custom Token format not valid, refreshing it Feb 14 16:07:58 office volumio[851]: STREAMING PROXY: Starting server on port 3245 Feb 14 16:07:58 office volumio[851]: Node JS runtime: 14 Feb 14 16:07:58 office volumio[851]: info: MyVolumio login type: Token Feb 14 16:07:58 office volumio[851]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.863425, 0] ../source3/libsmb/nmblib.c:917(send_udp) Feb 14 16:07:59 office nmbd[771]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.863793, 0] ../source3/libsmb/nmblib.c:917(send_udp) Feb 14 16:07:59 office nmbd[771]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.863880, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Feb 14 16:07:59 office nmbd[771]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.863979, 0] ../source3/libsmb/nmblib.c:917(send_udp) Feb 14 16:07:59 office nmbd[771]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.864059, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Feb 14 16:07:59 office nmbd[771]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.864142, 0] ../source3/libsmb/nmblib.c:917(send_udp) Feb 14 16:07:59 office nmbd[771]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.864231, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Feb 14 16:07:59 office nmbd[771]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.864305, 0] ../source3/libsmb/nmblib.c:917(send_udp) Feb 14 16:07:59 office nmbd[771]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.864381, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Feb 14 16:07:59 office nmbd[771]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.864454, 0] ../source3/libsmb/nmblib.c:917(send_udp) Feb 14 16:07:59 office nmbd[771]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Feb 14 16:07:59 office nmbd[771]: [2025/02/14 16:07:59.864521, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Feb 14 16:07:59 office nmbd[771]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Feb 14 16:08:01 office volumio[851]: info: MyVolumio token set successfully Feb 14 16:08:01 office volumio[851]: info: MYVOLUMIO: Adding device Feb 14 16:08:01 office volumio[851]: info: MYVOLUMIO: Evaluating Server Feb 14 16:08:01 office volumio-time-update[671]: volumio-time-update-util: Fetching time from Volumio... Feb 14 16:08:01 office volumio-time-update[671]: volumio-time-update-util: Setting system time to: 2025-02-14 16:08:01 Feb 14 16:08:01 office sudo[2057]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-02-14 16:08:01 Feb 14 16:08:01 office sudo[2057]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 14 16:08:01 office dbus-daemon[672]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.20' (uid=0 pid=2059 comm="timedatectl set-time 2025-02-14 16:08:01 ") Feb 14 16:08:01 office systemd[1]: Starting Time & Date Service... Feb 14 16:08:01 office volumio[851]: info: MyVolumio Plan changed: premium Feb 14 16:08:01 office volumio[851]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Feb 14 16:08:01 office volumio[851]: info: Removing browser output: myVolumio user plan is not superstar Feb 14 16:08:01 office volumio[851]: info: Removing audio output: Feb 14 16:08:01 office volumio[851]: info: MYVOLUMIO: Adding device Feb 14 16:08:01 office volumio[851]: info: MYVOLUMIO: Evaluating Server Feb 14 16:08:01 office volumio[851]: info: Remote config written successfully Feb 14 16:08:01 office volumio[851]: info: Starting Tunnel 1 Feb 14 16:08:01 office volumio[851]: info: Starting Tunnel Connection Checker Feb 14 16:08:01 office dbus-daemon[672]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 14 16:08:01 office systemd[1]: Started Time & Date Service. Feb 14 16:08:01 office systemd-timedated[2063]: Changed local time to Fri Feb 14 16:08:01 2025 Feb 14 16:08:01 office sudo[2057]: pam_unix(sudo:session): session closed for user root Feb 14 16:08:01 office volumio-time-update[671]: volumio-time-update-util: System time updated successfully. Feb 14 16:08:01 office systemd[1]: Started Volumio Time Update Utility. Feb 14 16:08:01 office systemd[1]: Reached target Multi-User System. Feb 14 16:08:01 office systemd[1]: Reached target Graphical Interface. Feb 14 16:08:01 office systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 14 16:08:01 office systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 14 16:08:01 office systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 14 16:08:01 office systemd[1]: Startup finished in 13.017s (kernel) + 1min 6.989s (userspace) = 1min 20.007s. Feb 14 16:08:01 office volumio[851]: error: Failed to ping endpoint us3.myvolumio.org : unknown error Feb 14 16:08:01 office volumio[851]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 14 16:08:01 office volumio[851]: Error: Unable to resolve or reject the same promise twice Feb 14 16:08:01 office volumio[851]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 14 16:08:01 office volumio[851]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Feb 14 16:08:01 office volumio[851]: at Socket.emit (events.js:327:22) Feb 14 16:08:01 office volumio[851]: at endReadableNT (internal/streams/readable.js:1327:12) Feb 14 16:08:01 office volumio[851]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 14 16:08:01 office volumio[851]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 14 16:08:01 office sudo[2083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-14 16:07 Feb 14 16:08:01 office sudo[2083]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"