2026-04-08T03:38:03 - INFO: MSIP3D 0.2.0
2026-04-08T03:38:03 - INFO: P3D files will be output to /working/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/ab2687ac-f0be-7ffd-2b31-cd865ecb306f
2026-04-08T03:38:03 - INFO: Found 10 TFD dictionary entries
2026-04-08T03:38:03 - INFO: Found TFD mission for 50001817
2026-04-08T03:38:03 - INFO: Recording will be processed as MD
2026-04-08T03:38:03 - INFO: Copying assets JSON to output directory...
2026-04-08T03:38:03 - INFO: Preparing counter data...
2026-04-08T03:38:03 - INFO: Interpreting counter as metric
2026-04-08T03:38:03 - INFO: Preparing size track from assets JSON...
2026-04-08T03:38:03 - INFO: Preparing material track from assets JSON...
2026-04-08T03:38:03 - INFO: Prepared counter data in 0.0173 s
2026-04-08T03:38:03 - INFO: Extracting sonar data...
TFD path: /working/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/tfd/50001817_001.tfd
TFD path: /working/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/tfd/output
Name: CCTV, Tag: 4855215978501720643
Name: SONAR_SENSOR_DATA, Tag: 6012079240663878227
Name: Index, Tag: 5291276999180902239
Name: SONAR, Tag: 6012079240663880375
Name: Dictionary, Tag: 18446744073709551615
Name: LASER, Tag: 4855215978501720652
Name: MISSION_FILE, Tag: 5073671569755687501
Name: Checkpoint, Tag: 4857243675797774090
Getting track SONAR
Number of frames: 512
12 / 512 [->___________________________________________________________________________] 2.34% ? p/s27 / 512 [---->________________________________________________________________________] 5.27% ? p/s41 / 512 [------>______________________________________________________________________] 8.01% ? p/s54 / 512 [------->___________________________________________________________________] 10.55% 70 p/s66 / 512 [--------->_________________________________________________________________] 12.89% 70 p/s79 / 512 [----------->_______________________________________________________________] 15.43% 70 p/s94 / 512 [------------->_____________________________________________________________] 18.36% 70 p/s108 / 512 [--------------->__________________________________________________________] 21.09% 70 p/s121 / 512 [----------------->________________________________________________________] 23.63% 70 p/s134 / 512 [------------------->______________________________________________________] 26.17% 70 p/s149 / 512 [--------------------->____________________________________________________] 29.10% 70 p/s163 / 512 [----------------------->__________________________________________________] 31.84% 70 p/s176 / 512 [------------------------->________________________________________________] 34.38% 70 p/s189 / 512 [--------------------------->______________________________________________] 36.91% 70 p/s204 / 512 [----------------------------->____________________________________________] 39.84% 70 p/s218 / 512 [------------------------------->__________________________________________] 42.58% 70 p/s231 / 512 [--------------------------------->________________________________________] 45.12% 70 p/s244 / 512 [----------------------------------->______________________________________] 47.66% 70 p/s259 / 512 [------------------------------------->____________________________________] 50.59% 70 p/s273 / 512 [--------------------------------------->__________________________________] 53.32% 70 p/s287 / 512 [----------------------------------------->________________________________] 56.05% 70 p/s303 / 512 [------------------------------------------->______________________________] 59.18% 70 p/s317 / 512 [--------------------------------------------->____________________________] 61.91% 70 p/s330 / 512 [----------------------------------------------->__________________________] 64.45% 70 p/s343 / 512 [------------------------------------------------->________________________] 66.99% 70 p/s357 / 512 [--------------------------------------------------->______________________] 69.73% 70 p/s373 / 512 [----------------------------------------------------->____________________] 72.85% 70 p/s389 / 512 [-------------------------------------------------------->_________________] 75.98% 70 p/s404 / 512 [---------------------------------------------------------->_______________] 78.91% 70 p/s418 / 512 [------------------------------------------------------------>_____________] 81.64% 70 p/s433 / 512 [-------------------------------------------------------------->___________] 84.57% 70 p/s446 / 512 [---------------------------------------------------------------->_________] 87.11% 70 p/s459 / 512 [------------------------------------------------------------------>_______] 89.65% 70 p/s473 / 512 [-------------------------------------------------------------------->_____] 92.38% 70 p/s487 / 512 [---------------------------------------------------------------------->___] 95.12% 70 p/s500 / 512 [------------------------------------------------------------------------>_] 97.66% 70 p/s512 / 512 [-------------------------------------------------------------------------] 100.00% 72 p/s2026-04-08T03:38:10 - INFO: Parsing 512 sonar sweeps from /working/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/tfd/output/SONAR/all-sweeps-info.csv...

  0%|          | 0/512 [00:00<?, ?it/s]
  0%|          | 2/512 [00:00<00:29, 17.42it/s]
  1%|          | 5/512 [00:00<00:21, 23.26it/s]
  2%|▏         | 8/512 [00:00<00:19, 25.22it/s]
  2%|▏         | 11/512 [00:00<00:19, 26.12it/s]
  3%|▎         | 14/512 [00:00<00:18, 26.50it/s]
  3%|▎         | 17/512 [00:00<00:21, 23.08it/s]
  4%|▍         | 20/512 [00:00<00:22, 22.12it/s]
  4%|▍         | 23/512 [00:01<00:24, 20.16it/s]
  5%|▌         | 26/512 [00:01<00:24, 20.14it/s]
  6%|▌         | 29/512 [00:01<00:25, 18.89it/s]
  6%|▌         | 31/512 [00:01<00:26, 18.09it/s]
  6%|▋         | 33/512 [00:01<00:27, 17.61it/s]
  7%|▋         | 35/512 [00:01<00:27, 17.05it/s]
  7%|▋         | 38/512 [00:01<00:25, 18.90it/s]
  8%|▊         | 41/512 [00:01<00:22, 21.06it/s]
  9%|▊         | 44/512 [00:02<00:20, 22.78it/s]
  9%|▉         | 47/512 [00:02<00:19, 24.04it/s]
 10%|▉         | 50/512 [00:02<00:19, 24.15it/s]
 10%|█         | 53/512 [00:02<00:21, 21.30it/s]
 11%|█         | 56/512 [00:02<00:22, 19.99it/s]
 12%|█▏        | 59/512 [00:02<00:20, 21.62it/s]
 12%|█▏        | 62/512 [00:02<00:22, 19.94it/s]
 13%|█▎        | 65/512 [00:03<00:24, 18.45it/s]
 13%|█▎        | 67/512 [00:03<00:25, 17.79it/s]
 13%|█▎        | 69/512 [00:03<00:25, 17.37it/s]
 14%|█▍        | 72/512 [00:03<00:22, 19.44it/s]
 15%|█▍        | 75/512 [00:03<00:21, 20.31it/s]
 15%|█▌        | 78/512 [00:03<00:19, 22.04it/s]
 16%|█▌        | 81/512 [00:03<00:20, 20.64it/s]
 16%|█▋        | 84/512 [00:04<00:22, 18.81it/s]
 17%|█▋        | 86/512 [00:04<00:23, 18.37it/s]
 17%|█▋        | 88/512 [00:04<00:23, 17.85it/s]
 18%|█▊        | 90/512 [00:04<00:24, 17.40it/s]
 18%|█▊        | 92/512 [00:04<00:24, 17.31it/s]
 19%|█▊        | 95/512 [00:04<00:22, 18.67it/s]
 19%|█▉        | 98/512 [00:04<00:20, 20.27it/s]
 20%|█▉        | 101/512 [00:04<00:18, 22.07it/s]
 20%|██        | 104/512 [00:05<00:17, 23.47it/s]
 21%|██        | 107/512 [00:05<00:17, 23.47it/s]
 21%|██▏       | 110/512 [00:05<00:19, 20.79it/s]
 22%|██▏       | 113/512 [00:05<00:20, 19.06it/s]
 23%|██▎       | 116/512 [00:05<00:19, 20.40it/s]
 23%|██▎       | 119/512 [00:05<00:20, 19.14it/s]
 24%|██▎       | 121/512 [00:06<00:21, 18.32it/s]
 24%|██▍       | 123/512 [00:06<00:22, 17.65it/s]
 24%|██▍       | 125/512 [00:06<00:22, 17.25it/s]
 25%|██▍       | 127/512 [00:06<00:22, 16.81it/s]
 25%|██▌       | 129/512 [00:06<00:23, 16.45it/s]
 26%|██▌       | 131/512 [00:06<00:22, 16.67it/s]
 26%|██▌       | 134/512 [00:06<00:20, 18.43it/s]
 27%|██▋       | 136/512 [00:06<00:20, 18.37it/s]
 27%|██▋       | 139/512 [00:07<00:19, 18.76it/s]
 28%|██▊       | 141/512 [00:07<00:20, 17.86it/s]
 28%|██▊       | 143/512 [00:07<00:21, 17.20it/s]
 28%|██▊       | 145/512 [00:07<00:21, 17.42it/s]
 29%|██▊       | 147/512 [00:07<00:21, 17.31it/s]
 29%|██▉       | 150/512 [00:07<00:18, 19.36it/s]
 30%|██▉       | 152/512 [00:07<00:19, 18.51it/s]
 30%|███       | 154/512 [00:07<00:18, 18.89it/s]
 31%|███       | 157/512 [00:07<00:16, 21.22it/s]
 31%|███▏      | 160/512 [00:08<00:16, 20.82it/s]
 32%|███▏      | 163/512 [00:08<00:18, 18.77it/s]
 32%|███▏      | 165/512 [00:08<00:18, 18.67it/s]
 33%|███▎      | 168/512 [00:08<00:17, 20.18it/s]
 33%|███▎      | 171/512 [00:08<00:18, 18.46it/s]
 34%|███▍      | 173/512 [00:08<00:19, 17.84it/s]
 34%|███▍      | 176/512 [00:08<00:16, 20.06it/s]
 35%|███▍      | 179/512 [00:09<00:15, 21.90it/s]
 36%|███▌      | 182/512 [00:09<00:14, 23.29it/s]
 36%|███▌      | 185/512 [00:09<00:14, 23.17it/s]
 37%|███▋      | 188/512 [00:09<00:13, 24.20it/s]
 37%|███▋      | 191/512 [00:09<00:12, 24.85it/s]
 38%|███▊      | 194/512 [00:09<00:12, 25.50it/s]
 38%|███▊      | 197/512 [00:09<00:12, 25.86it/s]
 39%|███▉      | 200/512 [00:09<00:11, 26.08it/s]
 40%|███▉      | 203/512 [00:10<00:11, 26.29it/s]
 40%|████      | 206/512 [00:10<00:12, 24.77it/s]
 41%|████      | 209/512 [00:10<00:14, 21.13it/s]
 41%|████▏     | 212/512 [00:10<00:14, 20.32it/s]
 42%|████▏     | 215/512 [00:10<00:15, 19.40it/s]
 43%|████▎     | 218/512 [00:10<00:15, 19.06it/s]
 43%|████▎     | 220/512 [00:10<00:15, 18.32it/s]
 43%|████▎     | 222/512 [00:11<00:16, 17.65it/s]
 44%|████▍     | 224/512 [00:11<00:16, 17.44it/s]
 44%|████▍     | 226/512 [00:11<00:16, 17.09it/s]
 45%|████▍     | 228/512 [00:11<00:16, 17.46it/s]
 45%|████▍     | 230/512 [00:11<00:16, 16.95it/s]
 45%|████▌     | 232/512 [00:11<00:16, 17.01it/s]
 46%|████▌     | 235/512 [00:11<00:13, 19.81it/s]
 46%|████▋     | 238/512 [00:11<00:12, 21.88it/s]
 47%|████▋     | 241/512 [00:12<00:11, 23.42it/s]
 48%|████▊     | 244/512 [00:12<00:10, 24.50it/s]
 48%|████▊     | 247/512 [00:12<00:10, 25.24it/s]
 49%|████▉     | 250/512 [00:12<00:10, 25.79it/s]
 49%|████▉     | 253/512 [00:12<00:10, 23.94it/s]
 50%|█████     | 256/512 [00:12<00:12, 20.64it/s]
 51%|█████     | 259/512 [00:12<00:13, 18.79it/s]
 51%|█████     | 261/512 [00:12<00:13, 18.56it/s]
 51%|█████▏    | 263/512 [00:13<00:14, 17.77it/s]
 52%|█████▏    | 265/512 [00:13<00:13, 17.70it/s]
 52%|█████▏    | 268/512 [00:13<00:12, 20.21it/s]
 53%|█████▎    | 271/512 [00:13<00:11, 20.09it/s]
 54%|█████▎    | 274/512 [00:13<00:10, 21.97it/s]
 54%|█████▍    | 277/512 [00:13<00:10, 23.35it/s]
 55%|█████▍    | 280/512 [00:13<00:09, 24.37it/s]
 55%|█████▌    | 283/512 [00:13<00:09, 25.00it/s]
 56%|█████▌    | 286/512 [00:14<00:09, 23.65it/s]
 56%|█████▋    | 289/512 [00:14<00:09, 24.50it/s]
 57%|█████▋    | 292/512 [00:14<00:09, 23.73it/s]
 58%|█████▊    | 295/512 [00:14<00:09, 22.73it/s]
 58%|█████▊    | 298/512 [00:14<00:09, 22.02it/s]
 59%|█████▉    | 301/512 [00:14<00:10, 19.75it/s]
 59%|█████▉    | 304/512 [00:14<00:10, 20.24it/s]
 60%|█████▉    | 307/512 [00:15<00:10, 18.77it/s]
 60%|██████    | 309/512 [00:15<00:11, 17.98it/s]
 61%|██████    | 311/512 [00:15<00:11, 17.37it/s]
 61%|██████▏   | 314/512 [00:15<00:10, 18.72it/s]
 62%|██████▏   | 316/512 [00:15<00:10, 18.92it/s]
 62%|██████▏   | 319/512 [00:15<00:10, 19.20it/s]
 63%|██████▎   | 321/512 [00:15<00:10, 18.89it/s]
 63%|██████▎   | 324/512 [00:16<00:09, 20.15it/s]
 64%|██████▍   | 327/512 [00:16<00:08, 22.01it/s]
 64%|██████▍   | 330/512 [00:16<00:07, 23.46it/s]
 65%|██████▌   | 333/512 [00:16<00:07, 24.05it/s]
 66%|██████▌   | 336/512 [00:16<00:07, 24.91it/s]
 66%|██████▌   | 339/512 [00:16<00:08, 21.40it/s]
 67%|██████▋   | 342/512 [00:16<00:08, 19.29it/s]
 67%|██████▋   | 345/512 [00:17<00:09, 18.04it/s]
 68%|██████▊   | 347/512 [00:17<00:09, 17.50it/s]
 68%|██████▊   | 350/512 [00:17<00:08, 19.71it/s]
 69%|██████▉   | 353/512 [00:17<00:07, 21.22it/s]
 70%|██████▉   | 356/512 [00:17<00:07, 20.55it/s]
 70%|███████   | 359/512 [00:17<00:07, 20.91it/s]
 71%|███████   | 362/512 [00:17<00:06, 22.39it/s]
 71%|███████▏  | 365/512 [00:17<00:07, 20.52it/s]
 72%|███████▏  | 368/512 [00:18<00:06, 20.65it/s]
 72%|███████▏  | 371/512 [00:18<00:06, 20.53it/s]
 73%|███████▎  | 374/512 [00:18<00:06, 19.72it/s]
 74%|███████▎  | 377/512 [00:18<00:07, 18.33it/s]
 74%|███████▍  | 379/512 [00:18<00:07, 17.63it/s]
 74%|███████▍  | 381/512 [00:18<00:07, 17.26it/s]
 75%|███████▍  | 383/512 [00:18<00:07, 17.07it/s]
 75%|███████▌  | 385/512 [00:19<00:07, 17.52it/s]
 76%|███████▌  | 388/512 [00:19<00:06, 20.13it/s]
 76%|███████▋  | 391/512 [00:19<00:05, 22.01it/s]
 77%|███████▋  | 394/512 [00:19<00:05, 22.86it/s]
 78%|███████▊  | 397/512 [00:19<00:04, 23.96it/s]
 78%|███████▊  | 400/512 [00:19<00:04, 24.67it/s]
 79%|███████▊  | 403/512 [00:19<00:04, 25.04it/s]
 79%|███████▉  | 406/512 [00:19<00:04, 25.26it/s]
 80%|███████▉  | 409/512 [00:20<00:04, 25.66it/s]
 80%|████████  | 412/512 [00:20<00:03, 25.94it/s]
 81%|████████  | 415/512 [00:20<00:03, 24.42it/s]
 82%|████████▏ | 418/512 [00:20<00:04, 21.88it/s]
 82%|████████▏ | 421/512 [00:20<00:04, 20.66it/s]
 83%|████████▎ | 424/512 [00:20<00:03, 22.14it/s]
 83%|████████▎ | 427/512 [00:20<00:03, 23.27it/s]
 84%|████████▍ | 430/512 [00:20<00:03, 24.17it/s]
 85%|████████▍ | 433/512 [00:21<00:03, 22.83it/s]
 85%|████████▌ | 436/512 [00:21<00:03, 20.02it/s]
 86%|████████▌ | 439/512 [00:21<00:03, 18.70it/s]
 86%|████████▌ | 441/512 [00:21<00:03, 17.95it/s]
 87%|████████▋ | 443/512 [00:21<00:03, 17.33it/s]
 87%|████████▋ | 445/512 [00:21<00:03, 17.35it/s]
 88%|████████▊ | 448/512 [00:21<00:03, 18.32it/s]
 88%|████████▊ | 451/512 [00:22<00:03, 18.04it/s]
 89%|████████▊ | 454/512 [00:22<00:02, 19.58it/s]
 89%|████████▉ | 457/512 [00:22<00:02, 21.44it/s]
 90%|████████▉ | 460/512 [00:22<00:02, 22.81it/s]
 90%|█████████ | 463/512 [00:22<00:02, 23.34it/s]
 91%|█████████ | 466/512 [00:22<00:02, 21.56it/s]
 92%|█████████▏| 469/512 [00:22<00:01, 21.58it/s]
 92%|█████████▏| 472/512 [00:23<00:01, 20.04it/s]
 93%|█████████▎| 475/512 [00:23<00:01, 21.73it/s]
 93%|█████████▎| 478/512 [00:23<00:01, 23.19it/s]
 94%|█████████▍| 481/512 [00:23<00:01, 21.88it/s]
 95%|█████████▍| 484/512 [00:23<00:01, 20.98it/s]
 95%|█████████▌| 487/512 [00:23<00:01, 21.68it/s]
 96%|█████████▌| 490/512 [00:23<00:00, 23.00it/s]
 96%|█████████▋| 493/512 [00:23<00:00, 23.83it/s]
 97%|█████████▋| 496/512 [00:24<00:00, 24.54it/s]
 97%|█████████▋| 499/512 [00:24<00:00, 24.10it/s]
 98%|█████████▊| 502/512 [00:24<00:00, 20.86it/s]
 99%|█████████▊| 505/512 [00:24<00:00, 20.95it/s]
 99%|█████████▉| 508/512 [00:24<00:00, 20.33it/s]
