2025-01-06T17:58:22 - INFO: DataSub 0.5.4
2025-01-06T17:58:22 - INFO: Subselection(s) will be output to /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub
2025-01-06 17:58:22,218 - deployment - INFO - Detected P3D version: P3D_1_0_0
2025-01-06 17:58:22,218 - deployment - INFO - Loading deplyoment info and structure
2025-01-06 17:58:23,728 - deployment - DEBUG - Deployment contains:
2025-01-06 17:58:23,728 - deployment - DEBUG - 4 image tracks
2025-01-06 17:58:23,728 - deployment - DEBUG - 0 lidar tracks
2025-01-06 17:58:23,728 - deployment - DEBUG - 1 payout tracks
2025-01-06T17:58:23 - INFO: Subselecting asset P07674 (f5695b70-8297-4ba1-aa64-0a083875d401)
2025-01-06T17:58:23 - INFO: No LiDAR data found
2025-01-06T17:58:23 - DEBUG: Trimming payout start time to 211372000000
2025-01-06T17:58:23 - DEBUG: Trimming payout end time to 1112505000000
2025-01-06T17:58:23 - DEBUG: Payout is increasing from 2.80416 m (211381000000) to 137.34288 m (1112162000000)
2025-01-06T17:58:23 - DEBUG: Trimming payout start distance to 2.804811
2025-01-06T17:58:23 - DEBUG: Trimming payout end distance to 137.362865
2025-01-06T17:58:23 - DEBUG: Trimmed payout has 4414 frames
2025-01-06T17:58:23 - INFO: Payout trimmed from 2.8346400000000003 m (211662000000) to 137.34288 m (1112162000000)
2025-01-06T17:58:23 - INFO: Subselecting with distance increment of 0.025
2025-01-06T17:58:27 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/f5695b70-8297-4ba1-aa64-0a083875d401/f5695b70-8297-4ba1-aa64-0a083875d401.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/f5695b70-8297-4ba1-aa64-0a083875d401/processing/data...
2025-01-06T17:59:06 - INFO: Disk image created successfully in 0:00:39.670959
2025-01-06T17:59:06 - INFO: Subselected P07674 in 0:00:44.770043
2025-01-06T17:59:06 - INFO: Subselecting asset P07673 (21f026d0-4b5c-438a-863b-9678bdb9ba66)
2025-01-06T17:59:06 - INFO: No LiDAR data found
2025-01-06T17:59:06 - DEBUG: Trimming payout start time to 1112505000000
2025-01-06T17:59:06 - DEBUG: Trimming payout end time to 1219238000000
2025-01-06T17:59:06 - DEBUG: Payout is increasing from 137.37336 m (1112708000000) to 140.14704 m (1219194000000)
2025-01-06T17:59:06 - DEBUG: Trimming payout start distance to 137.362865
2025-01-06T17:59:06 - DEBUG: Trimming payout end distance to 140.156657
2025-01-06T17:59:06 - DEBUG: Trimmed payout has 92 frames
2025-01-06T17:59:06 - INFO: Payout trimmed from 137.37336 m (1112708000000) to 140.14704 m (1219194000000)
2025-01-06T17:59:06 - INFO: Subselecting with distance increment of 0.025
2025-01-06T17:59:07 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/21f026d0-4b5c-438a-863b-9678bdb9ba66/21f026d0-4b5c-438a-863b-9678bdb9ba66.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/21f026d0-4b5c-438a-863b-9678bdb9ba66/processing/data...
2025-01-06T17:59:07 - INFO: Disk image created successfully in 0:00:00.682633
2025-01-06T17:59:07 - INFO: Subselected P07673 in 0:00:45.497528
2025-01-06T17:59:07 - INFO: Subselecting asset P07672 (819fc3d0-5112-490e-931a-f58ed0961bf9)
2025-01-06T17:59:07 - INFO: No LiDAR data found
2025-01-06T17:59:07 - DEBUG: Trimming payout start time to 1396354000000
2025-01-06T17:59:07 - DEBUG: Trimming payout end time to 2436523000000
2025-01-06T17:59:07 - DEBUG: Payout is increasing from 140.72616 m (1397082000000) to 294.132 m (2435440000000)
2025-01-06T17:59:07 - DEBUG: Trimming payout start distance to 140.725307
2025-01-06T17:59:07 - DEBUG: Trimming payout end distance to 294.132206
2025-01-06T17:59:07 - DEBUG: Trimmed payout has 5034 frames
2025-01-06T17:59:07 - INFO: Payout trimmed from 140.72616 m (1397082000000) to 294.132 m (2435440000000)
2025-01-06T17:59:07 - INFO: Subselecting with distance increment of 0.025
2025-01-06T17:59:09 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/819fc3d0-5112-490e-931a-f58ed0961bf9/819fc3d0-5112-490e-931a-f58ed0961bf9.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/819fc3d0-5112-490e-931a-f58ed0961bf9/processing/data...
2025-01-06T17:59:54 - INFO: Disk image created successfully in 0:00:44.864745
2025-01-06T17:59:54 - INFO: Subselected P07672 in 0:01:32.324707
2025-01-06T17:59:54 - INFO: Subselecting asset P07671 (2c5820fc-cb4b-482c-9a81-504acd60981c)
2025-01-06T17:59:54 - INFO: No LiDAR data found
2025-01-06T17:59:54 - DEBUG: Trimming payout start time to 2436523000000
2025-01-06T17:59:54 - DEBUG: Trimming payout end time to 3731713000000
2025-01-06T17:59:54 - DEBUG: Payout is increasing from 294.16248 m (2598259000000) to 456.77328 m (3729204000000)
2025-01-06T17:59:54 - DEBUG: Trimming payout start distance to 294.132206
2025-01-06T17:59:54 - DEBUG: Trimming payout end distance to 456.774049
2025-01-06T17:59:54 - DEBUG: Trimmed payout has 5336 frames
2025-01-06T17:59:54 - INFO: Payout trimmed from 294.16248 m (2598259000000) to 456.77328 m (3729204000000)
2025-01-06T17:59:54 - INFO: Subselecting with distance increment of 0.025
2025-01-06T17:59:56 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/2c5820fc-cb4b-482c-9a81-504acd60981c/2c5820fc-cb4b-482c-9a81-504acd60981c.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/2c5820fc-cb4b-482c-9a81-504acd60981c/processing/data...
2025-01-06T18:00:44 - INFO: Disk image created successfully in 0:00:47.347746
2025-01-06T18:00:44 - INFO: Subselected P07671 in 0:02:21.971345
2025-01-06T18:00:44 - INFO: Subselecting asset P07670 (29ceda97-7351-481e-b959-4ba87983da57)
2025-01-06T18:00:44 - INFO: No LiDAR data found
2025-01-06T18:00:44 - DEBUG: Trimming payout start time to 3731713000000
2025-01-06T18:00:44 - DEBUG: Trimming payout end time to 5218548000000
2025-01-06T18:00:44 - DEBUG: Payout is increasing from 456.80376 m (3829309000000) to 653.5216800000001 m (5218327000000)
2025-01-06T18:00:44 - DEBUG: Trimming payout start distance to 456.774049
2025-01-06T18:00:44 - DEBUG: Trimming payout end distance to 653.552460
2025-01-06T18:00:44 - DEBUG: Trimmed payout has 6455 frames
2025-01-06T18:00:44 - INFO: Payout trimmed from 456.80376 m (3829309000000) to 653.5216800000001 m (5218327000000)
2025-01-06T18:00:44 - INFO: Subselecting with distance increment of 0.025
2025-01-06T18:00:46 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/29ceda97-7351-481e-b959-4ba87983da57/29ceda97-7351-481e-b959-4ba87983da57.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/29ceda97-7351-481e-b959-4ba87983da57/processing/data...
2025-01-06T18:01:50 - INFO: Disk image created successfully in 0:01:03.538392
2025-01-06T18:01:50 - INFO: Subselected P07670 in 0:03:28.299526
2025-01-06T18:01:50 - INFO: Subselecting asset P07669 (3d64211e-03eb-4816-a04d-63a013840633)
2025-01-06T18:01:50 - INFO: No LiDAR data found
2025-01-06T18:01:50 - DEBUG: Trimming payout start time to 5218548000000
2025-01-06T18:01:50 - DEBUG: Trimming payout end time to 5723958000000
2025-01-06T18:01:50 - DEBUG: Payout is increasing from 653.55216 m (5218561000000) to 706.86168 m (5723801000000)
2025-01-06T18:01:50 - DEBUG: Trimming payout start distance to 653.552460
2025-01-06T18:01:50 - DEBUG: Trimming payout end distance to 706.861718
2025-01-06T18:01:50 - DEBUG: Trimmed payout has 1749 frames
2025-01-06T18:01:50 - INFO: Payout trimmed from 653.5826400000001 m (5218764000000) to 706.86168 m (5723801000000)
2025-01-06T18:01:50 - INFO: Subselecting with distance increment of 0.025
2025-01-06T18:01:51 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/3d64211e-03eb-4816-a04d-63a013840633/3d64211e-03eb-4816-a04d-63a013840633.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/3d64211e-03eb-4816-a04d-63a013840633/processing/data...
2025-01-06T18:02:07 - INFO: Disk image created successfully in 0:00:16.071298
2025-01-06T18:02:07 - INFO: Subselected P07669 in 0:03:45.075033
2025-01-06T18:02:07 - INFO: Subselecting asset P07668 (5e4a7c78-5e3d-4a91-b0fa-97ab70e4a08c)
2025-01-06T18:02:07 - INFO: No LiDAR data found
2025-01-06T18:02:07 - DEBUG: Trimming payout start time to 5723958000000
2025-01-06T18:02:07 - DEBUG: Trimming payout end time to 6747144000000
2025-01-06T18:02:07 - DEBUG: Payout is increasing from 706.89216 m (5862860000000) to 830.91528 m (6746965000000)
2025-01-06T18:02:07 - DEBUG: Trimming payout start distance to 706.861718
2025-01-06T18:02:07 - DEBUG: Trimming payout end distance to 830.940550
2025-01-06T18:02:07 - DEBUG: Trimmed payout has 4070 frames
2025-01-06T18:02:07 - INFO: Payout trimmed from 706.89216 m (5862860000000) to 830.91528 m (6746965000000)
2025-01-06T18:02:07 - INFO: Subselecting with distance increment of 0.025
2025-01-06T18:02:08 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/5e4a7c78-5e3d-4a91-b0fa-97ab70e4a08c/5e4a7c78-5e3d-4a91-b0fa-97ab70e4a08c.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/5e4a7c78-5e3d-4a91-b0fa-97ab70e4a08c/processing/data...
2025-01-06T18:02:49 - INFO: Disk image created successfully in 0:00:40.609148
2025-01-06T18:02:49 - INFO: Subselected P07668 in 0:04:27.299390
2025-01-06T18:02:49 - INFO: Subselecting asset P07667 (2ab1c929-4bf9-4082-a8f7-02e0e0be46bf)
2025-01-06T18:02:49 - INFO: No LiDAR data found
2025-01-06T18:02:49 - DEBUG: Trimming payout start time to 6747144000000
2025-01-06T18:02:49 - DEBUG: Trimming payout end time to 7826020000000
2025-01-06T18:02:49 - DEBUG: Payout is increasing from 830.94576 m (6747199000000) to 967.4352 m (7825712000000)
2025-01-06T18:02:49 - DEBUG: Trimming payout start distance to 830.940550
2025-01-06T18:02:49 - DEBUG: Trimming payout end distance to 967.458585
2025-01-06T18:02:49 - DEBUG: Trimmed payout has 4479 frames
2025-01-06T18:02:49 - INFO: Payout trimmed from 830.94576 m (6747199000000) to 967.4352 m (7825712000000)
2025-01-06T18:02:49 - INFO: Subselecting with distance increment of 0.025
2025-01-06T18:02:51 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/2ab1c929-4bf9-4082-a8f7-02e0e0be46bf/2ab1c929-4bf9-4082-a8f7-02e0e0be46bf.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/2ab1c929-4bf9-4082-a8f7-02e0e0be46bf/processing/data...
2025-01-06T18:03:35 - INFO: Disk image created successfully in 0:00:43.938910
2025-01-06T18:03:35 - INFO: Subselected P07667 in 0:05:13.110822
2025-01-06T18:03:35 - INFO: Subselecting asset P07666 (37c54e13-c0ca-4229-9589-7fac2691a9d0)
2025-01-06T18:03:35 - INFO: No LiDAR data found
2025-01-06T18:03:35 - DEBUG: Trimming payout start time to 7826020000000
2025-01-06T18:03:35 - DEBUG: Trimming payout end time to 9046950000000
2025-01-06T18:03:35 - DEBUG: Payout is increasing from 967.46568 m (7826133000000) to 1119.28656 m (9044501000000)
2025-01-06T18:03:35 - DEBUG: Trimming payout start distance to 967.458585
2025-01-06T18:03:35 - DEBUG: Trimming payout end distance to 1119.302042
2025-01-06T18:03:35 - DEBUG: Trimmed payout has 4982 frames
2025-01-06T18:03:35 - INFO: Payout trimmed from 967.46568 m (7826133000000) to 1119.28656 m (9044501000000)
2025-01-06T18:03:35 - INFO: Subselecting with distance increment of 0.025
2025-01-06T18:03:37 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/37c54e13-c0ca-4229-9589-7fac2691a9d0/37c54e13-c0ca-4229-9589-7fac2691a9d0.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/37c54e13-c0ca-4229-9589-7fac2691a9d0/processing/data...
2025-01-06T18:04:26 - INFO: Disk image created successfully in 0:00:48.910159
2025-01-06T18:04:26 - INFO: Subselected P07666 in 0:06:04.223799
2025-01-06T18:04:26 - INFO: Subselecting asset P07665 (1fabf2a5-95aa-4c0b-ad7b-0af5edeeffb7)
2025-01-06T18:04:26 - INFO: No LiDAR data found
2025-01-06T18:04:26 - DEBUG: Trimming payout start time to 9046950000000
2025-01-06T18:04:26 - DEBUG: Trimming payout end time to 10174572000000
2025-01-06T18:04:26 - DEBUG: Payout is increasing from 1119.3170400000001 m (9049352000000) to 1272.9362400000002 m (10174556000000)
2025-01-06T18:04:26 - DEBUG: Trimming payout start distance to 1119.302042
2025-01-06T18:04:26 - DEBUG: Trimming payout end distance to 1272.940278
2025-01-06T18:04:26 - DEBUG: Trimmed payout has 5041 frames
2025-01-06T18:04:26 - INFO: Payout trimmed from 1119.3170400000001 m (9049352000000) to 1272.9362400000002 m (10174556000000)
2025-01-06T18:04:26 - INFO: Subselecting with distance increment of 0.025
2025-01-06T18:04:28 - INFO: Creating disk image /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/1fabf2a5-95aa-4c0b-ad7b-0af5edeeffb7/1fabf2a5-95aa-4c0b-ad7b-0af5edeeffb7.iso from /working/ea8455ee-469b-4b1a-a20e-33c3cd3df64a/datasub/1fabf2a5-95aa-4c0b-ad7b-0af5edeeffb7/processing/data...
2025-01-06T18:05:18 - INFO: Disk image created successfully in 0:00:50.234065
2025-01-06T18:05:18 - INFO: Subselected P07665 in 0:06:56.736981
2025-01-06T18:05:18 - INFO: DataSub took 0:06:56.737065