-- Logs begin at Sat 2024-08-31 18:55:42 UTC, end at Wed 2024-09-04 17:19:59 UTC. --
Sep 04 17:19:04 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea7de619.f4752178 does not match aorg 0000000000.00000000 from server@144.76.66.157 xmt 0xea831508.2378676a
Sep 04 17:19:04 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea7de619.f43e5fa7 does not match aorg 0000000000.00000000 from server@90.187.112.137 xmt 0xea831508.236e5e56
Sep 04 17:19:04 kiwibox systemd[1]: Starting Daily apt download activities...
Sep 04 17:19:05 kiwibox ntpd[526]: Soliciting pool server 78.47.93.191
Sep 04 17:19:09 kiwibox volumio-remote-updater[431]: [2024-09-04 17:19:09] [connect] Successful connection
Sep 04 17:19:12 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea83150d.21273a8c does not match aorg 0xea83150f.208d8eb3 from server@78.47.168.188 xmt 0xea83150d.2424f218
Sep 04 17:19:12 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea83150d.252c6cd4 does not match aorg 0xea83150f.20eba217 from server@49.13.14.46 xmt 0xea83150d.2772fe11
Sep 04 17:19:12 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea83150d.2b324a80 does not match aorg 0xea83150f.215cadd5 from server@193.158.22.13 xmt 0xea83150d.2ba86b94
Sep 04 17:19:12 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea83150d.2a4d3729 does not match aorg 0xea83150f.21295d01 from server@185.244.195.159 xmt 0xea83150d.2c0e38fa
Sep 04 17:19:12 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea83150e.2125fd66 does not match aorg 0xea831510.2bae9757 from server@195.201.137.97 xmt 0xea83150e.23d9c144
Sep 04 17:19:12 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea83150e.2186e690 does not match aorg 0xea831510.2f617fb5 from server@217.91.44.17 xmt 0xea83150e.228642a8
Sep 04 17:19:12 kiwibox ntpd[526]: receive: Unexpected origin timestamp 0xea83150e.208c6923 does not match aorg 0xea831510.209009a3 from server@78.47.93.191 xmt 0xea83150e.23f8d94b
Sep 04 17:19:12 kiwibox volumio[811]: info: Loading plugin "outputs"...
Sep 04 17:19:13 kiwibox volumio[811]: info: Loading plugin "albumart"...
Sep 04 17:19:15 kiwibox volumio[811]: info: Plugin example_plugin is not enabled
Sep 04 17:19:15 kiwibox volumio[811]: info: Loading plugin "inputs"...
Sep 04 17:19:16 kiwibox volumio[811]: info: Loading plugin "updater_comm"...
Sep 04 17:19:24 kiwibox volumio-remote-updater[431]: [2024-09-04 17:19:24] [connect] Successful connection
Sep 04 17:19:29 kiwibox volumio[811]: info: Plugin mpdemulation is not enabled
Sep 04 17:19:30 kiwibox volumio[811]: info: Loading plugin "rest_api"...
Sep 04 17:19:30 kiwibox volumio[811]: info: Loading plugin "websocket"...
Sep 04 17:19:31 kiwibox volumio[811]: info: Starting Socket.io Server version 2.3.0
Sep 04 17:19:32 kiwibox volumio[811]: info: Loading i18n strings for locale en
Sep 04 17:19:32 kiwibox volumio[811]: Updating browse sources language
Sep 04 17:19:32 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 04 17:19:39 kiwibox volumio-remote-updater[431]: [2024-09-04 17:19:39] [connect] Successful connection
Sep 04 17:19:40 kiwibox volumio[811]: Forking 1 albumart workers
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::initPlayerControls
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 04 17:19:43 kiwibox volumio[811]: Express server listening on port 3000
Sep 04 17:19:43 kiwibox systemd[1]: apt-daily.service: Succeeded.
Sep 04 17:19:43 kiwibox volumio[811]: [Metrics] WebUI: 69s 712.96ms
Sep 04 17:19:43 kiwibox systemd[1]: Started Daily apt download activities.
Sep 04 17:19:43 kiwibox systemd[1]: Starting Daily apt upgrade and clean activities...
Sep 04 17:19:44 kiwibox volumio[811]: info: CoreStateMachine::resetVolumioState
Sep 04 17:19:44 kiwibox volumio[811]: info: CoreStateMachine::getcurrentVolume
Sep 04 17:19:44 kiwibox volumio[811]: info: CoreCommandRouter::volumioRetrievevolume
Sep 04 17:19:49 kiwibox volumio[811]: verbose: New Socket.io Connection to 192.168.10.64:3000 from 192.168.10.12 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Sep 04 17:19:49 kiwibox volumio[811]: verbose: New Socket.io Connection to 192.168.10.64:3000 from 192.168.10.12 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Sep 04 17:19:49 kiwibox volumio[811]: verbose: New Socket.io Connection to 192.168.10.64:3000 from 192.168.10.12 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Sep 04 17:19:49 kiwibox volumio[811]: verbose: New Socket.io Connection to 192.168.10.64:3000 from 192.168.10.12 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Sep 04 17:19:49 kiwibox volumio[811]: verbose: New Socket.io Connection to 192.168.10.64:3000 from 192.168.10.12 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Sep 04 17:19:49 kiwibox volumio[811]: verbose: New Socket.io Connection to 192.168.10.64:3000 from 192.168.10.12 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Sep 04 17:19:50 kiwibox volumio[811]: info: CoreStateMachine::pushState
Sep 04 17:19:50 kiwibox volumio[811]: info: CorePlayQueue::getTrack 0
Sep 04 17:19:50 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 17:19:50 kiwibox volumio[811]: info: CoreCommandRouter::volumioPushState
Sep 04 17:19:50 kiwibox volumio[811]: info: CoreStateMachine::updateTrackBlock
Sep 04 17:19:50 kiwibox volumio[811]: info: CorePlayQueue::getTrackBlock
Sep 04 17:19:50 kiwibox volumio[811]: info: CoreCommandRouter::volumioRetrievevolume
Sep 04 17:19:50 kiwibox volumio[811]: info:
Sep 04 17:19:50 kiwibox volumio[811]: ---------------------------- Client requests Volumio Play Playlist HeleneFischer
Sep 04 17:19:50 kiwibox volumio[811]: info: Play playlist HeleneFischer
Sep 04 17:19:51 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 04 17:19:51 kiwibox volumio[811]: info: Reloading queue from file
Sep 04 17:19:51 kiwibox volumio[811]: verbose: New Socket.io Connection to 192.168.10.64:3000 from 192.168.10.12 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreStateMachine::pushState
Sep 04 17:19:52 kiwibox volumio[811]: info: CorePlayQueue::getTrack 0
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreCommandRouter::volumioPushState
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreStateMachine::setRepeat false single undefined
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreStateMachine::pushState
Sep 04 17:19:52 kiwibox volumio[811]: info: CorePlayQueue::getTrack 0
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreCommandRouter::volumioPushState
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreStateMachine::setRandom null
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreStateMachine::pushState
Sep 04 17:19:52 kiwibox volumio[811]: info: CorePlayQueue::getTrack 0
Sep 04 17:19:52 kiwibox volumio[811]: info: CoreCommandRouter::volumioPushState
Sep 04 17:19:52 kiwibox volumio[811]: info: Setting Device type: Raspberry PI
Sep 04 17:19:52 kiwibox volumio[811]: info: Completed loading Core Plugins
Sep 04 17:19:52 kiwibox volumio[811]: info: Preparing to generate the ALSA configuration file
Sep 04 17:19:52 kiwibox volumio[811]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Sep 04 17:19:52 kiwibox volumio[811]: info: Reading ALSA contributions from plugins.
Sep 04 17:19:53 kiwibox volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Sep 04 17:19:53 kiwibox volumio[811]: info: Discovery: adding dfaa0fa0-eaa8-45a8-9ea0-aff549bb1f4f
Sep 04 17:19:53 kiwibox volumio[811]: info: Discovery: Found device kiwibox
Sep 04 17:19:53 kiwibox volumio[811]: info: CoreCommandRouter::volumioGetState
Sep 04 17:19:53 kiwibox volumio[811]: info: CorePlayQueue::getTrack 0
Sep 04 17:19:53 kiwibox volumio[811]: info: Discovery: A device disappeared from network
Sep 04 17:19:53 kiwibox volumio[811]: info: CoreCommandRouter::volumioClearQueue
Sep 04 17:19:53 kiwibox volumio[811]: info: CoreStateMachine::ClearQueue
Sep 04 17:19:53 kiwibox volumio[811]: info: CoreStateMachine::stop
Sep 04 17:19:53 kiwibox volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 17:19:53 kiwibox volumio[811]: info: CorePlayQueue::clearPlayQueue
Sep 04 17:19:53 kiwibox volumio[811]: info: CorePlayQueue::saveQueue
Sep 04 17:19:54 kiwibox volumio[811]: info: CoreCommandRouter::volumioPushState
Sep 04 17:19:54 kiwibox volumio[811]: info: CoreCommandRouter::volumioPushQueue
Sep 04 17:19:54 kiwibox volumio[811]: info: CoreCommandRouter::volumioAddQueueItems
Sep 04 17:19:54 kiwibox volumio[811]: info: CoreStateMachine::addQueueItems
Sep 04 17:19:54 kiwibox volumio[811]: info: CorePlayQueue::addQueueItems
Sep 04 17:19:54 kiwibox volumio[811]: info: Preload queue cleared
Sep 04 17:19:54 kiwibox volumio[811]: info: Adding Item to queue: mnt/INTERNAL/Helene Fischer/Helene Fischer - Atemlos durch die Nacht.m4a
Sep 04 17:19:54 kiwibox volumio[811]: info: Exploding uri mnt/INTERNAL/Helene Fischer/Helene Fischer - Atemlos durch die Nacht.m4a in service mpd
Sep 04 17:19:54 kiwibox volumio[811]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 04 17:19:54 kiwibox volumio[811]: TypeError: Cannot read property 'then' of undefined
Sep 04 17:19:54 kiwibox volumio[811]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19)
Sep 04 17:19:54 kiwibox volumio[811]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21)
Sep 04 17:19:54 kiwibox volumio[811]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1365:16)
Sep 04 17:19:54 kiwibox volumio[811]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Sep 04 17:19:54 kiwibox volumio[811]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Sep 04 17:19:54 kiwibox volumio[811]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30)
Sep 04 17:19:54 kiwibox volumio[811]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25)
Sep 04 17:19:54 kiwibox volumio[811]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:447:28)
Sep 04 17:19:54 kiwibox volumio[811]: at /volumio/app/playlistManager.js:726:30
Sep 04 17:19:54 kiwibox volumio[811]: at /volumio/node_modules/jsonfile/index.js:46:5
Sep 04 17:19:54 kiwibox volumio[811]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 04 17:19:54 kiwibox volumio-remote-updater[431]: [2024-09-04 17:19:54] [connect] Successful connection
Sep 04 17:19:54 kiwibox systemd[1]: apt-daily-upgrade.service: Succeeded.
Sep 04 17:19:54 kiwibox systemd[1]: Started Daily apt upgrade and clean activities.
Sep 04 17:19:56 kiwibox volumio[811]: Starting albumart workers
Sep 04 17:19:59 kiwibox sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 17:18
Sep 04 17:19:59 kiwibox sudo[1087]: 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"