-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Mon 2025-03-03 20:13:54 CET. -- Mar 03 20:12:04 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Fetching time from Volumio... Mar 03 20:12:05 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Setting system time to: 2025-03-03 20:12:05 Mar 03 20:12:05 kilus-musig-pi sudo[1698]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-03 20:12:05 Mar 03 20:12:05 kilus-musig-pi sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:12:05 kilus-musig-pi dbus-daemon[462]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.18' (uid=0 pid=1699 comm="timedatectl set-time 2025-03-03 20:12:05 ") Mar 03 20:12:05 kilus-musig-pi systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device Mar 03 20:12:05 kilus-musig-pi systemd[1]: systemd-timedated.service: Failed with result 'resources'. Mar 03 20:12:05 kilus-musig-pi systemd[1]: Failed to start Time & Date Service. Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="obtained new client token: AAAZsBEb/yucOIOQs5dBrHMuhHvr5GTX6S6Uoqi10MVdrlLnuYbz0QcYJXlHU7OuEJCSHtry4KiRT6UxnwDRZ7HddOt8Fm9so8vvXk9QFpHSAh8fiQUyBAnFQiVr2EzYN0RFiTDEPOZVU0qgQd0+kEh+uSDR8gbHgDJrExvbjSRbWmmVtpxZGwSO+Yr0Se2CR9rUiMtoPz5dsEBQdtayHJOTe2BDND8mJQZ6Wjx1dyHdjoxS+WoXwbUuoluXIQ==" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=info msg="connected to ap-gew4.spotify.com:4070" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="completed keyexchange" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="completed challenge" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="authenticated as d4zoy12sumfvsa5ke40f8286c" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="authenticated as d4zoy12sumfvsa5ke40f8286c" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="dealer connection opened" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=info msg="accepted zeroconf user d4zoy12sumfvsa5ke40f8286c from kilu-ThinkPad-X230" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="autoplay enabled: false" Mar 03 20:12:14 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:14+01:00" level=debug msg="received connection id: OWUyMWY4MjQtZDQ4NS00NDExLTg0MjItN2NjYzA3ZjNjYjI1K2RlYWxlcit0Y3A6Ly8wYWNhNTk4Ny5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArRERGRTlFRkQ3ODEwN0U5OUVDMkNEQjc3QzRDNzJFOTk0MEVGM0QwQTY3MDhDQkIyOEZDOTI4MDk1NzcxMzJGNg==" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="put connect state because NEW_DEVICE" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="handling transfer player command from f7033694aa1c73bf65c645439ab963f48ab304cc" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="resolved context of track" uri="spotify:playlist:37i9dQZF1EIfymOShLVB6x" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=trace msg="fetched new page 0 with 50 items (list: 50)" uri="spotify:playlist:37i9dQZF1EIfymOShLVB6x" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="shuffled context with seed 11417065000919688643 (len: 50, keep: 15)" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="loading track (paused: false, position: 28756731ms)" uri="spotify:track:4G6P8oKUtNko3Nye29DVCg" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=trace msg="emitting websocket event: will_play" Mar 03 20:12:15 kilus-musig-pi volumio[742]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4G6P8oKUtNko3Nye29DVCg","play_origin":"playlist"}} Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="selected format OGG_VORBIS_320 (339f62fee16345223244e8cc095d3e01362beb91)" uri="spotify:track:4G6P8oKUtNko3Nye29DVCg" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="requested aes key for file 339f62fee16345223244e8cc095d3e01362beb91, gid: 4G6P8oKUtNko3Nye29DVCg" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1365" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1130" Mar 03 20:12:15 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:15+01:00" level=debug msg="fetched first chunk of 21, total size is 10604840 bytes" uri="spotify:track:4G6P8oKUtNko3Nye29DVCg" Mar 03 20:12:16 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:16+01:00" level=debug msg="fetched chunk 20/20, size: 119080" uri="spotify:track:4G6P8oKUtNko3Nye29DVCg" Mar 03 20:12:16 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:16+01:00" level=debug msg="fetched chunk 1/20, size: 524288" uri="spotify:track:4G6P8oKUtNko3Nye29DVCg" Mar 03 20:12:16 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:16+01:00" level=warning msg="failed handling dealer request" error="failed loading current track (transfer): failed creating stream for spotify:track:4G6P8oKUtNko3Nye29DVCg: failed seeking stream: failed reading page: EOF" Mar 03 20:12:16 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:16+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Mar 03 20:12:16 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:16+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Mar 03 20:12:16 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:16+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Mar 03 20:12:16 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:16+01:00" level=debug msg="fetched chunk 3/20, size: 524288" uri="spotify:track:4G6P8oKUtNko3Nye29DVCg" Mar 03 20:12:16 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:16+01:00" level=debug msg="fetched chunk 2/20, size: 524288" uri="spotify:track:4G6P8oKUtNko3Nye29DVCg" Mar 03 20:12:22 kilus-musig-pi volumiologrotate[444]: ls: cannot access '/var/log/samba/log.wb-KILUS': No such file or directory Mar 03 20:12:22 kilus-musig-pi volumiologrotate[444]: ls: cannot access 'MUSIG': No such file or directory Mar 03 20:12:22 kilus-musig-pi volumiologrotate[444]: ls: cannot access 'PI': No such file or directory Mar 03 20:12:30 kilus-musig-pi volumio-time-update[456]: Failed to set time: Connection timed out Mar 03 20:12:30 kilus-musig-pi dbus-daemon[462]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 20:12:30 kilus-musig-pi sudo[1698]: pam_unix(sudo:session): session closed for user root Mar 03 20:12:30 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Error setting time. Mar 03 20:12:30 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Retrying in 5 seconds... Mar 03 20:12:35 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Fetching time from Volumio... Mar 03 20:12:35 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Setting system time to: 2025-03-03 20:12:35 Mar 03 20:12:35 kilus-musig-pi sudo[1804]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-03 20:12:35 Mar 03 20:12:35 kilus-musig-pi sudo[1804]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:12:35 kilus-musig-pi dbus-daemon[462]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=1805 comm="timedatectl set-time 2025-03-03 20:12:35 ") Mar 03 20:12:35 kilus-musig-pi systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device Mar 03 20:12:35 kilus-musig-pi systemd[1]: systemd-timedated.service: Failed with result 'resources'. Mar 03 20:12:35 kilus-musig-pi systemd[1]: Failed to start Time & Date Service. Mar 03 20:12:39 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:39+01:00" level=debug msg="handling pause player command from f7033694aa1c73bf65c645439ab963f48ab304cc" Mar 03 20:12:39 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:39+01:00" level=warning msg="failed handling dealer request" error="no primary stream" Mar 03 20:12:41 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:41+01:00" level=debug msg="handling pause player command from f7033694aa1c73bf65c645439ab963f48ab304cc" Mar 03 20:12:41 kilus-musig-pi go-librespot[1012]: time="2025-03-03T20:12:41+01:00" level=warning msg="failed handling dealer request" error="no primary stream" Mar 03 20:13:00 kilus-musig-pi volumio-time-update[456]: Failed to set time: Connection timed out Mar 03 20:13:00 kilus-musig-pi dbus-daemon[462]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 20:13:00 kilus-musig-pi sudo[1804]: pam_unix(sudo:session): session closed for user root Mar 03 20:13:00 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Error setting time. Mar 03 20:13:00 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Retrying in 5 seconds... Mar 03 20:13:05 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Fetching time from Volumio... Mar 03 20:13:05 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Setting system time to: 2025-03-03 20:13:05 Mar 03 20:13:05 kilus-musig-pi sudo[1864]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-03 20:13:05 Mar 03 20:13:05 kilus-musig-pi sudo[1864]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:13:05 kilus-musig-pi dbus-daemon[462]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.20' (uid=0 pid=1865 comm="timedatectl set-time 2025-03-03 20:13:05 ") Mar 03 20:13:05 kilus-musig-pi systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device Mar 03 20:13:05 kilus-musig-pi systemd[1]: systemd-timedated.service: Failed with result 'resources'. Mar 03 20:13:05 kilus-musig-pi systemd[1]: Failed to start Time & Date Service. Mar 03 20:13:15 kilus-musig-pi sudo[1885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 20:13:15 kilus-musig-pi sudo[1885]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:13:15 kilus-musig-pi sudo[1885]: pam_unix(sudo:session): session closed for user root Mar 03 20:13:15 kilus-musig-pi sudo[1887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 20:13:15 kilus-musig-pi sudo[1887]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:13:15 kilus-musig-pi sudo[1887]: pam_unix(sudo:session): session closed for user root Mar 03 20:13:15 kilus-musig-pi volumio[742]: verbose: New Socket.io Connection to 192.168.1.30 from 192.168.1.156 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 03 20:13:16 kilus-musig-pi sudo[1893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 20:13:16 kilus-musig-pi sudo[1893]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:13:16 kilus-musig-pi sudo[1893]: pam_unix(sudo:session): session closed for user root Mar 03 20:13:16 kilus-musig-pi sudo[1895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 20:13:16 kilus-musig-pi sudo[1895]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:13:16 kilus-musig-pi sudo[1895]: pam_unix(sudo:session): session closed for user root Mar 03 20:13:16 kilus-musig-pi volumio[742]: verbose: New Socket.io Connection to 192.168.1.30 from 192.168.1.156 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::volumioGetState Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CorePlayQueue::getTrack 0 Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: Received Get System Info Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: Discovery: Getting this device information Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::volumioGetState Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CorePlayQueue::getTrack 0 Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::volumioGetState Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CorePlayQueue::getTrack 0 Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: Listing playlists Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 03 20:13:16 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 03 20:13:17 kilus-musig-pi volumio[742]: info: CoreCommandRouter::volumioGetState Mar 03 20:13:17 kilus-musig-pi volumio[742]: info: CorePlayQueue::getTrack 0 Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: Received Get System Info Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: Discovery: Getting this device information Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: CoreCommandRouter::volumioGetState Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: CorePlayQueue::getTrack 0 Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 20:13:18 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 03 20:13:19 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 20:13:19 kilus-musig-pi volumio[742]: info: Received Get System Info Mar 03 20:13:19 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 20:13:19 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 20:13:19 kilus-musig-pi volumio[742]: info: Discovery: Getting this device information Mar 03 20:13:19 kilus-musig-pi volumio[742]: info: CoreCommandRouter::volumioGetState Mar 03 20:13:19 kilus-musig-pi volumio[742]: info: CorePlayQueue::getTrack 0 Mar 03 20:13:19 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 20:13:23 kilus-musig-pi volumiologrotate[444]: ls: cannot access '/var/log/samba/log.wb-KILUS': No such file or directory Mar 03 20:13:23 kilus-musig-pi volumiologrotate[444]: ls: cannot access 'MUSIG': No such file or directory Mar 03 20:13:23 kilus-musig-pi volumiologrotate[444]: ls: cannot access 'PI': No such file or directory Mar 03 20:13:26 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 03 20:13:27 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 20:13:27 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 03 20:13:30 kilus-musig-pi dbus-daemon[462]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 20:13:30 kilus-musig-pi volumio-time-update[456]: Failed to set time: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 20:13:30 kilus-musig-pi sudo[1864]: pam_unix(sudo:session): session closed for user root Mar 03 20:13:30 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Error setting time. Mar 03 20:13:30 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Retrying in 5 seconds... Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: Received Get System Version Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: Received Get System Info Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: Discovery: Getting this device information Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CoreCommandRouter::volumioGetState Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CorePlayQueue::getTrack 0 Mar 03 20:13:34 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 20:13:35 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Fetching time from Volumio... Mar 03 20:13:35 kilus-musig-pi volumio-time-update[456]: volumio-time-update-util: Setting system time to: 2025-03-03 20:13:35 Mar 03 20:13:35 kilus-musig-pi sudo[1985]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-03 20:13:35 Mar 03 20:13:35 kilus-musig-pi sudo[1985]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:13:35 kilus-musig-pi dbus-daemon[462]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.21' (uid=0 pid=1986 comm="timedatectl set-time 2025-03-03 20:13:35 ") Mar 03 20:13:35 kilus-musig-pi systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device Mar 03 20:13:35 kilus-musig-pi systemd[1]: systemd-timedated.service: Failed with result 'resources'. Mar 03 20:13:35 kilus-musig-pi systemd[1]: Failed to start Time & Date Service. Mar 03 20:13:46 kilus-musig-pi volumio[742]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 20:13:49 kilus-musig-pi volumio[742]: info: CALLMETHOD: user_interface Systeminfo getsysteminfo undefined Mar 03 20:13:49 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: Systeminfo , getsysteminfo Mar 03 20:13:49 kilus-musig-pi sudo[2005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/vcgencmd version Mar 03 20:13:49 kilus-musig-pi sudo[2005]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 20:13:49 kilus-musig-pi sudo[2005]: pam_unix(sudo:session): session closed for user root Mar 03 20:13:52 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 20:13:52 kilus-musig-pi volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 03 20:13:53 kilus-musig-pi volumio[742]: info: board is Raspberry Pi 2 Model B Rev 1.1 Mar 03 20:13:53 kilus-musig-pi volumio[742]: Storage info 131M 128M 0M Mar 03 20:13:53 kilus-musig-pi volumio[742]: Storage info 131M 128M 0M Mar 03 20:13:53 kilus-musig-pi volumio[742]: Storage info 131M 128M 0M Mar 03 20:13:53 kilus-musig-pi volumio[742]: BBBBBBBBBBBBBB-CPU Temp 34 °C Mar 03 20:13:53 kilus-musig-pi volumio[742]: info: Firmware detected: Nov 11 2024 15:50:32 version 903570ba72a9e117f92e5499de439f59dd96e417 (clean) (release) (start) Mar 03 20:13:53 kilus-musig-pi volumio[742]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 20:13:53 kilus-musig-pi volumio[742]: Error: ENOSPC: no space left on device, write Mar 03 20:13:53 kilus-musig-pi volumio[742]: at Object.writeSync (fs.js:711:3) Mar 03 20:13:53 kilus-musig-pi volumio[742]: at Object.writeFileSync (fs.js:1473:26) Mar 03 20:13:53 kilus-musig-pi volumio[742]: at Object.writeFileSync (/data/plugins/user_interface/Systeminfo/node_modules/v-conf/node_modules/jsonfile/index.js:115:13) Mar 03 20:13:53 kilus-musig-pi volumio[742]: at Config.save (/data/plugins/user_interface/Systeminfo/node_modules/v-conf/index.js:142:12) Mar 03 20:13:53 kilus-musig-pi volumio[742]: at Timeout._onTimeout (/data/plugins/user_interface/Systeminfo/node_modules/v-conf/index.js:129:18) Mar 03 20:13:53 kilus-musig-pi volumio[742]: at listOnTimeout (internal/timers.js:554:17) Mar 03 20:13:53 kilus-musig-pi volumio[742]: at processTimers (internal/timers.js:497:7) { Mar 03 20:13:53 kilus-musig-pi volumio[742]: errno: -28, Mar 03 20:13:53 kilus-musig-pi volumio[742]: syscall: 'write', Mar 03 20:13:53 kilus-musig-pi volumio[742]: code: 'ENOSPC' Mar 03 20:13:53 kilus-musig-pi volumio[742]: } Mar 03 20:13:53 kilus-musig-pi volumio[742]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 20:13:54 kilus-musig-pi sudo[2309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-03 20:12 Mar 03 20:13:54 kilus-musig-pi sudo[2309]: 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"