2025-04-01T15:58:52 - INFO: DataSub 0.5.4
2025-04-01T15:58:52 - INFO: Subselection(s) will be output to /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub
2025-04-01 15:58:52,362 - deployment - INFO - Detected P3D version: P3D_1_0_0
2025-04-01 15:58:52,362 - deployment - INFO - Loading deplyoment info and structure
2025-04-01 15:58:53,693 - deployment - DEBUG - Deployment contains:
2025-04-01 15:58:53,693 - deployment - DEBUG - 4 image tracks
2025-04-01 15:58:53,693 - deployment - DEBUG - 0 lidar tracks
2025-04-01 15:58:53,693 - deployment - DEBUG - 1 payout tracks
2025-04-01T15:58:53 - INFO: Subselecting asset P09254 (4a185a29-f1f6-4e94-a630-2f8d2ad1bb2d)
2025-04-01T15:58:53 - INFO: No LiDAR data found
2025-04-01T15:58:53 - DEBUG: Trimming payout start time to 117973000000
2025-04-01T15:58:53 - DEBUG: Trimming payout end time to 1132191000000
2025-04-01T15:58:53 - DEBUG: Payout is increasing from 2.62128 m (122242000000) to 142.70736 m (1128620000000)
2025-04-01T15:58:53 - DEBUG: Trimming payout start distance to 2.530037
2025-04-01T15:58:53 - DEBUG: Trimming payout end distance to 142.708796
2025-04-01T15:58:53 - DEBUG: Trimmed payout has 4597 frames
2025-04-01T15:58:53 - INFO: Payout trimmed from 2.62128 m (122242000000) to 142.70736 m (1128620000000)
2025-04-01T15:58:53 - INFO: Subselecting with distance increment of 0.025
2025-04-01T15:58:57 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/4a185a29-f1f6-4e94-a630-2f8d2ad1bb2d/4a185a29-f1f6-4e94-a630-2f8d2ad1bb2d.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/4a185a29-f1f6-4e94-a630-2f8d2ad1bb2d/processing/data...
2025-04-01T15:59:42 - INFO: Disk image created successfully in 0:00:45.380231
2025-04-01T15:59:42 - INFO: Subselected P09254 in 0:00:50.067648
2025-04-01T15:59:42 - INFO: Subselecting asset P09253 (476a1dcc-367f-48a9-8f64-7175329f8a79)
2025-04-01T15:59:42 - INFO: No LiDAR data found
2025-04-01T15:59:42 - DEBUG: Trimming payout start time to 1132191000000
2025-04-01T15:59:42 - DEBUG: Trimming payout end time to 2110449000000
2025-04-01T15:59:42 - DEBUG: Payout is increasing from 142.73784 m (1204749000000) to 274.38096 m (2108026000000)
2025-04-01T15:59:42 - DEBUG: Trimming payout start distance to 142.708796
2025-04-01T15:59:42 - DEBUG: Trimming payout end distance to 274.381627
2025-04-01T15:59:42 - DEBUG: Trimmed payout has 4320 frames
2025-04-01T15:59:42 - INFO: Payout trimmed from 142.73784 m (1204749000000) to 274.38096 m (2108026000000)
2025-04-01T15:59:42 - INFO: Subselecting with distance increment of 0.025
2025-04-01T15:59:43 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/476a1dcc-367f-48a9-8f64-7175329f8a79/476a1dcc-367f-48a9-8f64-7175329f8a79.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/476a1dcc-367f-48a9-8f64-7175329f8a79/processing/data...
2025-04-01T16:00:25 - INFO: Disk image created successfully in 0:00:42.019544
2025-04-01T16:00:25 - INFO: Subselected P09253 in 0:01:33.638284
2025-04-01T16:00:25 - INFO: Subselecting asset P09252 (53774404-0f04-46c5-a9cf-877d3ccbff06)
2025-04-01T16:00:25 - INFO: No LiDAR data found
2025-04-01T16:00:25 - DEBUG: Trimming payout start time to 2110449000000
2025-04-01T16:00:25 - DEBUG: Trimming payout end time to 3101688000000
2025-04-01T16:00:25 - DEBUG: Payout is increasing from 274.41144 m (2219395000000) to 398.28216000000003 m (3097821000000)
2025-04-01T16:00:25 - DEBUG: Trimming payout start distance to 274.381627
2025-04-01T16:00:25 - DEBUG: Trimming payout end distance to 398.283132
2025-04-01T16:00:25 - DEBUG: Trimmed payout has 4111 frames
2025-04-01T16:00:25 - INFO: Payout trimmed from 274.41144 m (2219395000000) to 398.28216000000003 m (3097821000000)
2025-04-01T16:00:25 - INFO: Subselecting with distance increment of 0.025
2025-04-01T16:00:27 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/53774404-0f04-46c5-a9cf-877d3ccbff06/53774404-0f04-46c5-a9cf-877d3ccbff06.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/53774404-0f04-46c5-a9cf-877d3ccbff06/processing/data...
2025-04-01T16:01:07 - INFO: Disk image created successfully in 0:00:40.354086
2025-04-01T16:01:07 - INFO: Subselected P09252 in 0:02:15.442505
2025-04-01T16:01:07 - INFO: Subselecting asset P09251 (12ad362b-5388-4c63-a4bb-3e1a429efedc)
2025-04-01T16:01:07 - INFO: No LiDAR data found
2025-04-01T16:01:07 - DEBUG: Trimming payout start time to 3101688000000
2025-04-01T16:01:07 - DEBUG: Trimming payout end time to 4055506000000
2025-04-01T16:01:07 - DEBUG: Payout is increasing from 398.31264 m (3219611000000) to 518.49528 m (4054232000000)
2025-04-01T16:01:07 - DEBUG: Trimming payout start distance to 398.283132
2025-04-01T16:01:07 - DEBUG: Trimming payout end distance to 518.495632
2025-04-01T16:01:07 - DEBUG: Trimmed payout has 3944 frames
2025-04-01T16:01:07 - INFO: Payout trimmed from 398.31264 m (3219611000000) to 518.49528 m (4054232000000)
2025-04-01T16:01:07 - INFO: Subselecting with distance increment of 0.025
2025-04-01T16:01:09 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/12ad362b-5388-4c63-a4bb-3e1a429efedc/12ad362b-5388-4c63-a4bb-3e1a429efedc.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/12ad362b-5388-4c63-a4bb-3e1a429efedc/processing/data...
2025-04-01T16:01:48 - INFO: Disk image created successfully in 0:00:39.527539
2025-04-01T16:01:48 - INFO: Subselected P09251 in 0:02:56.400789
2025-04-01T16:01:48 - INFO: Subselecting asset P09250 (91626273-d40b-4e1d-8fe0-1f1542772295)
2025-04-01T16:01:48 - INFO: No LiDAR data found
2025-04-01T16:01:48 - DEBUG: Trimming payout start time to 4055506000000
2025-04-01T16:01:48 - DEBUG: Trimming payout end time to 4276009000000
2025-04-01T16:01:48 - DEBUG: Payout is increasing from 518.52576 m (4165866000000) to 534.43632 m (4275831000000)
2025-04-01T16:01:48 - DEBUG: Trimming payout start distance to 518.495632
2025-04-01T16:01:48 - DEBUG: Trimming payout end distance to 534.467701
2025-04-01T16:01:48 - DEBUG: Trimmed payout has 523 frames
2025-04-01T16:01:48 - INFO: Payout trimmed from 518.52576 m (4165866000000) to 534.43632 m (4275831000000)
2025-04-01T16:01:48 - INFO: Subselecting with distance increment of 0.025
2025-04-01T16:01:48 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/91626273-d40b-4e1d-8fe0-1f1542772295/91626273-d40b-4e1d-8fe0-1f1542772295.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/91626273-d40b-4e1d-8fe0-1f1542772295/processing/data...
2025-04-01T16:01:53 - INFO: Disk image created successfully in 0:00:04.730236
2025-04-01T16:01:53 - INFO: Subselected P09250 in 0:03:01.326408
2025-04-01T16:01:53 - INFO: Subselecting asset P09249 (0efe02de-df11-4f7a-86e7-0d80928fa8a4)
2025-04-01T16:01:53 - INFO: No LiDAR data found
2025-04-01T16:01:53 - DEBUG: Trimming payout start time to 4276009000000
2025-04-01T16:01:53 - DEBUG: Trimming payout end time to 5428587000000
2025-04-01T16:01:53 - DEBUG: Payout is increasing from 534.4668 m (4276018000000) to 697.74816 m (5425871000000)
2025-04-01T16:01:53 - DEBUG: Trimming payout start distance to 534.467701
2025-04-01T16:01:53 - DEBUG: Trimming payout end distance to 697.748693
2025-04-01T16:01:53 - DEBUG: Trimmed payout has 5357 frames
2025-04-01T16:01:53 - INFO: Payout trimmed from 534.49728 m (4276221000000) to 697.74816 m (5425871000000)
2025-04-01T16:01:53 - INFO: Subselecting with distance increment of 0.025
2025-04-01T16:01:55 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/0efe02de-df11-4f7a-86e7-0d80928fa8a4/0efe02de-df11-4f7a-86e7-0d80928fa8a4.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/0efe02de-df11-4f7a-86e7-0d80928fa8a4/processing/data...
2025-04-01T16:02:54 - INFO: Disk image created successfully in 0:00:59.147333
2025-04-01T16:02:54 - INFO: Subselected P09249 in 0:04:02.407335
2025-04-01T16:02:54 - INFO: Subselecting asset P09248 (f2b43857-42ac-4dbb-af0a-7704f1b0f95e)
2025-04-01T16:02:54 - INFO: No LiDAR data found
2025-04-01T16:02:54 - DEBUG: Trimming payout start time to 5428587000000
2025-04-01T16:02:54 - DEBUG: Trimming payout end time to 6971314000000
2025-04-01T16:02:54 - DEBUG: Payout is increasing from 697.7786400000001 m (5582074000000) to 897.7884 m (6971092000000)
2025-04-01T16:02:54 - DEBUG: Trimming payout start distance to 697.748693
2025-04-01T16:02:54 - DEBUG: Trimming payout end distance to 897.819271
2025-04-01T16:02:54 - DEBUG: Trimmed payout has 6563 frames
2025-04-01T16:02:54 - INFO: Payout trimmed from 697.7786400000001 m (5582074000000) to 897.7884 m (6971092000000)
2025-04-01T16:02:54 - INFO: Subselecting with distance increment of 0.025
2025-04-01T16:02:57 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/f2b43857-42ac-4dbb-af0a-7704f1b0f95e/f2b43857-42ac-4dbb-af0a-7704f1b0f95e.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/f2b43857-42ac-4dbb-af0a-7704f1b0f95e/processing/data...
2025-04-01T16:04:10 - INFO: Disk image created successfully in 0:01:12.892394
2025-04-01T16:04:10 - INFO: Subselected P09248 in 0:05:17.683895
2025-04-01T16:04:10 - INFO: Subselecting asset P09247 (8fb7e1e3-2e48-4b55-bcf2-1407ed22b342)
2025-04-01T16:04:10 - INFO: No LiDAR data found
2025-04-01T16:04:10 - DEBUG: Trimming payout start time to 6971314000000
2025-04-01T16:04:10 - DEBUG: Trimming payout end time to 7068270000000
2025-04-01T16:04:10 - DEBUG: Payout is increasing from 897.81888 m (6971326000000) to 911.8701599999999 m (7068046000000)
2025-04-01T16:04:10 - DEBUG: Trimming payout start distance to 897.819271
2025-04-01T16:04:10 - DEBUG: Trimming payout end distance to 911.901451
2025-04-01T16:04:10 - DEBUG: Trimmed payout has 461 frames
2025-04-01T16:04:10 - INFO: Payout trimmed from 897.8493599999999 m (6971560000000) to 911.8701599999999 m (7068046000000)
2025-04-01T16:04:10 - INFO: Subselecting with distance increment of 0.025
2025-04-01T16:04:10 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/8fb7e1e3-2e48-4b55-bcf2-1407ed22b342/8fb7e1e3-2e48-4b55-bcf2-1407ed22b342.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/8fb7e1e3-2e48-4b55-bcf2-1407ed22b342/processing/data...
2025-04-01T16:04:14 - INFO: Disk image created successfully in 0:00:04.299011
2025-04-01T16:04:14 - INFO: Subselected P09247 in 0:05:22.156629
2025-04-01T16:04:14 - INFO: Subselecting asset P09246 (859e0ffb-8b96-4887-a0df-6a4285a2d29d)
2025-04-01T16:04:14 - INFO: No LiDAR data found
2025-04-01T16:04:14 - DEBUG: Trimming payout start time to 7068270000000
2025-04-01T16:04:14 - DEBUG: Trimming payout end time to 8227946000000
2025-04-01T16:04:14 - DEBUG: Payout is increasing from 911.9006400000001 m (7068280000000) to 1070.09184 m (8227727000000)
2025-04-01T16:04:14 - DEBUG: Trimming payout start distance to 911.901451
2025-04-01T16:04:14 - DEBUG: Trimming payout end distance to 1070.122320
2025-04-01T16:04:14 - DEBUG: Trimmed payout has 5190 frames
2025-04-01T16:04:14 - INFO: Payout trimmed from 911.9311200000001 m (7068468000000) to 1070.09184 m (8227727000000)
2025-04-01T16:04:14 - INFO: Subselecting with distance increment of 0.025
2025-04-01T16:04:16 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/859e0ffb-8b96-4887-a0df-6a4285a2d29d/859e0ffb-8b96-4887-a0df-6a4285a2d29d.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/859e0ffb-8b96-4887-a0df-6a4285a2d29d/processing/data...
2025-04-01T16:05:11 - INFO: Disk image created successfully in 0:00:54.609387
2025-04-01T16:05:11 - INFO: Subselected P09246 in 0:06:18.893455
2025-04-01T16:05:11 - INFO: Subselecting asset P09245 (345e8f53-ca92-49d3-9207-962d59a2d846)
2025-04-01T16:05:11 - INFO: No LiDAR data found
2025-04-01T16:05:11 - DEBUG: Trimming payout start time to 8227946000000
2025-04-01T16:05:11 - DEBUG: Trimming payout end time to 8942953000000
2025-04-01T16:05:11 - DEBUG: Payout is increasing from 1070.1223200000002 m (8227961000000) to 1155.2224800000001 m (8942726000000)
2025-04-01T16:05:11 - DEBUG: Trimming payout start distance to 1070.122320
2025-04-01T16:05:11 - DEBUG: Trimming payout end distance to 1155.251985
2025-04-01T16:05:11 - DEBUG: Trimmed payout has 2792 frames
2025-04-01T16:05:11 - INFO: Payout trimmed from 1070.1223200000002 m (8227961000000) to 1155.2224800000001 m (8942726000000)
2025-04-01T16:05:11 - INFO: Subselecting with distance increment of 0.025
2025-04-01T16:05:12 - INFO: Creating disk image /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/345e8f53-ca92-49d3-9207-962d59a2d846/345e8f53-ca92-49d3-9207-962d59a2d846.iso from /working/ca9f88da-cf45-43ec-a61e-91f8889a22b3/datasub/345e8f53-ca92-49d3-9207-962d59a2d846/processing/data...
2025-04-01T16:05:39 - INFO: Disk image created successfully in 0:00:27.059457
2025-04-01T16:05:39 - INFO: Subselected P09245 in 0:06:46.979522
2025-04-01T16:05:39 - INFO: DataSub took 0:06:46.979607