-- Logs begin at Thu 2024-03-28 15:35:24 UTC, end at Thu 2024-03-28 18:35:38 UTC. -- Mar 28 18:34:00 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:00 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:01 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:01 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:02 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:02 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:03 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:03 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:04 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:04 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:05 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:05 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:06 whiteax volumio[436]: error: message=Cannot read property '0' of undefined, stack=TypeError: Cannot read property '0' of undefined Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:83:67 Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:596:21 Mar 28 18:34:06 whiteax volumio[436]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:303:18) Mar 28 18:34:06 whiteax volumio[436]: at emitOne (events.js:116:13) Mar 28 18:34:06 whiteax volumio[436]: at Parser.emit (events.js:211:7) Mar 28 18:34:06 whiteax volumio[436]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:261:26) Mar 28 18:34:06 whiteax volumio[436]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 28 18:34:06 whiteax volumio[436]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 28 18:34:06 whiteax volumio[436]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 28 18:34:06 whiteax volumio[436]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 28 18:34:06 whiteax volumio[436]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:322:31) Mar 28 18:34:06 whiteax volumio[436]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:595:24 Mar 28 18:34:06 whiteax volumio[436]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:463:26) Mar 28 18:34:06 whiteax volumio[436]: at Request.self.callback (/volumio/node_modules/unirest/node_modules/request/request.js:187:22) Mar 28 18:34:06 whiteax volumio[436]: at emitTwo (events.js:126:13) Mar 28 18:34:06 whiteax volumio[436]: error: message=Cannot read property '0' of undefined, stack=TypeError: Cannot read property '0' of undefined Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:83:67 Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:596:21 Mar 28 18:34:06 whiteax volumio[436]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:303:18) Mar 28 18:34:06 whiteax volumio[436]: at emitOne (events.js:116:13) Mar 28 18:34:06 whiteax volumio[436]: at Parser.emit (events.js:211:7) Mar 28 18:34:06 whiteax volumio[436]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:261:26) Mar 28 18:34:06 whiteax volumio[436]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 28 18:34:06 whiteax volumio[436]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 28 18:34:06 whiteax volumio[436]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 28 18:34:06 whiteax volumio[436]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 28 18:34:06 whiteax volumio[436]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:322:31) Mar 28 18:34:06 whiteax volumio[436]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:595:24 Mar 28 18:34:06 whiteax volumio[436]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:463:26) Mar 28 18:34:06 whiteax volumio[436]: at Request.self.callback (/volumio/node_modules/unirest/node_modules/request/request.js:187:22) Mar 28 18:34:06 whiteax volumio[436]: at emitTwo (events.js:126:13) Mar 28 18:34:06 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:06 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:06 whiteax volumio[436]: error: message=Cannot read property '0' of undefined, stack=TypeError: Cannot read property '0' of undefined Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:83:67 Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:596:21 Mar 28 18:34:06 whiteax volumio[436]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:303:18) Mar 28 18:34:06 whiteax volumio[436]: at emitOne (events.js:116:13) Mar 28 18:34:06 whiteax volumio[436]: at Parser.emit (events.js:211:7) Mar 28 18:34:06 whiteax volumio[436]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:261:26) Mar 28 18:34:06 whiteax volumio[436]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 28 18:34:06 whiteax volumio[436]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 28 18:34:06 whiteax volumio[436]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 28 18:34:06 whiteax volumio[436]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 28 18:34:06 whiteax volumio[436]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:322:31) Mar 28 18:34:06 whiteax volumio[436]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 28 18:34:06 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:595:24 Mar 28 18:34:06 whiteax volumio[436]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:463:26) Mar 28 18:34:06 whiteax volumio[436]: at Request.self.callback (/volumio/node_modules/unirest/node_modules/request/request.js:187:22) Mar 28 18:34:06 whiteax volumio[436]: at emitTwo (events.js:126:13) Mar 28 18:34:06 whiteax volumio[436]: [SpotifyConnect] Sink released Mar 28 18:34:06 whiteax volumio[1677]: [Vollibrespot] : Loading track "Too Well" with Spotify URI "spotify:track:6Szgu8v7CAapag3XuuJX0b" Mar 28 18:34:06 whiteax volumio[436]: [SpotifyConnect] Pushing metadata Vollibrespot: true Mar 28 18:34:06 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:34:06 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:06 whiteax volumio[436]: [SpotifyConnect] Currently active: volspotconnect2 Mar 28 18:34:06 whiteax volumio[436]: [SpotifyConnect] Pushing new state :: true Mar 28 18:34:06 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:34:06 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:34:06 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:34:06 whiteax volumio[436]: info: Received update from a service different from the one supposed to be playing music. Processing service interruption. Current mpd Received volspotconnect2 Mar 28 18:34:07 whiteax volumio[436]: error: message=Cannot read property '0' of undefined, stack=TypeError: Cannot read property '0' of undefined Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:83:67 Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:596:21 Mar 28 18:34:07 whiteax volumio[436]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:303:18) Mar 28 18:34:07 whiteax volumio[436]: at emitOne (events.js:116:13) Mar 28 18:34:07 whiteax volumio[436]: at Parser.emit (events.js:211:7) Mar 28 18:34:07 whiteax volumio[436]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:261:26) Mar 28 18:34:07 whiteax volumio[436]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 28 18:34:07 whiteax volumio[436]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 28 18:34:07 whiteax volumio[436]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 28 18:34:07 whiteax volumio[436]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 28 18:34:07 whiteax volumio[436]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:322:31) Mar 28 18:34:07 whiteax volumio[436]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:595:24 Mar 28 18:34:07 whiteax volumio[436]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:463:26) Mar 28 18:34:07 whiteax volumio[436]: at Request.self.callback (/volumio/node_modules/unirest/node_modules/request/request.js:187:22) Mar 28 18:34:07 whiteax volumio[436]: at emitTwo (events.js:126:13) Mar 28 18:34:07 whiteax volumio[436]: error: message=Cannot read property '0' of undefined, stack=TypeError: Cannot read property '0' of undefined Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:83:67 Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:596:21 Mar 28 18:34:07 whiteax volumio[436]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:303:18) Mar 28 18:34:07 whiteax volumio[436]: at emitOne (events.js:116:13) Mar 28 18:34:07 whiteax volumio[436]: at Parser.emit (events.js:211:7) Mar 28 18:34:07 whiteax volumio[436]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:261:26) Mar 28 18:34:07 whiteax volumio[436]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 28 18:34:07 whiteax volumio[436]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 28 18:34:07 whiteax volumio[436]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 28 18:34:07 whiteax volumio[436]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 28 18:34:07 whiteax volumio[436]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:322:31) Mar 28 18:34:07 whiteax volumio[436]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:595:24 Mar 28 18:34:07 whiteax volumio[436]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:463:26) Mar 28 18:34:07 whiteax volumio[436]: at Request.self.callback (/volumio/node_modules/unirest/node_modules/request/request.js:187:22) Mar 28 18:34:07 whiteax volumio[436]: at emitTwo (events.js:126:13) Mar 28 18:34:07 whiteax volumio[436]: error: message=Cannot read property '0' of undefined, stack=TypeError: Cannot read property '0' of undefined Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:83:67 Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:596:21 Mar 28 18:34:07 whiteax volumio[436]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:303:18) Mar 28 18:34:07 whiteax volumio[436]: at emitOne (events.js:116:13) Mar 28 18:34:07 whiteax volumio[436]: at Parser.emit (events.js:211:7) Mar 28 18:34:07 whiteax volumio[436]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:261:26) Mar 28 18:34:07 whiteax volumio[436]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 28 18:34:07 whiteax volumio[436]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 28 18:34:07 whiteax volumio[436]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 28 18:34:07 whiteax volumio[436]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 28 18:34:07 whiteax volumio[436]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:322:31) Mar 28 18:34:07 whiteax volumio[436]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 28 18:34:07 whiteax volumio[436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:595:24 Mar 28 18:34:07 whiteax volumio[436]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:463:26) Mar 28 18:34:07 whiteax volumio[436]: at Request.self.callback (/volumio/node_modules/unirest/node_modules/request/request.js:187:22) Mar 28 18:34:07 whiteax volumio[436]: at emitTwo (events.js:126:13) Mar 28 18:34:07 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:07 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:08 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:08 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:08 whiteax volumio[1677]: [Vollibrespot] : Track "Too Well" loaded Mar 28 18:34:08 whiteax volumio[436]: [SpotifyConnect] Sink acquired Mar 28 18:34:08 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:34:08 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:08 whiteax volumio[436]: [SpotifyConnect] Currently active: volspotconnect2 Mar 28 18:34:08 whiteax volumio[436]: [SpotifyConnect] Pushing new state :: true Mar 28 18:34:08 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:34:08 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:34:08 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:34:08 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:08 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:34:08 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:08 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - volspotconnect2 Mar 28 18:34:08 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:34:08 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:08 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:08 whiteax sudo[25195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:08 whiteax sudo[25195]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:08 whiteax sudo[25195]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:08 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:08 whiteax sudo[25202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:09 whiteax sudo[25202]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:09 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:09 whiteax sudo[25202]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:09 whiteax sudo[25211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:09 whiteax volumio[436]: info: Pushing Favourites {"service":"volspotconnect2","uri":"spotify:track:6Szgu8v7CAapag3XuuJX0b","favourite":false} Mar 28 18:34:09 whiteax sudo[25211]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:09 whiteax sudo[25211]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:09 whiteax root[994]: [2024/03/28 18:34:09:4317] NOTICE: Sending : 2 Mar 28 18:34:09 whiteax root[994]: [2024/03/28 18:34:09:4318] NOTICE: ping Mar 28 18:34:09 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:09 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:10 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:10 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:11 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:11 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:12 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:12 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:13 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:13 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:14 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:14 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:15 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:15 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:16 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:16 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:17 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:17 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:18 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:18 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:19 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:19 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:19 whiteax root[994]: [2024/03/28 18:34:19:5409] NOTICE: Sending : 2 Mar 28 18:34:19 whiteax root[994]: [2024/03/28 18:34:19:5409] NOTICE: ping Mar 28 18:34:20 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:20 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:21 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:21 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:22 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:22 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:23 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:23 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:24 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:24 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:25 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:25 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:26 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:26 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:27 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:27 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:28 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:28 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:29 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:29 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:29 whiteax root[994]: [2024/03/28 18:34:29:6493] NOTICE: Sending : 2 Mar 28 18:34:29 whiteax root[994]: [2024/03/28 18:34:29:6493] NOTICE: ping Mar 28 18:34:30 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:30 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:31 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:31 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:32 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:32 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:33 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:33 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:34 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:34 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:35 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:35 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:36 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:36 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:37 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:37 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:38 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:38 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:39 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:39 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:39 whiteax root[994]: [2024/03/28 18:34:39:7577] NOTICE: Sending : 2 Mar 28 18:34:39 whiteax root[994]: [2024/03/28 18:34:39:7578] NOTICE: ping Mar 28 18:34:40 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:40 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:41 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:41 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:42 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:42 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:43 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:43 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:44 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:44 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:45 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:45 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:46 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:46 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:47 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:47 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:48 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:48 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:49 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:49 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:49 whiteax root[994]: [2024/03/28 18:34:49:8662] NOTICE: Sending : 2 Mar 28 18:34:49 whiteax root[994]: [2024/03/28 18:34:49:8663] NOTICE: ping Mar 28 18:34:50 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:50 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] Pushing metadata Vollibrespot: true Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] Currently active: volspotconnect2 Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] Pushing new state :: true Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:51 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - volspotconnect2 Mar 28 18:34:51 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:51 whiteax sudo[25307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:51 whiteax sudo[25307]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:51 whiteax sudo[25307]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:51 whiteax sudo[25312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:51 whiteax sudo[25312]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:51 whiteax sudo[25312]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:51 whiteax sudo[25320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:51 whiteax sudo[25320]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:51 whiteax volumio[436]: info: Pushing Favourites {"service":"volspotconnect2","uri":"spotify:track:6Szgu8v7CAapag3XuuJX0b","favourite":false} Mar 28 18:34:51 whiteax sudo[25320]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:51 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:51 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] Sink released Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] Device is inactive! Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] Relinquishing Volumio state, Spotify session: true Mar 28 18:34:51 whiteax volumio[436]: UNSET VOLATILE Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] unSetVolatile called Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] Relinquishing Volumio state to another service, Spotify session: true Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] Received stop Mar 28 18:34:51 whiteax volumio[436]: [SpotifyConnect] FE => [ 4, [length]: 1 ] Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::resetVolumioState Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::getcurrentVolume Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::volumioRetrievevolume Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::updateTrackBlock Mar 28 18:34:51 whiteax volumio[436]: info: CorePlayQueue::getTrackBlock Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::volumioStop Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:51 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:34:51 whiteax volumio[436]: info: VOLUMIOSTOP: service stopped - mpd Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::stop Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 18:34:51 whiteax volumio[436]: UNSET VOLATILE Mar 28 18:34:51 whiteax volumio[436]: info: VolumeController:: Volume=undefined Mute =undefined Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:34:51 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:51 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:51 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - stop, service - mpd Mar 28 18:34:51 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:51 whiteax sudo[25336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:51 whiteax sudo[25336]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:51 whiteax sudo[25336]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:51 whiteax sudo[25342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:51 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:51 whiteax sudo[25342]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:51 whiteax sudo[25342]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:51 whiteax sudo[25349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:51 whiteax volumio[436]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/ROBV_TESLA/Retro/001 If It Makes You Happy - Sheryl Crow - Sheryl Crow.mp3","favourite":false} Mar 28 18:34:51 whiteax sudo[25349]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:51 whiteax sudo[25349]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] spotifyApi::Pause complete { body: {}, Mar 28 18:34:52 whiteax volumio[436]: headers: Mar 28 18:34:52 whiteax volumio[436]: { 'cache-control': 'private, max-age=0', Mar 28 18:34:52 whiteax volumio[436]: 'x-robots-tag': 'noindex, nofollow', Mar 28 18:34:52 whiteax volumio[436]: 'access-control-allow-origin': '*', Mar 28 18:34:52 whiteax volumio[436]: 'access-control-allow-headers': 'Accept, App-Platform, Authorization, Content-Type, Origin, Retry-After, Spotify-App-Version, X-Cloud-Trace-Context, client-token, content-access-token', Mar 28 18:34:52 whiteax volumio[436]: 'access-control-allow-methods': 'GET, POST, OPTIONS, PUT, DELETE, PATCH', Mar 28 18:34:52 whiteax volumio[436]: 'access-control-allow-credentials': 'true', Mar 28 18:34:52 whiteax volumio[436]: 'access-control-max-age': '604800', Mar 28 18:34:52 whiteax volumio[436]: 'content-length': '0', Mar 28 18:34:52 whiteax volumio[436]: 'strict-transport-security': 'max-age=31536000', Mar 28 18:34:52 whiteax volumio[436]: 'x-content-type-options': 'nosniff', Mar 28 18:34:52 whiteax volumio[436]: date: 'Thu, 28 Mar 2024 18:34:51 GMT', Mar 28 18:34:52 whiteax volumio[436]: server: 'envoy', Mar 28 18:34:52 whiteax volumio[436]: via: 'HTTP/2 edgeproxy, 1.1 google', Mar 28 18:34:52 whiteax volumio[436]: 'alt-svc': 'h3=":443"; ma=2592000,h3-29=":443"; ma=2592000', Mar 28 18:34:52 whiteax volumio[436]: connection: 'close' }, Mar 28 18:34:52 whiteax volumio[436]: statusCode: 202 } Mar 28 18:34:52 whiteax volumio[1677]: [Vollibrespot] : volStop Mar 28 18:34:52 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:52 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Pushing metadata Vollibrespot: false Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:52 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Currently active: mpd Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Pushing new state :: false Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:34:52 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:34:52 whiteax volumio[436]: info: Received update from a service different from the one supposed to be playing music. Processing service interruption. Current mpd Received volspotconnect2 Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Device is active! Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:52 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Currently active: mpd Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Stopping currently active service Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::volumioStop Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:52 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:34:52 whiteax volumio[436]: info: VOLUMIOSTOP: service stopped - mpd Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::stop Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 18:34:52 whiteax volumio[436]: UNSET VOLATILE Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Vollibrespot Active Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:52 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Currently active: mpd Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Setting Volatile state to Volspotconnect2 Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:52 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - volspotconnect2 Mar 28 18:34:52 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:52 whiteax sudo[25365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Currently active: volspotconnect2 Mar 28 18:34:52 whiteax volumio[436]: [SpotifyConnect] Pushing new state :: true Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:52 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - volspotconnect2 Mar 28 18:34:52 whiteax sudo[25365]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:52 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:52 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:52 whiteax sudo[25365]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:52 whiteax sudo[25369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:52 whiteax sudo[25369]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:52 whiteax sudo[25369]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:52 whiteax sudo[25378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:52 whiteax sudo[25378]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:52 whiteax sudo[25385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:52 whiteax sudo[25378]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:52 whiteax sudo[25385]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:53 whiteax sudo[25385]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:53 whiteax sudo[25401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:53 whiteax sudo[25401]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:53 whiteax sudo[25401]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:53 whiteax sudo[25409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:53 whiteax sudo[25409]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:53 whiteax sudo[25409]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:53 whiteax volumio[436]: [SpotifyConnect] Sink acquired Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:34:53 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:53 whiteax volumio[436]: [SpotifyConnect] Currently active: volspotconnect2 Mar 28 18:34:53 whiteax volumio[436]: [SpotifyConnect] Pushing new state :: true Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:34:53 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:34:53 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:34:53 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:53 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - volspotconnect2 Mar 28 18:34:53 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:53 whiteax sudo[25423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:34:53 whiteax sudo[25423]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:53 whiteax sudo[25423]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:53 whiteax sudo[25427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:53 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:34:53 whiteax sudo[25427]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:53 whiteax sudo[25427]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:53 whiteax volumio[436]: info: Pushing Favourites {"service":"volspotconnect2","uri":"spotify:track:6Szgu8v7CAapag3XuuJX0b","favourite":false} Mar 28 18:34:53 whiteax sudo[25434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:34:53 whiteax volumio[436]: info: Pushing Favourites {"service":"volspotconnect2","uri":"spotify:track:6Szgu8v7CAapag3XuuJX0b","favourite":false} Mar 28 18:34:53 whiteax volumio[436]: info: Pushing Favourites {"service":"volspotconnect2","uri":"spotify:track:6Szgu8v7CAapag3XuuJX0b","favourite":false} Mar 28 18:34:53 whiteax sudo[25434]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:34:53 whiteax sudo[25434]: pam_unix(sudo:session): session closed for user root Mar 28 18:34:53 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:53 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:54 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:54 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:55 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:55 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:56 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:56 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:57 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:57 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:58 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:58 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:59 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:59 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:34:59 whiteax root[994]: [2024/03/28 18:34:59:9755] NOTICE: Sending : 2 Mar 28 18:34:59 whiteax root[994]: [2024/03/28 18:34:59:9756] NOTICE: ping Mar 28 18:35:00 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:00 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] Relinquishing Volumio state, Spotify session: true Mar 28 18:35:01 whiteax volumio[436]: UNSET VOLATILE Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] unSetVolatile called Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] Relinquishing Volumio state to another service, Spotify session: true Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] Received stop Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] FE => [ 4, [length]: 1 ] Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] Connect Session is done Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::resetVolumioState Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::getcurrentVolume Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::volumioRetrievevolume Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::updateTrackBlock Mar 28 18:35:01 whiteax volumio[436]: info: CorePlayQueue::getTrackBlock Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::volumioStop Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:01 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:35:01 whiteax volumio[436]: info: VOLUMIOSTOP: service stopped - mpd Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::stop Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 18:35:01 whiteax volumio[436]: UNSET VOLATILE Mar 28 18:35:01 whiteax volumio[436]: info: VolumeController:: Volume=undefined Mute =undefined Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:01 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:01 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - stop, service - mpd Mar 28 18:35:01 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:01 whiteax sudo[25468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:01 whiteax sudo[25468]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:01 whiteax sudo[25468]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:01 whiteax sudo[25471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:01 whiteax sudo[25471]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:01 whiteax sudo[25476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:01 whiteax sudo[25471]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:01 whiteax volumio[436]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/ROBV_TESLA/Retro/001 If It Makes You Happy - Sheryl Crow - Sheryl Crow.mp3","favourite":false} Mar 28 18:35:01 whiteax sudo[25476]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:01 whiteax sudo[25476]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:01 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:01 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:01 whiteax volumio[1677]: [Vollibrespot] : volStop Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] Sink released Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] Device is inactive! Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] Relinquishing Volumio state, Spotify session: true Mar 28 18:35:01 whiteax volumio[436]: UNSET VOLATILE Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::resetVolumioState Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::getcurrentVolume Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::volumioRetrievevolume Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::updateTrackBlock Mar 28 18:35:01 whiteax volumio[436]: info: CorePlayQueue::getTrackBlock Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::volumioStop Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:01 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:35:01 whiteax volumio[436]: info: VOLUMIOSTOP: service stopped - mpd Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::stop Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 18:35:01 whiteax volumio[436]: UNSET VOLATILE Mar 28 18:35:01 whiteax volumio[436]: info: VolumeController:: Volume=undefined Mute =undefined Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:01 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:01 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:01 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - stop, service - mpd Mar 28 18:35:01 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:01 whiteax sudo[25498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:01 whiteax sudo[25498]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:01 whiteax sudo[25498]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:01 whiteax sudo[25503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:01 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:01 whiteax sudo[25503]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:01 whiteax sudo[25503]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:01 whiteax sudo[25510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:01 whiteax sudo[25510]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:01 whiteax volumio[436]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/ROBV_TESLA/Retro/001 If It Makes You Happy - Sheryl Crow - Sheryl Crow.mp3","favourite":false} Mar 28 18:35:01 whiteax sudo[25510]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:01 whiteax volumio[436]: [SpotifyConnect] spotifyApi::Pause complete { body: {}, Mar 28 18:35:01 whiteax volumio[436]: headers: Mar 28 18:35:01 whiteax volumio[436]: { 'cache-control': 'private, max-age=0', Mar 28 18:35:01 whiteax volumio[436]: 'x-robots-tag': 'noindex, nofollow', Mar 28 18:35:01 whiteax volumio[436]: 'access-control-allow-origin': '*', Mar 28 18:35:01 whiteax volumio[436]: 'access-control-allow-headers': 'Accept, App-Platform, Authorization, Content-Type, Origin, Retry-After, Spotify-App-Version, X-Cloud-Trace-Context, client-token, content-access-token', Mar 28 18:35:01 whiteax volumio[436]: 'access-control-allow-methods': 'GET, POST, OPTIONS, PUT, DELETE, PATCH', Mar 28 18:35:01 whiteax volumio[436]: 'access-control-allow-credentials': 'true', Mar 28 18:35:01 whiteax volumio[436]: 'access-control-max-age': '604800', Mar 28 18:35:01 whiteax volumio[436]: 'strict-transport-security': 'max-age=31536000', Mar 28 18:35:01 whiteax volumio[436]: 'x-content-type-options': 'nosniff', Mar 28 18:35:01 whiteax volumio[436]: vary: 'Accept-Encoding', Mar 28 18:35:01 whiteax volumio[436]: date: 'Thu, 28 Mar 2024 18:35:01 GMT', Mar 28 18:35:01 whiteax volumio[436]: server: 'envoy', Mar 28 18:35:01 whiteax volumio[436]: via: 'HTTP/2 edgeproxy, 1.1 google', Mar 28 18:35:01 whiteax volumio[436]: 'alt-svc': 'h3=":443"; ma=2592000,h3-29=":443"; ma=2592000', Mar 28 18:35:01 whiteax volumio[436]: connection: 'close' }, Mar 28 18:35:01 whiteax volumio[436]: statusCode: 204 } Mar 28 18:35:02 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:02 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:03 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:03 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:04 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:04 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:05 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:05 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:06 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:06 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:07 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:07 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:08 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:08 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:09 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:09 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:10 whiteax root[994]: [2024/03/28 18:35:10:0842] NOTICE: Sending : 2 Mar 28 18:35:10 whiteax root[994]: [2024/03/28 18:35:10:0842] NOTICE: ping Mar 28 18:35:10 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:10 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:11 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:11 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:12 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:12 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:13 whiteax root[994]: 2024-03-28 06:35:13.178660 PM [AirPlay] Control pair-setup HK ([fe80::422:a3c9:f6ac:54f9%wlan0]:54033), type 4 Mar 28 18:35:13 whiteax root[994]: 2024-03-28 06:35:13.433644 PM [AirPlay] Control pair-setup HK ([fe80::422:a3c9:f6ac:54f9%wlan0]:54033), type 4 Mar 28 18:35:13 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:13 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.057536 PM [Airtunesd] Received Client IP Update Message Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.057735 PM [Airtunesd] Unsupported session copy property request: rtpSkewPlatformAdjust Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.068241 PM [AirPlay] Updated Bonjour TXT for _airplay._tcp. Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.073947 PM [AirPlay] Updated Bonjour TXT for _raop._tcp. Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.074239 PM [Airtunesd] Unsupported session copy property request: ptpPowerState Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.074429 PM [Airtunesd] Received and Unknown Update Message Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.075074 PM [AirPlay] _GeneralAudioAddIPAddrs: our ptp info: { Mar 28 18:35:14 whiteax root[994]: "SupportsClockPortMatchingOverride" : false Mar 28 18:35:14 whiteax root[994]: "Addresses" : Mar 28 18:35:14 whiteax root[994]: [ Mar 28 18:35:14 whiteax root[994]: "192.168.0.126" Mar 28 18:35:14 whiteax root[994]: ] Mar 28 18:35:14 whiteax root[994]: "ID" : "1b4d2304-bfda-42b8-b11c-d41a54a754f0" Mar 28 18:35:14 whiteax root[994]: } Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.106649 PM [AirPlay] _requestProcessGetParameter:server volume set to 0.0 Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.115906 PM [AirPlay] AirPlay;2.0.4(28.0) master session started from [fe80::422:a3c9:f6ac:54f9%wlan0]:54033, 0/0x0 noErr Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.128515 PM [AirPlay] AirPlayReceiverSessionSetPeers: [ Mar 28 18:35:14 whiteax root[994]: "fe80::422:a3c9:f6ac:54f9", Mar 28 18:35:14 whiteax root[994]: "192.168.0.232" Mar 28 18:35:14 whiteax root[994]: ] Mar 28 18:35:14 whiteax root[994]: on wlan0 Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.173936 PM [AirTunesAvnuClock] PTPClockLaunch: launched PID 25552 Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.374550 PM [AirTunesAvnuClock] PTPClockOpenMsgPort Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.374822 PM [AirTunesAvnuClock] Device at ip address 192.168.0.232 is added into the clock group. Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.380930 PM [Airtunesd] Received and Unknown Update Message Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.381210 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.394927 PM [AirPlay] _requestProcessSetParameterText: dbVolume = -20.0 Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.395108 PM [AirPlay] _requestProcessSetParameterText:server volume set to -20.0 Mar 28 18:35:14 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:14 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.748397 PM [Airtunesd] Received and Unknown Update Message Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.748663 PM [Airtunesd] Received and Unknown Update Message Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.749178 PM [Airtunesd] Received and Unknown Update Message Mar 28 18:35:14 whiteax root[994]: 2024-03-28 06:35:14.751554 PM [AirPlay] Main audio setting up ALAC/44100/16/2 for default, input no, loopback no, volume:-20.000000 Mar 28 18:35:14 whiteax root[994]: Source Format ID : 616c6163 Mar 28 18:35:15 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:15 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:15 whiteax root[994]: Frames: 256, period time: 5804, buff_size: 524288 Mar 28 18:35:15 whiteax root[994]: 2024-03-28 06:35:15.792240 PM [AudioStream] ALSA device is not in SND_PCM_STATE_RUNNING or SND_PCM_STATE_DRAINING state in AudioThreadFn loop. It may be okay. Mar 28 18:35:15 whiteax root[994]: 2024-03-28 06:35:15.803359 PM [AirPlay] SetRateAndAnchorTime inRate 1 rtpTme 1736821544 netTime (timeline=74da38fffe90762e secs=1711650915 flags=0) Mar 28 18:35:15 whiteax root[994]: 2024-03-28 06:35:15.803710 PM [AirPlay] SetRateAndAnchorTime timeline match after #0 tries Mar 28 18:35:15 whiteax root[994]: 2024-03-28 06:35:15.803879 PM [Airtunesd] Received Play Status Update Message Mar 28 18:35:15 whiteax root[994]: [2024/03/28 18:35:15:8040] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Mar 28 18:35:15 whiteax volumio[436]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Mar 28 18:35:15 whiteax volumio[436]: info: Airplay started streaming Mar 28 18:35:15 whiteax volumio[436]: info: AIRPLAY: Un-Docking Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:35:15 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:35:15 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:15 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:15 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Mar 28 18:35:15 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:15 whiteax root[994]: [2024/03/28 18:35:15:8891] NOTICE: Sending : 42["volume", 33] Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:15 whiteax sudo[25567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:15 whiteax root[994]: 2024-03-28 06:35:15.932755 PM [AirPlay] Flushing receiver complete: flushSeq 55994 flushTS 1736899833 count 0 Mar 28 18:35:15 whiteax root[994]: 2024-03-28 06:35:15.933092 PM [Airtunesd] Received Play Status Update Message Mar 28 18:35:15 whiteax root[994]: 2024-03-28 06:35:15.933370 PM [AirPlay] ProcessPkt Flush Complete flushSeq 55994 flushTS 1736899833 count 0 Seq # 56003 TS 1736903001 Mar 28 18:35:15 whiteax root[994]: [2024/03/28 18:35:15:9336] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Mar 28 18:35:15 whiteax sudo[25567]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:15 whiteax sudo[25567]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:15 whiteax sudo[25573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:15 whiteax sudo[25573]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:15 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:16 whiteax sudo[25573]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:16 whiteax sudo[25580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:16 whiteax volumio[436]: info: VolumeController::SetAlsaVolume33 Mar 28 18:35:16 whiteax volumio[436]: amixer -M set -c 0 "Digital" 33% Mar 28 18:35:16 whiteax sudo[25580]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:16 whiteax sudo[25580]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:16 whiteax volumio[436]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Mar 28 18:35:16 whiteax volumio[436]: info: Airplay stopped playing. Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:35:16 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:35:16 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:16 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:16 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Mar 28 18:35:16 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:16 whiteax sudo[25596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:16 whiteax sudo[25596]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:16 whiteax sudo[25598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:16 whiteax sudo[25596]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:16 whiteax sudo[25598]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:16 whiteax volumio[436]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Mar 28 18:35:16 whiteax volumio[436]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Mar 28 18:35:16 whiteax sudo[25598]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:16 whiteax sudo[25604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:16 whiteax sudo[25604]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:16 whiteax volumio[436]: null Mar 28 18:35:16 whiteax volumio[436]: info: VolumeController::Volume 33 Mar 28 18:35:16 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:16 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:16 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Mar 28 18:35:16 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:16 whiteax sudo[25604]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:16 whiteax sudo[25624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:16 whiteax sudo[25624]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:16 whiteax sudo[25624]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:16 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:16 whiteax sudo[25631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:16 whiteax sudo[25636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:16 whiteax volumio[436]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Mar 28 18:35:16 whiteax sudo[25636]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:16 whiteax sudo[25631]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:16 whiteax sudo[25631]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:16 whiteax sudo[25636]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:16 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:16 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:17 whiteax root[994]: 2024-03-28 06:35:17.523061 PM [AirPlay] AirPlayReceiverSessionSetPeers: [ Mar 28 18:35:17 whiteax root[994]: "fe80::422:a3c9:f6ac:54f9", Mar 28 18:35:17 whiteax root[994]: "192.168.0.232" Mar 28 18:35:17 whiteax root[994]: ] Mar 28 18:35:17 whiteax root[994]: on wlan0 Mar 28 18:35:17 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:17 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:17 whiteax root[994]: 2024-03-28 06:35:17.597772 PM [AirPlay] SetRateAndAnchorTime inRate 1 rtpTme 1736900711 netTime (timeline=74da38fffe90762e secs=1711650917 flags=0) Mar 28 18:35:17 whiteax root[994]: 2024-03-28 06:35:17.597972 PM [AirPlay] SetRateAndAnchorTime timeline match after #0 tries Mar 28 18:35:17 whiteax root[994]: 2024-03-28 06:35:17.598127 PM [Airtunesd] Received Play Status Update Message Mar 28 18:35:17 whiteax root[994]: [2024/03/28 18:35:17:5982] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Mar 28 18:35:17 whiteax volumio[436]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Mar 28 18:35:17 whiteax volumio[436]: info: Airplay started streaming Mar 28 18:35:17 whiteax volumio[436]: info: AIRPLAY: Un-Docking Mar 28 18:35:17 whiteax root[994]: 2024-03-28 06:35:17.638135 PM [Airtunesd] Received Meta Data Update Message Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:35:17 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:35:17 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:17 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:17 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Mar 28 18:35:17 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:17 whiteax root[994]: 2024-03-28 06:35:17.713756 PM [AirPlay] Concealed 664 unit gap (89082 vs 89746), curr seq 55994 Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:17 whiteax sudo[25658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:17 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:17 whiteax sudo[25660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:17 whiteax sudo[25658]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:17 whiteax volumio[436]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Mar 28 18:35:17 whiteax sudo[25660]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:17 whiteax sudo[25658]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:17 whiteax sudo[25666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:17 whiteax sudo[25660]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:17 whiteax sudo[25666]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:17 whiteax sudo[25666]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:18 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:18 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:19 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:19 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:20 whiteax root[994]: [2024/03/28 18:35:20:2015] NOTICE: Sending : 2 Mar 28 18:35:20 whiteax root[994]: [2024/03/28 18:35:20:2016] NOTICE: ping Mar 28 18:35:20 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:20 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:21 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:21 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:22 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:22 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:23 whiteax root[994]: [2024/03/28 18:35:23:4112] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Mar 28 18:35:23 whiteax root[994]: "artwork_mime_type": "image\/jpeg", Mar 28 18:35:23 whiteax root[994]: "artwork_file": "\/tmp\/airplay2.artwork.jpg" Mar 28 18:35:23 whiteax root[994]: }}] Mar 28 18:35:23 whiteax volumio[436]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:23 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Mar 28 18:35:23 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.440942 PM [Airtunesd] Received and Unknown Update Message Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.441285 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.451360 PM [AirPlay] Teardown Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.453338 PM [AudioStream] Requested to quit AudioThreadFn loop. Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:23 whiteax sudo[25698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:23 whiteax sudo[25698]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:23 whiteax sudo[25698]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:23 whiteax sudo[25702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:23 whiteax sudo[25702]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.554993 PM [AirPlay] Main audio torn down Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.555460 PM [Airtunesd] Received Play Status Update Message Mar 28 18:35:23 whiteax root[994]: [2024/03/28 18:35:23:5556] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Mar 28 18:35:23 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:23 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.566589 PM [AirPlay] Teardown Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.566947 PM [AirPlay] AirPlay session ended: Dur=9 seconds Reason=0/0x0 noErr Mar 28 18:35:23 whiteax root[994]: Glitches: 0%, 1 total, 0 glitchy minute(s) Mar 28 18:35:23 whiteax root[994]: Retransmits: 0 sent, 0 received, 0 futile, 0 not found, 0/0/0 ms min/max/avg, 0/0 ms retry min/max Mar 28 18:35:23 whiteax root[994]: Packets: 0 lost, 0 unrecovered, 0 late, 0 max burst, 0 big losses, 72% compression Mar 28 18:35:23 whiteax root[994]: Time Sync: 1000000000/0/0 ms min/max/avg RTT, 2147483647/-2147483648/0 µS min/max/avg offset, 0 step(s) Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.567609 PM [Airtunesd] Received Play Status Update Message Mar 28 18:35:23 whiteax root[994]: [2024/03/28 18:35:23:5681] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.572476 PM [Airtunesd] Received Play Status Update Message Mar 28 18:35:23 whiteax root[994]: [2024/03/28 18:35:23:5728] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.574961 PM [AirTunesAvnuClock] Device at ip address 192.168.0.232 is removed from the clock group. Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.575448 PM [AirTunesAvnuClock] AirTunesPTPClock_Finalize Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.575779 PM [AirTunesAvnuClock] AirTunesPTPClock_Finalize: SIGTERM 25552 Mar 28 18:35:23 whiteax sudo[25702]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.596227 PM [AirTunesAvnuClock] ptp process 25552 exited with no errors Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.606420 PM [AirPlay] Updated Bonjour TXT for _airplay._tcp. Mar 28 18:35:23 whiteax sudo[25710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.615110 PM [AirPlay] Updated Bonjour TXT for _raop._tcp. Mar 28 18:35:23 whiteax root[994]: 2024-03-28 06:35:23.615434 PM [AirPlaySessionManager] Releasing master session:0x6DB08D78 Mar 28 18:35:23 whiteax sudo[25710]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:23 whiteax sudo[25710]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:23 whiteax volumio[436]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Mar 28 18:35:23 whiteax volumio[436]: info: Airplay stopped playing. Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:23 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Mar 28 18:35:23 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:23 whiteax sudo[25728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:23 whiteax sudo[25728]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:23 whiteax sudo[25728]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:23 whiteax sudo[25733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:23 whiteax sudo[25733]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:23 whiteax volumio[436]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Mar 28 18:35:23 whiteax volumio[436]: info: Airplay stopped playing. Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:23 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Mar 28 18:35:23 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:23 whiteax sudo[25733]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:23 whiteax sudo[25740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:23 whiteax sudo[25740]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:23 whiteax sudo[25740]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:23 whiteax sudo[25752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:23 whiteax sudo[25752]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:23 whiteax sudo[25752]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:23 whiteax sudo[25763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:23 whiteax sudo[25763]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:23 whiteax sudo[25763]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:23 whiteax volumio[436]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Mar 28 18:35:23 whiteax volumio[436]: info: Airplay stopped playing. Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::pushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::volumioPushState Mar 28 18:35:23 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:23 whiteax volumio[436]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Mar 28 18:35:23 whiteax volumio[436]: info: interfaceApi::pushState Mar 28 18:35:24 whiteax sudo[25772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:24 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:24 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 28 18:35:24 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:24 whiteax sudo[25772]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:24 whiteax sudo[25778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:24 whiteax sudo[25772]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:24 whiteax sudo[25778]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:24 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Mar 28 18:35:24 whiteax sudo[25778]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:24 whiteax sudo[25790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:24 whiteax volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 18:35:24 whiteax sudo[25797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 18:35:24 whiteax sudo[25790]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:24 whiteax sudo[25797]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:24 whiteax sudo[25790]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:24 whiteax volumio[436]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Mar 28 18:35:24 whiteax sudo[25797]: pam_unix(sudo:session): session closed for user root Mar 28 18:35:24 whiteax volumio[436]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Mar 28 18:35:24 whiteax volumio[436]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Mar 28 18:35:24 whiteax volumio[436]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Mar 28 18:35:24 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:24 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:25 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:25 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:26 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:26 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:27 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:27 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:28 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:28 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:29 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:29 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:30 whiteax root[994]: [2024/03/28 18:35:30:3154] NOTICE: Sending : 2 Mar 28 18:35:30 whiteax root[994]: [2024/03/28 18:35:30:3155] NOTICE: ping Mar 28 18:35:30 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:30 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:31 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:31 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:32 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:32 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:33 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:33 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:34 whiteax volumio[1677]: [Vollibrespot] : SessionActive! Mar 28 18:35:34 whiteax volumio[436]: [SpotifyConnect] Connect Session is active! Mar 28 18:35:34 whiteax volumio[1677]: [Vollibrespot] : Loading track "Too Well" with Spotify URI "spotify:track:6Szgu8v7CAapag3XuuJX0b" Mar 28 18:35:34 whiteax volumio[436]: [SpotifyConnect] Pushing metadata Vollibrespot: false Mar 28 18:35:34 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:35:34 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:34 whiteax volumio[436]: [SpotifyConnect] Currently active: airplay Mar 28 18:35:34 whiteax volumio[436]: [SpotifyConnect] Pushing new state :: false Mar 28 18:35:34 whiteax volumio[436]: info: CoreCommandRouter::servicePushState Mar 28 18:35:34 whiteax volumio[436]: info: CoreStateMachine::syncState Mar 28 18:35:34 whiteax volumio[436]: info: CorePlayQueue::getTrack 0 Mar 28 18:35:34 whiteax volumio[436]: info: Received update from a service different from the one supposed to be playing music. Processing service interruption. Current mpd Received volspotconnect2 Mar 28 18:35:34 whiteax volumio[436]: [SpotifyConnect] Token: Mar 28 18:35:34 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:34 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:35 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:35 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:36 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:36 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:36 whiteax volumio[1677]: [Vollibrespot] : Track "Too Well" loaded Mar 28 18:35:36 whiteax volumio[436]: [SpotifyConnect] Device is active! Mar 28 18:35:36 whiteax volumio[436]: info: CoreCommandRouter::volumioGetState Mar 28 18:35:36 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:36 whiteax volumio[436]: [SpotifyConnect] Currently active: airplay Mar 28 18:35:36 whiteax volumio[436]: [SpotifyConnect] Stopping currently active service Mar 28 18:35:36 whiteax volumio[436]: info: CoreCommandRouter::volumioStop Mar 28 18:35:36 whiteax volumio[436]: info: CoreStateMachine::getState Mar 28 18:35:36 whiteax volumio[436]: info: VOLUMIOSTOP: service stopped - airplay Mar 28 18:35:36 whiteax volumio[436]: info: CoreStateMachine::stop Mar 28 18:35:36 whiteax volumio[436]: info: CoreStateMachine::serviceStop Mar 28 18:35:36 whiteax volumio[436]: info: Received STOP, but no service to execute it Mar 28 18:35:36 whiteax volumio[436]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 18:35:36 whiteax volumio[436]: TypeError: Cannot read property 'then' of undefined Mar 28 18:35:36 whiteax volumio[436]: at SpotConnEvents. (/volumio/app/plugins/music_service/volspotconnect2/index.js:148:23) Mar 28 18:35:36 whiteax volumio[436]: at emitOne (events.js:116:13) Mar 28 18:35:36 whiteax volumio[436]: at SpotConnEvents.emit (events.js:211:7) Mar 28 18:35:36 whiteax volumio[436]: at SpotConnEvents.parseData (/volumio/app/plugins/music_service/volspotconnect2/SpotConnController.js:48:16) Mar 28 18:35:36 whiteax volumio[436]: at Socket.SpotConnEvents._udpsource.on.msg (/volumio/app/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Mar 28 18:35:36 whiteax volumio[436]: at emitTwo (events.js:126:13) Mar 28 18:35:36 whiteax volumio[436]: at Socket.emit (events.js:214:7) Mar 28 18:35:36 whiteax volumio[436]: at UDP.onMessage [as onmessage] (dgram.js:659:8) Mar 28 18:35:36 whiteax volumio[436]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 18:35:37 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:37 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:38 whiteax sudo[25848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-28 18:34 Mar 28 18:35:38 whiteax sudo[25848]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 18:35:38 whiteax lircd[716]: lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Mar 28 18:35:38 whiteax lircd-0.9.4c[716]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' PRETTY_NAME="Raspbian GNU/Linux 9 (stretch)" NAME="Raspbian GNU/Linux" VERSION_ID="9" VERSION="9 (stretch)" VERSION_CODENAME=stretch 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_FE_VERSION="187be2f9c830c4fe312adf5ee10d6ca76c1221c8" VOLUMIO_BE_VERSION="47ab3b567cf0a562ecf4682a54cba4be0c4c2f3f" VOLUMIO_ARCH="arm" VERSION="V2.13.2" VOLUMIO_VERSION="V2.13.2 - Toasted Cherry" VOLUMIO_VARIANT="AxiomAir" VOLUMIO_HARDWARE="AxiomAir" VOLUMIO_BUILD_DATE="2020-12-29"