root@aismap:/opt/aismapv2# AIS_BLE_BROADCAST_ENCODING=msgpack 
root@aismap:/opt/aismapv2# systemctl restart ble-gatt.service 
root@aismap:/opt/aismapv2# journalctl -u ble-gatt.service -f
Journal file /var/log/journal/5dcf904c44344fed93689949d7018827/system@00a94b2b966748b6a2f50a7b3948cb43-000000000000151e-0006501c00a6f34a.journal is truncated, ignoring file.
Apr 24 10:56:54 aismap python3[25757]: [2026-04-24 10:56:54.749] [INFO]    Возвращаем 4 объектов (сервисы + характеристики)
Apr 24 10:56:54 aismap python3[25757]: [2026-04-24 10:56:54.799] [INFO] ✅ GATT Application зарегистрирован успешно
Apr 24 10:56:54 aismap python3[25757]: [2026-04-24 10:56:54.822] [INFO] [Advertisement] GetAll вызван для интерфейса: org.bluez.LEAdvertisement1
Apr 24 10:56:54 aismap python3[25757]: [2026-04-24 10:56:54.829] [INFO] [Advertisement] Возвращаем свойства рекламы:
Apr 24 10:56:54 aismap python3[25757]: [2026-04-24 10:56:54.834] [INFO]   Type: peripheral
Apr 24 10:56:54 aismap python3[25757]: [2026-04-24 10:56:54.836] [INFO]   LocalName: AIS
Apr 24 10:56:54 aismap python3[25757]: [2026-04-24 10:56:54.836] [INFO]   ServiceUUIDs: 1 сервисов
Apr 24 10:56:54 aismap python3[25757]: [2026-04-24 10:56:54.844] [INFO] ✅ Advertisement зарегистрирован успешно - устройство должно быть видно при сканировании
Apr 24 10:56:56 aismap python3[25757]: [2026-04-24 10:56:56.656] [INFO] [ais_hub] WS connecting: ws://127.0.0.1:8081/ws
Apr 24 10:56:56 aismap python3[25757]: [2026-04-24 10:56:56.668] [INFO] [ais_hub] WS connected
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.488] [INFO] [DATA] StartNotify (CCCD enabled)
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.716] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=95 preview=7b22636d64223a2268656c6c6f222c22636c69656e74223a22616e64726f6964...(+63B)
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.717] [INFO] [CONTROL] cmd=hello device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'hello', 'client': 'android', 'app_version': '1.0', 'proto': 1, 'encodings': ['msgpack', 'json']}
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.720] [DEBUG] [BCAST] paced emit #1 qdepth=1 dropped=0 gap_ms=8.0
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.722] [DEBUG] [DATA] notify broadcast sent=1 bytes=130 preview=010101000000020078007b226f6b223a747275652c2270726f746f223a312c22...(+98B)
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.730] [DEBUG] [BCAST] paced emit #2 qdepth=0 dropped=0 gap_ms=8.0
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.732] [DEBUG] [DATA] notify broadcast sent=2 bytes=102 preview=01010100010002005c00652c226c6976655f6576656e7473223a747275652c22...(+70B)
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.789] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=80 preview=7b22636d64223a226765745f736e617073686f74222c22696e636c756465223a...(+48B)
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.790] [INFO] [CONTROL] cmd=get_snapshot device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'get_snapshot', 'include': ['ownship', 'vessels', 'stats'], 'max_vessels': 500}
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.794] [DEBUG] [SNAPSHOT] waiting broadcast lock sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE snapshot_id=1
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.795] [DEBUG] [SNAPSHOT] acquired broadcast lock sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.865] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=80 preview=7b22636d64223a226765745f736e617073686f74222c22696e636c756465223a...(+48B)
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.866] [INFO] [CONTROL] cmd=get_snapshot device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'get_snapshot', 'include': ['ownship', 'vessels', 'stats'], 'max_vessels': 500}
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.867] [DEBUG] [DATA] broadcast frames=1 msg_type=0x07 msg_id=2 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.868] [DEBUG] [BCAST] paced emit #3 qdepth=0 dropped=0 gap_ms=8.0
Apr 24 11:03:03 aismap python3[25757]: [2026-04-24 11:03:03.870] [DEBUG] [DATA] notify broadcast sent=3 bytes=75 preview=010702000000010041007b22636f6465223a22736e617073686f745f62757379...(+43B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.067] [DEBUG] [DATA] broadcast frames=1 msg_type=0x02 msg_id=3 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.070] [DEBUG] [SNAPSHOT] vessels progress sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE sent=360/500 seq=10 bcast_q=1
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.071] [DEBUG] [DATA] broadcast frames=2 msg_type=0x03 msg_id=4 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.074] [DEBUG] [BCAST] paced emit #4 qdepth=2 dropped=0 gap_ms=8.0
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.073] [INFO] [SNAPSHOT] done sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE snapshot_id=1 vessels=500 bcast_dropped=0
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.075] [DEBUG] [DATA] broadcast frames=6 msg_type=0x03 msg_id=5 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.084] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=6 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.085] [DEBUG] [BCAST] paced emit #5 qdepth=124 dropped=0 gap_ms=8.0
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.093] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=7 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.101] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=8 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.107] [DEBUG] [BCAST] paced emit #6 qdepth=357 dropped=0 gap_ms=8.0
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.110] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=9 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.118] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=10 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.124] [DEBUG] [BCAST] paced emit #7 qdepth=590 dropped=0 gap_ms=8.0
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.127] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=11 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.136] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=12 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.137] [DEBUG] [BCAST] paced emit #8 qdepth=823 dropped=0 gap_ms=8.0
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.148] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=13 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.150] [DEBUG] [BCAST] paced emit #9 qdepth=939 dropped=0 gap_ms=8.0
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.158] [DEBUG] [DATA] broadcast frames=116 msg_type=0x03 msg_id=14 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.166] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=15 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.173] [DEBUG] [BCAST] paced emit #10 qdepth=1174 dropped=0 gap_ms=8.0
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.175] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=16 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.183] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=17 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.188] [DEBUG] [DATA] broadcast frames=59 msg_type=0x03 msg_id=18 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.189] [DEBUG] [DATA] broadcast frames=1 msg_type=0x04 msg_id=19 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.191] [DEBUG] [DATA] notify broadcast sent=4 bytes=122 preview=010203000000010070007b22736e617073686f745f6964223a312c2273656374...(+90B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.193] [DEBUG] [DATA] notify broadcast sent=5 bytes=190 preview=0103040000000200b4007b22736e617073686f745f6964223a312c2273656374...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.194] [DEBUG] [DATA] notify broadcast sent=6 bytes=47 preview=01030400010002002500785f7175616c697479223a332c2273617473223a6e75...(+15B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.196] [DEBUG] [DATA] notify broadcast sent=7 bytes=190 preview=0103050000000600b4007b22736e617073686f745f6964223a312c2273656374...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.200] [DEBUG] [DATA] notify broadcast sent=8 bytes=190 preview=0103050001000600b400636865725f727373695f646174616772616d73223a31...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.202] [DEBUG] [DATA] notify broadcast sent=9 bytes=190 preview=0103050002000600b4006f727473223a363936362c226169735f6d73675f3234...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.212] [DEBUG] [DATA] notify broadcast sent=10 bytes=190 preview=0103050003000600b400616d73223a31323031352c2273746174655f736c6f74...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.214] [DEBUG] [DATA] notify broadcast sent=11 bytes=190 preview=0103050004000600b40065735f677073223a393531342c226770735f66697865...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.215] [DEBUG] [DATA] notify broadcast sent=12 bytes=68 preview=01030500050006003a00735f6d73675f32223a332c226169735f6d73675f3139...(+36B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.218] [DEBUG] [DATA] notify broadcast sent=13 bytes=190 preview=0103060000007500b4007b22736e617073686f745f6964223a312c2273656374...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.229] [DEBUG] [DATA] notify broadcast sent=14 bytes=190 preview=0103060001007500b400382c2264223a31387d2c22766f79616765223a7b2265...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.233] [DEBUG] [DATA] notify broadcast sent=15 bytes=190 preview=0103060002007500b400616c223a7b226c6173745f6462223a6e756c6c2c226c...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.240] [DEBUG] [DATA] notify broadcast sent=16 bytes=190 preview=0103060003007500b400703a302e302e302e303a353030353a3139322e313638...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.244] [DEBUG] [DATA] notify broadcast sent=17 bytes=190 preview=0103060004007500b40061223a6e756c6c2c2264726175676874223a6e756c6c...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.251] [DEBUG] [DATA] notify broadcast sent=18 bytes=190 preview=0103060005007500b4006173745f7473223a6e756c6c2c226c6173745f736c6f...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.259] [DEBUG] [DATA] notify broadcast sent=19 bytes=190 preview=0103060006007500b4002e32322e3230225d2c226d73675f7479706573223a5b...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.268] [DEBUG] [DATA] notify broadcast sent=20 bytes=190 preview=0103060007007500b4006c2c2264657374696e6174696f6e223a6e756c6c7d2c...(+158B)
Apr 24 11:03:05 aismap python3[25757]: [2026-04-24 11:03:05.794] [DEBUG] [DATA] notify broadcast sent=200 bytes=190 preview=0103070046007500b4006c6c2c2264726175676874223a6e756c6c2c22646573...(+158B)
Apr 24 11:03:06 aismap python3[25757]: [2026-04-24 11:03:06.264] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=78 preview=7b22636d64223a22737562736372696265222c226576656e7473223a5b226f77...(+46B)
Apr 24 11:03:06 aismap python3[25757]: [2026-04-24 11:03:06.266] [INFO] [CONTROL] cmd=subscribe device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'subscribe', 'events': ['ownship.update', 'target.update', 'stats.update']}
Apr 24 11:03:06 aismap python3[25757]: [2026-04-24 11:03:06.268] [DEBUG] [DATA] broadcast frames=1 msg_type=0x06 msg_id=20 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:07 aismap python3[25757]: [2026-04-24 11:03:07.403] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:07 aismap python3[25757]: [2026-04-24 11:03:07.499] [DEBUG] [DATA] notify broadcast sent=400 bytes=190 preview=0103090024007500b4006963223a7b226c6174223a6e756c6c2c226c6f6e223a...(+158B)
Apr 24 11:03:08 aismap python3[25757]: [2026-04-24 11:03:08.349] [DEBUG] [BCAST] paced emit #500 qdepth=982 dropped=0 gap_ms=8.0
Apr 24 11:03:09 aismap python3[25757]: [2026-04-24 11:03:09.200] [DEBUG] [DATA] notify broadcast sent=600 bytes=190 preview=01030b0002007500b400745f6462223a6e756c6c2c226c6173745f7473223a6e...(+158B)
Apr 24 11:03:10 aismap python3[25757]: [2026-04-24 11:03:10.896] [DEBUG] [DATA] notify broadcast sent=800 bytes=190 preview=01030c0055007500b400322c2264696d73223a7b2261223a372c2262223a3132...(+158B)
Apr 24 11:03:12 aismap python3[25757]: [2026-04-24 11:03:12.421] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:12 aismap python3[25757]: [2026-04-24 11:03:12.600] [DEBUG] [BCAST] paced emit #1000 qdepth=488 dropped=0 gap_ms=8.0
Apr 24 11:03:12 aismap python3[25757]: [2026-04-24 11:03:12.602] [DEBUG] [DATA] notify broadcast sent=1000 bytes=190 preview=01030e0033007400b400676e616c223a7b226c6173745f6462223a6e756c6c2c...(+158B)
Apr 24 11:03:14 aismap python3[25757]: [2026-04-24 11:03:14.325] [DEBUG] [DATA] notify broadcast sent=1200 bytes=190 preview=0103100012007500b400393036222c22696d6f223a6e756c6c2c22736869705f...(+158B)
Apr 24 11:03:16 aismap python3[25757]: [2026-04-24 11:03:16.033] [DEBUG] [DATA] notify broadcast sent=1400 bytes=190 preview=0103110065007500b4006c6c2c226c6173745f6368616e6e656c223a6e756c6c...(+158B)
Apr 24 11:03:16 aismap python3[25757]: [2026-04-24 11:03:16.952] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=78 preview=7b22636d64223a22737562736372696265222c226576656e7473223a5b226f77...(+46B)
Apr 24 11:03:16 aismap python3[25757]: [2026-04-24 11:03:16.953] [INFO] [CONTROL] cmd=subscribe device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'subscribe', 'events': ['ownship.update', 'target.update', 'stats.update']}
Apr 24 11:03:16 aismap python3[25757]: [2026-04-24 11:03:16.954] [DEBUG] [DATA] broadcast frames=1 msg_type=0x06 msg_id=21 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:17 aismap python3[25757]: [2026-04-24 11:03:17.425] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:22 aismap python3[25757]: [2026-04-24 11:03:22.440] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:22 aismap python3[25757]: [2026-04-24 11:03:22.476] [DEBUG] [BCAST] paced emit #1500 qdepth=1 dropped=0 gap_ms=8.0
Apr 24 11:03:27 aismap python3[25757]: [2026-04-24 11:03:27.461] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:32 aismap python3[25757]: [2026-04-24 11:03:32.482] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:33 aismap python3[25757]: [2026-04-24 11:03:33.526] [INFO] [BlueZ] Device disconnected: /org/bluez/hci0/dev_4B_4E_32_24_64_CE -> removing session
Apr 24 11:03:33 aismap python3[25757]: [2026-04-24 11:03:33.527] [INFO] [BlueZ] sessions now: 0
Apr 24 11:03:33 aismap python3[25757]: [2026-04-24 11:03:33.528] [INFO] [DATA] StopNotify (CCCD disabled)
Apr 24 11:03:34 aismap python3[25757]: [2026-04-24 11:03:34.867] [INFO] [BlueZ] Device connected: /org/bluez/hci0/dev_4B_4E_32_24_64_CE sessions=0
Apr 24 11:03:36 aismap python3[25757]: [2026-04-24 11:03:36.937] [INFO] [DATA] StartNotify (CCCD enabled)
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.127] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=95 preview=7b22636d64223a2268656c6c6f222c22636c69656e74223a22616e64726f6964...(+63B)
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.128] [INFO] [CONTROL] cmd=hello device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'hello', 'client': 'android', 'app_version': '1.0', 'proto': 1, 'encodings': ['msgpack', 'json']}
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.202] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=80 preview=7b22636d64223a226765745f736e617073686f74222c22696e636c756465223a...(+48B)
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.203] [INFO] [CONTROL] cmd=get_snapshot device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'get_snapshot', 'include': ['ownship', 'vessels', 'stats'], 'max_vessels': 500}
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.204] [DEBUG] [SNAPSHOT] waiting broadcast lock sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE snapshot_id=1
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.206] [DEBUG] [SNAPSHOT] acquired broadcast lock sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.277] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=80 preview=7b22636d64223a226765745f736e617073686f74222c22696e636c756465223a...(+48B)
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.278] [INFO] [CONTROL] cmd=get_snapshot device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'get_snapshot', 'include': ['ownship', 'vessels', 'stats'], 'max_vessels': 500}
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.279] [DEBUG] [DATA] broadcast frames=1 msg_type=0x07 msg_id=2 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.460] [DEBUG] [DATA] broadcast frames=1 msg_type=0x02 msg_id=3 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.462] [DEBUG] [SNAPSHOT] vessels progress sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE sent=360/500 seq=10 bcast_q=1
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.464] [DEBUG] [DATA] broadcast frames=2 msg_type=0x03 msg_id=4 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.465] [INFO] [SNAPSHOT] done sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE snapshot_id=1 vessels=500 bcast_dropped=0
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.468] [DEBUG] [DATA] broadcast frames=6 msg_type=0x03 msg_id=5 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.475] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=6 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.483] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=7 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.492] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=8 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.504] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=9 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.508] [DEBUG] [FANOUT] suppress ev_type=stats.update during active snapshot sessions=1
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.517] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=10 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.525] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=11 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.534] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=12 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.542] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=13 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.550] [DEBUG] [DATA] broadcast frames=116 msg_type=0x03 msg_id=14 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.559] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=15 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.567] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=16 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.576] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=17 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.580] [DEBUG] [DATA] broadcast frames=59 msg_type=0x03 msg_id=18 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.581] [DEBUG] [DATA] broadcast frames=1 msg_type=0x04 msg_id=19 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:38 aismap python3[25757]: [2026-04-24 11:03:38.220] [DEBUG] [DATA] notify broadcast sent=1600 bytes=190 preview=010306004a007500b400796e616d6963223a7b226c6174223a36322e35393439...(+158B)
Apr 24 11:03:39 aismap python3[25757]: [2026-04-24 11:03:39.198] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=78 preview=7b22636d64223a22737562736372696265222c226576656e7473223a5b226f77...(+46B)
Apr 24 11:03:39 aismap python3[25757]: [2026-04-24 11:03:39.199] [INFO] [CONTROL] cmd=subscribe device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'subscribe', 'events': ['ownship.update', 'target.update', 'stats.update']}
Apr 24 11:03:39 aismap python3[25757]: [2026-04-24 11:03:39.200] [DEBUG] [DATA] broadcast frames=1 msg_type=0x06 msg_id=20 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:39 aismap python3[25757]: [2026-04-24 11:03:39.916] [DEBUG] [DATA] notify broadcast sent=1800 bytes=190 preview=0103080028007500b40074223a2d312e307d2c227369676e616c223a7b226c61...(+158B)
Apr 24 11:03:41 aismap python3[25757]: [2026-04-24 11:03:41.613] [DEBUG] [BCAST] paced emit #2000 qdepth=989 dropped=0 gap_ms=8.0
Apr 24 11:03:41 aismap python3[25757]: [2026-04-24 11:03:41.615] [DEBUG] [DATA] notify broadcast sent=2000 bytes=190 preview=01030a0006007500b400353a3139322e3136382e32322e3230225d2c226d7367...(+158B)
Apr 24 11:03:42 aismap python3[25757]: [2026-04-24 11:03:42.520] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:43 aismap python3[25757]: [2026-04-24 11:03:43.316] [DEBUG] [DATA] notify broadcast sent=2200 bytes=190 preview=01030b0059007500b4007374617469635f7473223a302e302c226c6173745f64...(+158B)
Apr 24 11:03:45 aismap python3[25757]: [2026-04-24 11:03:45.012] [DEBUG] [DATA] notify broadcast sent=2400 bytes=190 preview=01030d0037007500b4005f7473223a302e302c226c6173745f7365656e223a31...(+158B)
Apr 24 11:03:45 aismap python3[25757]: [2026-04-24 11:03:45.862] [DEBUG] [BCAST] paced emit #2500 qdepth=495 dropped=0 gap_ms=8.0
Apr 24 11:03:46 aismap python3[25757]: [2026-04-24 11:03:46.717] [DEBUG] [DATA] notify broadcast sent=2600 bytes=190 preview=01030f0016007500b400383031392c22736f67223a302e302c22636f67223a33...(+158B)
Apr 24 11:03:47 aismap python3[25757]: [2026-04-24 11:03:47.547] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:48 aismap python3[25757]: [2026-04-24 11:03:48.449] [DEBUG] [DATA] notify broadcast sent=2800 bytes=190 preview=0103100069007500b400223a337d2c22766f79616765223a7b22657461223a6e...(+158B)
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.147] [DEBUG] [BCAST] paced emit #3000 qdepth=1 dropped=0 gap_ms=8.0
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.150] [DEBUG] [DATA] notify broadcast sent=3000 bytes=190 preview=0105000004000600b4003531342c226770735f6669786573223a363334332c22...(+158B)
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.251] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=78 preview=7b22636d64223a22737562736372696265222c226576656e7473223a5b226f77...(+46B)
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.252] [INFO] [CONTROL] cmd=subscribe device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'subscribe', 'events': ['ownship.update', 'target.update', 'stats.update']}
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.253] [DEBUG] [DATA] broadcast frames=1 msg_type=0x06 msg_id=21 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:52 aismap python3[25757]: [2026-04-24 11:03:52.559] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:57 aismap python3[25757]: [2026-04-24 11:03:57.580] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:04:02 aismap python3[25757]: [2026-04-24 11:04:02.601] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:04:07 aismap python3[25757]: [2026-04-24 11:04:07.617] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:04:10 aismap python3[25757]: [2026-04-24 11:04:10.952] [INFO] [BlueZ] Device disconnected: /org/bluez/hci0/dev_4B_4E_32_24_64_CE -> removing session
Apr 24 11:04:10 aismap python3[25757]: [2026-04-24 11:04:10.953] [INFO] [BlueZ] sessions now: 0
Apr 24 11:04:10 aismap python3[25757]: [2026-04-24 11:04:10.955] [INFO] [DATA] StopNotify (CCCD disabled)
^C
root@aismap:/opt/aismapv2# journalctl -u ble-gatt.service -n 100 --no-pager
Journal file /var/log/journal/5dcf904c44344fed93689949d7018827/system@00a94b2b966748b6a2f50a7b3948cb43-000000000000151e-0006501c00a6f34a.journal is truncated, ignoring file.
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.189] [DEBUG] [DATA] broadcast frames=1 msg_type=0x04 msg_id=19 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.191] [DEBUG] [DATA] notify broadcast sent=4 bytes=122 preview=010203000000010070007b22736e617073686f745f6964223a312c2273656374...(+90B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.193] [DEBUG] [DATA] notify broadcast sent=5 bytes=190 preview=0103040000000200b4007b22736e617073686f745f6964223a312c2273656374...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.194] [DEBUG] [DATA] notify broadcast sent=6 bytes=47 preview=01030400010002002500785f7175616c697479223a332c2273617473223a6e75...(+15B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.196] [DEBUG] [DATA] notify broadcast sent=7 bytes=190 preview=0103050000000600b4007b22736e617073686f745f6964223a312c2273656374...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.200] [DEBUG] [DATA] notify broadcast sent=8 bytes=190 preview=0103050001000600b400636865725f727373695f646174616772616d73223a31...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.202] [DEBUG] [DATA] notify broadcast sent=9 bytes=190 preview=0103050002000600b4006f727473223a363936362c226169735f6d73675f3234...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.212] [DEBUG] [DATA] notify broadcast sent=10 bytes=190 preview=0103050003000600b400616d73223a31323031352c2273746174655f736c6f74...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.214] [DEBUG] [DATA] notify broadcast sent=11 bytes=190 preview=0103050004000600b40065735f677073223a393531342c226770735f66697865...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.215] [DEBUG] [DATA] notify broadcast sent=12 bytes=68 preview=01030500050006003a00735f6d73675f32223a332c226169735f6d73675f3139...(+36B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.218] [DEBUG] [DATA] notify broadcast sent=13 bytes=190 preview=0103060000007500b4007b22736e617073686f745f6964223a312c2273656374...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.229] [DEBUG] [DATA] notify broadcast sent=14 bytes=190 preview=0103060001007500b400382c2264223a31387d2c22766f79616765223a7b2265...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.233] [DEBUG] [DATA] notify broadcast sent=15 bytes=190 preview=0103060002007500b400616c223a7b226c6173745f6462223a6e756c6c2c226c...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.240] [DEBUG] [DATA] notify broadcast sent=16 bytes=190 preview=0103060003007500b400703a302e302e302e303a353030353a3139322e313638...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.244] [DEBUG] [DATA] notify broadcast sent=17 bytes=190 preview=0103060004007500b40061223a6e756c6c2c2264726175676874223a6e756c6c...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.251] [DEBUG] [DATA] notify broadcast sent=18 bytes=190 preview=0103060005007500b4006173745f7473223a6e756c6c2c226c6173745f736c6f...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.259] [DEBUG] [DATA] notify broadcast sent=19 bytes=190 preview=0103060006007500b4002e32322e3230225d2c226d73675f7479706573223a5b...(+158B)
Apr 24 11:03:04 aismap python3[25757]: [2026-04-24 11:03:04.268] [DEBUG] [DATA] notify broadcast sent=20 bytes=190 preview=0103060007007500b4006c2c2264657374696e6174696f6e223a6e756c6c7d2c...(+158B)
Apr 24 11:03:05 aismap python3[25757]: [2026-04-24 11:03:05.794] [DEBUG] [DATA] notify broadcast sent=200 bytes=190 preview=0103070046007500b4006c6c2c2264726175676874223a6e756c6c2c22646573...(+158B)
Apr 24 11:03:06 aismap python3[25757]: [2026-04-24 11:03:06.264] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=78 preview=7b22636d64223a22737562736372696265222c226576656e7473223a5b226f77...(+46B)
Apr 24 11:03:06 aismap python3[25757]: [2026-04-24 11:03:06.266] [INFO] [CONTROL] cmd=subscribe device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'subscribe', 'events': ['ownship.update', 'target.update', 'stats.update']}
Apr 24 11:03:06 aismap python3[25757]: [2026-04-24 11:03:06.268] [DEBUG] [DATA] broadcast frames=1 msg_type=0x06 msg_id=20 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:07 aismap python3[25757]: [2026-04-24 11:03:07.403] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:07 aismap python3[25757]: [2026-04-24 11:03:07.499] [DEBUG] [DATA] notify broadcast sent=400 bytes=190 preview=0103090024007500b4006963223a7b226c6174223a6e756c6c2c226c6f6e223a...(+158B)
Apr 24 11:03:08 aismap python3[25757]: [2026-04-24 11:03:08.349] [DEBUG] [BCAST] paced emit #500 qdepth=982 dropped=0 gap_ms=8.0
Apr 24 11:03:09 aismap python3[25757]: [2026-04-24 11:03:09.200] [DEBUG] [DATA] notify broadcast sent=600 bytes=190 preview=01030b0002007500b400745f6462223a6e756c6c2c226c6173745f7473223a6e...(+158B)
Apr 24 11:03:10 aismap python3[25757]: [2026-04-24 11:03:10.896] [DEBUG] [DATA] notify broadcast sent=800 bytes=190 preview=01030c0055007500b400322c2264696d73223a7b2261223a372c2262223a3132...(+158B)
Apr 24 11:03:12 aismap python3[25757]: [2026-04-24 11:03:12.421] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:12 aismap python3[25757]: [2026-04-24 11:03:12.600] [DEBUG] [BCAST] paced emit #1000 qdepth=488 dropped=0 gap_ms=8.0
Apr 24 11:03:12 aismap python3[25757]: [2026-04-24 11:03:12.602] [DEBUG] [DATA] notify broadcast sent=1000 bytes=190 preview=01030e0033007400b400676e616c223a7b226c6173745f6462223a6e756c6c2c...(+158B)
Apr 24 11:03:14 aismap python3[25757]: [2026-04-24 11:03:14.325] [DEBUG] [DATA] notify broadcast sent=1200 bytes=190 preview=0103100012007500b400393036222c22696d6f223a6e756c6c2c22736869705f...(+158B)
Apr 24 11:03:16 aismap python3[25757]: [2026-04-24 11:03:16.033] [DEBUG] [DATA] notify broadcast sent=1400 bytes=190 preview=0103110065007500b4006c6c2c226c6173745f6368616e6e656c223a6e756c6c...(+158B)
Apr 24 11:03:16 aismap python3[25757]: [2026-04-24 11:03:16.952] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=78 preview=7b22636d64223a22737562736372696265222c226576656e7473223a5b226f77...(+46B)
Apr 24 11:03:16 aismap python3[25757]: [2026-04-24 11:03:16.953] [INFO] [CONTROL] cmd=subscribe device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'subscribe', 'events': ['ownship.update', 'target.update', 'stats.update']}
Apr 24 11:03:16 aismap python3[25757]: [2026-04-24 11:03:16.954] [DEBUG] [DATA] broadcast frames=1 msg_type=0x06 msg_id=21 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:17 aismap python3[25757]: [2026-04-24 11:03:17.425] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:22 aismap python3[25757]: [2026-04-24 11:03:22.440] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:22 aismap python3[25757]: [2026-04-24 11:03:22.476] [DEBUG] [BCAST] paced emit #1500 qdepth=1 dropped=0 gap_ms=8.0
Apr 24 11:03:27 aismap python3[25757]: [2026-04-24 11:03:27.461] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:32 aismap python3[25757]: [2026-04-24 11:03:32.482] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:33 aismap python3[25757]: [2026-04-24 11:03:33.526] [INFO] [BlueZ] Device disconnected: /org/bluez/hci0/dev_4B_4E_32_24_64_CE -> removing session
Apr 24 11:03:33 aismap python3[25757]: [2026-04-24 11:03:33.527] [INFO] [BlueZ] sessions now: 0
Apr 24 11:03:33 aismap python3[25757]: [2026-04-24 11:03:33.528] [INFO] [DATA] StopNotify (CCCD disabled)
Apr 24 11:03:34 aismap python3[25757]: [2026-04-24 11:03:34.867] [INFO] [BlueZ] Device connected: /org/bluez/hci0/dev_4B_4E_32_24_64_CE sessions=0
Apr 24 11:03:36 aismap python3[25757]: [2026-04-24 11:03:36.937] [INFO] [DATA] StartNotify (CCCD enabled)
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.127] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=95 preview=7b22636d64223a2268656c6c6f222c22636c69656e74223a22616e64726f6964...(+63B)
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.128] [INFO] [CONTROL] cmd=hello device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'hello', 'client': 'android', 'app_version': '1.0', 'proto': 1, 'encodings': ['msgpack', 'json']}
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.202] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=80 preview=7b22636d64223a226765745f736e617073686f74222c22696e636c756465223a...(+48B)
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.203] [INFO] [CONTROL] cmd=get_snapshot device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'get_snapshot', 'include': ['ownship', 'vessels', 'stats'], 'max_vessels': 500}
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.204] [DEBUG] [SNAPSHOT] waiting broadcast lock sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE snapshot_id=1
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.206] [DEBUG] [SNAPSHOT] acquired broadcast lock sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.277] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=80 preview=7b22636d64223a226765745f736e617073686f74222c22696e636c756465223a...(+48B)
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.278] [INFO] [CONTROL] cmd=get_snapshot device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'get_snapshot', 'include': ['ownship', 'vessels', 'stats'], 'max_vessels': 500}
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.279] [DEBUG] [DATA] broadcast frames=1 msg_type=0x07 msg_id=2 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.460] [DEBUG] [DATA] broadcast frames=1 msg_type=0x02 msg_id=3 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.462] [DEBUG] [SNAPSHOT] vessels progress sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE sent=360/500 seq=10 bcast_q=1
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.464] [DEBUG] [DATA] broadcast frames=2 msg_type=0x03 msg_id=4 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.465] [INFO] [SNAPSHOT] done sess=/org/bluez/hci0/dev_4B_4E_32_24_64_CE snapshot_id=1 vessels=500 bcast_dropped=0
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.468] [DEBUG] [DATA] broadcast frames=6 msg_type=0x03 msg_id=5 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.475] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=6 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.483] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=7 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.492] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=8 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.504] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=9 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.508] [DEBUG] [FANOUT] suppress ev_type=stats.update during active snapshot sessions=1
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.517] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=10 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.525] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=11 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.534] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=12 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.542] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=13 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.550] [DEBUG] [DATA] broadcast frames=116 msg_type=0x03 msg_id=14 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.559] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=15 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.567] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=16 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.576] [DEBUG] [DATA] broadcast frames=117 msg_type=0x03 msg_id=17 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.580] [DEBUG] [DATA] broadcast frames=59 msg_type=0x03 msg_id=18 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:37 aismap python3[25757]: [2026-04-24 11:03:37.581] [DEBUG] [DATA] broadcast frames=1 msg_type=0x04 msg_id=19 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:38 aismap python3[25757]: [2026-04-24 11:03:38.220] [DEBUG] [DATA] notify broadcast sent=1600 bytes=190 preview=010306004a007500b400796e616d6963223a7b226c6174223a36322e35393439...(+158B)
Apr 24 11:03:39 aismap python3[25757]: [2026-04-24 11:03:39.198] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=78 preview=7b22636d64223a22737562736372696265222c226576656e7473223a5b226f77...(+46B)
Apr 24 11:03:39 aismap python3[25757]: [2026-04-24 11:03:39.199] [INFO] [CONTROL] cmd=subscribe device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'subscribe', 'events': ['ownship.update', 'target.update', 'stats.update']}
Apr 24 11:03:39 aismap python3[25757]: [2026-04-24 11:03:39.200] [DEBUG] [DATA] broadcast frames=1 msg_type=0x06 msg_id=20 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:39 aismap python3[25757]: [2026-04-24 11:03:39.916] [DEBUG] [DATA] notify broadcast sent=1800 bytes=190 preview=0103080028007500b40074223a2d312e307d2c227369676e616c223a7b226c61...(+158B)
Apr 24 11:03:41 aismap python3[25757]: [2026-04-24 11:03:41.613] [DEBUG] [BCAST] paced emit #2000 qdepth=989 dropped=0 gap_ms=8.0
Apr 24 11:03:41 aismap python3[25757]: [2026-04-24 11:03:41.615] [DEBUG] [DATA] notify broadcast sent=2000 bytes=190 preview=01030a0006007500b400353a3139322e3136382e32322e3230225d2c226d7367...(+158B)
Apr 24 11:03:42 aismap python3[25757]: [2026-04-24 11:03:42.520] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:43 aismap python3[25757]: [2026-04-24 11:03:43.316] [DEBUG] [DATA] notify broadcast sent=2200 bytes=190 preview=01030b0059007500b4007374617469635f7473223a302e302c226c6173745f64...(+158B)
Apr 24 11:03:45 aismap python3[25757]: [2026-04-24 11:03:45.012] [DEBUG] [DATA] notify broadcast sent=2400 bytes=190 preview=01030d0037007500b4005f7473223a302e302c226c6173745f7365656e223a31...(+158B)
Apr 24 11:03:45 aismap python3[25757]: [2026-04-24 11:03:45.862] [DEBUG] [BCAST] paced emit #2500 qdepth=495 dropped=0 gap_ms=8.0
Apr 24 11:03:46 aismap python3[25757]: [2026-04-24 11:03:46.717] [DEBUG] [DATA] notify broadcast sent=2600 bytes=190 preview=01030f0016007500b400383031392c22736f67223a302e302c22636f67223a33...(+158B)
Apr 24 11:03:47 aismap python3[25757]: [2026-04-24 11:03:47.547] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:48 aismap python3[25757]: [2026-04-24 11:03:48.449] [DEBUG] [DATA] notify broadcast sent=2800 bytes=190 preview=0103100069007500b400223a337d2c22766f79616765223a7b22657461223a6e...(+158B)
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.147] [DEBUG] [BCAST] paced emit #3000 qdepth=1 dropped=0 gap_ms=8.0
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.150] [DEBUG] [DATA] notify broadcast sent=3000 bytes=190 preview=0105000004000600b4003531342c226770735f6669786573223a363334332c22...(+158B)
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.251] [INFO] [CONTROL] WriteValue device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE bytes=78 preview=7b22636d64223a22737562736372696265222c226576656e7473223a5b226f77...(+46B)
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.252] [INFO] [CONTROL] cmd=subscribe device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE json={'cmd': 'subscribe', 'events': ['ownship.update', 'target.update', 'stats.update']}
Apr 24 11:03:50 aismap python3[25757]: [2026-04-24 11:03:50.253] [DEBUG] [DATA] broadcast frames=1 msg_type=0x06 msg_id=21 device=/org/bluez/hci0/dev_4B_4E_32_24_64_CE enc=json
Apr 24 11:03:52 aismap python3[25757]: [2026-04-24 11:03:52.559] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:03:57 aismap python3[25757]: [2026-04-24 11:03:57.580] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:04:02 aismap python3[25757]: [2026-04-24 11:04:02.601] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:04:07 aismap python3[25757]: [2026-04-24 11:04:07.617] [DEBUG] [DATA] broadcast frames=6 msg_type=0x05 ev_type=stats.update sessions=1 enc=json
Apr 24 11:04:10 aismap python3[25757]: [2026-04-24 11:04:10.952] [INFO] [BlueZ] Device disconnected: /org/bluez/hci0/dev_4B_4E_32_24_64_CE -> removing session
Apr 24 11:04:10 aismap python3[25757]: [2026-04-24 11:04:10.953] [INFO] [BlueZ] sessions now: 0
Apr 24 11:04:10 aismap python3[25757]: [2026-04-24 11:04:10.955] [INFO] [DATA] StopNotify (CCCD disabled)
root@aismap:/opt/aismapv2#