-- Logs begin at Thu 2019-02-14 15:41:59 IST, end at Tue 2024-11-26 21:34:10 IST. -- Nov 26 21:33:02 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 21:33:02 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 21:33:02 my-dac volumio[1039]: info: Discovery: Getting this device information Nov 26 21:33:02 my-dac volumio[1039]: info: CoreCommandRouter::volumioGetState Nov 26 21:33:02 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 21:33:03 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 21:33:03 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 21:33:03 my-dac volumio[1039]: info: Discovery: Getting this device information Nov 26 21:33:03 my-dac volumio[1039]: info: CoreCommandRouter::volumioGetState Nov 26 21:33:03 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 21:33:08 my-dac volumiologrotate[666]: ls: cannot access '/var/log/samba/log.wb-MY': No such file or directory Nov 26 21:33:08 my-dac volumiologrotate[666]: ls: cannot access 'DAC': No such file or directory Nov 26 21:33:21 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 21:33:21 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 21:33:21 my-dac volumio[1039]: info: Discovery: Getting this device information Nov 26 21:33:21 my-dac volumio[1039]: info: CoreCommandRouter::volumioGetState Nov 26 21:33:21 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 21:33:33 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 21:33:33 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 21:33:33 my-dac volumio[1039]: info: Discovery: Getting this device information Nov 26 21:33:33 my-dac volumio[1039]: info: CoreCommandRouter::volumioGetState Nov 26 21:33:33 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=debug msg="handling resume player command from aa5cf697dc648290abd4f698e640f46176f8833e" Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=trace msg="seek to 41296ms (diff: 196ms, samples: 1821153, bytes: 1826643)" uri="spotify:track:7a53HqqArd4b9NF4XAmlbI" Nov 26 21:33:42 my-dac kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 5102 us, period size = 225 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 98 frames" Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=debug msg="resume track at 41067ms" Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=trace msg="scheduling prefetch in 91s" Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=debug msg="sending successful reply for dealer request" Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 26 21:33:42 my-dac go-librespot[1322]: time="2024-11-26T21:33:42+05:30" level=trace msg="emitting websocket event: playing" Nov 26 21:33:42 my-dac volumio[1039]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7a53HqqArd4b9NF4XAmlbI","play_origin":"playlist"}} Nov 26 21:33:42 my-dac volumio[1039]: SPOTIFY: PUSH STATE SPOTIFY Nov 26 21:33:42 my-dac volumio[1039]: SPOTIFY: {"status":"play","service":"spop","title":"Kings & Queens","artist":"Ava Max","album":"Heaven & Hell","albumart":"https://i.scdn.co/image/ab67616d00001e029a95e89d24214b94de36ccf7","uri":"spotify:track:7a53HqqArd4b9NF4XAmlbI","trackType":"spotify","seek":42035,"duration":162,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Nov 26 21:33:42 my-dac volumio[1039]: info: CoreCommandRouter::servicePushState Nov 26 21:33:42 my-dac volumio[1039]: info: CoreStateMachine::pushState Nov 26 21:33:42 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 21:33:42 my-dac volumio[1039]: info: CoreCommandRouter::volumioPushState Nov 26 21:33:42 my-dac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Nov 26 21:33:42 my-dac volumio[1039]: SPOTIFY: PUSH STATE SPOTIFY Nov 26 21:33:42 my-dac volumio[1039]: SPOTIFY: {"status":"play","service":"spop","title":"Kings & Queens","artist":"Ava Max","album":"Heaven & Hell","albumart":"https://i.scdn.co/image/ab67616d00001e029a95e89d24214b94de36ccf7","uri":"spotify:track:7a53HqqArd4b9NF4XAmlbI","trackType":"spotify","seek":42035,"duration":162,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Nov 26 21:33:42 my-dac volumio[1039]: info: CoreCommandRouter::servicePushState Nov 26 21:33:42 my-dac volumio[1039]: info: CoreStateMachine::pushState Nov 26 21:33:42 my-dac volumio[1039]: info: CoreCommandRouter::volumioPushState Nov 26 21:33:42 my-dac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Nov 26 21:33:50 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 21:33:50 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 21:33:50 my-dac volumio[1039]: info: Discovery: Getting this device information Nov 26 21:33:50 my-dac volumio[1039]: info: CoreCommandRouter::volumioGetState Nov 26 21:33:50 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 21:34:03 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 21:34:03 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 21:34:03 my-dac volumio[1039]: info: Discovery: Getting this device information Nov 26 21:34:03 my-dac volumio[1039]: info: CoreCommandRouter::volumioGetState Nov 26 21:34:03 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 21:34:08 my-dac go-librespot[1322]: time="2024-11-26T21:34:08+05:30" level=debug msg="update volume to 21627/65535" Nov 26 21:34:08 my-dac go-librespot[1322]: time="2024-11-26T21:34:08+05:30" level=debug msg="put connect state because VOLUME_CHANGED" Nov 26 21:34:08 my-dac go-librespot[1322]: time="2024-11-26T21:34:08+05:30" level=trace msg="emitting websocket event: volume" Nov 26 21:34:08 my-dac volumio[1039]: SPOTIFY: received: {"type":"volume","data":{"value":34,"max":100}} Nov 26 21:34:08 my-dac volumio[1039]: SPOTIFY: RECEIVED SPOTIFY VOLUME 34 Nov 26 21:34:08 my-dac volumio[1039]: info: Setting Volumio Volume from Spotify: 34 Nov 26 21:34:08 my-dac volumio[1039]: info: VolumeController::SetAlsaVolume34 Nov 26 21:34:08 my-dac volumio[1039]: info: CoreCommandRouter::volumioGetState Nov 26 21:34:08 my-dac volumio[1039]: info: CoreStateMachine::pushState Nov 26 21:34:08 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 21:34:08 my-dac volumio[1039]: info: CoreCommandRouter::volumioPushState Nov 26 21:34:09 my-dac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Nov 26 21:34:09 my-dac volumiologrotate[666]: ls: cannot access '/var/log/samba/log.wb-MY': No such file or directory Nov 26 21:34:09 my-dac volumiologrotate[666]: ls: cannot access 'DAC': No such file or directory Nov 26 21:34:09 my-dac go-librespot[1322]: time="2024-11-26T21:34:09+05:30" level=debug msg="update volume to 13107/65535" Nov 26 21:34:09 my-dac go-librespot[1322]: time="2024-11-26T21:34:09+05:30" level=debug msg="put connect state because VOLUME_CHANGED" Nov 26 21:34:09 my-dac go-librespot[1322]: time="2024-11-26T21:34:09+05:30" level=trace msg="emitting websocket event: volume" Nov 26 21:34:09 my-dac volumio[1039]: SPOTIFY: received: {"type":"volume","data":{"value":20,"max":100}} Nov 26 21:34:09 my-dac volumio[1039]: SPOTIFY: RECEIVED SPOTIFY VOLUME 20 Nov 26 21:34:09 my-dac volumio[1039]: info: Setting Volumio Volume from Spotify: 20 Nov 26 21:34:09 my-dac volumio[1039]: info: VolumeController::SetAlsaVolume20 Nov 26 21:34:09 my-dac volumio[1039]: info: CoreCommandRouter::volumioGetState Nov 26 21:34:09 my-dac volumio[1039]: info: CoreStateMachine::pushState Nov 26 21:34:09 my-dac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 21:34:09 my-dac volumio[1039]: info: CoreCommandRouter::volumioPushState Nov 26 21:34:09 my-dac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 Nov 26 21:34:10 my-dac volumio[1039]: info: [1732637050015] [80s80s] Pushing the next song state Michael Jackson - 2000 Watts and getting next track. Nov 26 21:34:10 my-dac volumio[1039]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 21:34:10 my-dac volumio[1039]: TypeError: Cannot set property 'name' of undefined Nov 26 21:34:10 my-dac volumio[1039]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Nov 26 21:34:10 my-dac volumio[1039]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Nov 26 21:34:10 my-dac volumio[1039]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Nov 26 21:34:10 my-dac volumio[1039]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Nov 26 21:34:10 my-dac volumio[1039]: at processImmediate (internal/timers.js:461:21) Nov 26 21:34:10 my-dac volumio[1039]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 21:34:10 my-dac go-librespot[1322]: time="2024-11-26T21:34:10+05:30" level=debug msg="update volume to 22282/65535" Nov 26 21:34:10 my-dac go-librespot[1322]: time="2024-11-26T21:34:10+05:30" level=debug msg="put connect state because VOLUME_CHANGED" Nov 26 21:34:10 my-dac go-librespot[1322]: time="2024-11-26T21:34:10+05:30" level=trace msg="emitting websocket event: volume" Nov 26 21:34:10 my-dac sudo[2549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 21:33 Nov 26 21:34:10 my-dac sudo[2549]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"