100%|█████████▉| 511/512 [00:24<00:00, 21.48it/s]
100%|██████████| 512/512 [00:24<00:00, 20.57it/s]
2026-04-08T03:38:35 - INFO: Running DataPrep with "python -m dataprep --force --no-counter --no-video --no-laser --sonar --sonar-format cbor --temperature 17.8 --salinity 0 --pressure 0 --sonar-cluster-size 15 --sonar-mask-angle 120 --sonar-despike --sonar-flip /working/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/ab2687ac-f0be-7ffd-2b31-cd865ecb306f"
2026-04-08T03:38:37 - INFO: DataPrep 0.14.0
2026-04-08T03:38:37 - INFO: Prepared data will be output to /working/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/processing/data
2026-04-08T03:38:37 - deployment - WARNING: No CCTV directory, defaulting to P3D 1.0
2026-04-08T03:38:37 - deployment - INFO: Detected P3D version: P3D_1
2026-04-08T03:38:37 - INFO: Recording GUID: ab2687ac-f0be-7ffd-2b31-cd865ecb306f
2026-04-08T03:38:37 - INFO: Preparing sonar data...
2026-04-08T03:38:37 - INFO: /working/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/sonar/sonar.dat has metadata version 0.1 (0x00000001)
Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/dataprep/__main__.py", line 171, in main
    dataprep.prepare.prepare(
  File "/usr/local/lib/python3.11/site-packages/dataprep/prepare.py", line 320, in prepare
    sonar = dataprep.sonar.Sonar.from_file(sonars[0])
            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.11/site-packages/dataprep/sonar.py", line 88, in from_file
    sweeps=[
           ^
  File "/usr/local/lib/python3.11/site-packages/dataprep/sonar.py", line 89, in <listcomp>
    Sweep.from_bin(b, steps, samples)
  File "/usr/local/lib/python3.11/site-packages/dataprep/sonar.py", line 118, in from_bin
    beams=[Beam.from_bin(data[i : i + sample_len]) for i in range(4, len(data), sample_len)],
          ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.11/site-packages/dataprep/sonar.py", line 118, in <listcomp>
    beams=[Beam.from_bin(data[i : i + sample_len]) for i in range(4, len(data), sample_len)],
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.11/site-packages/dataprep/sonar.py", line 142, in from_bin
    raise ValueError("Invalid beam signature")
ValueError: Invalid beam signature
Traceback (most recent call last):
  File "/app/src/msip3d/__main__.py", line 259, in main
    msip3d.sonar.extract_sonar(
  File "/app/src/msip3d/sonar.py", line 115, in extract_sonar
    subprocess.run(cmd, check=True)
  File "/usr/local/lib/python3.11/subprocess.py", line 571, in run
    raise CalledProcessError(retcode, process.args,
subprocess.CalledProcessError: Command '['python', '-m', 'dataprep', '--force', '--no-counter', '--no-video', '--no-laser', '--sonar', '--sonar-format', 'cbor', '--temperature', '17.8', '--salinity', '0', '--pressure', '0', '--sonar-cluster-size', '15', '--sonar-mask-angle', '120', '--sonar-despike', '--sonar-flip', '/working/ab2687ac-f0be-7ffd-2b31-cd865ecb306f/ab2687ac-f0be-7ffd-2b31-cd865ecb306f']' returned non-zero exit status 255.