-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2024-11-24 13:32:39 CET. --
Nov 24 13:31:11 volumio go-librespot[9825]: time="2024-11-24T13:31:11+01:00" level=debug msg="fetched chunk 5/16, size: 524288" uri="spotify:track:7pUaac45jIJLZIgxYJDZzl"
Nov 24 13:31:14 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 24 13:31:14 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 24 13:31:14 volumio volumio[8563]: info: Discovery: Getting this device information
Nov 24 13:31:14 volumio volumio[8563]: info: CoreCommandRouter::volumioGetState
Nov 24 13:31:14 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:31:14 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 24 13:31:22 volumio go-librespot[9825]: time="2024-11-24T13:31:22+01:00" level=debug msg="fetched chunk 6/16, size: 524288" uri="spotify:track:7pUaac45jIJLZIgxYJDZzl"
Nov 24 13:31:35 volumio go-librespot[9825]: time="2024-11-24T13:31:35+01:00" level=debug msg="fetched chunk 7/16, size: 524288" uri="spotify:track:7pUaac45jIJLZIgxYJDZzl"
Nov 24 13:31:44 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 24 13:31:44 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 24 13:31:44 volumio volumio[8563]: info: Discovery: Getting this device information
Nov 24 13:31:44 volumio volumio[8563]: info: CoreCommandRouter::volumioGetState
Nov 24 13:31:44 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:31:44 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 24 13:31:47 volumio go-librespot[9825]: time="2024-11-24T13:31:47+01:00" level=debug msg="fetched chunk 8/16, size: 524288" uri="spotify:track:7pUaac45jIJLZIgxYJDZzl"
Nov 24 13:31:59 volumio go-librespot[9825]: time="2024-11-24T13:31:59+01:00" level=debug msg="fetched chunk 9/16, size: 524288" uri="spotify:track:7pUaac45jIJLZIgxYJDZzl"
Nov 24 13:32:12 volumio go-librespot[9825]: time="2024-11-24T13:32:12+01:00" level=debug msg="fetched chunk 10/16, size: 524288" uri="spotify:track:7pUaac45jIJLZIgxYJDZzl"
Nov 24 13:32:14 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 24 13:32:14 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 24 13:32:14 volumio volumio[8563]: info: Discovery: Getting this device information
Nov 24 13:32:14 volumio volumio[8563]: info: CoreCommandRouter::volumioGetState
Nov 24 13:32:14 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:14 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::volumioPause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::stPlaybackTimer
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::servicePause
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::servicePause
Nov 24 13:32:16 volumio volumio[8563]: info: Spotify Received pause
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: SPOTIFY PAUSE
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: {"status":"play","position":6,"title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d0000b2731fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","codec":"ogg","seek":0,"duration":205,"samplerate":"320 kbps","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":84,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"}
Nov 24 13:32:16 volumio volumio[8563]: info: Sending Spotify command to local API: /player/pause
Nov 24 13:32:16 volumio go-librespot[9825]: time="2024-11-24T13:32:16+01:00" level=debug msg="pause track at 90743ms"
Nov 24 13:32:16 volumio go-librespot[9825]: time="2024-11-24T13:32:16+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Nov 24 13:32:16 volumio go-librespot[9825]: time="2024-11-24T13:32:16+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Nov 24 13:32:16 volumio go-librespot[9825]: time="2024-11-24T13:32:16+01:00" level=trace msg="emitting websocket event: paused"
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","play_origin":"go-librespot"}}
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: PUSH STATE SPOTIFY
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: {"status":"pause","service":"spop","title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d00001e021fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","seek":89000,"duration":205,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::servicePushState
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d00001e021fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","seek":89000,"duration":205,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Nov 24 13:32:16 volumio volumio[8563]: verbose: CURRENT POSITION 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::syncState stateService pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::syncState currentStatus pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::pushState
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::volumioPushState
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::stPlaybackTimer
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","play_origin":"go-librespot"}}
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: PUSH STATE SPOTIFY
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: {"status":"pause","service":"spop","title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d00001e021fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","seek":89000,"duration":205,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::servicePushState
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d00001e021fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","seek":89000,"duration":205,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Nov 24 13:32:16 volumio volumio[8563]: verbose: CURRENT POSITION 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::syncState stateService pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::syncState currentStatus pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::pushState
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::volumioPushState
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::stPlaybackTimer
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","play_origin":"go-librespot"}}
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: PUSH STATE SPOTIFY
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: {"status":"pause","service":"spop","title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d00001e021fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","seek":89000,"duration":205,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::servicePushState
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d00001e021fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","seek":89000,"duration":205,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Nov 24 13:32:16 volumio volumio[8563]: verbose: CURRENT POSITION 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::syncState stateService pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::syncState currentStatus pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::pushState
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::volumioPushState
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::stPlaybackTimer
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","play_origin":"go-librespot"}}
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: PUSH STATE SPOTIFY
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: {"status":"pause","service":"spop","title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d00001e021fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","seek":89000,"duration":205,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::servicePushState
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"As I Can Breathe","artist":"ARKA'N ASRAFOKOR","album":"Zã Keli","albumart":"https://i.scdn.co/image/ab67616d00001e021fb0e6245f7718de0f870a0e","uri":"spotify:track:7pUaac45jIJLZIgxYJDZzl","trackType":"spotify","seek":89000,"duration":205,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Nov 24 13:32:16 volumio volumio[8563]: verbose: CURRENT POSITION 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::syncState stateService pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::syncState currentStatus pause
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::pushState
Nov 24 13:32:16 volumio volumio[8563]: info: CorePlayQueue::getTrack 6
Nov 24 13:32:16 volumio volumio[8563]: info: CoreCommandRouter::volumioPushState
Nov 24 13:32:16 volumio volumio[8563]: info: CoreStateMachine::stPlaybackTimer
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84
Nov 24 13:32:16 volumio volumio[8563]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84
Nov 24 13:32:16 volumio volumio[8563]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X'
Nov 24 13:32:35 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Nov 24 13:32:35 volumio volumio[8563]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Nov 24 13:32:39 volumio sudo[10748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Nov 24 13:32:39 volumio sudo[10748]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 24 13:32:39 volumio sudo[10748]: pam_unix(sudo:session): session closed for user root
Nov 24 13:32:39 volumio sudo[10751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service
Nov 24 13:32:39 volumio sudo[10751]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 24 13:32:39 volumio systemd[1]: Created slice system-getty.slice.
Nov 24 13:32:39 volumio sudo[10754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service
Nov 24 13:32:39 volumio sudo[10754]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 24 13:32:39 volumio systemd[1]: Started Getty on tty1.
Nov 24 13:32:39 volumio volumio[8563]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set.
Nov 24 13:32:39 volumio volumio[8563]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 24 13:32:39 volumio volumio[8563]: TypeError: Cannot read property 'split' of undefined
Nov 24 13:32:39 volumio volumio[8563]: at /data/plugins/user_interface/touch_display/index.js:1258:37
Nov 24 13:32:39 volumio volumio[8563]: at ChildProcess.exithandler (child_process.js:299:7)
Nov 24 13:32:39 volumio volumio[8563]: at ChildProcess.emit (events.js:315:20)
Nov 24 13:32:39 volumio volumio[8563]: at maybeClose (internal/child_process.js:1048:16)
Nov 24 13:32:39 volumio volumio[8563]: at Socket. (internal/child_process.js:439:11)
Nov 24 13:32:39 volumio volumio[8563]: at Socket.emit (events.js:315:20)
Nov 24 13:32:39 volumio volumio[8563]: at Pipe. (net.js:673:12)
Nov 24 13:32:39 volumio volumio[8563]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 24 13:32:39 volumio sudo[10758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service
Nov 24 13:32:39 volumio sudo[10758]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 24 13:32:39 volumio sudo[10751]: pam_unix(sudo:session): session closed for user root
Nov 24 13:32:39 volumio systemd[1]: Reloading.
Nov 24 13:32:39 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Nov 24 13:32:39 volumio sudo[10783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-24 13:31
Nov 24 13:32:39 volumio sudo[10783]: 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"