-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-03-31 11:46:40 CEST. -- Mar 31 11:46:22 volumio1 ntpd[857]: receive: Unexpected origin timestamp 0xe9b2d1dd.8be143fd does not match aorg 0000000000.00000000 from server@194.35.12.210 xmt 0xe9b3af6e.78f92536 Mar 31 11:46:22 volumio1 ntpd[857]: receive: Unexpected origin timestamp 0xe9b2d1dd.8bdd17e8 does not match aorg 0000000000.00000000 from server@185.232.69.65 xmt 0xe9b3af6e.79d5bf58 Mar 31 11:46:22 volumio1 volumio[837]: info: Discovery: A device disappeared from network Mar 31 11:46:22 volumio1 volumio[837]: info: Discovery: Device volumio1 disappeared from network Mar 31 11:46:22 volumio1 systemd[1]: Starting Daily apt download activities... Mar 31 11:46:22 volumio1 volumio[837]: info: Discovery: adding 47d5fc00-1eee-4046-a0f0-c97f93d4523a Mar 31 11:46:22 volumio1 volumio[837]: info: Discovery: Found device Volumio1 Mar 31 11:46:22 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetState Mar 31 11:46:22 volumio1 volumio[837]: info: CorePlayQueue::getTrack 0 Mar 31 11:46:22 volumio1 nmbd[617]: [2024/03/31 11:46:22.875095, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 31 11:46:22 volumio1 nmbd[617]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.46 for name WORKGROUP<1d>. Mar 31 11:46:22 volumio1 nmbd[617]: This response was from IP 192.168.1.25, reporting an IP address of 192.168.1.25. Mar 31 11:46:22 volumio1 nmbd[617]: [2024/03/31 11:46:22.876487, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 31 11:46:22 volumio1 nmbd[617]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.1.46 for name WORKGROUP<1d>. Mar 31 11:46:22 volumio1 nmbd[617]: This response was from IP 192.168.1.25, reporting an IP address of 192.168.1.25. Mar 31 11:46:22 volumio1 nmbd[617]: [2024/03/31 11:46:22.876680, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 31 11:46:22 volumio1 nmbd[617]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.1.46 for name WORKGROUP<1d>. Mar 31 11:46:22 volumio1 nmbd[617]: This response was from IP 192.168.1.25, reporting an IP address of 192.168.1.25. Mar 31 11:46:22 volumio1 volumio-remote-updater[502]: [2024-03-31 11:46:22] [connect] Successful connection Mar 31 11:46:23 volumio1 volumio-remote-updater[502]: [2024-03-31 11:46:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1711878382 101 Mar 31 11:46:23 volumio1 volumio[837]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Mar 31 11:46:23 volumio1 systemd[1]: apt-daily.service: Succeeded. Mar 31 11:46:23 volumio1 systemd[1]: Started Daily apt download activities. Mar 31 11:46:23 volumio1 systemd[1]: Starting Daily apt upgrade and clean activities... Mar 31 11:46:23 volumio1 systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 31 11:46:23 volumio1 systemd[1]: Started Daily apt upgrade and clean activities. Mar 31 11:46:26 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 11:46:26 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 11:46:26 volumio1 volumio[837]: info: Discovery: Getting this device information Mar 31 11:46:26 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetState Mar 31 11:46:26 volumio1 volumio[837]: info: CorePlayQueue::getTrack 0 Mar 31 11:46:26 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 11:46:26 volumio1 volumio[837]: verbose: New Socket.io Connection to 192.168.1.46 from 192.168.1.39 UA: okhttp/4.9.2 Total Clients: 2 Mar 31 11:46:26 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetState Mar 31 11:46:26 volumio1 volumio[837]: info: CorePlayQueue::getTrack 0 Mar 31 11:46:26 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 31 11:46:26 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 31 11:46:27 volumio1 sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 31 11:46:27 volumio1 sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 11:46:27 volumio1 sudo[1080]: pam_unix(sudo:session): session closed for user root Mar 31 11:46:27 volumio1 sudo[1082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 31 11:46:27 volumio1 sudo[1082]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 11:46:27 volumio1 sudo[1082]: pam_unix(sudo:session): session closed for user root Mar 31 11:46:27 volumio1 sudo[1086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 31 11:46:27 volumio1 sudo[1086]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 11:46:27 volumio1 systemd[1]: Started UPnP Renderer front-end to MPD. Mar 31 11:46:27 volumio1 sudo[1086]: pam_unix(sudo:session): session closed for user root Mar 31 11:46:27 volumio1 volumio[837]: info: Upmpdcli Daemon Started Mar 31 11:46:27 volumio1 volumio[837]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 31 11:46:28 volumio1 systemd[1]: systemd-fsckd.service: Succeeded. Mar 31 11:46:29 volumio1 sh[406]: timed out Mar 31 11:46:29 volumio1 dhcpcd[449]: timed out Mar 31 11:46:29 volumio1 sh[406]: dhcpcd exited Mar 31 11:46:29 volumio1 dhcpcd[449]: dhcpcd exited Mar 31 11:46:29 volumio1 sh[406]: ifup: failed to bring up eth0 Mar 31 11:46:29 volumio1 systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 31 11:46:29 volumio1 systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 31 11:46:31 volumio1 sudo[1091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 31 11:46:31 volumio1 sudo[1091]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 11:46:31 volumio1 sudo[1093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 31 11:46:31 volumio1 sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 11:46:31 volumio1 sudo[1091]: pam_unix(sudo:session): session closed for user root Mar 31 11:46:31 volumio1 sudo[1093]: pam_unix(sudo:session): session closed for user root Mar 31 11:46:31 volumio1 volumio[837]: verbose: New Socket.io Connection to 192.168.1.46 from 192.168.1.39 UA: okhttp/4.9.2 Total Clients: 3 Mar 31 11:46:31 volumio1 volumio[837]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 31 11:46:31 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 31 11:46:31 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 31 11:46:31 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetVisibleSources Mar 31 11:46:31 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 31 11:46:31 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetState Mar 31 11:46:31 volumio1 volumio[837]: info: CorePlayQueue::getTrack 0 Mar 31 11:46:31 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 31 11:46:31 volumio1 systemd[1]: systemd-hostnamed.service: Succeeded. Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 31 11:46:32 volumio1 volumio[837]: info: Received Get System Info Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 11:46:32 volumio1 volumio[837]: info: Discovery: Getting this device information Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetState Mar 31 11:46:32 volumio1 volumio[837]: info: CorePlayQueue::getTrack 0 Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetState Mar 31 11:46:32 volumio1 volumio[837]: info: CorePlayQueue::getTrack 0 Mar 31 11:46:32 volumio1 volumio[837]: info: Listing playlists Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 31 11:46:32 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 31 11:46:33 volumio1 volumio[837]: info: Received Get System Info Mar 31 11:46:33 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 11:46:33 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 11:46:33 volumio1 volumio[837]: info: Discovery: Getting this device information Mar 31 11:46:33 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetState Mar 31 11:46:33 volumio1 volumio[837]: info: CorePlayQueue::getTrack 0 Mar 31 11:46:33 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 11:46:34 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetQueue Mar 31 11:46:34 volumio1 volumio[837]: info: CoreStateMachine::getQueue Mar 31 11:46:34 volumio1 volumio[837]: info: CorePlayQueue::getQueue Mar 31 11:46:37 volumio1 volumio[837]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 31 11:46:38 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 31 11:46:38 volumio1 volumio[837]: info: Received Get System Info Mar 31 11:46:38 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 11:46:38 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 11:46:38 volumio1 volumio[837]: info: Discovery: Getting this device information Mar 31 11:46:38 volumio1 volumio[837]: info: CoreCommandRouter::volumioGetState Mar 31 11:46:38 volumio1 volumio[837]: info: CorePlayQueue::getTrack 0 Mar 31 11:46:38 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 11:46:39 volumio1 volumio[837]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 31 11:46:39 volumio1 volumio[837]: info: Preload queue cleared Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: mnt/USB/VOL/Musik/Picard/Audiophile/Best Audiophile Voices/04 Stacey Kent feat. Jim Tomlinson - So Nice.mp3 Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: mnt/USB/VOL/Musik/div/Jazz/KariBremnes/06 Kari Bremnes - A Lover in Berlin.mp3 Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: mnt/USB/VOL/Musik/Youtube/year24/jan24/BABYLON BERLIN - Ein Tag wie Gold (Meret Becker & MEUTE) [Official O.S.T.].mp3 Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: mnt/USB/VOL/Musik/INTERNAL/Millennium Gold-CD (01-2000)/06 - RAY WYLIE HUBBARD - Last Train To Amsterdam.flac Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: mnt/USB/VOL/Musik/Youtube/year24/jan24/Birdy - I Only Want To Be With You.mp3 Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22White%20Horse%22%2C%22artist%22%3A%22Chris%20Stapleton%22%2C%22album%22%3A%22Higher%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FN7tWZ9kRToe77sveuY8Fv_DLlbLl9xVYIz7PdzMuPSE5f6YtNjkcm4xFNTrUfQc13vjyBRqU4gMxU_7bwQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2256Snhw2qMJ4%22%2C%22playlistId%22%3A%22RDAMVM56Snhw2qMJ4%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2256Snhw2qMJ4%22%2C%22playlistId%22%3A%22RDAMVM56Snhw2qMJ4%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: mnt/USB/VOL/Musik/Picard/picarddiv/S-V/Simone Kopmajer/Emotion/03 Go.mp3 Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: mnt/USB/VOL/Musik/div/Jazz/09 Everybody Loves Somebody Sometime.mp3 Mar 31 11:46:39 volumio1 volumio[837]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22White%20Horse%22%2C%22artist%22%3A%22Chris%20Stapleton%22%2C%22album%22%3A%22Higher%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FN7tWZ9kRToe77sveuY8Fv_DLlbLl9xVYIz7PdzMuPSE5f6YtNjkcm4xFNTrUfQc13vjyBRqU4gMxU_7bwQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2256Snhw2qMJ4%22%2C%22playlistId%22%3A%22RDAMVM56Snhw2qMJ4%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2256Snhw2qMJ4%22%2C%22playlistId%22%3A%22RDAMVM56Snhw2qMJ4%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D Mar 31 11:46:39 volumio1 volumio[837]: info: Exploding uri mnt/USB/VOL/Musik/Picard/Audiophile/Best Audiophile Voices/04 Stacey Kent feat. Jim Tomlinson - So Nice.mp3 in service mpd Mar 31 11:46:39 volumio1 volumio[837]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 11:46:39 volumio1 volumio[837]: TypeError: Cannot read property 'then' of undefined Mar 31 11:46:39 volumio1 volumio[837]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Mar 31 11:46:39 volumio1 volumio[837]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Mar 31 11:46:39 volumio1 volumio[837]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) Mar 31 11:46:39 volumio1 volumio[837]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Mar 31 11:46:39 volumio1 volumio[837]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Mar 31 11:46:39 volumio1 volumio[837]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Mar 31 11:46:39 volumio1 volumio[837]: at listOnTimeout (internal/timers.js:554:17) Mar 31 11:46:39 volumio1 volumio[837]: at processTimers (internal/timers.js:497:7) Mar 31 11:46:39 volumio1 volumio[837]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 11:46:40 volumio1 sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-31 11:45 Mar 31 11:46:40 volumio1 sudo[1107]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"