-- Logs begin at Wed 2024-05-01 04:39:49 UTC, end at Tue 2025-12-30 04:50:56 UTC. --
Dec 30 04:49:00 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:00 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:01 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:01 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:02 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:02 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Duration is 326400
Dec 30 04:49:02 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:49:02 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:49:02 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:49:02 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:02 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 3
Dec 30 04:49:03 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:03 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:04 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:04 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:05 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:05 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:06 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 68
Dec 30 04:49:06 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:07 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 68
Dec 30 04:49:07 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:08 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70
Dec 30 04:49:08 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:09 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:09 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:10 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:10 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:11 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:11 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:12 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:12 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:13 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:13 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:14 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:14 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:15 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:15 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:16 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:16 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Duration is 0
Dec 30 04:49:16 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 3
Dec 30 04:49:17 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 68
Dec 30 04:49:17 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:18 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:18 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:19 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:19 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: idle
Dec 30 04:49:19 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:49:19 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:49:19 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:49:19 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:19 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:20 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 17
Dec 30 04:49:20 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: l2cap op 2, len 16, out 0
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0002, PSM 0x0001, scid 0x0051
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: PSM(0x0001) do not need parse
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: l2cap op 3, len 20, out 1
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0044, scid 0x0051, result 0x0000
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: l2cap op 6, len 16, out 0
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0002, dcid 0x0044, scid 0x0051
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0002, dcid 0x0044, scid 0x0051, dir 0
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp busy->idle!
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 0
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0002
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19
Dec 30 04:49:21 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:22 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:22 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: stopped
Dec 30 04:49:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:49:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:49:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Duration is 326400
Dec 30 04:49:22 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 3
Dec 30 04:49:23 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:23 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:24 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:24 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:25 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:25 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:26 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:26 opera-amp150 kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 798
Dec 30 04:49:26 opera-amp150 kernel: rtk_btcoex: HID not connected, nothing to be down
Dec 30 04:49:26 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:27 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:27 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:28 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: pending
Dec 30 04:49:28 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: active
Dec 30 04:49:28 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: true
Dec 30 04:49:28 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:49:28 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioStop
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreStateMachine::stop
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 04:49:28 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:49:28 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: BLUETOOTH: Starting Playback Routine
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 0
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: HID not connected, nothing to be down
Dec 30 04:49:28 opera-amp150 volumio[966]: info: Enabling Bluetooth Audio Output
Dec 30 04:49:28 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:49:28 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:49:28 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: bluetooth
Dec 30 04:49:28 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:28 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:49:28 opera-amp150 volumio[966]: info: Bluetooth Detach Command
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreStateMachine::resetVolumioState
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreStateMachine::getcurrentVolume
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioRetrievevolume
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioStop
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreStateMachine::stop
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 04:49:28 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:49:28 opera-amp150 volumio[966]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified
Dec 30 04:49:28 opera-amp150 volumio[966]: xcb_connection_has_error() returned true
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 4
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0002
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x04
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: rtp: v 2, cc 0, pt 96
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: syncword: 9c
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: freq 44.1kHz
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: blocks 16
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: channel mode JOINT_STEREO
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: allocation method LOUDNESS
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: subbands 8
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: bitpool 53
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc51
Dec 30 04:49:28 opera-amp150 volumio[966]: info: VolumeController:: Volume=undefined Mute =false
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreStateMachine::updateTrackBlock
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CorePlayQueue::getTrackBlock
Dec 30 04:49:28 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioRetrievevolume
Dec 30 04:49:28 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:29 opera-amp150 volumio[966]: info: VolumeController:: Volume=92 Mute =false
Dec 30 04:49:29 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:49:29 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:49:29 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:49:29 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:49:29 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 35
Dec 30 04:49:29 opera-amp150 volumio[966]: info: Bluetooth Audio successfully Enabled
Dec 30 04:49:29 opera-amp150 volumio[966]: info: Bluetooth Audio successfully Disabled
Dec 30 04:49:29 opera-amp150 volumio[966]: info: Bluetooth Successfully Detached
Dec 30 04:49:29 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:49:29 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:49:29 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:49:29 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:29 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:30 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: playing
Dec 30 04:49:30 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: true
Dec 30 04:49:30 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:49:30 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:30 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioStop
Dec 30 04:49:30 opera-amp150 volumio[966]: info: CoreStateMachine::stop
Dec 30 04:49:30 opera-amp150 volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 04:49:30 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:49:30 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: BLUETOOTH: Starting Playback Routine
Dec 30 04:49:30 opera-amp150 volumio[966]: info: Enabling Bluetooth Audio Output
Dec 30 04:49:30 opera-amp150 volumio[966]: info: Bluetooth Audio successfully Enabled
Dec 30 04:49:30 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70
Dec 30 04:49:30 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:31 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Duration is 158106
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:49:31 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:31 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:49:31 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:49:31 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: bluetooth
Dec 30 04:49:31 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:49:31 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:49:31 opera-amp150 volumio[966]: info: Bluetooth Detach Command
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::resetVolumioState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::getcurrentVolume
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioRetrievevolume
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioStop
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::stop
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 04:49:31 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:49:31 opera-amp150 volumio[966]: verbose: STATE SERVICE {"status":"pause","service":"bluetooth","title":"La Califfa","artist":"Sarah Brightman","album":"Amalfi","albumart":"/albumart?cacheid=441&web=Sarah%20Brightman/Amalfi/extralarge&path=&icon=&metadata=false","uri":"","trackType":"bt","seek":41,"duration":158,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Dec 30 04:49:31 opera-amp150 volumio[966]: verbose: CURRENT POSITION 0
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::syncState stateService pause
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:49:31 opera-amp150 volumio[966]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified
Dec 30 04:49:31 opera-amp150 volumio[966]: xcb_connection_has_error() returned true
Dec 30 04:49:31 opera-amp150 volumio[966]: info: Bluetooth Audio successfully Disabled
Dec 30 04:49:31 opera-amp150 volumio[966]: info: Bluetooth Successfully Detached
Dec 30 04:49:31 opera-amp150 volumio[966]: info: VolumeController:: Volume=undefined Mute =false
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreStateMachine::updateTrackBlock
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CorePlayQueue::getTrackBlock
Dec 30 04:49:31 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioRetrievevolume
Dec 30 04:49:31 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 3
Dec 30 04:49:32 opera-amp150 volumio[966]: info: VolumeController:: Volume=92 Mute =false
Dec 30 04:49:32 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:49:32 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:49:32 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:49:32 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:49:32 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 67
Dec 30 04:49:32 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:33 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70
Dec 30 04:49:33 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:34 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70
Dec 30 04:49:34 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:35 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:35 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:36 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 67
Dec 30 04:49:36 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:37 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70
Dec 30 04:49:37 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:38 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:38 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:39 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:39 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:40 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:40 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:41 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:41 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:42 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:42 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:43 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:43 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:44 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:44 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:45 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:45 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:46 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:46 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:47 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:47 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:48 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:48 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:49 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 68
Dec 30 04:49:49 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:50 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:50 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:51 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:51 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:52 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:52 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:53 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:53 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:54 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:49:54 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:49:54 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:49:54 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:54 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:54 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:55 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:55 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 1
Dec 30 04:49:56 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Duration is 0
Dec 30 04:49:56 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:56 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 2
Dec 30 04:49:57 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:49:57 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: idle
Dec 30 04:49:57 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:58 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: stopped
Dec 30 04:49:58 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:49:58 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:49:58 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:49:58 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 5
Dec 30 04:49:58 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp busy->idle!
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 0
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0002
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19
Dec 30 04:49:59 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:00 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:00 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:01 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:01 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:02 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:02 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:03 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:03 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:04 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:04 opera-amp150 kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 798
Dec 30 04:50:04 opera-amp150 kernel: rtk_btcoex: HID not connected, nothing to be down
Dec 30 04:50:04 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:05 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:05 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:06 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:06 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:07 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:07 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:08 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:08 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:09 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:09 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:10 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:10 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:50:10 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:50:10 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:50:10 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:50:10 opera-amp150 kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 0
Dec 30 04:50:10 opera-amp150 kernel: rtk_btcoex: HID not connected, nothing to be down
Dec 30 04:50:10 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:11 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:11 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:12 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:12 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: playing
Dec 30 04:50:12 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: true
Dec 30 04:50:12 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:50:12 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:50:12 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioStop
Dec 30 04:50:12 opera-amp150 volumio[966]: info: CoreStateMachine::stop
Dec 30 04:50:12 opera-amp150 volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 04:50:12 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:50:12 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: BLUETOOTH: Starting Playback Routine
Dec 30 04:50:12 opera-amp150 volumio[966]: info: Enabling Bluetooth Audio Output
Dec 30 04:50:12 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Duration is 233000
Dec 30 04:50:12 opera-amp150 volumio[966]: info: Bluetooth Audio successfully Enabled
Dec 30 04:50:12 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:50:12 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:12 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:12 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:12 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 3
Dec 30 04:50:13 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:13 opera-amp150 volumio[966]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Dec 30 04:50:13 opera-amp150 volumio[966]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Dec 30 04:50:13 opera-amp150 volumio[966]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Dec 30 04:50:13 opera-amp150 volumio[966]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Dec 30 04:50:13 opera-amp150 volumio[966]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Dec 30 04:50:13 opera-amp150 volumio[966]: at Promise._failFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:445:13)
Dec 30 04:50:13 opera-amp150 volumio[966]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Dec 30 04:50:13 opera-amp150 volumio[966]: at _combinedTickCallback (internal/process/next_tick.js:131:7)
Dec 30 04:50:13 opera-amp150 volumio[966]: at process._tickCallback (internal/process/next_tick.js:180:9)
Dec 30 04:50:13 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:14 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:14 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:15 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:15 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:16 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:16 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:17 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:17 opera-amp150 kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 798
Dec 30 04:50:17 opera-amp150 kernel: rtk_btcoex: HID not connected, nothing to be down
Dec 30 04:50:17 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:18 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:18 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:19 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:19 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:20 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:20 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:21 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:21 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:50:21 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:50:21 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: bluetooth
Dec 30 04:50:21 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:50:21 opera-amp150 kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 0
Dec 30 04:50:21 opera-amp150 kernel: rtk_btcoex: HID not connected, nothing to be down
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:21 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:50:21 opera-amp150 volumio[966]: info: Bluetooth Detach Command
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::resetVolumioState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::getcurrentVolume
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioRetrievevolume
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioStop
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::stop
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 04:50:21 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:21 opera-amp150 volumio[966]: verbose: STATE SERVICE {"status":"pause","service":"bluetooth","title":"记得","artist":"林家谦","album":"MEMENTO - EP","albumart":"/albumart?cacheid=441&web=%E6%9E%97%E5%AE%B6%E8%B0%A6/MEMENTO%20-%20EP/extralarge&path=&icon=&metadata=false","uri":"","trackType":"bt","seek":0,"duration":233,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Dec 30 04:50:21 opera-amp150 volumio[966]: verbose: CURRENT POSITION 0
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::syncState stateService pause
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:21 opera-amp150 volumio[966]: info: Bluetooth Audio successfully Disabled
Dec 30 04:50:21 opera-amp150 volumio[966]: info: Bluetooth Successfully Detached
Dec 30 04:50:21 opera-amp150 volumio[966]: info: VolumeController:: Volume=92 Mute =false
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::updateTrackBlock
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CorePlayQueue::getTrackBlock
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioRetrievevolume
Dec 30 04:50:21 opera-amp150 volumio[966]: info: VolumeController:: Volume=92 Mute =false
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:21 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:21 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:22 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: playing
Dec 30 04:50:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: true
Dec 30 04:50:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 30 04:50:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:50:22 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioStop
Dec 30 04:50:22 opera-amp150 volumio[966]: info: CoreStateMachine::stop
Dec 30 04:50:22 opera-amp150 volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 04:50:22 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:50:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: BLUETOOTH: Starting Playback Routine
Dec 30 04:50:22 opera-amp150 volumio[966]: info: Enabling Bluetooth Audio Output
Dec 30 04:50:22 opera-amp150 volumio[966]: info: Bluetooth Audio successfully Enabled
Dec 30 04:50:22 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: pending
Dec 30 04:50:22 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: active
Dec 30 04:50:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: true
Dec 30 04:50:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: bluetooth
Dec 30 04:50:22 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:50:22 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:50:22 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:22 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:22 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 4
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0002
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x04
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: rtp: v 2, cc 0, pt 96
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: syncword: 9c
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: freq 44.1kHz
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: blocks 16
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: channel mode JOINT_STEREO
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: allocation method LOUDNESS
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: subbands 8
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: bitpool 53
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc51
Dec 30 04:50:22 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:23 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 37
Dec 30 04:50:23 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:24 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:24 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:25 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 71
Dec 30 04:50:25 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:26 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 68
Dec 30 04:50:26 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:27 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:27 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:28 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:28 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:29 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:29 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:30 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:30 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:31 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:31 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:32 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:32 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:33 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 67
Dec 30 04:50:33 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:34 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70
Dec 30 04:50:34 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:35 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:35 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:36 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:36 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:37 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:37 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:38 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:38 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:39 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:39 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:40 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:40 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:41 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:41 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:42 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:42 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:43 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 67
Dec 30 04:50:43 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:44 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 71
Dec 30 04:50:44 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:45 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 68
Dec 30 04:50:45 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:46 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:46 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:47 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:47 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:48 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:48 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:49 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:49 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:50 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:50 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:51 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:51 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: paused
Dec 30 04:50:51 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Playing: false
Dec 30 04:50:51 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: VOLATILE: bluetooth
Dec 30 04:50:51 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: STATE:undefined
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:51 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:50:51 opera-amp150 volumio[966]: info: Bluetooth Detach Command
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::resetVolumioState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::getcurrentVolume
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioRetrievevolume
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioStop
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::stop
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 04:50:51 opera-amp150 volumio[966]: verbose: UNSET VOLATILE
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:51 opera-amp150 volumio[966]: verbose: STATE SERVICE {"status":"pause","service":"bluetooth","title":"记得","artist":"林家谦","album":"MEMENTO - EP","albumart":"/albumart?cacheid=441&web=%E6%9E%97%E5%AE%B6%E8%B0%A6/MEMENTO%20-%20EP/extralarge&path=&icon=&metadata=false","uri":"","trackType":"bt","seek":0,"duration":233,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Dec 30 04:50:51 opera-amp150 volumio[966]: verbose: CURRENT POSITION 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::syncState stateService pause
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:51 opera-amp150 volumio[966]: BT PLUGIN MESSAGE: Duration is 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:51 opera-amp150 volumio[966]: verbose: STATE SERVICE {"status":"pause","service":"bluetooth","title":"unknow","artist":"unknow","album":"unknow","albumart":"/albumart?cacheid=441&web=unknow/unknow/extralarge&path=&icon=&metadata=false","uri":"","trackType":"bt","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Dec 30 04:50:51 opera-amp150 volumio[966]: verbose: CURRENT POSITION 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::syncState stateService pause
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:51 opera-amp150 volumio[966]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified
Dec 30 04:50:51 opera-amp150 volumio[966]: xcb_connection_has_error() returned true
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::servicePushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:51 opera-amp150 volumio[966]: verbose: STATE SERVICE {"status":"pause","service":"bluetooth","title":"unknow","artist":"unknow","album":"unknow","albumart":"/albumart?cacheid=441&web=unknow/unknow/extralarge&path=&icon=&metadata=false","uri":"","trackType":"bt","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Dec 30 04:50:51 opera-amp150 volumio[966]: verbose: CURRENT POSITION 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::syncState stateService pause
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:51 opera-amp150 volumio[966]: info: Bluetooth Audio successfully Disabled
Dec 30 04:50:51 opera-amp150 volumio[966]: info: Bluetooth Successfully Detached
Dec 30 04:50:51 opera-amp150 volumio[966]: info: VolumeController:: Volume=undefined Mute =false
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::updateTrackBlock
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrackBlock
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioRetrievevolume
Dec 30 04:50:51 opera-amp150 volumio[966]: info: VolumeController:: Volume=92 Mute =false
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreStateMachine::pushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioPushState
Dec 30 04:50:51 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 04:50:51 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 3
Dec 30 04:50:52 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioGetState
Dec 30 04:50:52 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:52 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:52 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioGetState
Dec 30 04:50:52 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:52 opera-amp150 sudo[2743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 30 04:50:52 opera-amp150 sudo[2745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 30 04:50:52 opera-amp150 sudo[2743]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 30 04:50:52 opera-amp150 sudo[2745]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 30 04:50:52 opera-amp150 sudo[2743]: pam_unix(sudo:session): session closed for user root
Dec 30 04:50:52 opera-amp150 sudo[2745]: pam_unix(sudo:session): session closed for user root
Dec 30 04:50:52 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:53 opera-amp150 sudo[2762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 30 04:50:53 opera-amp150 sudo[2762]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 30 04:50:53 opera-amp150 sudo[2764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 30 04:50:53 opera-amp150 sudo[2762]: pam_unix(sudo:session): session closed for user root
Dec 30 04:50:53 opera-amp150 sudo[2764]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 30 04:50:53 opera-amp150 sudo[2764]: pam_unix(sudo:session): session closed for user root
Dec 30 04:50:53 opera-amp150 volumio[966]: info: CoreCommandRouter::volumioGetState
Dec 30 04:50:53 opera-amp150 volumio[966]: info: CorePlayQueue::getTrack 0
Dec 30 04:50:53 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 30 04:50:53 opera-amp150 volumio[966]: error: Could not retrieve plugin audio_interface multiroom
Dec 30 04:50:53 opera-amp150 volumio[966]: info: Listing playlists
Dec 30 04:50:53 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 30 04:50:53 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 30 04:50:53 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 30 04:50:53 opera-amp150 volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 30 04:50:53 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:53 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:54 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69
Dec 30 04:50:54 opera-amp150 volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: idle
Dec 30 04:50:54 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:55 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 17
Dec 30 04:50:55 opera-amp150 kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0
Dec 30 04:50:56 opera-amp150 volumio[966]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 30 04:50:56 opera-amp150 volumio[966]: { Error: connect ETIMEDOUT 108.160.165.11:443
Dec 30 04:50:56 opera-amp150 volumio[966]: at Object._errnoException (util.js:1022:11)
Dec 30 04:50:56 opera-amp150 volumio[966]: at _exceptionWithHostPort (util.js:1044:20)
Dec 30 04:50:56 opera-amp150 volumio[966]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Dec 30 04:50:56 opera-amp150 volumio[966]: code: 'ETIMEDOUT',
Dec 30 04:50:56 opera-amp150 volumio[966]: errno: 'ETIMEDOUT',
Dec 30 04:50:56 opera-amp150 volumio[966]: syscall: 'connect',
Dec 30 04:50:56 opera-amp150 volumio[966]: address: '108.160.165.11',
Dec 30 04:50:56 opera-amp150 volumio[966]: port: 443 }
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp busy->idle!
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 0
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0002
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00
Dec 30 04:50:56 opera-amp150 kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19
Dec 30 04:50:56 opera-amp150 volumio[966]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 30 04:50:56 opera-amp150 sudo[2799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-30 04:49
Dec 30 04:50:56 opera-amp150 sudo[2799]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="opera"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022"
VOLUMIO_VERSION="1.033"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_VENDOR="Opera Consonance"
VOLUMIO_MODEL="X5"
VOLUMIO_VENDOR_MODEL="Opera X5"
VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"