-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-08-18 20:28:57 CEST. --
Aug 18 20:28:45 volumio sudo[9085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 18 20:28:45 volumio sudo[9085]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 18 20:28:45 volumio sudo[9085]: pam_unix(sudo:session): session closed for user root
Aug 18 20:28:45 volumio sudo[9088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 18 20:28:45 volumio sudo[9088]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 18 20:28:45 volumio sudo[9088]: pam_unix(sudo:session): session closed for user root
Aug 18 20:28:45 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.178.92 from 192.168.178.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:129.0) Gecko/20100101 Firefox/129.0 Engine version: 3 Transport: polling Total Clients: 8
Aug 18 20:28:45 volumio sudo[9093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 18 20:28:45 volumio sudo[9093]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 18 20:28:45 volumio sudo[9093]: pam_unix(sudo:session): session closed for user root
Aug 18 20:28:45 volumio sudo[9096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 18 20:28:45 volumio sudo[9096]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 18 20:28:45 volumio sudo[9096]: pam_unix(sudo:session): session closed for user root
Aug 18 20:28:45 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.178.92 from 192.168.178.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:129.0) Gecko/20100101 Firefox/129.0 Engine version: 3 Transport: polling Total Clients: 8
Aug 18 20:28:45 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
Aug 18 20:28:45 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:45 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 18 20:28:45 volumio volumio[1072]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Aug 18 20:28:45 volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 18 20:28:45 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 18 20:28:45 volumio volumio[1072]: info: Listing playlists
Aug 18 20:28:45 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 18 20:28:45 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 18 20:28:45 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 18 20:28:45 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 18 20:28:48 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 18 20:28:48 volumio volumio[1072]: info: Received Get System Info
Aug 18 20:28:48 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 18 20:28:48 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 18 20:28:48 volumio volumio[1072]: info: Discovery: Getting this device information
Aug 18 20:28:48 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
Aug 18 20:28:48 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:48 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 18 20:28:48 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 18 20:28:50 volumio volumio[1072]: info: CoreCommandRouter::volumioPlay
Aug 18 20:28:50 volumio volumio[1072]: info: CoreStateMachine::play index undefined
Aug 18 20:28:50 volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 18 20:28:50 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:50 volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer
Aug 18 20:28:50 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:50 volumio volumio[1072]: verbose: ControllerMpd::clearAddPlayTracks USB/Extreme_SSD/MP3 320 Only/Dub Spencer & Trance Hill - 2010 - Riding Strange Horses/01. Dub Spencer & Trance Hill - Man with the Harmonica.mp3
Aug 18 20:28:50 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand stop
Aug 18 20:28:50 volumio volumio[1072]: info: sendMpdCommand stop took 1 milliseconds
Aug 18 20:28:50 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand clear
Aug 18 20:28:50 volumio volumio[1072]: info:
Aug 18 20:28:50 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
Aug 18 20:28:50 volumio volumio[1072]: info: Ignoring MPD Status Update
Aug 18 20:28:50 volumio volumio[1072]: info: sendMpdCommand clear took 1 milliseconds
Aug 18 20:28:50 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand add "USB/Extreme_SSD/MP3 320 Only/Dub Spencer & Trance Hill - 2010 - Riding Strange Horses/01. Dub Spencer & Trance Hill - Man with the Harmonica.mp3"
Aug 18 20:28:50 volumio volumio[1072]: error: updateQueue error: null
Aug 18 20:28:50 volumio volumio[1072]: info:
Aug 18 20:28:50 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
Aug 18 20:28:50 volumio volumio[1072]: info: Ignoring MPD Status Update
Aug 18 20:28:50 volumio volumio[1072]: info: ------------------------------ 2ms
Aug 18 20:28:50 volumio volumio[1072]: info: sendMpdCommand add "USB/Extreme_SSD/MP3 320 Only/Dub Spencer & Trance Hill - 2010 - Riding Strange Horses/01. Dub Spencer & Trance Hill - Man with the Harmonica.mp3" took 2 milliseconds
Aug 18 20:28:50 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand play
Aug 18 20:28:50 volumio volumio[1072]: info: ------------------------------ 2ms
Aug 18 20:28:50 volumio volumio[1072]: info: sendMpdCommand play took 1 milliseconds
Aug 18 20:28:51 volumio volumio[1072]: info:
Aug 18 20:28:51 volumio volumio[1072]: ---------------------------- MPD announces state update: player
Aug 18 20:28:51 volumio volumio[1072]: info: ControllerMpd::getState
Aug 18 20:28:51 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 20:28:51 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Aug 18 20:28:51 volumio volumio[1072]: info:
Aug 18 20:28:51 volumio volumio[1072]: ---------------------------- MPD announces state update: player
Aug 18 20:28:51 volumio volumio[1072]: info: sendMpdCommand status took 28 milliseconds
Aug 18 20:28:51 volumio volumio[1072]: info: ControllerMpd::getState
Aug 18 20:28:51 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 20:28:51 volumio volumio[1072]: verbose: ControllerMpd::parseState
Aug 18 20:28:51 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 20:28:51 volumio volumio[1072]: info: sendMpdCommand status took 1 milliseconds
Aug 18 20:28:51 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 1 milliseconds
Aug 18 20:28:51 volumio volumio[1072]: verbose: ControllerMpd::parseState
Aug 18 20:28:51 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 20:28:51 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo
Aug 18 20:28:51 volumio volumio[1072]: info: ControllerMpd::pushState
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::servicePushState
Aug 18 20:28:51 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:51 volumio volumio[1072]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Man with the Harmonica","artist":"Dub Spencer & Trance Hill","album":"Riding Strange Horses","uri":"USB/Extreme_SSD/MP3 320 Only/Dub Spencer & Trance Hill - 2010 - Riding Strange Horses/01. Dub Spencer & Trance Hill - Man with the Harmonica.mp3","trackType":"mp3"}
Aug 18 20:28:51 volumio volumio[1072]: verbose: CURRENT POSITION 0
Aug 18 20:28:51 volumio volumio[1072]: info: CoreStateMachine::syncState stateService play
Aug 18 20:28:51 volumio volumio[1072]: info: CoreStateMachine::syncState currentStatus stop
Aug 18 20:28:51 volumio volumio[1072]: info: ------------------------------ 33ms
Aug 18 20:28:51 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 18 20:28:51 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo
Aug 18 20:28:51 volumio volumio[1072]: info: ControllerMpd::pushState
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::servicePushState
Aug 18 20:28:51 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:51 volumio volumio[1072]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":232,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Man with the Harmonica","artist":"Dub Spencer & Trance Hill","album":"Riding Strange Horses","uri":"USB/Extreme_SSD/MP3 320 Only/Dub Spencer & Trance Hill - 2010 - Riding Strange Horses/01. Dub Spencer & Trance Hill - Man with the Harmonica.mp3","trackType":"mp3"}
Aug 18 20:28:51 volumio volumio[1072]: verbose: CURRENT POSITION 0
Aug 18 20:28:51 volumio volumio[1072]: info: CoreStateMachine::syncState stateService play
Aug 18 20:28:51 volumio volumio[1072]: info: CoreStateMachine::syncState currentStatus play
Aug 18 20:28:51 volumio volumio[1072]: info: Received an update from plugin. extracting info from payload
Aug 18 20:28:51 volumio volumio[1072]: info: CoreStateMachine::pushState
Aug 18 20:28:51 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
Aug 18 20:28:51 volumio volumio[1072]: info: MRS: Pushing multiroomSync output update for this device
Aug 18 20:28:51 volumio volumio[1072]: info: MRS: Pushing multiroomSync output
Aug 18 20:28:51 volumio volumio[1072]: info: CoreStateMachine::pushState
Aug 18 20:28:51 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
Aug 18 20:28:51 volumio volumio[1072]: info: MRS: Pushing multiroomSync output update for this device
Aug 18 20:28:51 volumio volumio[1072]: info: MRS: Pushing multiroomSync output
Aug 18 20:28:51 volumio volumio[1072]: info: ------------------------------ 28ms
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 18 20:28:51 volumio volumio[1072]: info: Received Get System Info
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 18 20:28:51 volumio volumio[1072]: info: Discovery: Getting this device information
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
Aug 18 20:28:51 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
Aug 18 20:28:51 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 18 20:28:57 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay
Aug 18 20:28:57 volumio volumio[1072]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom
Aug 18 20:28:57 volumio volumio[1072]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 18 20:28:57 volumio volumio[1072]: TypeError: Cannot read property 'then' of undefined
Aug 18 20:28:57 volumio volumio[1072]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9)
Aug 18 20:28:57 volumio volumio[1072]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2260:30)
Aug 18 20:28:57 volumio volumio[1072]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1442:26)
Aug 18 20:28:57 volumio volumio[1072]: at Socket.emit (events.js:315:20)
Aug 18 20:28:57 volumio volumio[1072]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Aug 18 20:28:57 volumio volumio[1072]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Aug 18 20:28:57 volumio volumio[1072]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 18 20:28:57 volumio sudo[9113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-18 20:27
Aug 18 20:28:57 volumio sudo[9113]: 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"