-- Logs begin at Thu 2019-02-14 12:11:59 EET, end at Wed 2024-05-01 22:21:05 EEST. --
May 01 22:20:00 volumio go-librespot[1242]: time="2024-05-01T22:20:00+03:00" level=debug msg="fetched chunk 14/22, size: 524288"
May 01 22:20:29 volumio go-librespot[1242]: time="2024-05-01T22:20:29+03:00" level=debug msg="fetched chunk 15/22, size: 524288"
May 01 22:20:58 volumio go-librespot[1242]: time="2024-05-01T22:20:58+03:00" level=debug msg="fetched chunk 16/22, size: 524288"
May 01 22:21:03 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:03 volumio volumio[883]: info: CorePlayQueue::getTrack 155
May 01 22:21:03 volumio volumio[883]: info: Spotify seek to: 0
May 01 22:21:03 volumio volumio[883]: info: Sending Spotify command with payload to local API: /player/seek
May 01 22:21:03 volumio go-librespot[1242]: time="2024-05-01T22:21:03+03:00" level=debug msg="seek track to 0ms"
May 01 22:21:03 volumio go-librespot[1242]: time="2024-05-01T22:21:03+03:00" level=trace msg="seek to 0ms (diff: -65ms, samples: 0, bytes: 2566)"
May 01 22:21:03 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:03 volumio volumio[883]: info: CorePlayQueue::getTrack 155
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::stop
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::stPlaybackTimer
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:03 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::pushState
May 01 22:21:03 volumio volumio[883]: info: CorePlayQueue::getTrack 155
May 01 22:21:03 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 22:21:03 volumio volumio[883]: info: CoreCommandRouter::volumioPushState
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::serviceStop
May 01 22:21:03 volumio volumio[883]: info: CorePlayQueue::getTrack 155
May 01 22:21:03 volumio volumio[883]: info: CoreCommandRouter::serviceStop
May 01 22:21:03 volumio volumio[883]: info: Spotify Stop
May 01 22:21:03 volumio volumio[883]: SPOTIFY: SPOTIFY STOP
May 01 22:21:03 volumio volumio[883]: SPOTIFY: {"status":"play","position":155,"title":"Sorrow - Live","artist":"Pink Floyd","album":"Pulse","albumart":"https://i.scdn.co/image/ab67616d0000b27369f4b7cda08f4ed73cc20474","uri":"spotify:track:6SxyNIVaeVROFI6WZhoi7A","trackType":"spotify","codec":"ogg","seek":0,"duration":649,"samplerate":"160 kbps","bitdepth":"16 bit","channels":2,"random":true,"repeat":false,"repeatSingle":false,"consume":false,"volume":"100","dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"}
May 01 22:21:03 volumio volumio[883]: info: Sending Spotify command to local API: /player/pause
May 01 22:21:03 volumio volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
May 01 22:21:03 volumio volumio[883]: SPOTIFY: SPOTIFY VOLUME 100
May 01 22:21:03 volumio volumio[883]: SPOTIFY: VOLUMIO VOLUME 100
May 01 22:21:03 volumio volumio[883]: SPOTIFY: DELTA VOLUME ENOUGH: false
May 01 22:21:03 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:03 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:03 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:03 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:03 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrackBlock
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::serviceClearAddPlay
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 01 22:21:04 volumio volumio[883]: error: WARNING: No clearAddPlayTracks method for service spop
May 01 22:21:04 volumio go-librespot[1242]: time="2024-05-01T22:21:04+03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 01 22:21:04 volumio go-librespot[1242]: time="2024-05-01T22:21:04+03:00" level=trace msg="emitting websocket event: seek"
May 01 22:21:04 volumio volumio[883]: SPOTIFY: received: {"type":"seek","data":{"uri":"spotify:track:6SxyNIVaeVROFI6WZhoi7A","position":0,"duration":649066,"play_origin":"go-librespot"}}
May 01 22:21:04 volumio volumio[883]: SPOTIFY: PUSH STATE SPOTIFY
May 01 22:21:04 volumio volumio[883]: SPOTIFY: {"status":"play","service":"spop","title":"Sorrow - Live","artist":"Pink Floyd","album":"Pulse","albumart":"https://i.scdn.co/image/ab67616d00001e0269f4b7cda08f4ed73cc20474","uri":"spotify:track:6SxyNIVaeVROFI6WZhoi7A","trackType":"spotify","seek":0,"duration":649,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::servicePushState
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrack 299
May 01 22:21:04 volumio volumio[883]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Sorrow - Live","artist":"Pink Floyd","album":"Pulse","albumart":"https://i.scdn.co/image/ab67616d00001e0269f4b7cda08f4ed73cc20474","uri":"spotify:track:6SxyNIVaeVROFI6WZhoi7A","trackType":"spotify","seek":0,"duration":649,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
May 01 22:21:04 volumio volumio[883]: verbose: CURRENT POSITION 299
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::syncState stateService play
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus stop
May 01 22:21:04 volumio volumio[883]: info: CoreCommandRouter::volumioPrevious
May 01 22:21:04 volumio volumio[883]: info: CoreStateMachine::previous
May 01 22:21:04 volumio volumio[883]: info: CorePlayQueue::getTrack 299
May 01 22:21:04 volumio volumio[883]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 01 22:21:04 volumio volumio[883]: TypeError: Cannot read property 'service' of undefined
May 01 22:21:04 volumio volumio[883]: at CoreStateMachine.previous (/volumio/app/statemachine.js:1315:97)
May 01 22:21:04 volumio volumio[883]: at CoreCommandRouter.volumioPrevious (/volumio/app/index.js:94:28)
May 01 22:21:04 volumio volumio[883]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:246:33)
May 01 22:21:04 volumio volumio[883]: at Socket.emit (events.js:400:28)
May 01 22:21:04 volumio volumio[883]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 01 22:21:04 volumio volumio[883]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
May 01 22:21:04 volumio volumio[883]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 01 22:21:04 volumio go-librespot[1242]: time="2024-05-01T22:21:04+03:00" level=debug msg="pause track at 646ms"
May 01 22:21:04 volumio go-librespot[1242]: time="2024-05-01T22:21:04+03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 01 22:21:04 volumio go-librespot[1242]: time="2024-05-01T22:21:04+03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 01 22:21:04 volumio go-librespot[1242]: time="2024-05-01T22:21:04+03:00" level=trace msg="emitting websocket event: paused"
May 01 22:21:05 volumio sudo[1580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 22:20
May 01 22:21:05 volumio sudo[1580]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="893d2e91c55a7857b58762e70c2f65b9d163562b"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 21 Oct 2023 01:32:22 PM CEST"
VOLUMIO_VERSION="3.569"
VOLUMIO_HARDWARE="orangepione"
VOLUMIO_DEVICENAME="Orange Pi One"
VOLUMIO_HASH="b0f15aed38b8bdda1847e50972efef63"