Skip to content

Instantly share code, notes, and snippets.

@aaronchongth
Created September 4, 2019 09:39
Show Gist options
  • Save aaronchongth/1888715072e92b0dbc29d2107ca9d2ee to your computer and use it in GitHub Desktop.
Save aaronchongth/1888715072e92b0dbc29d2107ca9d2ee to your computer and use it in GitHub Desktop.
Turtlebot3 - ROS2 Dashing - Navigation 2 bringup - Rviz2 issues
aaron@elite:~/turtlebot3/turtlebot3_ws$ ros2 launch turtlebot3_navigation2 navigation2.launch.py map:=/home/aaron/turtlebot3/maps/office/map.yaml
[INFO] [launch]: All log files can be found below /home/aaron/.ros/log/2019-09-04-16-16-40-762722-elite-32126
[INFO] [launch]: Default logging verbosity is set to INFO
567585001.059015 [0] ros2: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[INFO] [lifecycle_manager-1]: process started with pid [32153]
[INFO] [map_server-2]: process started with pid [32154]
[INFO] [amcl-3]: process started with pid [32155]
[INFO] [world_model-4]: process started with pid [32156]
[INFO] [dwb_controller-5]: process started with pid [32165]
[INFO] [navfn_planner-6]: process started with pid [32167]
[INFO] [recoveries_node-7]: process started with pid [32185]
[INFO] [bt_navigator-8]: process started with pid [32194]
[INFO] [rviz2-9]: process started with pid [32211]
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Creating
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Starting the system bringup...
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Creating and initializing lifecycle service clients
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Configuring and activating map_server
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Configuring and activating amcl
[map_server-2] [INFO] [map_server]: Creating
[map_server-2] [INFO] [map_server]: Configuring
[map_server-2] [INFO] [map_server]: OccGridLoader: Creating
[map_server-2] [INFO] [map_server]: OccGridLoader: Configuring
[map_server-2] [INFO] [map_server]: Activating
[map_server-2] [INFO] [map_server]: OccGridLoader: Activating
[amcl-3] [INFO] [amcl]: Creating
[amcl-3] [INFO] [amcl]: Configuring
[amcl-3] [INFO] [amcl]: initTransforms
[world_model-4] [INFO] [world_model]: Creating
[world_model-4] [INFO] [global_costmap.global_costmap]: Creating
[dwb_controller-5] [INFO] [dwb_controller]: Creating
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Creating
[navfn_planner-6] [INFO] [navfn_planner]: Creating
[recoveries_node-7] [INFO] [recoveries]: Configuring Spin
[recoveries_node-7] [INFO] [recoveries]: Configuring BackUp
[bt_navigator-8] [INFO] [bt_navigator]: Creating
[lifecycle_manager-1] 567585001.276549 [0] lifecycle_: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[map_server-2] 567585001.284538 [0] map_server: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[map_server-2] [WARN] [map_server]: Mode parameter not set, using default value (trinary): bad conversion
[amcl-3] 567585001.283922 [0] amcl: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[amcl-3] [WARN] [rcl.logging_rosout]: Publisher already registered for provided node name. If this is due to multiple nodes with the same name then all logs for that logger name will go out over the existing publisher. As soon as any node with that name is destructed it will unregister the publisher, preventing any further logs for that name from being published on the rosout topic.
[world_model-4] 567585001.288050 [0] world_mode: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[dwb_controller-5] 567585001.292782 [0] dwb_contro: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[navfn_planner-6] 567585001.292729 [0] navfn_plan: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[recoveries_node-7] 567585001.300615 [0] recoveries: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[recoveries_node-7] [WARN] [rcl.logging_rosout]: Publisher already registered for provided node name. If this is due to multiple nodes with the same name then all logs for that logger name will go out over the existing publisher. As soon as any node with that name is destructed it will unregister the publisher, preventing any further logs for that name from being published on the rosout topic.
[bt_navigator-8] 567585001.302955 [0] bt_navigat: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[amcl-3] [INFO] [amcl]: initPubSub
[amcl-3] [INFO] [amcl]: Subscribed to map topic.
[amcl-3] [INFO] [amcl]: Activating
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Configuring and activating world_model
[world_model-4] [INFO] [world_model]: Configuring
[world_model-4] [INFO] [global_costmap.global_costmap]: Configuring
[world_model-4] [INFO] [global_costmap.global_costmap]: Using plugin "static_layer"
[world_model-4] [INFO] [global_costmap.global_costmap]: Using plugin "obstacle_layer"
[world_model-4] [INFO] [global_costmap.global_costmap]: Subscribed to Topics: scan
[world_model-4] [INFO] [global_costmap.global_costmap]: Using plugin "inflation_layer"
[world_model-4] [INFO] [world_model]: Activating
[world_model-4] [INFO] [global_costmap.global_costmap]: Activating
[world_model-4] [INFO] [global_costmap.global_costmap]: Checking transform
[world_model-4] [INFO] [global_costmap.global_costmap]: StaticLayer: Resizing costmap to 138 X 239 at 0.050000 m/pix
[rviz2-9] 567585001.418830 [0] rviz2: using network interface enp42s0 (udp/192.168.0.130) selected arbitrarily from: enp42s0, docker0
[rviz2-9] [INFO] [rviz2]: Stereo is NOT SUPPORTED
[rviz2-9] [INFO] [rviz2]: OpenGl version: 4.6 (GLSL 4.6)
[rviz2-9] [INFO] [rviz2]: Stereo is NOT SUPPORTED
[rviz2-9] [WARN] [rcl.logging_rosout]: Publisher already registered for provided node name. If this is due to multiple nodes with the same name then all logs for that logger name will go out over the existing publisher. As soon as any node with that name is destructed it will unregister the publisher, preventing any further logs for that name from being published on the rosout topic.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00788 timeout was 1.
[rviz2-9] [INFO] [rviz2]: Trying to create a map of size 138 x 239 using 1 swatches
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.0077 timeout was 1.
[amcl-3] [WARN] [amcl]: Waiting for map....
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] Parsing robot urdf xml string.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00769 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.0076 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[amcl-3] [WARN] [amcl]: Waiting for map....
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00661 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00703 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[amcl-3] [WARN] [amcl]: Waiting for map....
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00689 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00663 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[amcl-3] [WARN] [amcl]: Waiting for map....
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00761 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00822 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [INFO] [rviz2]: Setting goal: Frame:map, Position(0.0267055, 0.0424035, 0), Orientation(0, 0, -0.995032, 0.0995549) = Angle: -2.94215
[amcl-3] [INFO] [amcl]: initialPoseReceived
[amcl-3] [INFO] [amcl]: Setting pose (1567585012.347375): 0.027 0.042 -2.942
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: . canTransform returned after 1.00847 timeout was 1.
[amcl-3] [WARN] [amcl]: Waiting for map....
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[rviz2-9] [ERROR] [rviz2]: "map" passed to lookupTransform argument target_frame does not exist.
[amcl-3] [INFO] [amcl]: Received a 138 X 239 map @ 0.050 m/pix
[amcl-3]
[amcl-3] [INFO] [amcl]: Setting pose (1567585013.313209): 0.027 0.042 -2.942
[amcl-3] [INFO] [amcl]: createLaserObject
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585012.87058 but the latest data is at time 1567585012.77517, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [INFO] [global_costmap.global_costmap]: Timed out waiting for transform from base_link to map to become available, tf error: Lookup would require extrapolation at time 1567585011.66383, but only time 1567585013.66907 is in the buffer, when looking up transform from frame [base_link] to frame [map]. canTransform returned after 1.00823 timeout was 1.
[amcl-3] [INFO] [amcl_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585003.039 for reason(0)
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585013.07059 but the latest data is at time 1567585012.77517, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585013.27181 but the latest data is at time 1567585012.77517, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585013.47175 but the latest data is at time 1567585013.36382, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585003.039 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585003.241 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585003.441 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585003.643 for reason(0)
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585013.67310 but the latest data is at time 1567585013.61378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [INFO] [global_costmap.global_costmap]: start
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Configuring and activating dwb_controller
[dwb_controller-5] [INFO] [dwb_controller]: Configuring
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Configuring
[rviz2-9] [INFO] [rviz2]: Trying to create a map of size 138 x 239 using 1 swatches
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Using plugin "obstacle_layer"
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Subscribed to Topics: scan
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Using plugin "inflation_layer"
[dwb_controller-5] [INFO] [dwb_controller]: Setting transform_tolerance to 0.200000
[dwb_controller-5] [INFO] [dwb_controller]: Using critic "RotateToGoal" (dwb_critics::RotateToGoalCritic)
[dwb_controller-5] [INFO] [dwb_controller]: Critic plugin initialized
[dwb_controller-5] [INFO] [dwb_controller]: Using critic "Oscillation" (dwb_critics::OscillationCritic)
[dwb_controller-5] [INFO] [dwb_controller]: Critic plugin initialized
[dwb_controller-5] [INFO] [dwb_controller]: Using critic "BaseObstacle" (dwb_critics::BaseObstacleCritic)
[dwb_controller-5] [INFO] [dwb_controller]: Critic plugin initialized
[dwb_controller-5] [INFO] [dwb_controller]: Using critic "GoalAlign" (dwb_critics::GoalAlignCritic)
[dwb_controller-5] [INFO] [dwb_controller]: Critic plugin initialized
[dwb_controller-5] [INFO] [dwb_controller]: Using critic "PathAlign" (dwb_critics::PathAlignCritic)
[dwb_controller-5] [INFO] [dwb_controller]: Critic plugin initialized
[dwb_controller-5] [INFO] [dwb_controller]: Using critic "PathDist" (dwb_critics::PathDistCritic)
[dwb_controller-5] [INFO] [dwb_controller]: Critic plugin initialized
[dwb_controller-5] [INFO] [dwb_controller]: Using critic "GoalDist" (dwb_critics::GoalDistCritic)
[dwb_controller-5] [INFO] [dwb_controller]: Critic plugin initialized
[dwb_controller-5] [INFO] [dwb_controller]: Controller frequency set to 20.0000Hz
[dwb_controller-5] [INFO] [dwb_controller]: Activating
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Activating
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Checking transform
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585014.1452, global_pose stamp: 1567585013.7638, tolerance: 0.3000, difference: 0.3814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585014.3452, global_pose stamp: 1567585013.7638, tolerance: 0.3000, difference: 0.5814
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585013.87301 but the latest data is at time 1567585013.76380, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585003.843 for reason(0)
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585014.5452, global_pose stamp: 1567585014.0638, tolerance: 0.3000, difference: 0.4814
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585004.044 for reason(0)
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585014.07439 but the latest data is at time 1567585014.06382, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585014.27437 but the latest data is at time 1567585014.16378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585004.244 for reason(0)
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585014.7452, global_pose stamp: 1567585014.3138, tolerance: 0.3000, difference: 0.4314
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00674 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585014.9452, global_pose stamp: 1567585014.3638, tolerance: 0.3000, difference: 0.5814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585015.1452, global_pose stamp: 1567585014.4638, tolerance: 0.3000, difference: 0.6814
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585004.444 for reason(0)
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585014.47569 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585015.3452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 0.8314
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585015.5452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 1.0314
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585015.7452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 1.2314
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00657 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585015.9452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 1.4314
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585016.1452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 1.6314
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585016.3452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 1.8314
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585016.5452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 2.0314
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585016.7452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 2.2314
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00683 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585016.9452, global_pose stamp: 1567585014.5138, tolerance: 0.3000, difference: 2.4314
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585017.1452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 2.5313
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585017.3452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 2.7313
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585017.5452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 2.9313
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585017.7452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 3.1313
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00674 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585017.9452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 3.3313
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585018.1452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 3.5313
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585018.3452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 3.7313
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585018.5452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 3.9313
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585018.7452, global_pose stamp: 1567585014.6139, tolerance: 0.3000, difference: 4.1313
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00776 timeout was 1.
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585014.67572 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585018.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 4.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585019.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 4.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585019.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 4.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585019.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 4.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585019.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 5.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00798 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585019.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 5.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585020.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 5.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585020.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 5.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585020.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 5.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585020.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 6.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00823 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585020.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 6.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585021.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 6.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585021.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 6.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585021.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 6.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585021.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 7.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00769 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585021.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 7.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585022.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 7.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585022.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 7.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585022.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 7.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585022.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 8.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00663 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585022.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 8.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585023.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 8.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585023.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 8.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585023.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 8.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585023.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 9.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00714 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585023.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 9.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585024.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 9.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585024.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 9.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585024.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 9.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585024.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 10.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00867 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585024.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 10.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585025.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 10.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585025.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 10.6814
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585014.87600 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585025.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 10.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585025.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 11.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.0081 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585025.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 11.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585026.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 11.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585026.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 11.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585026.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 11.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585026.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 12.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00862 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585026.9453, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 12.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585027.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 12.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585027.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 12.6814
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585015.07737 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585027.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 12.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585027.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 13.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00706 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585027.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 13.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585028.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 13.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585028.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 13.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585028.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 13.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585028.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 14.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00741 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585028.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 14.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585029.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 14.4814
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585015.27724 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585029.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 14.6814
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585015.47912 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585029.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 14.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585029.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 15.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00734 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585029.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 15.2814
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585015.67990 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585030.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 15.4814
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585015.87983 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585030.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 15.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585030.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 15.8814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585030.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 16.0814
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00764 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585030.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 16.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585031.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 16.4814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585031.3452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 16.6814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585031.5452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 16.8814
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585016.08106 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585031.7452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 17.0814
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585004.646 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: Timed out waiting for transform from base_link to odom to become available, tf error: . canTransform returned after 1.00751 timeout was 1.
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585031.9452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 17.2814
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585032.1452, global_pose stamp: 1567585014.6638, tolerance: 0.3000, difference: 17.4814
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585004.846 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585005.047 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585005.247 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585005.447 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585005.648 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585005.848 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585006.050 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585006.250 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585006.450 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585006.651 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585006.851 for reason(0)
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585032.3452, global_pose stamp: 1567585017.0811, tolerance: 0.3000, difference: 15.2641
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585009.860 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585009.660 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585009.459 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585009.259 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585009.058 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585008.858 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585008.656 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585008.456 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585008.255 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585008.055 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585007.854 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585007.654 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585007.454 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585007.252 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585007.053 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585010.061 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585010.261 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585010.463 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585010.663 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585011.064 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585013.472 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585013.272 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585021.954 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585011.265 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585011.867 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585012.068 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585012.268 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585012.469 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585012.669 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585012.871 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585013.071 for reason(0)
[world_model-4] [ERROR] [global_costmap.global_costmap]: Extrapolation Error looking up robot pose: Lookup would require extrapolation into the past. Requested time 1567585032.26373 but the earliest data is at time 1567585032.93529, when looking up transform from frame [base_link] to frame [map]
[world_model-4]
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585021.954 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585016.081 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585015.880 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585015.680 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585015.479 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585015.277 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585015.077 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585014.876 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585014.676 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585014.476 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585014.274 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585014.074 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585013.873 for reason(0)
[dwb_controller-5] [INFO] [local_costmap.local_costmap]: start
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Configuring and activating navfn_planner
[navfn_planner-6] [INFO] [navfn_planner]: Configuring
[world_model-4] [ERROR] [global_costmap.global_costmap]: Extrapolation Error looking up robot pose: Lookup would require extrapolation into the past. Requested time 1567585032.51374 but the earliest data is at time 1567585032.93529, when looking up transform from frame [base_link] to frame [map]
[world_model-4]
[navfn_planner-6] [INFO] [navfn_planner]: Activating
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Configuring and activating bt_navigator
[bt_navigator-8] [INFO] [bt_navigator]: Configuring
[rviz2-9] [ERROR] [navigation_dialog_action_client]: Goal was rejected by server
[rviz2-9] [INFO] [rviz2]: Trying to create a map of size 60 x 60 using 1 swatches
[bt_navigator-8] [INFO] [bt_navigator_client_node]: Waiting for "ComputePathToPose" action server
[bt_navigator-8] [INFO] [bt_navigator_client_node]: "ComputePathToPose" BtActionNode initialized
[bt_navigator-8] [INFO] [bt_navigator_client_node]: Waiting for "FollowPath" action server
[bt_navigator-8] [INFO] [bt_navigator_client_node]: "FollowPath" BtActionNode initialized
[bt_navigator-8] [INFO] [bt_navigator_client_node]: Waiting for "Spin" action server
[bt_navigator-8] [INFO] [bt_navigator_client_node]: "Spin" BtActionNode initialized
[bt_navigator-8] [INFO] [bt_navigator]: Activating
[lifecycle_manager-1] [INFO] [lifecycle_manager]: The system is active
[world_model-4] [ERROR] [global_costmap.global_costmap]: Extrapolation Error looking up robot pose: Lookup would require extrapolation into the past. Requested time 1567585032.86373 but the earliest data is at time 1567585032.93529, when looking up transform from frame [base_link] to frame [map]
[world_model-4]
[world_model-4] [ERROR] [global_costmap.global_costmap]: Extrapolation Error looking up robot pose: Lookup would require extrapolation into the past. Requested time 1567585032.91373 but the earliest data is at time 1567585032.93529, when looking up transform from frame [base_link] to frame [map]
[world_model-4]
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585033.3345, global_pose stamp: 1567585033.0138, tolerance: 0.3000, difference: 0.3207
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585033.7345, global_pose stamp: 1567585033.4137, tolerance: 0.3000, difference: 0.3208
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585037.3345, global_pose stamp: 1567585036.8639, tolerance: 0.3000, difference: 0.4706
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585037.3452, global_pose stamp: 1567585036.8639, tolerance: 0.3000, difference: 0.4813
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585037.5345, global_pose stamp: 1567585036.8639, tolerance: 0.3000, difference: 0.6706
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585037.5452, global_pose stamp: 1567585036.8639, tolerance: 0.3000, difference: 0.6814
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585037.7345, global_pose stamp: 1567585036.8639, tolerance: 0.3000, difference: 0.8706
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585037.7452, global_pose stamp: 1567585036.8639, tolerance: 0.3000, difference: 0.8813
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585037.9345, global_pose stamp: 1567585036.8639, tolerance: 0.3000, difference: 1.0706
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585037.9452, global_pose stamp: 1567585036.8639, tolerance: 0.3000, difference: 1.0813
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585038.1345, global_pose stamp: 1567585036.9137, tolerance: 0.3000, difference: 1.2208
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585038.1452, global_pose stamp: 1567585036.9137, tolerance: 0.3000, difference: 1.2315
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585038.3345, global_pose stamp: 1567585036.9137, tolerance: 0.3000, difference: 1.4208
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585038.3452, global_pose stamp: 1567585036.9637, tolerance: 0.3000, difference: 1.3815
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585038.5345, global_pose stamp: 1567585036.9637, tolerance: 0.3000, difference: 1.5708
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585038.5452, global_pose stamp: 1567585036.9637, tolerance: 0.3000, difference: 1.5815
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585038.7345, global_pose stamp: 1567585036.9637, tolerance: 0.3000, difference: 1.7708
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585038.7452, global_pose stamp: 1567585036.9637, tolerance: 0.3000, difference: 1.7815
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585038.9345, global_pose stamp: 1567585037.0138, tolerance: 0.3000, difference: 1.9207
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585038.9452, global_pose stamp: 1567585037.0138, tolerance: 0.3000, difference: 1.9315
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585039.1345, global_pose stamp: 1567585037.0637, tolerance: 0.3000, difference: 2.0708
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585039.1452, global_pose stamp: 1567585037.0637, tolerance: 0.3000, difference: 2.0815
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585039.3345, global_pose stamp: 1567585037.0637, tolerance: 0.3000, difference: 2.2708
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585039.3452, global_pose stamp: 1567585037.0637, tolerance: 0.3000, difference: 2.2815
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585039.5345, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 2.4208
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585039.5452, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 2.4315
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585039.7345, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 2.6208
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585039.7452, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 2.6315
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585039.9345, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 2.8208
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585039.9452, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 2.8315
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585040.1345, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 3.0208
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585040.1452, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 3.0315
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585040.3345, global_pose stamp: 1567585037.1137, tolerance: 0.3000, difference: 3.2208
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585040.3452, global_pose stamp: 1567585037.1638, tolerance: 0.3000, difference: 3.1814
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585040.5345, global_pose stamp: 1567585037.1638, tolerance: 0.3000, difference: 3.3707
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585040.5452, global_pose stamp: 1567585037.1638, tolerance: 0.3000, difference: 3.3814
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585040.7345, global_pose stamp: 1567585037.1638, tolerance: 0.3000, difference: 3.5707
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585040.7452, global_pose stamp: 1567585037.1638, tolerance: 0.3000, difference: 3.5815
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585040.9345, global_pose stamp: 1567585037.1638, tolerance: 0.3000, difference: 3.7707
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585040.9452, global_pose stamp: 1567585037.3279, tolerance: 0.3000, difference: 3.6173
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585041.1345, global_pose stamp: 1567585037.3279, tolerance: 0.3000, difference: 3.8066
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585041.1452, global_pose stamp: 1567585037.3279, tolerance: 0.3000, difference: 3.8173
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585041.3345, global_pose stamp: 1567585037.3279, tolerance: 0.3000, difference: 4.0066
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585041.3452, global_pose stamp: 1567585037.3279, tolerance: 0.3000, difference: 4.0173
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585041.5345, global_pose stamp: 1567585037.3755, tolerance: 0.3000, difference: 4.1590
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585041.5452, global_pose stamp: 1567585037.3755, tolerance: 0.3000, difference: 4.1698
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585041.7345, global_pose stamp: 1567585037.5235, tolerance: 0.3000, difference: 4.2110
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585041.7452, global_pose stamp: 1567585038.0296, tolerance: 0.3000, difference: 3.7156
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585041.9345, global_pose stamp: 1567585038.0296, tolerance: 0.3000, difference: 3.9049
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585041.9452, global_pose stamp: 1567585038.0296, tolerance: 0.3000, difference: 3.9156
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585042.1345, global_pose stamp: 1567585038.2447, tolerance: 0.3000, difference: 3.8898
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585042.1452, global_pose stamp: 1567585038.2447, tolerance: 0.3000, difference: 3.9005
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585042.3345, global_pose stamp: 1567585038.2447, tolerance: 0.3000, difference: 4.0898
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585042.3452, global_pose stamp: 1567585038.2447, tolerance: 0.3000, difference: 4.1005
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585042.5345, global_pose stamp: 1567585038.2447, tolerance: 0.3000, difference: 4.2898
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585042.5452, global_pose stamp: 1567585038.2447, tolerance: 0.3000, difference: 4.3005
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585042.7345, global_pose stamp: 1567585038.3754, tolerance: 0.3000, difference: 4.3591
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585042.7452, global_pose stamp: 1567585038.3754, tolerance: 0.3000, difference: 4.3698
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585042.9345, global_pose stamp: 1567585038.3754, tolerance: 0.3000, difference: 4.5591
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585042.9452, global_pose stamp: 1567585038.3754, tolerance: 0.3000, difference: 4.5698
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585043.1345, global_pose stamp: 1567585038.3754, tolerance: 0.3000, difference: 4.7591
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585043.1452, global_pose stamp: 1567585038.5170, tolerance: 0.3000, difference: 4.6282
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585043.3345, global_pose stamp: 1567585038.5170, tolerance: 0.3000, difference: 4.8175
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585043.3452, global_pose stamp: 1567585038.5170, tolerance: 0.3000, difference: 4.8282
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585043.5345, global_pose stamp: 1567585038.8668, tolerance: 0.3000, difference: 4.6677
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585043.5452, global_pose stamp: 1567585038.8668, tolerance: 0.3000, difference: 4.6784
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585043.7345, global_pose stamp: 1567585038.8668, tolerance: 0.3000, difference: 4.8677
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585043.7452, global_pose stamp: 1567585038.8668, tolerance: 0.3000, difference: 4.8784
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585043.9345, global_pose stamp: 1567585038.8668, tolerance: 0.3000, difference: 5.0677
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585043.9452, global_pose stamp: 1567585038.8668, tolerance: 0.3000, difference: 5.0784
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585044.1345, global_pose stamp: 1567585039.3182, tolerance: 0.3000, difference: 4.8163
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585044.1452, global_pose stamp: 1567585039.3182, tolerance: 0.3000, difference: 4.8270
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585044.3345, global_pose stamp: 1567585039.3182, tolerance: 0.3000, difference: 5.0163
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585044.3452, global_pose stamp: 1567585039.3182, tolerance: 0.3000, difference: 5.0270
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585044.5345, global_pose stamp: 1567585040.3825, tolerance: 0.3000, difference: 4.1520
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585044.5452, global_pose stamp: 1567585040.3825, tolerance: 0.3000, difference: 4.1627
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585044.7345, global_pose stamp: 1567585040.4911, tolerance: 0.3000, difference: 4.2434
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585044.7452, global_pose stamp: 1567585040.8800, tolerance: 0.3000, difference: 3.8652
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585044.9345, global_pose stamp: 1567585040.8800, tolerance: 0.3000, difference: 4.0545
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585044.9452, global_pose stamp: 1567585040.8800, tolerance: 0.3000, difference: 4.0652
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585045.1345, global_pose stamp: 1567585041.1395, tolerance: 0.3000, difference: 3.9950
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585045.1452, global_pose stamp: 1567585041.1395, tolerance: 0.3000, difference: 4.0057
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585045.3345, global_pose stamp: 1567585041.2457, tolerance: 0.3000, difference: 4.0888
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585045.3452, global_pose stamp: 1567585041.2457, tolerance: 0.3000, difference: 4.0995
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585031.935 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585032.137 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585032.337 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585032.738 for reason(0)
[world_model-4] [INFO] [global_costmap.global_costmap_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585032.537 for reason(0)
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585045.5345, global_pose stamp: 1567585043.2283, tolerance: 0.3000, difference: 2.3062
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585045.5452, global_pose stamp: 1567585043.2283, tolerance: 0.3000, difference: 2.3169
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585045.7345, global_pose stamp: 1567585044.4439, tolerance: 0.3000, difference: 1.2906
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585045.7452, global_pose stamp: 1567585044.4439, tolerance: 0.3000, difference: 1.3013
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585045.9345, global_pose stamp: 1567585044.7261, tolerance: 0.3000, difference: 1.2084
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585045.9452, global_pose stamp: 1567585044.9088, tolerance: 0.3000, difference: 1.0363
[amcl-3] [INFO] [amcl_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585045.125 for reason(0)
[amcl-3] [INFO] [amcl_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585045.160 for reason(0)
[amcl-3] [INFO] [amcl_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585045.200 for reason(0)
[amcl-3] [INFO] [amcl_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585045.227 for reason(0)
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585046.1345, global_pose stamp: 1567585044.9161, tolerance: 0.3000, difference: 1.2184
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585046.1452, global_pose stamp: 1567585044.9668, tolerance: 0.3000, difference: 1.1784
[amcl-3] [INFO] [amcl_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585045.266 for reason(0)
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585045.73789 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[amcl-3] [INFO] [amcl_rclcpp_node]: [signalFailure] Drop message: frame 'base_scan' at time 1567585045.296 for reason(0)
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585045.85093 but the latest data is at time 1567585014.46378, when looking up transform from frame [base_scan] to frame [map]
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585046.3345, global_pose stamp: 1567585045.4209, tolerance: 0.3000, difference: 0.9136
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585046.3452, global_pose stamp: 1567585045.4915, tolerance: 0.3000, difference: 0.8537
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585045.97875 but the latest data is at time 1567585017.92121, when looking up transform from frame [base_scan] to frame [map]
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585046.5345, global_pose stamp: 1567585045.6206, tolerance: 0.3000, difference: 0.9139
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585046.5452, global_pose stamp: 1567585045.6206, tolerance: 0.3000, difference: 0.9246
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585046.18004 but the latest data is at time 1567585017.92121, when looking up transform from frame [base_scan] to frame [map]
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585046.7345, global_pose stamp: 1567585045.9135, tolerance: 0.3000, difference: 0.8210
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585046.7452, global_pose stamp: 1567585045.9135, tolerance: 0.3000, difference: 0.8317
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585046.38053 but the latest data is at time 1567585045.98313, when looking up transform from frame [base_scan] to frame [map]
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585046.9345, global_pose stamp: 1567585046.1275, tolerance: 0.3000, difference: 0.8070
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585046.9452, global_pose stamp: 1567585046.1275, tolerance: 0.3000, difference: 0.8177
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585046.58035 but the latest data is at time 1567585046.12752, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585046.78156 but the latest data is at time 1567585046.50528, when looking up transform from frame [base_scan] to frame [map]
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585047.1345, global_pose stamp: 1567585046.5053, tolerance: 0.3000, difference: 0.6292
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585047.1452, global_pose stamp: 1567585046.5053, tolerance: 0.3000, difference: 0.6399
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585046.98170 but the latest data is at time 1567585046.58340, when looking up transform from frame [base_scan] to frame [map]
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585047.3345, global_pose stamp: 1567585046.9713, tolerance: 0.3000, difference: 0.3632
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585047.3452, global_pose stamp: 1567585046.9713, tolerance: 0.3000, difference: 0.3739
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585047.18319 but the latest data is at time 1567585047.07912, when looking up transform from frame [base_scan] to frame [map]
[dwb_controller-5] [WARN] [local_costmap.local_costmap]: Transform timeout. Current time: 1567585047.5345, global_pose stamp: 1567585047.1136, tolerance: 0.3000, difference: 0.4208
[world_model-4] [WARN] [global_costmap.global_costmap]: Transform timeout. Current time: 1567585047.5452, global_pose stamp: 1567585047.1136, tolerance: 0.3000, difference: 0.4316
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585047.38320 but the latest data is at time 1567585047.11364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585047.58458 but the latest data is at time 1567585047.56369, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585047.78459 but the latest data is at time 1567585047.76372, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585047.98592 but the latest data is at time 1567585047.96370, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585048.18592 but the latest data is at time 1567585048.11371, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585048.38596 but the latest data is at time 1567585048.36368, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585048.58724 but the latest data is at time 1567585048.56365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585048.78731 but the latest data is at time 1567585048.71365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585048.98846 but the latest data is at time 1567585048.91365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585049.18840 but the latest data is at time 1567585049.16366, when looking up transform from frame [base_scan] to frame [map]
[bt_navigator-8] [INFO] [bt_navigator]: Begin navigating from current location to (0.88, -1.06)
[bt_navigator-8] terminate called after throwing an instance of 'rclcpp::exceptions::RCLError'
[bt_navigator-8] what(): error taking goal response: error not set
[ERROR] [bt_navigator-8]: process has died [pid 32194, exit code -6, cmd '/opt/ros/dashing/lib/nav2_bt_navigator/bt_navigator __node:=bt_navigator __params:=/tmp/tmpunwizjq1'].
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585049.38966 but the latest data is at time 1567585049.36368, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585049.59004 but the latest data is at time 1567585049.51368, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585049.79143 but the latest data is at time 1567585049.76374, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585049.99141 but the latest data is at time 1567585049.96370, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585050.19128 but the latest data is at time 1567585050.16366, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585050.39282 but the latest data is at time 1567585050.31368, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585050.59280 but the latest data is at time 1567585050.56364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585050.79405 but the latest data is at time 1567585050.76364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585050.99437 but the latest data is at time 1567585050.91368, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585051.19543 but the latest data is at time 1567585051.11370, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585051.39544 but the latest data is at time 1567585051.36364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585051.59680 but the latest data is at time 1567585051.56364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585051.79808 but the latest data is at time 1567585051.76364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585051.99804 but the latest data is at time 1567585051.96363, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585052.19929 but the latest data is at time 1567585052.16365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585052.39930 but the latest data is at time 1567585052.36364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585052.60061 but the latest data is at time 1567585052.56366, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585052.80055 but the latest data is at time 1567585052.76366, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585053.00179 but the latest data is at time 1567585052.96363, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585053.20178 but the latest data is at time 1567585053.16365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585053.40326 but the latest data is at time 1567585053.36383, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585053.60341 but the latest data is at time 1567585053.56363, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585053.80325 but the latest data is at time 1567585053.76365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585054.00452 but the latest data is at time 1567585053.96365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585054.20466 but the latest data is at time 1567585054.11366, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585054.40842 but the latest data is at time 1567585054.36363, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585054.80708 but the latest data is at time 1567585054.76362, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585055.00709 but the latest data is at time 1567585054.96363, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585055.20828 but the latest data is at time 1567585055.16362, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585055.40829 but the latest data is at time 1567585055.36365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585055.60980 but the latest data is at time 1567585055.51370, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585055.80980 but the latest data is at time 1567585055.76369, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585056.01118 but the latest data is at time 1567585055.96365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585056.21127 but the latest data is at time 1567585056.16362, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585056.41254 but the latest data is at time 1567585056.36362, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585056.61256 but the latest data is at time 1567585056.56362, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585056.81377 but the latest data is at time 1567585056.76361, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585057.01390 but the latest data is at time 1567585056.96364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585057.21420 but the latest data is at time 1567585057.16361, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585057.41549 but the latest data is at time 1567585057.36365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585057.61555 but the latest data is at time 1567585057.56364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585057.81702 but the latest data is at time 1567585057.76365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585058.01726 but the latest data is at time 1567585057.96362, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585058.21839 but the latest data is at time 1567585058.16365, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585058.41852 but the latest data is at time 1567585058.36368, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585058.61867 but the latest data is at time 1567585058.56360, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585058.82013 but the latest data is at time 1567585058.76361, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585059.02129 but the latest data is at time 1567585058.96364, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] [ERROR] [rviz2]: Lookup would require extrapolation into the future. Requested time 1567585059.22139 but the latest data is at time 1567585059.16361, when looking up transform from frame [base_scan] to frame [map]
[rviz2-9] terminate called after throwing an instance of 'rclcpp::exceptions::RCLError'
[rviz2-9] what(): error taking status: error not set
[ERROR] [rviz2-9]: process has died [pid 32211, exit code -6, cmd '/opt/ros/dashing/lib/rviz2/rviz2 -d /opt/ros/dashing/share/nav2_bringup/launch/nav2_default_view.rviz __node:=rviz2 __params:=/tmp/launch_params_im21ktyq'].
^C[WARNING] [launch]: user interrupted with ctrl-c (SIGINT)
[recoveries_node-7] [INFO] [rclcpp]: signal_handler(signal_value=2)
[INFO] [lifecycle_manager-1]: process has finished cleanly [pid 32153]
[INFO] [map_server-2]: process has finished cleanly [pid 32154]
[INFO] [world_model-4]: process has finished cleanly [pid 32156]
[INFO] [dwb_controller-5]: process has finished cleanly [pid 32165]
[INFO] [navfn_planner-6]: process has finished cleanly [pid 32167]
[INFO] [recoveries_node-7]: process has finished cleanly [pid 32185]
[dwb_controller-5] [INFO] [rclcpp]: signal_handler(signal_value=2)
[world_model-4] [INFO] [rclcpp]: signal_handler(signal_value=2)
[world_model-4] [INFO] [world_model]: Destroying
[lifecycle_manager-1] [INFO] [rclcpp]: signal_handler(signal_value=2)
[lifecycle_manager-1] [INFO] [lifecycle_manager]: Destroying
[amcl-3] [INFO] [rclcpp]: signal_handler(signal_value=2)
[amcl-3] [INFO] [amcl]: Destroying
[navfn_planner-6] [INFO] [rclcpp]: signal_handler(signal_value=2)
[navfn_planner-6] [INFO] [navfn_planner]: Destroying
[map_server-2] [INFO] [rclcpp]: signal_handler(signal_value=2)
[INFO] [amcl-3]: process has finished cleanly [pid 32155]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment