-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Mon 2024-05-13 15:46:50 CST. -- May 13 15:45:02 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 13 15:45:02 volumio volumio[6106]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 15 May 13 15:45:02 volumio volumio[6106]: info: CoreCommandRouter::volumioGetState May 13 15:45:02 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:45:05 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 13 15:45:05 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 13 15:45:05 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 13 15:45:05 volumio volumio-remote-updater[566]: No test mode May 13 15:45:05 volumio volumio-remote-updater[566]: No alpha test mode May 13 15:45:05 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 13 15:45:06 volumio volumio[6106]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 13 15:45:06 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 13 15:45:07 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 13 15:45:07 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 13 15:45:07 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 13 15:45:07 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 13 15:45:07 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 13 15:45:07 volumio volumio[6106]: info: CoreCommandRouter::volumioGetBrowseSources May 13 15:45:07 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 13 15:45:08 volumio volumio[6106]: error: MyVolumio Plugin failed to authenticate in a timely fashion May 13 15:45:08 volumio volumio[6106]: info: Completed starting MyVolumio Plugin May 13 15:45:08 volumio volumio[6106]: info: BOOT COMPLETED May 13 15:45:08 volumio volumio[6106]: [Metrics] CommandRouter: 37s 7.14ms May 13 15:45:08 volumio volumio[6106]: info: CoreCommandRouter::volumiosetStartupVolume May 13 15:45:08 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 13 15:45:08 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 13 15:45:08 volumio volumio[6106]: info: CoreCommandRouter::Close All Modals sent May 13 15:45:08 volumio volumio[6106]: info: CoreCommandRouter::Close All Modals sent May 13 15:45:09 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 13 15:45:09 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 13 15:45:09 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 13 15:46:30 volumio kernel: usb 2-1: USB disconnect, device number 2 May 13 15:46:30 volumio volumio[6106]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/C83F-F280 /dev/disk/by-id/usb-ADATA_USB_Flash_Drive_2431318351270028-0:0-part1 /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-label/\\xd0¼Ӿ\\xed /dev/disk/by-partuuid/61a64ba9-9d46-4208-9653-acdefa591caa /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_FS_LABEL":"_¼Ӿ_","ID_FS_LABEL_ENC":"\\xd0¼Ӿ\\xed","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"C83F-F280","ID_FS_UUID_ENC":"C83F-F280","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"USB_Flash_Drive","ID_MODEL_ENC":"USB\\x20Flash\\x20Drive\\x20","ID_MODEL_ID":"de7a","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"30865408","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"61a64ba9-9d46-4208-9653-acdefa591caa","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"9653f2ac-6a77-425f-86db-b50a17fd0674","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"ADATA_USB_Flash_Drive_2431318351270028-0:0","ID_SERIAL_SHORT":"2431318351270028","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"ADATA","ID_VENDOR_ENC":"ADATA\\x20\\x20\\x20","ID_VENDOR_ID":"125f","MAJOR":"8","MINOR":"1","PARTN":"1","PARTNAME":"Basic data partition","SEQNUM":"1818","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"13701025"} May 13 15:46:30 volumio sudo[6465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 May 13 15:46:30 volumio sudo[6465]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 15:46:30 volumio systemd[897]: media-_\xc2\xbc\xd3\xbe_.mount: Succeeded. May 13 15:46:30 volumio systemd[1]: media-_\xc2\xbc\xd3\xbe_.mount: Succeeded. May 13 15:46:30 volumio sudo[6465]: pam_unix(sudo:session): session closed for user root May 13 15:46:34 volumio volumio[6106]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/_¼Ӿ_ May 13 15:46:35 volumio volumio[6106]: info: Scanning removed location : "USB/_¼Ӿ_" May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:35 volumio volumio[6106]: info: May 13 15:46:35 volumio volumio[6106]: ---------------------------- MPD announces state update: update May 13 15:46:35 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:35 volumio volumio[6106]: info: May 13 15:46:35 volumio volumio[6106]: ---------------------------- MPD announces state update: update May 13 15:46:35 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:35 volumio volumio[6106]: info: May 13 15:46:35 volumio volumio[6106]: ---------------------------- MPD announces state update: update May 13 15:46:35 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:35 volumio volumio[6106]: info: sendMpdCommand status took 8 milliseconds May 13 15:46:35 volumio volumio[6106]: info: sendMpdCommand status took 6 milliseconds May 13 15:46:35 volumio volumio[6106]: info: sendMpdCommand status took 5 milliseconds May 13 15:46:35 volumio volumio[6106]: info: sendMpdCommand status took 4 milliseconds May 13 15:46:35 volumio volumio[6106]: info: sendMpdCommand status took 5 milliseconds May 13 15:46:35 volumio volumio[6106]: info: sendMpdCommand status took 4 milliseconds May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:35 volumio volumio[6106]: info: Command Router : Notfying DB Updatetrue May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:35 volumio volumio[6106]: info: Command Router : Notfying DB Updatetrue May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::Close All Modals sent May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:35 volumio volumio[6106]: info: Command Router : Notfying DB Updatetrue May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::Close All Modals sent May 13 15:46:35 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:35 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:35 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:35 volumio volumio[6106]: info: No code May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:35 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:35 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:35 volumio volumio[6106]: info: No code May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:35 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:35 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:35 volumio volumio[6106]: info: No code May 13 15:46:35 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:35 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:35 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 523ms May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 521ms May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 521ms May 13 15:46:36 volumio volumio[6106]: info: MPD Database updated - AlbumList cache refreshed May 13 15:46:36 volumio volumio[6106]: info: May 13 15:46:36 volumio volumio[6106]: ---------------------------- MPD announces state update: database May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: May 13 15:46:36 volumio volumio[6106]: ---------------------------- MPD announces state update: update May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: MPD Database updated - AlbumList cache refreshed May 13 15:46:36 volumio volumio[6106]: info: May 13 15:46:36 volumio volumio[6106]: ---------------------------- MPD announces state update: database May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: May 13 15:46:36 volumio volumio[6106]: ---------------------------- MPD announces state update: update May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: MPD Database updated - AlbumList cache refreshed May 13 15:46:36 volumio volumio[6106]: info: May 13 15:46:36 volumio volumio[6106]: ---------------------------- MPD announces state update: database May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: May 13 15:46:36 volumio volumio[6106]: ---------------------------- MPD announces state update: update May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::getState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::sendMpdCommand status May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 75 milliseconds May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 75 milliseconds May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 75 milliseconds May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 74 milliseconds May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 74 milliseconds May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 75 milliseconds May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 74 milliseconds May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 74 milliseconds May 13 15:46:36 volumio volumio[6106]: info: sendMpdCommand status took 74 milliseconds May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: info: Command Router : Notfying DB Updatefalse May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::Close All Modals sent May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: info: Command Router : Notfying DB Updatefalse May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::Close All Modals sent May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: info: Command Router : Notfying DB Updatefalse May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::Close All Modals sent May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: verbose: ControllerMpd::parseState May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:36 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: No code May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:36 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: No code May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:36 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: No code May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:36 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: No code May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:36 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: No code May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: ControllerMpd::pushState May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::servicePushState May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 15:46:36 volumio volumio[6106]: verbose: CURRENT POSITION 0 May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState stateService stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::syncState currentStatus stop May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: No code May 13 15:46:36 volumio volumio[6106]: info: CoreStateMachine::pushState May 13 15:46:36 volumio volumio[6106]: info: CorePlayQueue::getTrack 0 May 13 15:46:36 volumio volumio[6106]: info: CoreCommandRouter::volumioPushState May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 488ms May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 489ms May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 486ms May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 487ms May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 485ms May 13 15:46:36 volumio volumio[6106]: info: ------------------------------ 486ms May 13 15:46:50 volumio volumio[6106]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 15:46:50 volumio volumio[6106]: Error: connect ETIMEDOUT 157.240.17.41:80 May 13 15:46:50 volumio volumio[6106]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 13 15:46:50 volumio volumio[6106]: errno: -110, May 13 15:46:50 volumio volumio[6106]: code: 'ETIMEDOUT', May 13 15:46:50 volumio volumio[6106]: syscall: 'connect', May 13 15:46:50 volumio volumio[6106]: address: '157.240.17.41', May 13 15:46:50 volumio volumio[6106]: port: 80 May 13 15:46:50 volumio volumio[6106]: } May 13 15:46:50 volumio volumio[6106]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 15:46:50 volumio sudo[6535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-13 15:45 May 13 15:46:50 volumio sudo[6535]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"