vexing_test_failure.txt

  2: Test command: /usr/bin/python3 "-u" "/opt/ros/foxy/share/ament_cmake_test/cmake/run_test.py" "/home/runner/work/rmf_ros2/rmf_ros2/ros_ws/build/rmf_fleet_adapter/test_results/rmf_fleet_adapter/rmf_fleet_adapter_test.catch2.xml" "--package-name" "rmf_fleet_adapter" "--output-file" "/home/runner/work/rmf_ros2/rmf_ros2/ros_ws/build/rmf_fleet_adapter/ament_cmake_catch2/rmf_fleet_adapter_test.txt" "--command" "/home/runner/work/rmf_ros2/rmf_ros2/ros_ws/build/rmf_fleet_adapter/rmf_fleet_adapter_test" "-r junit" "-o /home/runner/work/rmf_ros2/rmf_ros2/ros_ws/build/rmf_fleet_adapter/test_results/rmf_fleet_adapter/rmf_fleet_adapter_test.catch2.xml"
  2: Test timeout computed to be: 300
  2: -- run_test.py: invoking following command in '/home/runner/work/rmf_ros2/rmf_ros2/ros_ws/build/rmf_fleet_adapter':
  2:  - /home/runner/work/rmf_ros2/rmf_ros2/ros_ws/build/rmf_fleet_adapter/rmf_fleet_adapter_test -r junit -o /home/runner/work/rmf_ros2/rmf_ros2/ros_ws/build/rmf_fleet_adapter/test_results/rmf_fleet_adapter/rmf_fleet_adapter_test.catch2.xml
  2: [WARN] [1624030160.244560086] [rclcpp]: logging was initialized more than once
  2: [INFO] [1624030160.306077805] [rmf_traffic_blockade_node]: New path for A with 5 checkpoints
  2: [INFO] [1624030160.308695403] [rmf_traffic_blockade_node]: Ready: A2
  2: [INFO] [1624030160.314645728] [rmf_traffic_blockade_node]: New path for B with 5 checkpoints
  2: [INFO] [1624030160.315367555] [rmf_traffic_blockade_node]: Ready: B1
  2: [INFO] [1624030160.316438295] [rmf_traffic_blockade_node]: Canceling: B
  2: [INFO] [1624030160.317330029] [rmf_traffic_blockade_node]: Canceling: A
  2: [WARN] [1624030160.333923254] [rclcpp]: logging was initialized more than once
  2: [INFO] [1624030161.341620642] [rmf_traffic_blockade_node]: New path for A with 5 checkpoints
  2: [INFO] [1624030161.342327668] [rmf_traffic_blockade_node]: Ready: A1
  2: [INFO] [1624030161.346703233] [rmf_traffic_blockade_node]: New path for B with 5 checkpoints
  2: [INFO] [1624030161.347162851] [rmf_traffic_blockade_node]: Ready: B1
  2: [INFO] [1624030161.393321891] [rmf_traffic_blockade_node]: Reached: A2
  2: [INFO] [1624030161.394080219] [rmf_traffic_blockade_node]: Canceling: B
  2: [INFO] [1624030161.394383831] [rmf_traffic_blockade_node]: Canceling: A
  2: [INFO] [1624030161.427073063] [test_node_0]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030161.470144387] [test_node_1]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030161.504161569] [test_node_2]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030163.528640682] [test_node_3]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030163.563422792] [test_node_4]: Added a robot named [test_robot] with participant ID [0]
  2: [WARN] [1624030168.331625393] [test_node_4]: Fleet [test_fleet] is not configured to accept any task requests. Use FleetUpdateHadndle::accept_task_requests(~) to define a callback for accepting requests
  2: [WARN] [1624030171.887389110] [test_node_4]: Fleet [test_fleet] is not configured to accept any task requests. Use FleetUpdateHadndle::accept_task_requests(~) to define a callback for accepting requests
  2: [INFO] [1624030173.588623168] [test_node_5]: Added a robot named [test_robot] with participant ID [0]
  2: [WARN] [1624030175.287449336] [test_node_5]: Fleet [test_fleet] is not configured to accept any task requests. Use FleetUpdateHadndle::accept_task_requests(~) to define a callback for accepting requests
  2: [WARN] [1624030178.411320118] [test_node_5]: Fleet [test_fleet] is not configured to accept any task requests. Use FleetUpdateHadndle::accept_task_requests(~) to define a callback for accepting requests
  2: [INFO] [1624030183.618645838] [test_node_6]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030183.657682709] [test_node_7]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030183.683209071] [test_node_8]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030185.710425675] [test_node_9]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030185.740465909] [test_node_10]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030185.778536547] [test_node_11]: Added a robot named [test_robot] with participant ID [0]
  2: [WARN] [1624030185.931783335] [test_node_11]: Fleet [test_fleet] is not configured to accept any task requests. Use FleetUpdateHadndle::accept_task_requests(~) to define a callback for accepting requests
  2: [INFO] [1624030186.907444586] [test_node_12]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030188.034746264] [test_node_13]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030188.172324060] [test_node_14]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030188.250703720] [test_node_15]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030190.374250927] [test_node_16]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030190.496939460] [test_node_17]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030190.529495290] [test_node_18]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030190.562743246] [test_node_19]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030192.588787569] [test_node_20]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030195.612111152] [test_node_21]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030195.788984323] [test_node_22]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030195.915068179] [test_node_23]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030195.990659730] [test_node_24]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030197.019632240] [test_node_25]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030197.058253697] [test_node_26]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030199.086592701] [test_node_27]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030202.121245417] [test_node_28]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030202.255996365] [test_node_29]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030202.390992722] [test_node_30]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030202.425443513] [test_node_31]: Added a robot named [test_robot] with participant ID [0]
  2: [INFO] [1624030203.450976630] [test_node_32]: Added a robot named [test_robot_0] with participant ID [0]
  2: [INFO] [1624030203.452656193] [test_node_32]: Added a robot named [test_robot_1] with participant ID [1]
  2: [INFO] [1624030328.478457499] [test_Delivery]: Added a robot named [T0] with participant ID [0]
  2: [INFO] [1624030329.479711756] [test_Delivery]: Generated Delivery request for task_id:[test_delivery]
  2: [INFO] [1624030329.480050967] [test_Delivery]: Planning for [1] robot(s) and [1] request(s)
  2: [INFO] [1624030329.483408875] [test_Delivery]: Submitted BidProposal to accommodate task [test_delivery] by robot [T0] with new cost [102.353318]
  2: [INFO] [1624030329.483601581] [test_Delivery]: Bid for task_id:[test_delivery] awarded to fleet [test_fleet]. Processing request...
  2: [INFO] [1624030329.485090329] [test_Delivery]: Assignments updated for robots in fleet [test_fleet] to accommodate task_id:[test_delivery]
  2: [INFO] [1624030329.486658779] [test_Delivery]: Beginning new task [test_delivery] for [test_fleet/T0]. Remaining queue size: 0
  2: [INFO] [1624030330.006007009] [test_Loop]: Added a robot named [T0] with participant ID [0]
  2: [INFO] [1624030330.008667994] [test_Loop]: Added a robot named [T1] with participant ID [1]
  2: [INFO] [1624030331.009926458] [test_Loop]: Generated Loop request for task_id:[loop_0]
  2: [INFO] [1624030331.010056363] [test_Loop]: Planning for [2] robot(s) and [1] request(s)
  2: [INFO] [1624030331.011688115] [test_Loop]: Submitted BidProposal to accommodate task [loop_0] by robot [T0] with new cost [477.403018]
  2: [INFO] [1624030331.011767617] [test_Loop]: Bid for task_id:[loop_0] awarded to fleet [test_fleet]. Processing request...
  2: [INFO] [1624030331.013196263] [test_Loop]: Assignments updated for robots in fleet [test_fleet] to accommodate task_id:[loop_0]
  2: [INFO] [1624030331.013870385] [test_Loop]: Generated Loop request for task_id:[loop_1]
  2: [INFO] [1624030331.014291598] [test_Loop]: Planning for [2] robot(s) and [2] request(s)
  2: [INFO] [1624030331.014747813] [test_Loop]: Beginning new task [loop_0] for [test_fleet/T0]. Remaining queue size: 0
  2: [INFO] [1624030331.020379293] [test_Loop]: Submitted BidProposal to accommodate task [loop_1] by robot [T1] with new cost [1004.122909]
  2: [INFO] [1624030331.020847008] [test_Loop]: Bid for task_id:[loop_1] awarded to fleet [test_fleet]. Processing request...
  2: [INFO] [1624030331.021278722] [test_Loop]: Planning for [2] robot(s) and [1] request(s)
  2: [INFO] [1624030331.023862405] [test_Loop]: Assignments updated for robots in fleet [test_fleet] to accommodate task_id:[loop_1]
  2: [INFO] [1624030331.031608153] [test_Loop]: Beginning new task [loop_1] for [test_fleet/T1]. Remaining queue size: 0
  2: -- run_test.py: return code 2
  2: -- run_test.py: verify result file '/home/runner/work/rmf_ros2/rmf_ros2/ros_ws/build/rmf_fleet_adapter/test_results/rmf_fleet_adapter/rmf_fleet_adapter_test.catch2.xml'
  2/3 Test #2: rmf_fleet_adapter_test ...........***Failed  174.32 sec