-- Logs begin at Sun 2024-04-28 10:49:17 UTC, end at Tue 2024-04-30 16:31:43 UTC. -- Apr 30 16:30:02 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:08 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:13 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:19 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:24 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:30 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:35 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:41 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:46 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:52 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:30:57 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:03 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:09 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:14 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:20 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:25 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:31 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:36 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:42 volumio_lobby volumio[26458]: INFO:librespot_playback::player: SpCon::kSpDeviceActive Apr 30 16:31:42 volumio_lobby volumio[21046]: info: [SpConDebug] Device is active! Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::volumioGetState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::getState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CorePlayQueue::getTrack 0 Apr 30 16:31:42 volumio_lobby volumio[21046]: info: [SpConDebug] Currently active:mpd Apr 30 16:31:42 volumio_lobby volumio[21046]: info: [SpConDebug] Stopping currently active service Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::volumioStop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::stop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 16:31:42 volumio_lobby volumio[21046]: UNSET VOLATILE Apr 30 16:31:42 volumio_lobby volumio[21046]: info: [SpConDebug] SpotConn Active Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::volumioGetState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::getState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CorePlayQueue::getTrack 0 Apr 30 16:31:42 volumio_lobby volumio[21046]: info: [SpConDebug] Currently active:mpd Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 16:31:42 volumio_lobby kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::servicePushState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::syncState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::pushState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::getState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::volumioPushState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 16:31:42 volumio_lobby volumio[26458]: INFO:librespot_playback::player: SpCon::kSpSinkActive Apr 30 16:31:42 volumio_lobby volumio[21046]: info: [SpConDebug] Sink acquired Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::servicePushState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::syncState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::pushState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::getState Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::volumioPushState Apr 30 16:31:42 volumio_lobby sudo[30910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 16:31:42 volumio_lobby sudo[30910]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 16:31:42 volumio_lobby sudo[30910]: pam_unix(sudo:session): session closed for user root Apr 30 16:31:42 volumio_lobby sudo[30918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 16:31:42 volumio_lobby wpa_supplicant[893]: wlan0: Failed to initiate sched scan Apr 30 16:31:42 volumio_lobby sudo[30918]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 16:31:42 volumio_lobby sudo[30918]: pam_unix(sudo:session): session closed for user root Apr 30 16:31:42 volumio_lobby volumio[21046]: info: Airplay started streaming Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::volumioStop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::stop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::serviceStop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::serviceStop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: [SpConDebug] Received stop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 16:31:42 volumio_lobby volumio[21046]: info: Airplay started streaming Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::volumioStop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::stop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::serviceStop Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreCommandRouter::serviceStop Apr 30 16:31:42 volumio_lobby volumio[21046]: error: WARNING: No stop method for service airplay Apr 30 16:31:42 volumio_lobby volumio[21046]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 16:31:43 volumio_lobby volumio[26458]: INFO:librespot_playback::player: SpCon::kSpDeviceInactive Apr 30 16:31:43 volumio_lobby volumio[21046]: info: [SpConDebug] Killing Volumio state, Spotify session: true Apr 30 16:31:43 volumio_lobby volumio[21046]: info: [SpConDebug] SpotConn is done! Apr 30 16:31:43 volumio_lobby volumio[26458]: INFO:librespot_playback::player: SpCon::kSpSinkInactive Apr 30 16:31:43 volumio_lobby volumio[21046]: info: CoreCommandRouter::volumioGetState Apr 30 16:31:43 volumio_lobby volumio[21046]: info: CoreStateMachine::getState Apr 30 16:31:43 volumio_lobby volumio[21046]: info: [SpConDebug] Currently active:volspotconnect2 Apr 30 16:31:43 volumio_lobby volumio[21046]: UNSET VOLATILE Apr 30 16:31:43 volumio_lobby volumio[21046]: STOPPING SHAIRPORT Apr 30 16:31:43 volumio_lobby volumio[21046]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 16:31:43 volumio_lobby volumio[21046]: ReferenceError: stopAirPlay is not defined Apr 30 16:31:43 volumio_lobby volumio[21046]: at AirPlayInterface.unsetVol (/volumio/app/plugins/music_service/airplay_emulation/index.js:344:5) Apr 30 16:31:43 volumio_lobby volumio[21046]: at CoreStateMachine.unSetVolatile (/volumio/app/statemachine.js:1550:31) Apr 30 16:31:43 volumio_lobby volumio[21046]: at ControllerVolspotconnect.DeactivateState (/data/plugins/music_service/volspotconnect2/index.js:243:42) Apr 30 16:31:43 volumio_lobby volumio[21046]: at SpotConnEvents. (/data/plugins/music_service/volspotconnect2/index.js:154:8) Apr 30 16:31:43 volumio_lobby volumio[21046]: at emitOne (events.js:116:13) Apr 30 16:31:43 volumio_lobby volumio[21046]: at SpotConnEvents.emit (events.js:211:7) Apr 30 16:31:43 volumio_lobby volumio[21046]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:51:16) Apr 30 16:31:43 volumio_lobby volumio[21046]: at Socket.SpotConnEvents.self._udpsource.on.msg (/data/plugins/music_service/volspotconnect2/SpotConnController.js:16:12) Apr 30 16:31:43 volumio_lobby volumio[21046]: at emitTwo (events.js:126:13) Apr 30 16:31:43 volumio_lobby volumio[21046]: at Socket.emit (events.js:214:7) Apr 30 16:31:43 volumio_lobby volumio[21046]: at UDP.onMessage [as onmessage] (dgram.js:659:8) Apr 30 16:31:43 volumio_lobby kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 30 16:31:43 volumio_lobby volumio[21046]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 16:31:43 volumio_lobby volumio[26458]: INFO:librespot_playback::player: SpCon::kSpPlaybackNotifyBecameInactive Apr 30 16:31:43 volumio_lobby sudo[30950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-30 16:30 Apr 30 16:31:43 volumio_lobby sudo[30950]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="c00a19098320053824010d132d6bfb39774a7d2f" VOLUMIO_FE_VERSION="e2f152c30d370c9c7c86508a02c0323bef5c243b" VOLUMIO_BE_VERSION="909cc76a7609428f005f8e2878227062cb5328a6" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Sep 17 00:18:22 CEST 2018" VOLUMIO_VERSION="2.457" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="cdde21c6e3d40ce352c051f661950d1b"