-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Thu 2025-05-08 14:26:29 UTC. -- May 08 14:25:02 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:25:09 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:25:17 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:25:19 volumiow ntpd[686]: 5.189.151.39 local addr 192.168.2.82 -> May 08 14:25:25 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:25:32 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:25:36 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 08 14:25:36 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 08 14:25:36 volumiow volumio[898]: info: Discovery: Getting this device information May 08 14:25:36 volumiow volumio[898]: info: CoreCommandRouter::volumioGetState May 08 14:25:36 volumiow volumio[898]: info: CorePlayQueue::getTrack 2 May 08 14:25:36 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 08 14:25:40 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:25:41 volumiow ntpd[686]: 162.159.200.123 local addr 192.168.2.82 -> May 08 14:25:44 volumiow volumio[898]: info: CoreCommandRouter::volumioPause May 08 14:25:44 volumiow volumio[898]: info: CoreStateMachine::pause May 08 14:25:44 volumiow volumio[898]: info: CoreStateMachine::stPlaybackTimer May 08 14:25:44 volumiow volumio[898]: info: CoreStateMachine::servicePause May 08 14:25:44 volumiow volumio[898]: info: CorePlayQueue::getTrack 2 May 08 14:25:44 volumiow volumio[898]: info: CoreCommandRouter::servicePause May 08 14:25:44 volumiow volumio[898]: info: ControllerMpd::pause May 08 14:25:44 volumiow volumio[898]: verbose: ControllerMpd::sendMpdCommand pause May 08 14:25:44 volumiow volumio[898]: info: May 08 14:25:44 volumiow volumio[898]: ---------------------------- MPD announces state update: player May 08 14:25:44 volumiow volumio[898]: info: sendMpdCommand pause took 58 milliseconds May 08 14:25:44 volumiow volumio[898]: info: ControllerMpd::getState May 08 14:25:44 volumiow volumio[898]: verbose: ControllerMpd::sendMpdCommand status May 08 14:25:44 volumiow volumio[898]: info: sendMpdCommand status took 1 milliseconds May 08 14:25:44 volumiow volumio[898]: verbose: ControllerMpd::parseState May 08 14:25:44 volumiow volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 14:25:44 volumiow volumio[898]: info: sendMpdCommand playlistinfo took 1 milliseconds May 08 14:25:44 volumiow volumio[898]: verbose: ControllerMpd::parseTrackInfo May 08 14:25:44 volumiow volumio[898]: info: ControllerMpd::pushState May 08 14:25:44 volumiow volumio[898]: info: CoreCommandRouter::servicePushState May 08 14:25:44 volumiow volumio[898]: info: CorePlayQueue::getTrack 2 May 08 14:25:44 volumiow volumio[898]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":287062,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"668 Kbps","isStreaming":false,"title":"You look good to me","artist":"Oscar Peterson Trio, The","album":"We get requests (K2HD)","uri":"USB/MUSIC_W/JAZZ/Oscar Peterson Trio/We get requests (K2HD)/01 Oscar Peterson Trio, The - You look good to me.flac","trackType":"flac"} May 08 14:25:44 volumiow volumio[898]: verbose: CURRENT POSITION 2 May 08 14:25:44 volumiow volumio[898]: info: CoreStateMachine::syncState stateService pause May 08 14:25:44 volumiow volumio[898]: info: CoreStateMachine::syncState currentStatus pause May 08 14:25:44 volumiow volumio[898]: info: CoreStateMachine::pushState May 08 14:25:44 volumiow volumio[898]: info: CorePlayQueue::getTrack 2 May 08 14:25:44 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 14:25:44 volumiow volumio[898]: info: CoreCommandRouter::volumioPushState May 08 14:25:44 volumiow volumio[898]: info: CoreStateMachine::stPlaybackTimer May 08 14:25:44 volumiow volumio[898]: info: ------------------------------ 18ms May 08 14:25:44 volumiow volumio[898]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 May 08 14:25:45 volumiow ntpd[686]: 37.114.40.20 local addr 192.168.2.82 -> May 08 14:25:45 volumiow ntpd[686]: 91.202.42.84 local addr 192.168.2.82 -> May 08 14:25:47 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:25:48 volumiow volumio[898]: info: CoreCommandRouter::volumioGetQueue May 08 14:25:48 volumiow volumio[898]: info: CoreStateMachine::getQueue May 08 14:25:48 volumiow volumio[898]: info: CorePlayQueue::getQueue May 08 14:25:55 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:25:59 volumiow volumio[898]: Searching all installed plugins May 08 14:25:59 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 08 14:25:59 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: , search May 08 14:25:59 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 08 14:25:59 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 08 14:25:59 volumiow volumio[898]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 08 14:25:59 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 08 14:25:59 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: spop , search May 08 14:25:59 volumiow volumio[898]: info: New access token = BQDqsV-tzdDQqYUAr1daLLaKustlxKNqe0FvhEtqTliFqm0IiCMCdzcjKZg3iGEngyrITewtlIgeIL7jlGXWS7CzbXN-lGLLh-A2g_bvnZT2jWNZHn18P5KXEDEGGMbNtd7yrX2ZcFPl_H0JLWPAC4rmKWtfA1gEO22-sj4M1wtaZiiFNKSTAGxPFEA4YVyODviwUNg7iRA17u6aaOoR7qRbbidXbSVz5AXHOE2stje1Tza8n-224NgrCOzHl3i26tSf_-vZiP4Ej9gi6TgRhe4jVwD5Aepp0H1HVrU1lJEZugo May 08 14:26:00 volumiow volumio[898]: info: All search sources collected, pushing search results May 08 14:26:03 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:26:06 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 08 14:26:06 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 08 14:26:06 volumiow volumio[898]: info: Discovery: Getting this device information May 08 14:26:06 volumiow volumio[898]: info: CoreCommandRouter::volumioGetState May 08 14:26:06 volumiow volumio[898]: info: CorePlayQueue::getTrack 2 May 08 14:26:06 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 08 14:26:10 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:26:18 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:26:18 volumiow ntpd[686]: 159.69.64.189 local addr 192.168.2.82 -> May 08 14:26:25 volumiow wpa_supplicant[784]: wlan0: Failed to initiate sched scan May 08 14:26:29 volumiow volumio[898]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch May 08 14:26:29 volumiow volumio[898]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 14:26:29 volumiow volumio[898]: TypeError: Cannot read property 'then' of undefined May 08 14:26:29 volumiow volumio[898]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:470:20) May 08 14:26:29 volumiow volumio[898]: at Socket.emit (events.js:315:20) May 08 14:26:29 volumiow volumio[898]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 08 14:26:29 volumiow volumio[898]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 08 14:26:29 volumiow volumio[898]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 14:26:29 volumiow sudo[1297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-08 14:25 May 08 14:26:29 volumiow sudo[1297]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST" VOLUMIO_VERSION="3.546" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"