-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-07-19 14:17:19 CEST. -- Jul 19 14:16:42 volumiob3 ntpd[795]: receive: Unexpected origin timestamp 0xea44d3f3.f7ef3dc6 does not match aorg 0000000000.00000000 from server@94.16.122.152 xmt 0xea44d7aa.c05b6576 Jul 19 14:16:42 volumiob3 ntpd[795]: receive: Unexpected origin timestamp 0xea44d3f3.f7f8206c does not match aorg 0000000000.00000000 from server@212.132.97.26 xmt 0xea44d7aa.c0e89fa6 Jul 19 14:16:45 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 19 14:16:45 volumiob3 volumio[944]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 19 14:16:45 volumiob3 volumio[944]: info: CoreCommandRouter::volumioGetState Jul 19 14:16:45 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:16:48 volumiob3 volumio[944]: info: CoreCommandRouter::volumioGetState Jul 19 14:16:48 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:16:48 volumiob3 volumio[944]: info: Listing playlists Jul 19 14:16:48 volumiob3 volumio[944]: info: Listing playlists Jul 19 14:16:50 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 14:16:50 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 14:16:50 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 19 14:16:50 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 19 14:16:50 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 19 14:16:50 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 19 14:16:50 volumiob3 volumio[944]: info: CoreCommandRouter::volumioGetBrowseSources Jul 19 14:16:50 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 19 14:16:51 volumiob3 kernel: rc rc0: two consecutive events of type pulse Jul 19 14:16:51 volumiob3 volumio[944]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 19 14:16:51 volumiob3 volumio[944]: info: Completed starting MyVolumio Plugin Jul 19 14:16:51 volumiob3 volumio[944]: info: BOOT COMPLETED Jul 19 14:16:51 volumiob3 volumio[944]: [Metrics] CommandRouter: 73s 832.37ms Jul 19 14:16:51 volumiob3 volumio[944]: info: CoreCommandRouter::volumiosetStartupVolume Jul 19 14:16:51 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 14:16:51 volumiob3 volumio[944]: info: VolumeController:: Setting startup Volume 70 Jul 19 14:16:51 volumiob3 volumio[944]: info: VolumeController::SetAlsaVolume70 Jul 19 14:16:51 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 14:16:52 volumiob3 volumio[944]: info: CoreCommandRouter::Close All Modals sent Jul 19 14:16:52 volumiob3 volumio[944]: info: CoreCommandRouter::Close All Modals sent Jul 19 14:16:52 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:16:52 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:16:52 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:16:52 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:16:52 volumiob3 volumio[944]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 19 14:16:52 volumiob3 volumio[944]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 19 14:16:52 volumiob3 volumio[944]: info: camilladsp stopping service pid 1220... Jul 19 14:16:52 volumiob3 volumio[944]: info: camilladsp service terminated, instance 1 Jul 19 14:16:52 volumiob3 volumio[944]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 19 14:16:52 volumiob3 volumio[944]: info: camilladsp service started and running in background, instance 1 Jul 19 14:16:52 volumiob3 volumio[944]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 19 14:16:52 volumiob3 volumio[944]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 19 14:16:52 volumiob3 volumio[944]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 19 14:16:52 volumiob3 volumio[944]: error: FusionDsp - WebSocket error: [object Object] Jul 19 14:16:52 volumiob3 volumio[944]: info: camilladsp spawned new process with pid 1849, instance 1, run: true Jul 19 14:16:52 volumiob3 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Jul 19 14:16:53 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 19 14:16:53 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 19 14:16:53 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 19 14:16:57 volumiob3 volumio[944]: info: camilladsp spawned new process with pid 1856, instance 1, run: true Jul 19 14:16:57 volumiob3 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Jul 19 14:16:58 volumiob3 volumio[944]: info: CoreCommandRouter::volumioGetState Jul 19 14:16:58 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:08 volumiob3 volumio[944]: info: CoreCommandRouter::volumioGetState Jul 19 14:17:08 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:08 volumiob3 volumio[944]: info: Listing playlists Jul 19 14:17:08 volumiob3 volumio[944]: info: Listing playlists Jul 19 14:17:12 volumiob3 volumio[944]: info: [IrActivityLed] ir command received: 0000000077e120c5 00 KEY_PLAY iremote Jul 19 14:17:12 volumiob3 volumio[944]: info: [IrActivityLed] Starting to blink LED Jul 19 14:17:12 volumiob3 volumio[944]: info: [IrActivityLed] Error: ENOENT: no such file or directory, open '/sys/class/leds/led1/trigger' Jul 19 14:17:12 volumiob3 volumio[944]: info: [IrActivityLed] ir command received: 0000000077e120c5 01 KEY_PLAY iremote Jul 19 14:17:12 volumiob3 irexec[1336]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 19 14:17:12 volumiob3 irexec[1336]: Dload Upload Total Spent Left Speed Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- Client requests Volumio toggle Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioToggle Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::play index undefined Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::startPlaybackTimer Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::clearAddPlayTracks NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 14:17:12 volumiob3 irexec[1336]: [158B blob data] Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand stop took 5 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand clear Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces system playlist update Jul 19 14:17:12 volumiob3 volumio[944]: info: Ignoring MPD Status Update Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand clear took 4 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand add "NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3" Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces system playlist update Jul 19 14:17:12 volumiob3 volumio[944]: info: Ignoring MPD Status Update Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces system playlist update Jul 19 14:17:12 volumiob3 volumio[944]: info: Ignoring MPD Status Update Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces system playlist update Jul 19 14:17:12 volumiob3 volumio[944]: info: Ignoring MPD Status Update Jul 19 14:17:12 volumiob3 volumio[944]: error: updateQueue error: null Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces system playlist update Jul 19 14:17:12 volumiob3 volumio[944]: info: Ignoring MPD Status Update Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 15ms Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand add "NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3" took 13 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 11ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 9ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 8ms Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand play Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces system playlist update Jul 19 14:17:12 volumiob3 volumio[944]: info: Ignoring MPD Status Update Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces system playlist update Jul 19 14:17:12 volumiob3 volumio[944]: info: Ignoring MPD Status Update Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces system playlist update Jul 19 14:17:12 volumiob3 volumio[944]: info: Ignoring MPD Status Update Jul 19 14:17:12 volumiob3 volumio[944]: error: Upnp client error: Error: This socket has been ended by the other party Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 14ms Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand play took 9 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 9ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 7ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 5ms Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces state update: player Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::getState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces state update: player Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::getState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces state update: player Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::getState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces state update: player Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::getState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:17:12 volumiob3 volumio[944]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 19 14:17:12 volumiob3 volumio[944]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 19 14:17:12 volumiob3 volumio[944]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces state update: player Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand status took 38 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand status took 36 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::getState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand status took 36 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand status took 33 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces state update: player Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::getState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces state update: player Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::getState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:17:12 volumiob3 volumio[944]: info: Jul 19 14:17:12 volumiob3 volumio[944]: ---------------------------- MPD announces state update: player Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::getState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand status took 18 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand playlistinfo took 15 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand playlistinfo took 14 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand status took 11 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand status took 9 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand status took 8 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseState Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::servicePushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":149,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"The Hawaiian Wedding Song","artist":"Andy Williams","album":"Best Of Andy Williams","uri":"NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3","trackType":"mp3"} Jul 19 14:17:12 volumiob3 volumio[944]: verbose: CURRENT POSITION 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState stateService play Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState currentStatus stop Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::servicePushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":149,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"The Hawaiian Wedding Song","artist":"Andy Williams","album":"Best Of Andy Williams","uri":"NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3","trackType":"mp3"} Jul 19 14:17:12 volumiob3 volumio[944]: verbose: CURRENT POSITION 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState stateService play Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:17:12 volumiob3 volumio[944]: info: Received an update from plugin. extracting info from payload Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::servicePushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":149,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"The Hawaiian Wedding Song","artist":"Andy Williams","album":"Best Of Andy Williams","uri":"NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3","trackType":"mp3"} Jul 19 14:17:12 volumiob3 volumio[944]: verbose: CURRENT POSITION 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState stateService play Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:17:12 volumiob3 volumio[944]: info: Received an update from plugin. extracting info from payload Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::servicePushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: STATE SERVICE {"status":"play","position":0,"seek":571,"duration":149,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"The Hawaiian Wedding Song","artist":"Andy Williams","album":"Best Of Andy Williams","uri":"NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3","trackType":"mp3"} Jul 19 14:17:12 volumiob3 volumio[944]: verbose: CURRENT POSITION 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState stateService play Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:17:12 volumiob3 volumio[944]: info: Received an update from plugin. extracting info from payload Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 150ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 251ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 250ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 250ms Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand playlistinfo took 208 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand playlistinfo took 203 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: info: sendMpdCommand playlistinfo took 202 milliseconds Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:17:12 volumiob3 volumio[944]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::servicePushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":149,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"The Hawaiian Wedding Song","artist":"Andy Williams","album":"Best Of Andy Williams","uri":"NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3","trackType":"mp3"} Jul 19 14:17:12 volumiob3 volumio[944]: verbose: CURRENT POSITION 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState stateService play Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:17:12 volumiob3 volumio[944]: info: Received an update from plugin. extracting info from payload Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::servicePushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":149,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"The Hawaiian Wedding Song","artist":"Andy Williams","album":"Best Of Andy Williams","uri":"NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3","trackType":"mp3"} Jul 19 14:17:12 volumiob3 volumio[944]: verbose: CURRENT POSITION 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState stateService play Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:17:12 volumiob3 volumio[944]: info: Received an update from plugin. extracting info from payload Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::servicePushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":149,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"The Hawaiian Wedding Song","artist":"Andy Williams","album":"Best Of Andy Williams","uri":"NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3","trackType":"mp3"} Jul 19 14:17:12 volumiob3 volumio[944]: verbose: CURRENT POSITION 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState stateService play Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:17:12 volumiob3 volumio[944]: info: Received an update from plugin. extracting info from payload Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: ControllerMpd::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::servicePushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":149,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"The Hawaiian Wedding Song","artist":"Andy Williams","album":"Best Of Andy Williams","uri":"NAS/OsMeusCDs/AndyWilliams/01 The Hawaiian Wedding Song.mp3","trackType":"mp3"} Jul 19 14:17:12 volumiob3 volumio[944]: verbose: CURRENT POSITION 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState stateService play Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:17:12 volumiob3 volumio[944]: info: Received an update from plugin. extracting info from payload Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreStateMachine::pushState Jul 19 14:17:12 volumiob3 volumio[944]: info: CorePlayQueue::getTrack 0 Jul 19 14:17:12 volumiob3 volumio[944]: info: CoreCommandRouter::volumioPushState Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 448ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 436ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 436ms Jul 19 14:17:12 volumiob3 volumio[944]: info: ------------------------------ 435ms Jul 19 14:17:12 volumiob3 volumio[944]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 19 14:17:18 volumiob3 lircd[1322]: lircd-0.10.1[1322]: Info: removed client Jul 19 14:17:18 volumiob3 lircd-0.10.1[1322]: Info: removed client Jul 19 14:17:18 volumiob3 volumio[944]: info: [IrActivityLed] releasing built-in LED Jul 19 14:17:18 volumiob3 volumio[944]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 14:17:18 volumiob3 volumio[944]: TypeError: Cannot read property 'toString' of undefined Jul 19 14:17:18 volumiob3 volumio[944]: at IrActivityLedController.releaseLed (/data/plugins/system_hardware/iractivityled/index.js:232:61) Jul 19 14:17:18 volumiob3 volumio[944]: at IrActivityLedController.onStop (/data/plugins/system_hardware/iractivityled/index.js:68:17) Jul 19 14:17:18 volumiob3 volumio[944]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jul 19 14:17:18 volumiob3 volumio[944]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Jul 19 14:17:18 volumiob3 volumio[944]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1537:29) Jul 19 14:17:18 volumiob3 volumio[944]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1383:47) Jul 19 14:17:18 volumiob3 volumio[944]: at Socket.emit (events.js:315:20) Jul 19 14:17:18 volumiob3 volumio[944]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 19 14:17:18 volumiob3 volumio[944]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 19 14:17:18 volumiob3 volumio[944]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 14:17:19 volumiob3 sudo[1895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-19 14:16 Jul 19 14:17:19 volumiob3 sudo[1895]: 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="905ee02fb5387537cfa16b84ebd7f14b7640848e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 18 Jul 2024 07:14:40 PM CEST" VOLUMIO_VERSION="3.741" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a68099d1a5f4301106a28f85f8548ae3"