-- Logs begin at Thu 2026-01-08 04:55:33 UTC, end at Sun 2026-08-30 05:51:53 UTC. -- Aug 30 05:51:43 opera kernel: rtk_btcoex: hci accept connreq, notify wifi page start Aug 30 05:51:43 opera kernel: rtk_btcoex: notify wifi page success end Aug 30 05:51:43 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Aug 30 05:51:43 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0001, PSM 0x0001, scid 0x1711 Aug 30 05:51:43 opera kernel: rtk_btcoex: PSM(0x0001) do not need parse Aug 30 05:51:43 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:43 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0040, scid 0x1711, result 0x0000 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0001, dcid 0x0040, scid 0x1711 Aug 30 05:51:44 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x0040, scid 0x1711, dir 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0001, PSM 0x0019, scid 0x1811 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0040, scid 0x1811, result 0x0001 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0040, scid 0x1811, result 0x0000 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap connection success, update connection Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: is_add 1, profile_index 2 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x04 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x04 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0001, PSM 0x0017, scid 0x1912 Aug 30 05:51:44 opera kernel: rtk_btcoex: PSM(0x0017) do not need parse Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0041, scid 0x1912, result 0x0001 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0041, scid 0x1912, result 0x0000 Aug 30 05:51:44 opera kernel: input: 38:E1:3D:72:21:A6 as /devices/virtual/input/input4 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0001, PSM 0x001f, scid 0x1a13 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0042, scid 0x1a13, result 0x0000 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap connection success, update connection Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: is_add 1, profile_index 3 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x0c Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00 Aug 30 05:51:44 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn req, hndl 0x0001, PSM 0x001b, scid 0x0043 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: RX l2cap conn rsp, hndl 0x0001, dcid 0x1c15, scid 0x0043, result 0x0001 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: RX l2cap conn rsp, hndl 0x0001, dcid 0x1c15, scid 0x0043, result 0x0000 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap connection success, update connection Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: is_add 1, profile_index 3 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x0c Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 2 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Aug 30 05:51:44 opera bluetoothd[867]: Browsing: Refusing unexpected connect Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0001, PSM 0x001b, scid 0x1b14 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0044, scid 0x1b14, result 0x0001 Aug 30 05:51:44 opera kernel: BUG: spinlock bad magic on CPU#1, bluetoothd/867 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: lock: 0xd700da44, .magic: 00000000, .owner: /-1, .owner_cpu: 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0044, scid 0x1b14, result 0x0003 Aug 30 05:51:44 opera kernel: CPU: 1 PID: 867 Comm: bluetoothd Not tainted 4.4.71+ #23 Aug 30 05:51:44 opera kernel: Hardware name: Rockchip (Device Tree) Aug 30 05:51:44 opera kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Aug 30 05:51:44 opera kernel: [] (show_stack) from [] (dump_stack+0x84/0xa0) Aug 30 05:51:44 opera kernel: [] (dump_stack) from [] (spin_dump+0x8c/0xa0) Aug 30 05:51:44 opera kernel: [] (spin_dump) from [] (spin_bug+0x34/0x38) Aug 30 05:51:44 opera kernel: [] (spin_bug) from [] (do_raw_spin_lock+0x30/0x1a4) Aug 30 05:51:44 opera kernel: [] (do_raw_spin_lock) from [] (_raw_spin_lock_irqsave+0x20/0x28) Aug 30 05:51:44 opera kernel: [] (_raw_spin_lock_irqsave) from [] (skb_dequeue+0x24/0x74) Aug 30 05:51:44 opera kernel: [] (skb_dequeue) from [] (skb_queue_purge+0x20/0x34) Aug 30 05:51:44 opera kernel: [] (skb_queue_purge) from [] (l2cap_chan_del+0x1e0/0x1fc) Aug 30 05:51:44 opera kernel: [] (l2cap_chan_del) from [] (l2cap_chan_close+0x18c/0x1ac) Aug 30 05:51:44 opera kernel: [] (l2cap_chan_close) from [] (l2cap_sock_shutdown+0x2a4/0x378) Aug 30 05:51:44 opera kernel: [] (l2cap_sock_shutdown) from [] (l2cap_sock_release+0x40/0x90) Aug 30 05:51:44 opera kernel: [] (l2cap_sock_release) from [] (sock_release+0x30/0xac) Aug 30 05:51:44 opera kernel: [] (sock_release) from [] (sock_close+0x1c/0x24) Aug 30 05:51:44 opera kernel: [] (sock_close) from [] (__fput+0xf8/0x1d4) Aug 30 05:51:44 opera kernel: [] (__fput) from [] (____fput+0x18/0x1c) Aug 30 05:51:44 opera kernel: [] (____fput) from [] (task_work_run+0xac/0xc0) Aug 30 05:51:44 opera kernel: [] (task_work_run) from [] (do_work_pending+0xa0/0xbc) Aug 30 05:51:44 opera kernel: [] (do_work_pending) from [] (slow_work_pending+0xc/0x20) Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0001, PSM 0x0019, scid 0x1d16 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0044, scid 0x1d16, result 0x0001 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Aug 30 05:51:44 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0001, dcid 0x0044, scid 0x1d16, result 0x0000 Aug 30 05:51:44 opera kernel: rtk_btcoex: l2cap connection success, update connection Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: is_add 1, profile_index 2 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x0c Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 2 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 2 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Aug 30 05:51:44 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Aug 30 05:51:45 opera volumio[21932]: BT PLUGIN MESSAGE: Duration is 200000 Aug 30 05:51:45 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Aug 30 05:51:45 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 19 Aug 30 05:51:45 opera kernel: rtk_btcoex: timeout_handler: pan idle->busy! Aug 30 05:51:45 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Aug 30 05:51:45 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 8 Aug 30 05:51:45 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 30 05:51:45 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 30 05:51:45 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Aug 30 05:51:45 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Aug 30 05:51:45 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x08 Aug 30 05:51:45 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 30 05:51:46 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Aug 30 05:51:46 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 2 Aug 30 05:51:46 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan busy->idle! Aug 30 05:51:46 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Aug 30 05:51:46 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 0 Aug 30 05:51:46 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 30 05:51:46 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 30 05:51:46 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Aug 30 05:51:46 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Aug 30 05:51:46 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00 Aug 30 05:51:46 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 30 05:51:47 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Aug 30 05:51:47 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Aug 30 05:51:48 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Aug 30 05:51:48 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Aug 30 05:51:49 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Aug 30 05:51:49 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Aug 30 05:51:49 opera volumio[21932]: info: VolumeController::SetAlsaVolume43 Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: Volume set to 43 Aug 30 05:51:49 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:49 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:49 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:49 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:49 opera bluetoothd[867]: /org/bluez/hci0/dev_38_E1_3D_72_21_A6/fd0: fd(23) ready Aug 30 05:51:49 opera volumio[21932]: ------------------------------------ BT MESSAGE: BT STATUS: pending Aug 30 05:51:49 opera volumio[21932]: ------------------------------------ BT MESSAGE: BT STATUS: active Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: Playing: true Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: VOLATILE: airplay_emulation Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: STATE:undefined Aug 30 05:51:49 opera volumio[21932]: info: CoreCommandRouter::volumioStop Aug 30 05:51:49 opera volumio[21932]: info: CoreStateMachine::stop Aug 30 05:51:49 opera volumio[21932]: info: CoreStateMachine::serviceStop Aug 30 05:51:49 opera volumio[21932]: info: CoreCommandRouter::serviceStop Aug 30 05:51:49 opera volumio[21932]: info: Airplay Stop Aug 30 05:51:49 opera volumio[21932]: info: Stopping Airplay Playback and sending pause command to client via USR2 Aug 30 05:51:49 opera sudo[13279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 29930 Aug 30 05:51:49 opera sudo[13279]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 05:51:49 opera sudo[13279]: pam_unix(sudo:session): session closed for user root Aug 30 05:51:49 opera shairport-sync[29930]: {"time":1788068711719,"response":"airplayActive Success"} Aug 30 05:51:49 opera systemd[1]: shairport-sync.service: main process exited, code=killed, status=12/USR2 Aug 30 05:51:49 opera systemd[1]: Unit shairport-sync.service entered failed state. Aug 30 05:51:49 opera volumio[21932]: info: Shairport-Sync paused with USR2 Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: BLUETOOTH: Starting Playback Routine Aug 30 05:51:49 opera volumio[21932]: info: Enabling Bluetooth Audio Output Aug 30 05:51:49 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Aug 30 05:51:49 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 4 Aug 30 05:51:49 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 30 05:51:49 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 30 05:51:49 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Aug 30 05:51:49 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Aug 30 05:51:49 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x04 Aug 30 05:51:49 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 30 05:51:49 opera kernel: rtk_btcoex: rtp: v 2, cc 0, pt 96 Aug 30 05:51:49 opera kernel: rtk_btcoex: syncword: 9c Aug 30 05:51:49 opera kernel: rtk_btcoex: freq 44.1kHz Aug 30 05:51:49 opera kernel: rtk_btcoex: blocks 16 Aug 30 05:51:49 opera kernel: rtk_btcoex: channel mode JOINT_STEREO Aug 30 05:51:49 opera kernel: rtk_btcoex: allocation method LOUDNESS Aug 30 05:51:49 opera kernel: rtk_btcoex: subbands 8 Aug 30 05:51:49 opera kernel: rtk_btcoex: bitpool 53 Aug 30 05:51:49 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc51 Aug 30 05:51:49 opera volumio[21932]: ------------------------------------ BT MESSAGE: BT STATUS: playing Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: Playing: true Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: VOLATILE: bluetooth Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: STATE:undefined Aug 30 05:51:49 opera volumio[21932]: BT PLUGIN MESSAGE: Duration is 0 Aug 30 05:51:49 opera volumio[21932]: info: Bluetooth Audio successfully Enabled Aug 30 05:51:50 opera volumio[21932]: BT PLUGIN MESSAGE: Duration is 173000 Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::servicePushState Aug 30 05:51:50 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:50 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::servicePushState Aug 30 05:51:50 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:50 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:50 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 51 Aug 30 05:51:50 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 8 Aug 30 05:51:50 opera kernel: rtk_btcoex: timeout_handler: pan idle->busy! Aug 30 05:51:50 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Aug 30 05:51:50 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = c Aug 30 05:51:50 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 30 05:51:50 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 30 05:51:50 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Aug 30 05:51:50 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Aug 30 05:51:50 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x0c Aug 30 05:51:50 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 30 05:51:50 opera volumio[21932]: info: Restarting Shairport-Sync after stop Aug 30 05:51:50 opera sudo[13301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 05:51:50 opera sudo[13301]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 05:51:50 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Aug 30 05:51:50 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 05:51:50 opera sudo[13301]: pam_unix(sudo:session): session closed for user root Aug 30 05:51:50 opera volumio[21932]: info: Shairport-Sync retarted Aug 30 05:51:50 opera volumio[21932]: BT PLUGIN MESSAGE: Duration is 173000 Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::servicePushState Aug 30 05:51:50 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:50 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::servicePushState Aug 30 05:51:50 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:50 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:50 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:51 opera volumio[21932]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Aug 30 05:51:51 opera volumio[21932]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Aug 30 05:51:51 opera volumio[21932]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Aug 30 05:51:51 opera volumio[21932]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Aug 30 05:51:51 opera volumio[21932]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Aug 30 05:51:51 opera volumio[21932]: at Promise._failFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:445:13) Aug 30 05:51:51 opera volumio[21932]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Aug 30 05:51:51 opera volumio[21932]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Aug 30 05:51:51 opera volumio[21932]: at process._tickCallback (internal/process/next_tick.js:180:9) Aug 30 05:51:51 opera volumio[21932]: BT PLUGIN MESSAGE: Duration is 173000 Aug 30 05:51:51 opera volumio[21932]: info: CoreCommandRouter::servicePushState Aug 30 05:51:51 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:51 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:51 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:51 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:51 opera volumio[21932]: info: CoreCommandRouter::servicePushState Aug 30 05:51:51 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:51 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:51 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:51 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:51 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69 Aug 30 05:51:51 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 7 Aug 30 05:51:52 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69 Aug 30 05:51:52 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 1 Aug 30 05:51:52 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan busy->idle! Aug 30 05:51:52 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Aug 30 05:51:52 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 4 Aug 30 05:51:52 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 30 05:51:52 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 30 05:51:52 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Aug 30 05:51:52 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Aug 30 05:51:52 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x04 Aug 30 05:51:52 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 30 05:51:52 opera volumio[21932]: BT PLUGIN MESSAGE: Duration is 173000 Aug 30 05:51:52 opera volumio[21932]: info: CoreCommandRouter::servicePushState Aug 30 05:51:52 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:52 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:52 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:52 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:52 opera volumio[21932]: info: CoreCommandRouter::servicePushState Aug 30 05:51:52 opera volumio[21932]: info: CoreStateMachine::pushState Aug 30 05:51:52 opera volumio[21932]: info: CoreCommandRouter::volumioPushState Aug 30 05:51:52 opera volumio[21932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 05:51:52 opera volumio[21932]: info: Updating RAAT Signal Path Aug 30 05:51:53 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 68 Aug 30 05:51:53 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Aug 30 05:51:53 opera volumio[21932]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 05:51:53 opera volumio[21932]: { Error: connect ETIMEDOUT 74.86.12.173:443 Aug 30 05:51:53 opera volumio[21932]: at Object._errnoException (util.js:1022:11) Aug 30 05:51:53 opera volumio[21932]: at _exceptionWithHostPort (util.js:1044:20) Aug 30 05:51:53 opera volumio[21932]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Aug 30 05:51:53 opera volumio[21932]: code: 'ETIMEDOUT', Aug 30 05:51:53 opera volumio[21932]: errno: 'ETIMEDOUT', Aug 30 05:51:53 opera volumio[21932]: syscall: 'connect', Aug 30 05:51:53 opera volumio[21932]: address: '74.86.12.173', Aug 30 05:51:53 opera volumio[21932]: port: 443 } Aug 30 05:51:53 opera volumio[21932]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 05:51:53 opera sudo[13334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-30 05:50 Aug 30 05:51:53 opera sudo[13334]: 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"