-- Logs begin at Tue 2024-08-20 09:20:35 CEST, end at Tue 2024-08-20 09:47:26 CEST. --
Aug 20 09:46:11 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 20 09:46:15 starostwovolumio volumio[920]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/amd64
Aug 20 09:46:18 starostwovolumio volumio[920]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/amd64
Aug 20 09:46:18 starostwovolumio volumio[920]: info: Folder /tmp/plugins removed
Aug 20 09:46:19 starostwovolumio volumio[920]: info: Check plugin dependencies
Aug 20 09:46:19 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 20 09:46:19 starostwovolumio volumio[920]: info: Checking if plugin already exists
Aug 20 09:46:19 starostwovolumio volumio[920]: info: Rename folder
Aug 20 09:46:19 starostwovolumio volumio[920]: info: Folder /tmp/downloaded_plugin.zip removed
Aug 20 09:46:19 starostwovolumio volumio[920]: info: Move to category
Aug 20 09:46:26 starostwovolumio volumio-remote-updater[644]: [2024-08-20 09:46:26] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
Aug 20 09:46:29 starostwovolumio ntpd[900]: 178.215.228.24 local addr 192.168.1.26 ->
Aug 20 09:46:31 starostwovolumio volumio-remote-updater[644]: [2024-08-20 09:46:31] [connect] Successful connection
Aug 20 09:46:43 starostwovolumio ntpd[900]: 91.212.242.20 local addr 192.168.1.26 ->
Aug 20 09:46:43 starostwovolumio volumio-remote-updater[644]: [2024-08-20 09:46:43] [connect] Successful connection
Aug 20 09:46:58 starostwovolumio volumio-remote-updater[644]: [2024-08-20 09:46:58] [connect] Successful connection
Aug 20 09:47:02 starostwovolumio volumio[920]: info: Checking if install.sh is present
Aug 20 09:47:02 starostwovolumio volumio[920]: info: Executing install.sh
Aug 20 09:47:02 starostwovolumio volumio[920]: info:
Aug 20 09:47:02 starostwovolumio volumio[920]: ---------------------------- MPD announces state update: player
Aug 20 09:47:02 starostwovolumio volumio[920]: info: ControllerMpd::getState
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand status
Aug 20 09:47:02 starostwovolumio volumio[920]: info: sendMpdCommand status took 22 milliseconds
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: ControllerMpd::parseState
Aug 20 09:47:02 starostwovolumio volumio[920]: info: ControllerMpd::pushState
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreCommandRouter::servicePushState
Aug 20 09:47:02 starostwovolumio sudo[2859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/now_playing/install.sh
Aug 20 09:47:02 starostwovolumio sudo[2859]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreStateMachine::pushState
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioPushState
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CorePlayQueue::getTrack 0
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: CURRENT POSITION 0
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreStateMachine::syncState stateService stop
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreStateMachine::syncState currentStatus play
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreStateMachine::play index undefined
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreStateMachine::pushState
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CorePlayQueue::getTrack 1
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioPushState
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CorePlayQueue::getTrack 1
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreStateMachine::startPlaybackTimer
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CorePlayQueue::getTrack 1
Aug 20 09:47:02 starostwovolumio volumio[920]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Seven%20Nation%20Army%22%2C%22artist%22%3A%22The%20White%20Stripes%22%2C%22album%22%3A%22Elephant%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FtntNX15loRQ3Bqmw4MJunOy_lC43qU2Dqu3eBGWBSbQodGgzIDbnNDLtHCYpsKggh592RmaHnDdSacEe%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22D_QLxj8jCF0%22%2C%22playlistId%22%3A%22RDCLAK5uy_mP3cXpsPxDWkZAGQWsJzRel1LJMiVtG2k%22%2C%22params%22%3A%22OAHyAQQIARgDkgQjUVBBOF9TMGM5VjRDT0RkbW50TG90ZDZXVWVEY05IaDZlYU8%253D%22%2C%22index%22%3A1%2C%22playlistSetVideoId%22%3A%22289F4A46DF0A30D2%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_mP3cXpsPxDWkZAGQWsJzRel1LJMiVtG2k%22%2C%22params%22%3A%22OAHyAQQIARgDkgQjUVBBOF9TMGM5VjRDT0RkbW50TG90ZDZXVWVEY05IaDZlYU8%253D%22%2C%22videoId%22%3A%22Et51PwPWFX0%22%7D%7D%7D%7D
Aug 20 09:47:02 starostwovolumio volumio[920]: info: ------------------------------ 57ms
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreStateMachine::pushState
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CorePlayQueue::getTrack 1
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 20 09:47:02 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioPushState
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: New Socket.io Connection to 192.168.1.26 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: New Socket.io Connection to 192.168.1.26 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: New Socket.io Connection to 192.168.1.26 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Aug 20 09:47:02 starostwovolumio volumio-remote-updater[644]: [2024-08-20 09:47:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724140018 101
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4
Aug 20 09:47:02 starostwovolumio volumio[920]: verbose: New Socket.io Connection to 192.168.1.26 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Aug 20 09:47:03 starostwovolumio volumio[920]: info: [ytmusic] Preferred format is Opus
Aug 20 09:47:03 starostwovolumio volumio[920]: info: CorePlayQueue::getTrack 1
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand stop
Aug 20 09:47:03 starostwovolumio volumio[920]: info: sendMpdCommand stop took 19 milliseconds
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand clear
Aug 20 09:47:03 starostwovolumio volumio[920]: info:
Aug 20 09:47:03 starostwovolumio volumio[920]: ---------------------------- MPD announces system playlist update
Aug 20 09:47:03 starostwovolumio volumio[920]: info: Ignoring MPD Status Update
Aug 20 09:47:03 starostwovolumio volumio[920]: info: sendMpdCommand clear took 4 milliseconds
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-x2pm-f5fs.googlevideo.com/videoplayback?expire=1724161622&ei=9knEZobEOfu16dsP2s-iuA4&ip=88.220.63.6&id=o-ALYNNrydZJGstgnEN2uLxTQfYYzw8mga7EHYzqxek9VK&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=m3&mm=31%2C29&mn=sn-x2pm-f5fs%2Csn-f5f7kn7z&ms=au%2Crdu&mv=m&mvi=3&pl=23&ctier=A&pfa=5&gcr=pl&initcwndbps=2560000&hightc=yes&siu=1&bui=AQmm2exuuNUMmf1cRIrBaTZWTRvadTZWaIZz-6lTveQMQu8yaDKG5q1JZQwaOY-fVuhY9caK0g&spc=Mv1m9uE-Cc6RjGdFF0kpqJCEgW4DqTmY6lWC6735X-cL8rVR_wQKmGKDKagV5-k&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=XMZVyM0aFmbwEc-AuC1xwyQQ&rqh=1&gir=yes&clen=7173665&dur=232.121&lmt=1714543260634142&mt=1724139680&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=XORGu2LRzDazOg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgbzSOfJX9gBzXhSH7uY5TKfekwKiskS1NsNzwnskTkmECIQDSVXyIkZ4lFhAh4xj4CwzLaf61oujjDCfyUXWuSDupAw%3D%3D&sig=AJfQdSswRgIhAMYjatAACzM0VegiSh0zUprimEhU5QpI-8Cs0-Z5RFXoAiEA8DsmsE-2RcOPquCaNKNs25hZftNhJLtazfpj7Y80UCI%3D&cver=1.20211213.00.00&t.YouTube"
Aug 20 09:47:03 starostwovolumio volumio[920]: error: updateQueue error: null
Aug 20 09:47:03 starostwovolumio volumio[920]: info:
Aug 20 09:47:03 starostwovolumio volumio[920]: ---------------------------- MPD announces system playlist update
Aug 20 09:47:03 starostwovolumio volumio[920]: info: Ignoring MPD Status Update
Aug 20 09:47:03 starostwovolumio volumio[920]: info: ------------------------------ 9ms
Aug 20 09:47:03 starostwovolumio volumio[920]: info: sendMpdCommand addid "https://rr3---sn-x2pm-f5fs.googlevideo.com/videoplayback?expire=1724161622&ei=9knEZobEOfu16dsP2s-iuA4&ip=88.220.63.6&id=o-ALYNNrydZJGstgnEN2uLxTQfYYzw8mga7EHYzqxek9VK&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=m3&mm=31%2C29&mn=sn-x2pm-f5fs%2Csn-f5f7kn7z&ms=au%2Crdu&mv=m&mvi=3&pl=23&ctier=A&pfa=5&gcr=pl&initcwndbps=2560000&hightc=yes&siu=1&bui=AQmm2exuuNUMmf1cRIrBaTZWTRvadTZWaIZz-6lTveQMQu8yaDKG5q1JZQwaOY-fVuhY9caK0g&spc=Mv1m9uE-Cc6RjGdFF0kpqJCEgW4DqTmY6lWC6735X-cL8rVR_wQKmGKDKagV5-k&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=XMZVyM0aFmbwEc-AuC1xwyQQ&rqh=1&gir=yes&clen=7173665&dur=232.121&lmt=1714543260634142&mt=1724139680&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=XORGu2LRzDazOg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgbzSOfJX9gBzXhSH7uY5TKfekwKiskS1NsNzwnskTkmECIQDSVXyIkZ4lFhAh4xj4CwzLaf61oujjDCfyUXWuSDupAw%3D%3D&sig=AJfQdSswRgIhAMYjatAACzM0VegiSh0zUprimEhU5QpI-8Cs0-Z5RFXoAiEA8DsmsE-2RcOPquCaNKNs25hZftNhJLtazfpj7Y80UCI%3D&cver=1.20211213.00.00&t.YouTube" took 7 milliseconds
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: MPD COMMAND [object Object]
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: MPD COMMAND [object Object]
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: MPD COMMAND [object Object]
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Aug 20 09:47:03 starostwovolumio volumio[920]: info:
Aug 20 09:47:03 starostwovolumio volumio[920]: ---------------------------- MPD announces system playlist update
Aug 20 09:47:03 starostwovolumio volumio[920]: info: Ignoring MPD Status Update
Aug 20 09:47:03 starostwovolumio volumio[920]: info: ------------------------------ 15ms
Aug 20 09:47:03 starostwovolumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService mpd
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand play
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Aug 20 09:47:03 starostwovolumio volumio[920]: info: ------------------------------ 47ms
Aug 20 09:47:03 starostwovolumio volumio[920]: info: sendMpdCommand play took 46 milliseconds
Aug 20 09:47:03 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetState
Aug 20 09:47:03 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetState
Aug 20 09:47:03 starostwovolumio volumio[920]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Aug 20 09:47:04 starostwovolumio volumio[920]: info:
Aug 20 09:47:04 starostwovolumio volumio[920]: ---------------------------- MPD announces state update: player
Aug 20 09:47:04 starostwovolumio volumio[920]: info: ControllerMpd::getState
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand status
Aug 20 09:47:04 starostwovolumio volumio[920]: info:
Aug 20 09:47:04 starostwovolumio volumio[920]: ---------------------------- MPD announces state update: player
Aug 20 09:47:04 starostwovolumio volumio[920]: info: sendMpdCommand status took 13 milliseconds
Aug 20 09:47:04 starostwovolumio volumio[920]: info: ControllerMpd::getState
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand status
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: ControllerMpd::parseState
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 20 09:47:04 starostwovolumio volumio[920]: info: sendMpdCommand status took 7 milliseconds
Aug 20 09:47:04 starostwovolumio volumio[920]: info: sendMpdCommand playlistinfo took 7 milliseconds
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: ControllerMpd::parseState
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: ControllerMpd::parseTrackInfo
Aug 20 09:47:04 starostwovolumio volumio[920]: info: ControllerMpd::pushState
Aug 20 09:47:04 starostwovolumio volumio[920]: info: CoreCommandRouter::servicePushState
Aug 20 09:47:04 starostwovolumio volumio[920]: info: CorePlayQueue::getTrack 1
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seven Nation Army","artist":"The White Stripes","album":"Elephant","uri":"https://rr3---sn-x2pm-f5fs.googlevideo.com/videoplayback?expire=1724161622&ei=9knEZobEOfu16dsP2s-iuA4&ip=88.220.63.6&id=o-ALYNNrydZJGstgnEN2uLxTQfYYzw8mga7EHYzqxek9VK&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=m3&mm=31%2C29&mn=sn-x2pm-f5fs%2Csn-f5f7kn7z&ms=au%2Crdu&mv=m&mvi=3&pl=23&ctier=A&pfa=5&gcr=pl&initcwndbps=2560000&hightc=yes&siu=1&bui=AQmm2exuuNUMmf1cRIrBaTZWTRvadTZWaIZz-6lTveQMQu8yaDKG5q1JZQwaOY-fVuhY9caK0g&spc=Mv1m9uE-Cc6RjGdFF0kpqJCEgW4DqTmY6lWC6735X-cL8rVR_wQKmGKDKagV5-k&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=XMZVyM0aFmbwEc-AuC1xwyQQ&rqh=1&gir=yes&clen=7173665&dur=232.121&lmt=1714543260634142&mt=1724139680&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=XORGu2LRzDazOg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgbzSOfJX9gBzXhSH7uY5TKfekwKiskS1NsNzwnskTkmECIQDSVXyIkZ4lFhAh4xj4CwzLaf61oujjDCfyUXWuSDupAw%3D%3D&sig=AJfQdSswRgIhAMYjatAACzM0VegiSh0zUprimEhU5QpI-8Cs0-Z5RFXoAiEA8DsmsE-2RcOPquCaNKNs25hZftNhJLtazfpj7Y80UCI%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: CURRENT POSITION 1
Aug 20 09:47:04 starostwovolumio volumio[920]: info: CoreStateMachine::syncState stateService play
Aug 20 09:47:04 starostwovolumio volumio[920]: info: CoreStateMachine::syncState currentStatus stop
Aug 20 09:47:04 starostwovolumio volumio[920]: info: ------------------------------ 40ms
Aug 20 09:47:04 starostwovolumio volumio[920]: info: sendMpdCommand playlistinfo took 16 milliseconds
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: ControllerMpd::parseTrackInfo
Aug 20 09:47:04 starostwovolumio volumio[920]: info: ControllerMpd::pushState
Aug 20 09:47:04 starostwovolumio volumio[920]: info: CoreCommandRouter::servicePushState
Aug 20 09:47:04 starostwovolumio volumio[920]: info: CorePlayQueue::getTrack 1
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seven Nation Army","artist":"The White Stripes","album":"Elephant","uri":"https://rr3---sn-x2pm-f5fs.googlevideo.com/videoplayback?expire=1724161622&ei=9knEZobEOfu16dsP2s-iuA4&ip=88.220.63.6&id=o-ALYNNrydZJGstgnEN2uLxTQfYYzw8mga7EHYzqxek9VK&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=m3&mm=31%2C29&mn=sn-x2pm-f5fs%2Csn-f5f7kn7z&ms=au%2Crdu&mv=m&mvi=3&pl=23&ctier=A&pfa=5&gcr=pl&initcwndbps=2560000&hightc=yes&siu=1&bui=AQmm2exuuNUMmf1cRIrBaTZWTRvadTZWaIZz-6lTveQMQu8yaDKG5q1JZQwaOY-fVuhY9caK0g&spc=Mv1m9uE-Cc6RjGdFF0kpqJCEgW4DqTmY6lWC6735X-cL8rVR_wQKmGKDKagV5-k&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=XMZVyM0aFmbwEc-AuC1xwyQQ&rqh=1&gir=yes&clen=7173665&dur=232.121&lmt=1714543260634142&mt=1724139680&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=XORGu2LRzDazOg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgbzSOfJX9gBzXhSH7uY5TKfekwKiskS1NsNzwnskTkmECIQDSVXyIkZ4lFhAh4xj4CwzLaf61oujjDCfyUXWuSDupAw%3D%3D&sig=AJfQdSswRgIhAMYjatAACzM0VegiSh0zUprimEhU5QpI-8Cs0-Z5RFXoAiEA8DsmsE-2RcOPquCaNKNs25hZftNhJLtazfpj7Y80UCI%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
Aug 20 09:47:04 starostwovolumio volumio[920]: verbose: CURRENT POSITION 1
Aug 20 09:47:04 starostwovolumio volumio[920]: info: CoreStateMachine::syncState stateService play
Aug 20 09:47:05 starostwovolumio volumio[920]: info: CoreStateMachine::syncState currentStatus play
Aug 20 09:47:05 starostwovolumio volumio[920]: info: Received an update from plugin. extracting info from payload
Aug 20 09:47:05 starostwovolumio volumio[920]: info: CoreStateMachine::pushState
Aug 20 09:47:05 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 20 09:47:05 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioPushState
Aug 20 09:47:05 starostwovolumio volumio[920]: info: CoreStateMachine::pushState
Aug 20 09:47:05 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioPushState
Aug 20 09:47:05 starostwovolumio volumio[920]: info: ------------------------------ 88ms
Aug 20 09:47:06 starostwovolumio volumio[920]: verbose: New Socket.io Connection to 192.168.1.26 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetState
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreStateMachine::getQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CorePlayQueue::getQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: Listing playlists
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 20 09:47:06 starostwovolumio volumio[920]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetState
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreStateMachine::getQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CorePlayQueue::getQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: Listing playlists
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 20 09:47:06 starostwovolumio volumio[920]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetState
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreStateMachine::getQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CorePlayQueue::getQueue
Aug 20 09:47:06 starostwovolumio volumio[920]: info: Listing playlists
Aug 20 09:47:06 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 20 09:47:06 starostwovolumio volumio[920]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Aug 20 09:47:18 starostwovolumio sudo[2888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 20 09:47:18 starostwovolumio sudo[2888]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 20 09:47:18 starostwovolumio sudo[2888]: pam_unix(sudo:session): session closed for user root
Aug 20 09:47:18 starostwovolumio sudo[2890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 20 09:47:18 starostwovolumio sudo[2890]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 20 09:47:18 starostwovolumio sudo[2890]: pam_unix(sudo:session): session closed for user root
Aug 20 09:47:18 starostwovolumio volumio[920]: verbose: New Socket.io Connection to 192.168.1.26 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Aug 20 09:47:18 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 20 09:47:18 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetState
Aug 20 09:47:18 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 20 09:47:18 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 20 09:47:18 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 20 09:47:18 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 20 09:47:18 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 20 09:47:20 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 20 09:47:20 starostwovolumio volumio[920]: info: Received Get System Info
Aug 20 09:47:20 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 20 09:47:20 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 20 09:47:20 starostwovolumio volumio[920]: info: Discovery: Getting this device information
Aug 20 09:47:20 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetState
Aug 20 09:47:20 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 20 09:47:21 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 20 09:47:21 starostwovolumio volumio[920]: info: Received Get System Info
Aug 20 09:47:21 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 20 09:47:21 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 20 09:47:21 starostwovolumio volumio[920]: info: Discovery: Getting this device information
Aug 20 09:47:21 starostwovolumio volumio[920]: info: CoreCommandRouter::volumioGetState
Aug 20 09:47:21 starostwovolumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 20 09:47:22 starostwovolumio volumio[920]: info: Enabling plugin now_playing
Aug 20 09:47:22 starostwovolumio volumio[920]: info: Loading plugin "now_playing"...
Aug 20 09:47:22 starostwovolumio volumio[920]: error: !!!! WARNING !!!!
Aug 20 09:47:22 starostwovolumio volumio[920]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz'
Aug 20 09:47:22 starostwovolumio volumio[920]: Require stack:
Aug 20 09:47:22 starostwovolumio volumio[920]: - /data/plugins/user_interface/now_playing/dist/index.js
Aug 20 09:47:22 starostwovolumio volumio[920]: - /volumio/app/pluginmanager.js
Aug 20 09:47:22 starostwovolumio volumio[920]: - /volumio/app/index.js
Aug 20 09:47:22 starostwovolumio volumio[920]: - /volumio/index.js
Aug 20 09:47:22 starostwovolumio volumio[920]: error: Stack trace: Error: Cannot find module 'geo-tz'
Aug 20 09:47:22 starostwovolumio volumio[920]: Require stack:
Aug 20 09:47:22 starostwovolumio volumio[920]: - /data/plugins/user_interface/now_playing/dist/index.js
Aug 20 09:47:22 starostwovolumio volumio[920]: - /volumio/app/pluginmanager.js
Aug 20 09:47:22 starostwovolumio volumio[920]: - /volumio/app/index.js
Aug 20 09:47:22 starostwovolumio volumio[920]: - /volumio/index.js
Aug 20 09:47:22 starostwovolumio volumio[920]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:931:15)
Aug 20 09:47:22 starostwovolumio volumio[920]: at Function.Module._load (internal/modules/cjs/loader.js:774:27)
Aug 20 09:47:22 starostwovolumio volumio[920]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Aug 20 09:47:22 starostwovolumio volumio[920]: at require (internal/modules/cjs/helpers.js:107:18)
Aug 20 09:47:22 starostwovolumio volumio[920]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34)
Aug 20 09:47:22 starostwovolumio volumio[920]: at Module._compile (internal/modules/cjs/loader.js:1114:14)
Aug 20 09:47:22 starostwovolumio volumio[920]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10)
Aug 20 09:47:22 starostwovolumio volumio[920]: at Module.load (internal/modules/cjs/loader.js:979:32)
Aug 20 09:47:22 starostwovolumio volumio[920]: at Function.Module._load (internal/modules/cjs/loader.js:819:12)
Aug 20 09:47:22 starostwovolumio volumio[920]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Aug 20 09:47:22 starostwovolumio volumio[920]: error: !!!! WARNING !!!!
Aug 20 09:47:22 starostwovolumio volumio[920]: info: Done.
Aug 20 09:47:25 starostwovolumio volumio[920]: info: + geo-tz@8.0.2
Aug 20 09:47:25 starostwovolumio volumio[920]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 20 09:47:25 starostwovolumio volumio[920]: TypeError: Cannot read property 'broadcastMessage' of null
Aug 20 09:47:25 starostwovolumio volumio[920]: at /volumio/app/index.js:1515:32
Aug 20 09:47:25 starostwovolumio volumio[920]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17)
Aug 20 09:47:25 starostwovolumio volumio[920]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12)
Aug 20 09:47:25 starostwovolumio volumio[920]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1513:13)
Aug 20 09:47:25 starostwovolumio volumio[920]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20)
Aug 20 09:47:25 starostwovolumio volumio[920]: at Tail. (/volumio/app/pluginmanager.js:860:24)
Aug 20 09:47:25 starostwovolumio volumio[920]: at Tail.emit (events.js:400:28)
Aug 20 09:47:25 starostwovolumio volumio[920]: at ReadStream. (/volumio/node_modules/tail/lib/tail.js:51:33)
Aug 20 09:47:25 starostwovolumio volumio[920]: at ReadStream.emit (events.js:400:28)
Aug 20 09:47:25 starostwovolumio volumio[920]: at addChunk (internal/streams/readable.js:293:12)
Aug 20 09:47:25 starostwovolumio volumio[920]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 20 09:47:26 starostwovolumio sudo[2905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-20 09:46
Aug 20 09:47:26 starostwovolumio sudo[2905]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST"
VOLUMIO_VERSION="3.742"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"