Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Rapp stopping. #231

Open
jihoonl opened this issue May 14, 2014 · 4 comments
Open

Rapp stopping. #231

jihoonl opened this issue May 14, 2014 · 4 comments

Comments

@jihoonl
Copy link
Collaborator

jihoonl commented May 14, 2014

Scheduler somehow stopped a client without any reason.

These are logs I collected after I see client whoola stopped rapp.

/conductor/concert_clients topic

    name: whoola
    gateway_name: whoola69099bf7420b446b92fc400a08e31c0d
    platform_info: 
      uri: rocon:/waiterbot|turtlebot/whoola/hydro/precise
      version: acdc
      icon: 
        resource_name: ''
        format: png
    is_local_client: False
    state: available
    ip: 192.168.10.211
    conn_stats: 
      gateway_available: True
      time_since_last_seen: 3
      ping_latency_min: 1.82000005245
      ping_latency_max: 97.59400177
      ping_latency_avg: 23.170999527
      ping_latency_mdev: 29.7691993713
      network_info_available: True
      network_type: 2
      wireless_bitrate: 135000000.0
      wireless_link_quality: 42
      wireless_signal_level: -68.0
      wireless_noise_level: 0.0

concert_scheduler_requests

yujin@yujin-Gabrieli-Giovanni:~/demos/rocon_demo_201405/src/rocon_devices/rocon_hue$ concert_scheduler_requests 
##############################################################################
#                 Scheduler Request Feedback                                 #
##############################################################################
Requester [1faff986-4ed1-47e4-8fcd-31876e775001]
  Request
    Id        : 73cb89bb-6baa-4202-8b93-ab79560377a2
    Priority  : 1
    Status    : closed
    Resources : 07689304-2c71-4dbc-af3c-c18640a0e9c3-rocon:/waiterbot/whoola#ces_rapps/waiter_isolated-ces_rapps/waiter_isolated
##############################################################################
#                 Scheduler Request Feedback                                 #
##############################################################################
Requester [8a92dbf7-6858-4f11-a387-0c43cfc597cd]
  Request
    Id        : b926f7ef-e70c-4a71-95d3-606eae559919
    Priority  : 1
    Status    : granted
    Resources : 0df2037f-15e4-49ba-8abf-7890e27ec4c2-rocon:/pc/dudecbaf183b43494ae097196bd941d39876/hydro/precise-cafe_rapps/taskcoordinator
              : d57799eb-df3b-4e66-bf28-a28a963ec6b6-rocon:/waiterbot/adams1448a943393f4cba8f3b064c4c2cb4a9/hydro/precise-cafe_rapps/waiter
              : ec8239cd-475c-4366-b08b-4960151d4bdf-rocon:/waiterbot/zachb50d785f14d84af1969d0b0fb962b9df/hydro/precise-cafe_rapps/waiter
Requester [1faff986-4ed1-47e4-8fcd-31876e775001]
  Request
    Id        : 73cb89bb-6baa-4202-8b93-ab79560377a2
    Priority  : 1
    Status    : closed
    Resources : 07689304-2c71-4dbc-af3c-c18640a0e9c3-rocon:/waiterbot/whoola#ces_rapps/waiter_isolated-ces_rapps/waiter_isolated
##############################################################################
#                 Scheduler Request Feedback                                 #
##############################################################################
Requester [8a92dbf7-6858-4f11-a387-0c43cfc597cd]
  Request
    Id        : b926f7ef-e70c-4a71-95d3-606eae559919
    Priority  : 1
    Status    : granted
    Resources : 0df2037f-15e4-49ba-8abf-7890e27ec4c2-rocon:/pc/dudecbaf183b43494ae097196bd941d39876/hydro/precise-cafe_rapps/taskcoordinator
              : d57799eb-df3b-4e66-bf28-a28a963ec6b6-rocon:/waiterbot/adams1448a943393f4cba8f3b064c4c2cb4a9/hydro/precise-cafe_rapps/waiter
              : ec8239cd-475c-4366-b08b-4960151d4bdf-rocon:/waiterbot/zachb50d785f14d84af1969d0b0fb962b9df/hydro/precise-cafe_rapps/waiter
Requester [1faff986-4ed1-47e4-8fcd-31876e775001]
  Request
    Id        : 73cb89bb-6baa-4202-8b93-ab79560377a2
    Priority  : 1
    Status    : closed
    Resources : 07689304-2c71-4dbc-af3c-c18640a0e9c3-rocon:/waiterbot/whoola#ces_rapps/waiter_isolated-ces_rapps/waiter_isolated

Note that requester didn't re-request again at least for five mins.

Scheduler and conductor log related to whoola

[INFO] [WallTime: 1400063213.038120] Conductor : new client discovered [whoola69099bf7420b446b92fc400a08e31c0d]
[INFO] [WallTime: 1400063214.214663] Conductor : concert client transition [pending->uninvited][whoola]
[INFO] [WallTime: 1400063215.327883] Conductor : concert client transition [uninvited->joining][whoola]
[INFO] [WallTime: 1400063217.815071] Conductor : concert client transition [joining->available][whoola]
[INFO] [WallTime: 1400063217.863814] Scheduler : new concert client [whoola]
[INFO] [WallTime: 1400063217.902024] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
  Pruning...
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
    Pruning Resolvable Branches
      rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
  Pruned Tree
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
[INFO] [WallTime: 1400063217.912003] Scheduler : compatibility tree is valid, attempting to allocate [73cb89bb-6baa-4202-8b93-ab79560377a2]
[INFO] [WallTime: 1400063245.114621] Scheduler :   allocated [whoola]

Not very informative on client side log

[INFO] [WallTime: 1400063244.782792] Rapp Manager : successfully flipped ['drink_ar', 'drinks_dispensed', 'tray_empty', 'waiterbot_debug', 'order_cancelled']
[INFO] [WallTime: 1400063246.455109] Gateway : sending flip request [Cafeadd188b4a259412d9736e09b4f928563][subscriber][/vm_order/drink_order][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063246.554051] Gateway : sending flip request [Cafeadd188b4a259412d9736e09b4f928563][publisher][/vm_order/drink_ar][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063246.661848] Gateway : sending flip request [Cafeadd188b4a259412d9736e09b4f928563][publisher][/vm_order/waiterbot_debug][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063246.751466] Gateway : sending flip request [Cafeadd188b4a259412d9736e09b4f928563][publisher][/vm_order/order_cancelled][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063246.836520] Gateway : sending flip request [Cafeadd188b4a259412d9736e09b4f928563][publisher][/vm_order/tray_empty][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063246.931635] Gateway : sending flip request [Cafeadd188b4a259412d9736e09b4f928563][publisher][/vm_order/drinks_dispensed][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063288.458138] Rapp Manager : Stopping rapp 'ces_rapps/waiter_isolated'.
[whoola/target_pose_footprint_publisher-28] killing on exit
[whoola/origin_nav_target_publisher-27] killing on exit
[whoola/vm_nav_target_publisher-26] killing on exit
[whoola/ar_link_global_publisher-25] killing on exit
 [whoola/ar_link_right_publisher-23] killing on exit[whoola/ar_link_target_publisher-24] killing on exit

[whoola/ar_link_left_publisher-22] killing on exit
[whoola/init_pose_manager-21] killing on exit
[whoola/fake_localization-20] killing on exit
[whoola/move_base-19] killing on exit
[whoola/navigation_velocity_smoother-18] killing on exit
[ INFO] [1400063288.802206101]: Unloading nodelet /whoola/navigation_velocity_smoother from manager /mobile_base_nodelet_manager
[whoola/waypoint_manager-17] killing on exit
[whoola/waiterbot_ctrl_nowireless-16] killing on exit
[whoola/special_tasks_velocity_smoother-15] killing on exit
[ INFO] [1400063288.909429400]: Unloading nodelet /whoola/special_tasks_velocity_smoother from manager /mobile_base_nodelet_manager
[whoola/diff_drive_pose_controller-14] killing on exit
[ INFO] [1400063289.093769031]: Unloading nodelet /whoola/diff_drive_pose_controller from manager /mobile_base_nodelet_manager
[whoola/pose_controller_velocity_smoother-13] killing on exit
[ INFO] [1400063289.198676991]: Unloading nodelet /whoola/pose_controller_velocity_smoother from manager /mobile_base_nodelet_manager
[whoola/ar_pair_approach-12] killing on exit
[whoola/ar_pair_tracking-11] killing on exit

[whoola/ar_track_alvar-10] killing on exit
[whoola/colour_signal_node-8] killing on exit
[whoola/depthimage_to_laserscan-7] killing on exit
[ INFO] [1400063289.711643939]: Unloading nodelet /whoola/depthimage_to_laserscan from manager camera/camera_nodelet_manager
[whoola/camera/rectify_color-6] killing on exit
[ INFO] [1400063289.719584620]: Unloading nodelet /whoola/camera/rectify_color from manager camera_nodelet_manager
[whoola/camera/rectify_mono-5] killing on exit
[ INFO] [1400063289.738134705]: Unloading nodelet /whoola/camera/rectify_mono from manager camera_nodelet_manager
terminate called after throwing an instance of 'boost::exception_detail::clone_impl<boost::exception_detail::error_info_injector<boost::lock_error> >'
  what():  boost::lock_error
[whoola/camera/debayer-4] killing on exit
[ INFO] [1400063289.911041263]: Unloading nodelet /whoola/camera/debayer from manager camera_nodelet_manager
[whoola/camera/driver-3] killing on exit
[ INFO] [1400063289.917785215]: Unloading nodelet /whoola/camera/driver from manager camera_nodelet_manager
terminate called after throwing an instance of 'boost::exception_detail::clone_impl<boost::exception_detail::error_info_injector<boost::lock_error> >'
  what():  boost::lock_error
[whoola/camera/camera_nodelet_manager-2] killing on exit
[whoola/waiterbot_state_manager-1] killing on exit
[INFO] [WallTime: 1400063293.608970] Rapp Manager : stopped rapp [ces_rapps/waiter_isolated]'.
@jihoonl
Copy link
Collaborator Author

jihoonl commented May 14, 2014

Full log of concert.launch

... logging to /home/yujin/.ros/log/39453e44-db52-11e3-b7f5-207c8f21b358/roslaunch-yujin-Gabrieli-Giovanni-18806.log
Checking log directory for disk usage. This may take awhile.
Press Ctrl-C to interrupt
Done checking log file disk usage. Usage is <1GB.
started roslaunch server http://192.168.10.131:44964/

SUMMARY
========

PARAMETERS
 * /concert/conductor/auto_invite
 * /concert/conductor/local_clients_only
 * /concert/description
 * /concert/gateway/default_blacklist
 * /concert/gateway/disable_uuids
 * /concert/gateway/external_shutdown
 * /concert/gateway/firewall
 * /concert/gateway/hub_uri
 * /concert/gateway/hub_whitelist
 * /concert/gateway/name
 * /concert/gateway/network_interface
 * /concert/gateway/watch_loop_period
 * /concert/hub/external_shutdown
 * /concert/hub/gateway_unavailable_timeout
 * /concert/hub/max_memory
 * /concert/hub/name
 * /concert/hub/port
 * /concert/hub/zeroconf
 * /concert/icon
 * /concert/interactions/rosbridge_address
 * /concert/interactions/rosbridge_port
 * /concert/name
 * /concert/rosbridge_websocket/address
 * /concert/rosbridge_websocket/authenticate
 * /concert/rosbridge_websocket/port
 * /concert/services/auto_enable_services
 * /concert/services/services
 * /concert/zeroconf/zeroconf/services
 * /rocon/screen
 * /rosdistro
 * /rosversion

NODES
  /concert/zeroconf/
    zeroconf (zeroconf_avahi/zeroconf)
  /concert/
    conductor (concert_conductor/conductor.py)
    gateway (rocon_gateway/gateway.py)
    hub (rocon_hub/hub.py)
    interactions (rocon_interactions/interactions_manager.py)
    master (rocon_master_info/master.py)
    rocon_tf_reconstructor (rocon_tf_reconstructor/rocon_tf_reconstructor)
    rosapi (rosapi/rosapi)
    rosbridge_websocket (rosbridge_server/rosbridge_websocket)
    scheduler (concert_schedulers/compatibility_tree_scheduler.py)
    services (concert_service_manager/service_manager)

auto-starting new master
process[master]: started with pid [18835]
ROS_MASTER_URI=http://192.168.10.131:11311/
setting /run_id to 39453e44-db52-11e3-b7f5-207c8f21b358
process[rosout-1]: started with pid [18848]
started core service [/rosout]
process[concert/master-2]: started with pid [18866]
process[concert/services-3]: started with pid [18885]
process[concert/conductor-4]: started with pid [18916]
process[concert/scheduler-5]: started with pid [18969]
[INFO] [WallTime: 1400063198.998445] scheduler request topic: ~requests
process[concert/interactions-6]: started with pid [19100]
process[concert/hub-7]: started with pid [19205]
process[concert/gateway-8]: started with pid [19361]
process[concert/zeroconf/zeroconf-9]: started with pid [19364]
[INFO] [WallTime: 1400063200.548732] Hub : version 2.2.12
[INFO] [WallTime: 1400063200.724857] Hub : reset hub variables on the redis server.
[INFO] [WallTime: 1400063200.763345] Hub : advertising 'Cafe' on zeroconf [_ros-multimaster-hub._tcp, port 6380]
[INFO] [WallTime: 1400063201.010937] Gateway : generated unique hash name [Cafeadd188b4a259412d9736e09b4f928563]
process[concert/rocon_tf_reconstructor-10]: started with pid [19438]
[ INFO] [1400063201.053477285]: Initialized
[ INFO] [1400063201.053608363]: In Spin!
[INFO] [WallTime: 1400063201.064916] Gateway : checking if zeroconf services are available...
[ INFO] [1400063201.075336333]: Zeroconf: added a listener [_ros-multimaster-hub._tcp]
[INFO] [WallTime: 1400063201.088779] Gateway : discovered hub directly [http://localhost:6380]
process[concert/rosbridge_websocket-11]: started with pid [19484]
[ INFO] [1400063201.430641990]: Zeroconf: service successfully established [Cafe][_concert-master._tcp][11311]
[INFO] [WallTime: 1400063201.614106] Gateway : Found existing mismatched public key on the hub. Requesting resend for all flip-ins.
[INFO] [WallTime: 1400063201.615519] Gateway : registering on the hub [Cafe]
Established under name 'Cafe'
[ INFO] [1400063201.665125739]: Zeroconf: discovered new service [Cafe][_ros-multimaster-hub._tcp][local][3][ipv4]
process[concert/rosapi-12]: started with pid [19511]
registered capabilities (classes):
 - rosbridge_library.capabilities.call_service.CallService
 - rosbridge_library.capabilities.advertise.Advertise
 - rosbridge_library.capabilities.publish.Publish
 - rosbridge_library.capabilities.subscribe.Subscribe
 - <class 'rosbridge_library.capabilities.defragmentation.Defragment'>
 - rosbridge_library.capabilities.advertise_service.AdvertiseService
 - rosbridge_library.capabilities.service_response.ServiceResponse
 - rosbridge_library.capabilities.stop_service.StopService
[INFO] [WallTime: 1400063202.056843] Service Manager : serving request to enable 'admin'
[ INFO] [1400063202.165483487]: Zeroconf: resolved service [Cafe][_ros-multimaster-hub._tcp][local][3][ipv4][192.168.10.131:6380]
[INFO] [WallTime: 1400063202.211948] Rosbridge WebSocket server started on port 9090
[INFO] [WallTime: 1400063202.612468] Rosapi started
[INFO] [WallTime: 1400063202.626327] Gateway : discovered hub via zeroconf [localhost:6380]
[INFO] [WallTime: 1400063203.423487] Interactions : loading Gateway Graph [rocon_gateway_graph-Admin-/services/admin]
[INFO] [WallTime: 1400063203.424018] Interactions : loading Conductor Graph [concert_conductor_graph-Admin-/services/admin]
[INFO] [WallTime: 1400063203.424308] Interactions : loading Ros Graph [rqt_graph-Admin-/services/admin]
[INFO] [WallTime: 1400063203.424594] Interactions : loading Concert Info [concert_info-Admin-/services/admin]
[INFO] [WallTime: 1400063203.425229] Service Manager: service enabled [admin] [admin]
[INFO] [WallTime: 1400063203.425630] Service Manager : serving request to enable 'cafedelivery'
started roslaunch server http://192.168.10.131:35313/

SUMMARY
========

PARAMETERS
 * /rosdistro
 * /rosversion
 * /services/cafedelivery/auto_door_manager/table_id
 * /services/cafedelivery/cafe_delivery/filename
 * /services/cafedelivery/rocon_auto_door/arduino_ip
 * /services/cafedelivery/rocon_auto_door/close_door_trigger_duration
 * /services/cafedelivery/rocon_auto_door/door_ctrl_io_port
 * /services/cafedelivery/rocon_auto_door/open_door_trigger_duration
 * /services/cafedelivery/rocon_auto_door/open_door_trigger_duration_timer
 * /services/cafedelivery/rocon_auto_door/timer_ctrl

NODES
  /services/cafedelivery/
    auto_door_manager (cafe_devices_manager/auto_door_manager.py)
    cafe_delivery (concert_service_link_graph/static_link_graph_service.py)
    hue_manager (cafe_devices_manager/hue_manager.py)
    remote_order_manager (cafe_remote_order_manager/manager.py)
    rocon_auto_door (rocon_auto_door/auto_door.py)
    rocon_hue_bridge (rocon_hue/rocon_hue_bridge.py)

ROS_MASTER_URI=http://192.168.10.131:11311/
core service [/rosout] found
process[services/cafedelivery/cafe_delivery-1]: started with pid [19605]
process[services/cafedelivery/remote_order_manager-2]: started with pid [19613]
process[services/cafedelivery/rocon_hue_bridge-3]: started with pid [19631]
[INFO] [WallTime: 1400063205.462359] ROCON requester feedback topic: /concert/scheduler/requests_8a92dbf768584f11a3870c43cfc597cd
[INFO] [WallTime: 1400063205.543385] requester feedback topic: ~requests_8a92dbf768584f11a3870c43cfc597cd
[INFO] [WallTime: 1400063205.660449] Remote Order Manager : Initialized
process[services/cafedelivery/hue_manager-4]: started with pid [19665]
process[services/cafedelivery/rocon_auto_door-5]: started with pid [19670]
process[services/cafedelivery/auto_door_manager-6]: started with pid [19688]
[INFO] [WallTime: 1400063206.574005] Door control started in open/close configuration.
[INFO] [WallTime: 1400063206.986839] Table ID: 1
[WARN] [WallTime: 1400063207.221049] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063207.856311] Interactions : loading Web Search [web_url(http://www.google.com)-Customer-/services/cafedelivery]
[INFO] [WallTime: 1400063207.856803] Interactions : loading Cafe Dorothy Delivery Order [web_app(http://chimek.yujinrobot.com/rocon/cafe_concert/webapp/cafe_Dorothy/dorothy_web_menu.html)-Customer-/services/cafedelivery]
[INFO] [WallTime: 1400063207.857086] Interactions : loading Cafe Monitor [web_app(http://chimek.yujinrobot.com/rocon/cafe_concert/cafe_viewer/www/index.html)-Cafe Manager-/services/cafedelivery]
[INFO] [WallTime: 1400063207.857388] Interactions : loading Cafe Kitchen [web_app(http://chimek.yujinrobot.com/rocon/cafe_concert/kitchen/www/index.html)-Cafe Manager-/services/cafedelivery]
[INFO] [WallTime: 1400063207.858123] Service Manager: service enabled [cafedelivery] [cafedelivery]
[INFO] [WallTime: 1400063207.858662] Service Manager : serving request to enable 'cafe_database'
[INFO] [WallTime: 1400063208.111948] Rocon Hue : bridge not connect
started roslaunch server http://192.168.10.131:41738/

SUMMARY
========

PARAMETERS
 * /rosdistro
 * /rosversion
 * /services/cafe_database/annotations_manager/filename
 * /services/cafe_database/map_server/frame_id

NODES
  /services/cafe_database/
    annotations_manager (simple_annotation_server/simple_server.py)
    dummy_map_tf_broadcaster (tf/static_transform_publisher)
    map_server (map_server/map_server)

ROS_MASTER_URI=http://192.168.10.131:11311/
core service [/rosout] found
process[services/cafe_database/dummy_map_tf_broadcaster-7]: started with pid [19786]
process[services/cafe_database/map_server-8]: started with pid [19799]
[ INFO] [1400063209.264862918]: Loading map from image "/home/yujin/demos/rocon_demo_201405/src/cafe_concert/cafe_concert/maps/croom.pgm"
[ INFO] [1400063209.265707695]: Read a 169 X 177 map @ 0.050 m/cell
[WARN] [WallTime: 1400063209.435452] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
process[services/cafe_database/annotations_manager-9]: started with pid [19817]
[INFO] [WallTime: 1400063210.134082] Annotation Server : Initialized
[INFO] [WallTime: 1400063210.134889] Annotation Server : publish viz_markers
[INFO] [WallTime: 1400063210.136438] Interactions : loading Map Annotator [com.github.robotics_in_concert.rocon_android_apps.map_annotation.MainActivity-Cafe Manager-/services/cafe_database]
[INFO] [WallTime: 1400063210.137210] Service Manager: service enabled [cafe_database] [cafe_database]
[INFO] [WallTime: 1400063210.137662] Service Manager : serving request to enable 'vmdelivery'
[INFO] [WallTime: 1400063210.280971] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063210.801192] Conductor : new client discovered [dudecbaf183b43494ae097196bd941d39876]
[INFO] [WallTime: 1400063210.803881] Gateway : added pull rule [dudecbaf183b43494ae097196bd941d39876:(/dudecbaf183b43494ae097196bd941d39876/platform_info,service)]
[INFO] [WallTime: 1400063210.804334] Gateway : added pull rule [dudecbaf183b43494ae097196bd941d39876:(/dudecbaf183b43494ae097196bd941d39876/list_rapps,service)]
[INFO] [WallTime: 1400063210.804566] Gateway : added pull rule [dudecbaf183b43494ae097196bd941d39876:(/dudecbaf183b43494ae097196bd941d39876/invite,service)]
[INFO] [WallTime: 1400063210.804795] Gateway : added pull rule [dudecbaf183b43494ae097196bd941d39876:(/dudecbaf183b43494ae097196bd941d39876/status,publisher)]
started roslaunch server http://192.168.10.131:39867/

SUMMARY
========

PARAMETERS
 * /rosdistro
 * /rosversion
 * /services/vmdelivery/cafe_delivery/filename

NODES
  /services/vmdelivery/
    cafe_delivery (concert_service_link_graph/static_link_graph_service.py)

ROS_MASTER_URI=http://192.168.10.131:11311/
core service [/rosout] found
[INFO] [WallTime: 1400063211.040916] Gateway : pulling in connection [publisher][/dudecbaf183b43494ae097196bd941d39876/status][/app_manager][dudecbaf183b43494ae097196bd941d39876]
[INFO] [WallTime: 1400063211.043929] Gateway : pulling in connection [service][/dudecbaf183b43494ae097196bd941d39876/platform_info][/app_manager][dudecbaf183b43494ae097196bd941d39876]
[INFO] [WallTime: 1400063211.063148] Gateway : pulling in connection [service][/dudecbaf183b43494ae097196bd941d39876/invite][/app_manager][dudecbaf183b43494ae097196bd941d39876]
[INFO] [WallTime: 1400063211.082123] Gateway : pulling in connection [service][/dudecbaf183b43494ae097196bd941d39876/list_rapps][/app_manager][dudecbaf183b43494ae097196bd941d39876]
process[services/vmdelivery/cafe_delivery-10]: started with pid [19920]
[WARN] [WallTime: 1400063211.293249] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063211.603016] ROCON requester feedback topic: /concert/scheduler/requests_1faff9864ed147e48fcd31876e775001
[INFO] [WallTime: 1400063211.660939] requester feedback topic: ~requests_1faff9864ed147e48fcd31876e775001
[INFO] [WallTime: 1400063211.823445] Interactions : loading Vending Machine Orderer [com.github.robotics_in_concert.rocon_demo.waiterbot_order_app.CesDemoOrderApp-Customer-/services/vmdelivery]
[INFO] [WallTime: 1400063211.823871] Interactions : loading Pairing Listener [com.github.rosjava.android_remocons.listener.Listener-Android Pairing-/services/vmdelivery]
[INFO] [WallTime: 1400063211.824465] Service Manager: service enabled [vmdelivery] [vmdelivery]
[INFO] [WallTime: 1400063211.888672] Conductor : concert client transition [pending->uninvited][dude]
[INFO] [WallTime: 1400063211.889933] Gateway : removed pull rule [dudecbaf183b43494ae097196bd941d39876:/dudecbaf183b43494ae097196bd941d39876/platform_info]
[INFO] [WallTime: 1400063211.890687] Gateway : removed pull rule [dudecbaf183b43494ae097196bd941d39876:/dudecbaf183b43494ae097196bd941d39876/list_rapps]
[INFO] [WallTime: 1400063212.024609] Gateway : abandoning pulled connection [service][/dudecbaf183b43494ae097196bd941d39876/platform_info][/app_manager][dudecbaf183b43494ae097196bd941d39876]
[INFO] [WallTime: 1400063212.028301] Gateway : abandoning pulled connection [service][/dudecbaf183b43494ae097196bd941d39876/list_rapps][/app_manager][dudecbaf183b43494ae097196bd941d39876]
[INFO] [WallTime: 1400063212.468700] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063213.035777] Conductor : concert client transition [uninvited->joining][dude]
[INFO] [WallTime: 1400063213.036759] Gateway : removed pull rule [dudecbaf183b43494ae097196bd941d39876:/dudecbaf183b43494ae097196bd941d39876/invite]
[INFO] [WallTime: 1400063213.038120] Conductor : new client discovered [whoola69099bf7420b446b92fc400a08e31c0d]
[INFO] [WallTime: 1400063213.038999] Gateway : added pull rule [whoola69099bf7420b446b92fc400a08e31c0d:(/whoola69099bf7420b446b92fc400a08e31c0d/platform_info,service)]
[INFO] [WallTime: 1400063213.039451] Gateway : added pull rule [whoola69099bf7420b446b92fc400a08e31c0d:(/whoola69099bf7420b446b92fc400a08e31c0d/list_rapps,service)]
[INFO] [WallTime: 1400063213.040015] Gateway : added pull rule [whoola69099bf7420b446b92fc400a08e31c0d:(/whoola69099bf7420b446b92fc400a08e31c0d/invite,service)]
[INFO] [WallTime: 1400063213.040505] Gateway : added pull rule [whoola69099bf7420b446b92fc400a08e31c0d:(/whoola69099bf7420b446b92fc400a08e31c0d/status,publisher)]
[INFO] [WallTime: 1400063213.302276] Gateway : pulling in connection [publisher][/whoola69099bf7420b446b92fc400a08e31c0d/status][/app_manager][whoola69099bf7420b446b92fc400a08e31c0d]
[INFO] [WallTime: 1400063213.305514] Gateway : pulling in connection [service][/whoola69099bf7420b446b92fc400a08e31c0d/platform_info][/app_manager][whoola69099bf7420b446b92fc400a08e31c0d]
[INFO] [WallTime: 1400063213.326030] Gateway : pulling in connection [service][/whoola69099bf7420b446b92fc400a08e31c0d/list_rapps][/app_manager][whoola69099bf7420b446b92fc400a08e31c0d]
[INFO] [WallTime: 1400063213.346942] Gateway : pulling in connection [service][/whoola69099bf7420b446b92fc400a08e31c0d/invite][/app_manager][whoola69099bf7420b446b92fc400a08e31c0d]
[INFO] [WallTime: 1400063213.365019] Gateway : abandoning pulled connection [service][/dudecbaf183b43494ae097196bd941d39876/invite][/app_manager][dudecbaf183b43494ae097196bd941d39876]
[INFO] [WallTime: 1400063213.385395] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][service][/dudecbaf183b43494ae097196bd941d39876/stop_rapp][/app_manager]
[INFO] [WallTime: 1400063213.401498] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][service][/dudecbaf183b43494ae097196bd941d39876/start_rapp][/app_manager]
[WARN] [WallTime: 1400063213.491753] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063214.214663] Conductor : concert client transition [pending->uninvited][whoola]
[INFO] [WallTime: 1400063214.215749] Gateway : removed pull rule [whoola69099bf7420b446b92fc400a08e31c0d:/whoola69099bf7420b446b92fc400a08e31c0d/platform_info]
[INFO] [WallTime: 1400063214.216357] Gateway : removed pull rule [whoola69099bf7420b446b92fc400a08e31c0d:/whoola69099bf7420b446b92fc400a08e31c0d/list_rapps]
[INFO] [WallTime: 1400063214.225975] Conductor : concert client transition [joining->available][dude]
[ INFO] [1400063214.264309564]: Create Subscriber for : dude    Topic : /dude/robot_pose
[INFO] [WallTime: 1400063214.266546] Scheduler : new concert client [dude]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063214.291889] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
  Pruning...
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
    Pruning Resolvable Branches
      rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
  Pruned Tree
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
[INFO] [WallTime: 1400063214.303459] Scheduler : insufficient resources to satisfy request [73cb89bb-6baa-4202-8b93-ab79560377a2]
[INFO] [WallTime: 1400063214.316258] Gateway : abandoning pulled connection [service][/whoola69099bf7420b446b92fc400a08e31c0d/platform_info][/app_manager][whoola69099bf7420b446b92fc400a08e31c0d]
[INFO] [WallTime: 1400063214.318993] Gateway : abandoning pulled connection [service][/whoola69099bf7420b446b92fc400a08e31c0d/list_rapps][/app_manager][whoola69099bf7420b446b92fc400a08e31c0d]
[INFO] [WallTime: 1400063214.684280] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063215.327883] Conductor : concert client transition [uninvited->joining][whoola]
[INFO] [WallTime: 1400063215.328863] Gateway : removed pull rule [whoola69099bf7420b446b92fc400a08e31c0d:/whoola69099bf7420b446b92fc400a08e31c0d/invite]
[INFO] [WallTime: 1400063215.404192] Gateway : abandoning pulled connection [service][/whoola69099bf7420b446b92fc400a08e31c0d/invite][/app_manager][whoola69099bf7420b446b92fc400a08e31c0d]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063215.448135] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
  Pruning...
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
    Pruning Resolvable Branches
      rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
  Pruned Tree
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
[INFO] [WallTime: 1400063215.453391] Scheduler : insufficient resources to satisfy request [73cb89bb-6baa-4202-8b93-ab79560377a2]
[WARN] [WallTime: 1400063215.764517] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063216.816875] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
  Pruning...
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
    Pruning Resolvable Branches
      rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
  Pruned Tree
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : []
[INFO] [WallTime: 1400063216.823023] Scheduler : insufficient resources to satisfy request [73cb89bb-6baa-4202-8b93-ab79560377a2]
[INFO] [WallTime: 1400063216.955958] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063217.535633] Gateway : received a flip request [whoola69099bf7420b446b92fc400a08e31c0d][service][/whoola69099bf7420b446b92fc400a08e31c0d/stop_rapp][/app_manager]
[INFO] [WallTime: 1400063217.551533] Gateway : received a flip request [whoola69099bf7420b446b92fc400a08e31c0d][service][/whoola69099bf7420b446b92fc400a08e31c0d/start_rapp][/app_manager]
[INFO] [WallTime: 1400063217.815071] Conductor : concert client transition [joining->available][whoola]
[ INFO] [1400063217.848404679]: Create Subscriber for : whoola  Topic : /whoola/robot_pose
[INFO] [WallTime: 1400063217.863814] Scheduler : new concert client [whoola]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063217.902024] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
  Pruning...
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
    Pruning Resolvable Branches
      rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
  Pruned Tree
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
[INFO] [WallTime: 1400063217.912003] Scheduler : compatibility tree is valid, attempting to allocate [73cb89bb-6baa-4202-8b93-ab79560377a2]
[WARN] [WallTime: 1400063218.230458] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063218.881650] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063219.944075] Conductor : new client discovered [zachb50d785f14d84af1969d0b0fb962b9df]
[INFO] [WallTime: 1400063219.945377] Gateway : added pull rule [zachb50d785f14d84af1969d0b0fb962b9df:(/zachb50d785f14d84af1969d0b0fb962b9df/platform_info,service)]
[INFO] [WallTime: 1400063219.946090] Gateway : added pull rule [zachb50d785f14d84af1969d0b0fb962b9df:(/zachb50d785f14d84af1969d0b0fb962b9df/list_rapps,service)]
[INFO] [WallTime: 1400063219.946655] Gateway : added pull rule [zachb50d785f14d84af1969d0b0fb962b9df:(/zachb50d785f14d84af1969d0b0fb962b9df/invite,service)]
[INFO] [WallTime: 1400063219.947132] Gateway : added pull rule [zachb50d785f14d84af1969d0b0fb962b9df:(/zachb50d785f14d84af1969d0b0fb962b9df/status,publisher)]
[WARN] [WallTime: 1400063219.982943] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063220.192900] Gateway : pulling in connection [publisher][/zachb50d785f14d84af1969d0b0fb962b9df/status][/app_manager][zachb50d785f14d84af1969d0b0fb962b9df]
[INFO] [WallTime: 1400063220.195863] Gateway : pulling in connection [service][/zachb50d785f14d84af1969d0b0fb962b9df/platform_info][/app_manager][zachb50d785f14d84af1969d0b0fb962b9df]
[INFO] [WallTime: 1400063220.223552] Gateway : pulling in connection [service][/zachb50d785f14d84af1969d0b0fb962b9df/invite][/app_manager][zachb50d785f14d84af1969d0b0fb962b9df]
[INFO] [WallTime: 1400063220.253421] Gateway : pulling in connection [service][/zachb50d785f14d84af1969d0b0fb962b9df/list_rapps][/app_manager][zachb50d785f14d84af1969d0b0fb962b9df]
[INFO] [WallTime: 1400063220.857888] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063221.054193] Conductor : concert client transition [pending->uninvited][zach]
[INFO] [WallTime: 1400063221.055472] Gateway : removed pull rule [zachb50d785f14d84af1969d0b0fb962b9df:/zachb50d785f14d84af1969d0b0fb962b9df/platform_info]
[INFO] [WallTime: 1400063221.056194] Gateway : removed pull rule [zachb50d785f14d84af1969d0b0fb962b9df:/zachb50d785f14d84af1969d0b0fb962b9df/list_rapps]
[INFO] [WallTime: 1400063221.185860] Gateway : abandoning pulled connection [service][/zachb50d785f14d84af1969d0b0fb962b9df/platform_info][/app_manager][zachb50d785f14d84af1969d0b0fb962b9df]
[INFO] [WallTime: 1400063221.189385] Gateway : abandoning pulled connection [service][/zachb50d785f14d84af1969d0b0fb962b9df/list_rapps][/app_manager][zachb50d785f14d84af1969d0b0fb962b9df]
[WARN] [WallTime: 1400063221.965274] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063222.201335] Conductor : concert client transition [uninvited->joining][zach]
[INFO] [WallTime: 1400063222.202752] Gateway : removed pull rule [zachb50d785f14d84af1969d0b0fb962b9df:/zachb50d785f14d84af1969d0b0fb962b9df/invite]
[INFO] [WallTime: 1400063222.302765] Gateway : abandoning pulled connection [service][/zachb50d785f14d84af1969d0b0fb962b9df/invite][/app_manager][zachb50d785f14d84af1969d0b0fb962b9df]
[INFO] [WallTime: 1400063222.791746] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063223.843397] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063224.468076] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][service][/zachb50d785f14d84af1969d0b0fb962b9df/start_rapp][/app_manager]
[INFO] [WallTime: 1400063224.487322] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][service][/zachb50d785f14d84af1969d0b0fb962b9df/stop_rapp][/app_manager]
[INFO] [WallTime: 1400063224.633115] Conductor : concert client transition [joining->available][zach]
[ INFO] [1400063224.645802575]: Create Subscriber for : zach    Topic : /zach/robot_pose
[INFO] [WallTime: 1400063224.973414] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063225.986489] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063226.918157] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063227.998741] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063229.173026] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063230.188560] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063231.006736] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063232.023875] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063232.948746] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063233.960896] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063234.916528] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063235.933915] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063236.897976] Conductor : new client discovered [adams1448a943393f4cba8f3b064c4c2cb4a9]
[INFO] [WallTime: 1400063236.899239] Gateway : added pull rule [adams1448a943393f4cba8f3b064c4c2cb4a9:(/adams1448a943393f4cba8f3b064c4c2cb4a9/platform_info,service)]
[INFO] [WallTime: 1400063236.900139] Gateway : added pull rule [adams1448a943393f4cba8f3b064c4c2cb4a9:(/adams1448a943393f4cba8f3b064c4c2cb4a9/list_rapps,service)]
[INFO] [WallTime: 1400063236.901129] Gateway : added pull rule [adams1448a943393f4cba8f3b064c4c2cb4a9:(/adams1448a943393f4cba8f3b064c4c2cb4a9/invite,service)]
[INFO] [WallTime: 1400063236.901880] Gateway : added pull rule [adams1448a943393f4cba8f3b064c4c2cb4a9:(/adams1448a943393f4cba8f3b064c4c2cb4a9/status,publisher)]
[INFO] [WallTime: 1400063236.983319] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063237.088172] Gateway : pulling in connection [publisher][/adams1448a943393f4cba8f3b064c4c2cb4a9/status][/app_manager][adams1448a943393f4cba8f3b064c4c2cb4a9]
[INFO] [WallTime: 1400063237.090925] Gateway : pulling in connection [service][/adams1448a943393f4cba8f3b064c4c2cb4a9/invite][/app_manager][adams1448a943393f4cba8f3b064c4c2cb4a9]
[INFO] [WallTime: 1400063237.121140] Gateway : pulling in connection [service][/adams1448a943393f4cba8f3b064c4c2cb4a9/list_rapps][/app_manager][adams1448a943393f4cba8f3b064c4c2cb4a9]
[INFO] [WallTime: 1400063237.136623] Gateway : pulling in connection [service][/adams1448a943393f4cba8f3b064c4c2cb4a9/platform_info][/app_manager][adams1448a943393f4cba8f3b064c4c2cb4a9]
[INFO] [WallTime: 1400063238.028822] Conductor : concert client transition [pending->uninvited][adams]
[INFO] [WallTime: 1400063238.030100] Gateway : removed pull rule [adams1448a943393f4cba8f3b064c4c2cb4a9:/adams1448a943393f4cba8f3b064c4c2cb4a9/platform_info]
[INFO] [WallTime: 1400063238.030740] Gateway : removed pull rule [adams1448a943393f4cba8f3b064c4c2cb4a9:/adams1448a943393f4cba8f3b064c4c2cb4a9/list_rapps]
[WARN] [WallTime: 1400063238.066331] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063238.291241] Gateway : abandoning pulled connection [service][/adams1448a943393f4cba8f3b064c4c2cb4a9/list_rapps][/app_manager][adams1448a943393f4cba8f3b064c4c2cb4a9]
[INFO] [WallTime: 1400063238.294297] Gateway : abandoning pulled connection [service][/adams1448a943393f4cba8f3b064c4c2cb4a9/platform_info][/app_manager][adams1448a943393f4cba8f3b064c4c2cb4a9]
[INFO] [WallTime: 1400063238.892473] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063239.122370] Conductor : concert client transition [uninvited->joining][adams]
[INFO] [WallTime: 1400063239.123714] Gateway : removed pull rule [adams1448a943393f4cba8f3b064c4c2cb4a9:/adams1448a943393f4cba8f3b064c4c2cb4a9/invite]
[INFO] [WallTime: 1400063239.228464] Gateway : abandoning pulled connection [service][/adams1448a943393f4cba8f3b064c4c2cb4a9/invite][/app_manager][adams1448a943393f4cba8f3b064c4c2cb4a9]
[WARN] [WallTime: 1400063239.906940] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063240.872666] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063241.454200] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][service][/adams1448a943393f4cba8f3b064c4c2cb4a9/stop_rapp][/app_manager]
[INFO] [WallTime: 1400063241.474839] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][service][/adams1448a943393f4cba8f3b064c4c2cb4a9/start_rapp][/app_manager]
[WARN] [WallTime: 1400063242.061332] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063242.813699] Conductor : concert client transition [joining->available][adams]
[ INFO] [1400063242.845228590]: Create Subscriber for : adams   Topic : /adams/robot_pose
[INFO] [WallTime: 1400063243.134578] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063244.157011] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063245.114621] Scheduler :   allocated [whoola]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063245.143262] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063245.159234] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063245.176218] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063245.192931] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : []
  rocon:/waiterbot#cafe_rapps/waiter : []
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
      rocon:/waiterbot#cafe_rapps/waiter : []
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : []
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063245.207850] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
[INFO] [WallTime: 1400063245.209511] Scheduler : new concert client [zach]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      --> pruned leaves: zach
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063245.237455] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      --> pruned leaves: zach
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063245.265611] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      --> pruned leaves: zach
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : []
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : []
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    rocon:/waiterbot#cafe_rapps/waiter : []
[INFO] [WallTime: 1400063245.293856] Scheduler : insufficient resources to satisfy request [b926f7ef-e70c-4a71-95d3-606eae559919]
[INFO] [WallTime: 1400063245.295521] Scheduler : new concert client [adams]

Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
      --> pruned leaves: adams
      --> pruned resolvable branches: cafe_rapps/waiter
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
[INFO] [WallTime: 1400063245.340777] Scheduler : compatibility tree is valid, attempting to allocate [b926f7ef-e70c-4a71-95d3-606eae559919]
[INFO] [WallTime: 1400063245.417004] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063246.405543] Scheduler :   allocated [dude]
[WARN] [WallTime: 1400063246.432213] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063247.544403] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063248.056575] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/dude/waiter_2/delivery_order/goal][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.059572] Gateway : received a flip request [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/order_cancelled][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063248.061739] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/dude/waiter_2/delivery_order/feedback][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.066720] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/zach/delivery_order/goal][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.073084] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/dude/waiter_2/delivery_order/result][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.077221] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/zach/delivery_order/result][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.080467] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/cafe/send_order/feedback][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.082707] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/zach/delivery_order/feedback][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.086063] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/dude/waiter_2/delivery_order/cancel][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.088677] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/adams/delivery_order/result][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.092586] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/zach/delivery_order/cancel][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.095840] Gateway : received a flip request [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/drink_ar][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063248.100447] Gateway : received a flip request [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/drinks_dispensed][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063248.103744] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/cafe/send_order/result][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.107835] Gateway : received a flip request [whoola69099bf7420b446b92fc400a08e31c0d][subscriber][/vm_order/drink_order][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063248.116679] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/cafe/send_order/cancel][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.122716] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/cafe/list_order][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.126820] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/cafe/send_order/goal][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.133049] Gateway : received a flip request [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/waiterbot_debug][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063248.136610] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/adams/delivery_order/goal][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.140562] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/adams/delivery_order/cancel][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.144362] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][publisher][/cafe/send_order/status][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.148718] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/adams/delivery_order/feedback][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.156308] Gateway : received a flip request [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/tray_empty][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063248.160611] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/zach/delivery_order/status][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.167208] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/adams/delivery_order/status][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400063248.173717] Gateway : received a flip request [dudecbaf183b43494ae097196bd941d39876][subscriber][/dude/waiter_2/delivery_order/status][/dude/cafe_taskcoordinator]
[WARN] [WallTime: 1400063248.564642] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063249.341758] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063250.406675] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063252.854099] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063253.866156] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063254.907454] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063255.927513] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063256.881310] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063258.068957] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063259.009748] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063260.029827] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063261.283797] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063263.151243] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063264.191511] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063265.253274] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063266.302696] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063267.427457] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063268.233759] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063269.452540] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063270.127177] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063271.043734] Scheduler :   allocated [adams]
[WARN] [WallTime: 1400063271.172808] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063272.016790] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063272.888204] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][subscriber][/adams/delivery_order/cancel][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063272.917811] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][publisher][/adams/robot_pose][/adams/robot_pose_publisher]
[INFO] [WallTime: 1400063272.921857] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][publisher][/adams/delivery_order/feedback][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063272.926366] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][subscriber][/adams/delivery_order/goal][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063272.934852] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][subscriber][/annotation/tables][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063272.972913] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][publisher][/adams/delivery_order/status][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063272.975641] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][subscriber][/map][/adams/amcl]
[INFO] [WallTime: 1400063273.019055] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][subscriber][/annotation/ar_markers][/adams/waiterbot_ctrl_cafe]
[WARN] [WallTime: 1400063273.052392] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063273.053706] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][publisher][/adams/delivery_order/result][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063273.918350] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063274.969099] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063275.939497] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063276.970689] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063277.842585] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063278.852446] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063279.697166] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063280.710241] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063281.713027] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063282.726835] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063283.321442] Gateway : received a flip request [adams1448a943393f4cba8f3b064c4c2cb4a9][subscriber][/map][/adams/move_base]
[INFO] [WallTime: 1400063283.500376] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063284.511444] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063285.343220] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063286.358102] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063287.096963] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063288.219616] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063288.720752] Scheduler :   allocated [zach]
[INFO] [WallTime: 1400063288.746063] Requester : state change [pending->alive]
[INFO] [WallTime: 1400063288.755617] Requester : state change [pending->alive]
[INFO] [WallTime: 1400063289.401260] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063289.766161] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][subscriber][/annotation/tables][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063289.775778] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][subscriber][/map][/zach/amcl]
[WARN] [WallTime: 1400063290.411190] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063291.861263] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][subscriber][/annotation/ar_markers][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063292.124743] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][publisher][/zach/delivery_order/feedback][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063292.129562] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][subscriber][/zach/delivery_order/goal][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063292.145644] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][publisher][/zach/delivery_order/result][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063292.150057] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][subscriber][/zach/delivery_order/cancel][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063292.540917] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][publisher][/zach/delivery_order/status][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400063292.544130] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][publisher][/zach/robot_pose][/zach/robot_pose_publisher]
[INFO] [WallTime: 1400063292.838437] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063293.850362] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063294.001773] requester feedback topic: ~requests_1faff9864ed147e48fcd31876e775001
[INFO] [WallTime: 1400063294.711743] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063295.754191] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063295.914172] Gateway : unflipping received flip [whoola69099bf7420b446b92fc400a08e31c0d][subscriber][/vm_order/drink_order][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063296.574872] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063297.583361] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063297.901274] Gateway : unflipping received flip [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/order_cancelled][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063297.904423] Gateway : unflipping received flip [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/drink_ar][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063297.906928] Gateway : unflipping received flip [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/drinks_dispensed][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063297.909520] Gateway : unflipping received flip [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/waiterbot_debug][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063297.912514] Gateway : unflipping received flip [whoola69099bf7420b446b92fc400a08e31c0d][publisher][/vm_order/tray_empty][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400063298.230005] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063299.260150] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063300.201099] Rocon Hue : bridge not connect
[WARN] [WallTime: 1400063301.211920] Rocon Hue : failed to reach a server. Reason: [Errno -2] Name or service not known
[INFO] [WallTime: 1400063302.041098] Rocon Hue : bridge not connect
[INFO] [WallTime: 1400063302.240798] Gateway : received a flip request [zachb50d785f14d84af1969d0b0fb962b9df][subscriber][/map][/zach/move_base]

@stonier
Copy link
Member

stonier commented May 14, 2014

Condensing some information from the above:

  • Both priorities are the same
  • Whoola got the stop rapp command 42s after sending its flips.
  • Why is the scheduler request feedback for whoola missing before the request is closed?
  • Nothing is unallocated, rather the request is closed - doesn't look like a preemption problem.
  • Why does it take 28s from comfirming whoola's compatibility tree to allocating it?

Timings:

  • 63217.912003 : scheduler comfirms whoola's compatibility tree is valid
  • 63245.114621 : scheduler allocates whoola
  • 63245.143262 : scheduler fails to allocate the cafe request
  • 63245.159234 : scheduler fails to allocate the cafe request
  • 63245.176218 : scheduler fails to allocate the cafe request
  • 63245.192931 : scheduler fails to allocate the cafe request
  • 63245.207850 : scheduler fails to allocate the cafe request
  • 63245.209511 : zach becomes available
  • 63245.237455 : scheduler fails to allocate the cafe request
  • 63245.265611 : scheduler fails to allocate the cafe request
  • 63245.293856 : scheduler fails to allocate the cafe request
  • 63245.295521 : adams becomes available
  • 63245.340777 : cafe compatibility tree is valid for (dude, adams and zach)
  • 63246.405543 : scheduler allocates dude
  • 63271.043734 : scheduler allocates adams
  • 63288.720752 : scheduler allocates zach
  • 63295.914172 : received unflips from whoola

stonier added a commit that referenced this issue May 15, 2014
@stonier
logging to trace cancelling requests, #231.
8a28476
@jihoonl
Copy link
Collaborator Author

jihoonl commented May 15, 2014 

... logging to /home/yujin/.ros/log/ca0c08a4-dc10-11e3-a716-60eb6909cee3/roslaunch-yujin-Gabrieli-Giovanni-2906.log
Checking log directory for disk usage. This may take awhile.
Press Ctrl-C to interrupt
Done checking log file disk usage. Usage is <1GB.
started roslaunch server http://192.168.0.131:57014/

SUMMARY
========

PARAMETERS
 * /concert/conductor/auto_invite
 * /concert/conductor/local_clients_only
 * /concert/description
 * /concert/gateway/default_blacklist
 * /concert/gateway/disable_uuids
 * /concert/gateway/external_shutdown
 * /concert/gateway/firewall
 * /concert/gateway/hub_uri
 * /concert/gateway/hub_whitelist
 * /concert/gateway/name
 * /concert/gateway/network_interface
 * /concert/gateway/watch_loop_period
 * /concert/hub/external_shutdown
 * /concert/hub/gateway_unavailable_timeout
 * /concert/hub/max_memory
 * /concert/hub/name
 * /concert/hub/port
 * /concert/hub/zeroconf
 * /concert/icon
 * /concert/interactions/rosbridge_address
 * /concert/interactions/rosbridge_port
 * /concert/name
 * /concert/rosbridge_websocket/address
 * /concert/rosbridge_websocket/authenticate
 * /concert/rosbridge_websocket/port
 * /concert/services/auto_enable_services
 * /concert/services/services
 * /concert/zeroconf/zeroconf/services
 * /rocon/screen
 * /rosdistro
 * /rosversion

NODES
  /concert/zeroconf/
    zeroconf (zeroconf_avahi/zeroconf)
  /concert/
    conductor (concert_conductor/conductor.py)
    gateway (rocon_gateway/gateway.py)
    hub (rocon_hub/hub.py)
    interactions (rocon_interactions/interactions_manager.py)
    master (rocon_master_info/master.py)
    rocon_tf_reconstructor (rocon_tf_reconstructor/rocon_tf_reconstructor)
    rosapi (rosapi/rosapi)
    rosbridge_websocket (rosbridge_server/rosbridge_websocket)
    scheduler (concert_schedulers/compatibility_tree_scheduler.py)
    services (concert_service_manager/service_manager)

auto-starting new master
process[master]: started with pid [2936]
ROS_MASTER_URI=http://192.168.0.131:11311/
setting /run_id to ca0c08a4-dc10-11e3-a716-60eb6909cee3
process[rosout-1]: started with pid [2955]
started core service [/rosout]
process[concert/master-2]: started with pid [2968]
process[concert/services-3]: started with pid [2998]
process[concert/conductor-4]: started with pid [3018]
process[concert/scheduler-5]: started with pid [3046]
process[concert/interactions-6]: started with pid [3104]
[INFO] [WallTime: 1400145047.417579] scheduler request topic: ~requests
process[concert/hub-7]: started with pid [3228]
process[concert/gateway-8]: started with pid [3388]
[INFO] [WallTime: 1400145048.249643] Hub : version 2.2.12
[INFO] [WallTime: 1400145048.444468] Hub : reset hub variables on the redis server.
[INFO] [WallTime: 1400145048.499534] Hub : advertising 'Cafe' on zeroconf [_ros-multimaster-hub._tcp, port 6380]
process[concert/zeroconf/zeroconf-9]: started with pid [3453]
[INFO] [WallTime: 1400145048.853117] Gateway : generated unique hash name [Cafef1f65f0addbe498a92cfa622f549e985]
[INFO] [WallTime: 1400145048.889232] Gateway : checking if zeroconf services are available...
[ INFO] [1400145048.897625365]: Zeroconf: added a listener [_ros-multimaster-hub._tcp]
[INFO] [WallTime: 1400145048.904558] Gateway : discovered hub directly [http://localhost:6380]
process[concert/rocon_tf_reconstructor-10]: started with pid [3531]
[ INFO] [1400145049.097531742]: Initialized
[ INFO] [1400145049.097791354]: In Spin!
[ INFO] [1400145049.160272903]: Zeroconf: discovered new service [Cafe][_ros-multimaster-hub._tcp][local][2][ipv4]
Established under name 'Cafe'
[INFO] [WallTime: 1400145049.416399] Gateway : Found existing mismatched public key on the hub. Requesting resend for all flip-ins.
process[concert/rosbridge_websocket-11]: started with pid [3546]
[INFO] [WallTime: 1400145049.425974] Gateway : registering on the hub [Cafe]
process[concert/rosapi-12]: started with pid [3571]
[INFO] [WallTime: 1400145049.837982] Service Manager : serving request to enable 'admin'
[ INFO] [1400145049.882164051]: Zeroconf: resolved service [Cafe][_ros-multimaster-hub._tcp][local][2][ipv4][192.168.0.131:6380]
[ INFO] [1400145049.882492794]: Zeroconf: service successfully established [Cafe][_concert-master._tcp][11311]
[INFO] [WallTime: 1400145049.935853] Gateway : discovered hub via zeroconf [localhost:6380]
registered capabilities (classes):
 - rosbridge_library.capabilities.call_service.CallService
 - rosbridge_library.capabilities.advertise.Advertise
 - rosbridge_library.capabilities.publish.Publish
 - rosbridge_library.capabilities.subscribe.Subscribe
 - <class 'rosbridge_library.capabilities.defragmentation.Defragment'>
 - rosbridge_library.capabilities.advertise_service.AdvertiseService
 - rosbridge_library.capabilities.service_response.ServiceResponse
 - rosbridge_library.capabilities.stop_service.StopService
[INFO] [WallTime: 1400145050.508103] Rosbridge WebSocket server started on port 9090
[INFO] [WallTime: 1400145050.842383] Rosapi started
[INFO] [WallTime: 1400145051.145490] Interactions : loading Gateway Graph [rocon_gateway_graph-Admin-/services/admin]
[INFO] [WallTime: 1400145051.146008] Interactions : loading Conductor Graph [concert_conductor_graph-Admin-/services/admin]
[INFO] [WallTime: 1400145051.146287] Interactions : loading Ros Graph [rqt_graph-Admin-/services/admin]
[INFO] [WallTime: 1400145051.146548] Interactions : loading Concert Info [concert_info-Admin-/services/admin]
[INFO] [WallTime: 1400145051.147139] Service Manager: service enabled [admin] [admin]
[INFO] [WallTime: 1400145051.147527] Service Manager : serving request to enable 'cafedelivery'
[INFO] [WallTime: 1400145051.522216] Conductor : new client discovered [whoolac75e40dffeb44373a863d36dc71520a8]
[INFO] [WallTime: 1400145051.525924] Gateway : added pull rule [whoolac75e40dffeb44373a863d36dc71520a8:(/whoolac75e40dffeb44373a863d36dc71520a8/platform_info,service)]
[INFO] [WallTime: 1400145051.526438] Gateway : added pull rule [whoolac75e40dffeb44373a863d36dc71520a8:(/whoolac75e40dffeb44373a863d36dc71520a8/list_rapps,service)]
[INFO] [WallTime: 1400145051.526788] Gateway : added pull rule [whoolac75e40dffeb44373a863d36dc71520a8:(/whoolac75e40dffeb44373a863d36dc71520a8/invite,service)]
[INFO] [WallTime: 1400145051.527129] Gateway : added pull rule [whoolac75e40dffeb44373a863d36dc71520a8:(/whoolac75e40dffeb44373a863d36dc71520a8/status,publisher)]
[INFO] [WallTime: 1400145051.551049] Conductor : new client discovered [zachd312efeb7a634b6ca41ec74ee5f46b5c]
[INFO] [WallTime: 1400145051.552224] Gateway : added pull rule [zachd312efeb7a634b6ca41ec74ee5f46b5c:(/zachd312efeb7a634b6ca41ec74ee5f46b5c/platform_info,service)]
[INFO] [WallTime: 1400145051.552858] Gateway : added pull rule [zachd312efeb7a634b6ca41ec74ee5f46b5c:(/zachd312efeb7a634b6ca41ec74ee5f46b5c/list_rapps,service)]
[INFO] [WallTime: 1400145051.553327] Gateway : added pull rule [zachd312efeb7a634b6ca41ec74ee5f46b5c:(/zachd312efeb7a634b6ca41ec74ee5f46b5c/invite,service)]
[INFO] [WallTime: 1400145051.553766] Gateway : added pull rule [zachd312efeb7a634b6ca41ec74ee5f46b5c:(/zachd312efeb7a634b6ca41ec74ee5f46b5c/status,publisher)]
[INFO] [WallTime: 1400145051.566867] Conductor : new client discovered [adamsf2c1fa14d3bd4cc685aadba7b9913fc8]
[INFO] [WallTime: 1400145051.567829] Gateway : added pull rule [adamsf2c1fa14d3bd4cc685aadba7b9913fc8:(/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/platform_info,service)]
[INFO] [WallTime: 1400145051.568204] Gateway : added pull rule [adamsf2c1fa14d3bd4cc685aadba7b9913fc8:(/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/list_rapps,service)]
[INFO] [WallTime: 1400145051.568442] Gateway : added pull rule [adamsf2c1fa14d3bd4cc685aadba7b9913fc8:(/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/invite,service)]
[INFO] [WallTime: 1400145051.568671] Gateway : added pull rule [adamsf2c1fa14d3bd4cc685aadba7b9913fc8:(/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/status,publisher)]
[INFO] [WallTime: 1400145051.785016] Gateway : pulling in connection [publisher][/whoolac75e40dffeb44373a863d36dc71520a8/status][/app_manager][whoolac75e40dffeb44373a863d36dc71520a8]
[INFO] [WallTime: 1400145051.789075] Gateway : pulling in connection [publisher][/zachd312efeb7a634b6ca41ec74ee5f46b5c/status][/app_manager][zachd312efeb7a634b6ca41ec74ee5f46b5c]
[INFO] [WallTime: 1400145051.792335] Gateway : pulling in connection [publisher][/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/status][/app_manager][adamsf2c1fa14d3bd4cc685aadba7b9913fc8]
[INFO] [WallTime: 1400145051.795610] Gateway : pulling in connection [service][/whoolac75e40dffeb44373a863d36dc71520a8/invite][/app_manager][whoolac75e40dffeb44373a863d36dc71520a8]
[INFO] [WallTime: 1400145051.823944] Gateway : pulling in connection [service][/whoolac75e40dffeb44373a863d36dc71520a8/platform_info][/app_manager][whoolac75e40dffeb44373a863d36dc71520a8]
[INFO] [WallTime: 1400145051.841867] Gateway : pulling in connection [service][/whoolac75e40dffeb44373a863d36dc71520a8/list_rapps][/app_manager][whoolac75e40dffeb44373a863d36dc71520a8]
[INFO] [WallTime: 1400145051.857399] Gateway : pulling in connection [service][/zachd312efeb7a634b6ca41ec74ee5f46b5c/platform_info][/app_manager][zachd312efeb7a634b6ca41ec74ee5f46b5c]
[INFO] [WallTime: 1400145051.868084] Gateway : pulling in connection [service][/zachd312efeb7a634b6ca41ec74ee5f46b5c/list_rapps][/app_manager][zachd312efeb7a634b6ca41ec74ee5f46b5c]
[INFO] [WallTime: 1400145051.885842] Gateway : pulling in connection [service][/zachd312efeb7a634b6ca41ec74ee5f46b5c/invite][/app_manager][zachd312efeb7a634b6ca41ec74ee5f46b5c]
[INFO] [WallTime: 1400145051.909812] Gateway : pulling in connection [service][/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/list_rapps][/app_manager][adamsf2c1fa14d3bd4cc685aadba7b9913fc8]
[INFO] [WallTime: 1400145051.931822] Gateway : pulling in connection [service][/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/invite][/app_manager][adamsf2c1fa14d3bd4cc685aadba7b9913fc8]
[INFO] [WallTime: 1400145051.953665] Gateway : pulling in connection [service][/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/platform_info][/app_manager][adamsf2c1fa14d3bd4cc685aadba7b9913fc8]
started roslaunch server http://192.168.0.131:42283/

SUMMARY
========

PARAMETERS
 * /rosdistro
 * /rosversion
 * /services/cafedelivery/auto_door_manager/table_id
 * /services/cafedelivery/cafe_delivery/filename
 * /services/cafedelivery/rocon_auto_door/arduino_ip
 * /services/cafedelivery/rocon_auto_door/close_door_trigger_duration
 * /services/cafedelivery/rocon_auto_door/door_ctrl_io_port
 * /services/cafedelivery/rocon_auto_door/open_door_trigger_duration
 * /services/cafedelivery/rocon_auto_door/open_door_trigger_duration_timer
 * /services/cafedelivery/rocon_auto_door/timer_ctrl

NODES
  /services/cafedelivery/
    auto_door_manager (cafe_devices_manager/auto_door_manager.py)
    cafe_delivery (concert_service_link_graph/static_link_graph_service.py)
    hue_manager (cafe_devices_manager/hue_manager.py)
    remote_order_manager (cafe_remote_order_manager/manager.py)
    rocon_auto_door (rocon_auto_door/auto_door.py)
    rocon_hue_bridge (rocon_hue/rocon_hue_bridge.py)

ROS_MASTER_URI=http://192.168.0.131:11311/
core service [/rosout] found
process[services/cafedelivery/cafe_delivery-1]: started with pid [3700]
[INFO] [WallTime: 1400145052.690772] Conductor : concert client transition [pending->uninvited][whoola]
[INFO] [WallTime: 1400145052.692116] Gateway : removed pull rule [whoolac75e40dffeb44373a863d36dc71520a8:/whoolac75e40dffeb44373a863d36dc71520a8/platform_info]
[INFO] [WallTime: 1400145052.692564] Gateway : removed pull rule [whoolac75e40dffeb44373a863d36dc71520a8:/whoolac75e40dffeb44373a863d36dc71520a8/list_rapps]
process[services/cafedelivery/remote_order_manager-2]: started with pid [3713]
[INFO] [WallTime: 1400145052.735824] Conductor : concert client transition [pending->uninvited][zach]
[INFO] [WallTime: 1400145052.736885] Gateway : removed pull rule [zachd312efeb7a634b6ca41ec74ee5f46b5c:/zachd312efeb7a634b6ca41ec74ee5f46b5c/platform_info]
[INFO] [WallTime: 1400145052.737363] Gateway : removed pull rule [zachd312efeb7a634b6ca41ec74ee5f46b5c:/zachd312efeb7a634b6ca41ec74ee5f46b5c/list_rapps]
[INFO] [WallTime: 1400145052.783871] Conductor : concert client transition [pending->uninvited][adams]
[INFO] [WallTime: 1400145052.786493] Gateway : removed pull rule [adamsf2c1fa14d3bd4cc685aadba7b9913fc8:/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/platform_info]
[INFO] [WallTime: 1400145052.787009] Gateway : removed pull rule [adamsf2c1fa14d3bd4cc685aadba7b9913fc8:/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/list_rapps]
[INFO] [WallTime: 1400145052.867370] Gateway : abandoning pulled connection [service][/whoolac75e40dffeb44373a863d36dc71520a8/platform_info][/app_manager][whoolac75e40dffeb44373a863d36dc71520a8]
[INFO] [WallTime: 1400145052.872040] Gateway : abandoning pulled connection [service][/whoolac75e40dffeb44373a863d36dc71520a8/list_rapps][/app_manager][whoolac75e40dffeb44373a863d36dc71520a8]
[INFO] [WallTime: 1400145052.876606] ROCON requester feedback topic: /concert/scheduler/requests_d02b805cbb7946c7827c6cfa1fba315a
[INFO] [WallTime: 1400145052.877542] Gateway : abandoning pulled connection [service][/zachd312efeb7a634b6ca41ec74ee5f46b5c/platform_info][/app_manager][zachd312efeb7a634b6ca41ec74ee5f46b5c]
[INFO] [WallTime: 1400145052.889192] Gateway : abandoning pulled connection [service][/zachd312efeb7a634b6ca41ec74ee5f46b5c/list_rapps][/app_manager][zachd312efeb7a634b6ca41ec74ee5f46b5c]
[INFO] [WallTime: 1400145052.892657] Gateway : abandoning pulled connection [service][/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/list_rapps][/app_manager][adamsf2c1fa14d3bd4cc685aadba7b9913fc8]
[INFO] [WallTime: 1400145052.895515] Gateway : abandoning pulled connection [service][/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/platform_info][/app_manager][adamsf2c1fa14d3bd4cc685aadba7b9913fc8]
[INFO] [WallTime: 1400145052.919830] requester feedback topic: ~requests_d02b805cbb7946c7827c6cfa1fba315a
process[services/cafedelivery/rocon_hue_bridge-3]: started with pid [3765]
[INFO] [WallTime: 1400145053.169333] Remote Order Manager : Initialized
process[services/cafedelivery/hue_manager-4]: started with pid [3779]
process[services/cafedelivery/rocon_auto_door-5]: started with pid [3784]
process[services/cafedelivery/auto_door_manager-6]: started with pid [3798]
[INFO] [WallTime: 1400145053.941794] Conductor : concert client transition [uninvited->joining][whoola]
[INFO] [WallTime: 1400145053.990089] Conductor : concert client transition [uninvited->joining][zach]
[INFO] [WallTime: 1400145054.054938] Conductor : concert client transition [uninvited->joining][adams]
[INFO] [WallTime: 1400145054.226460] Door control started in open/close configuration.
[INFO] [WallTime: 1400145054.427403] Table ID: 1
[INFO] [WallTime: 1400145054.444630] Rocon Hue : bridge connect
[INFO] [WallTime: 1400145055.106842] Gateway : received a flip request [whoolac75e40dffeb44373a863d36dc71520a8][service][/whoolac75e40dffeb44373a863d36dc71520a8/stop_rapp][/app_manager]
[INFO] [WallTime: 1400145055.133191] Gateway : received a flip request [whoolac75e40dffeb44373a863d36dc71520a8][service][/whoolac75e40dffeb44373a863d36dc71520a8/start_rapp][/app_manager]
[INFO] [WallTime: 1400145055.157240] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][service][/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/start_rapp][/app_manager]
[INFO] [WallTime: 1400145055.168047] Conductor : concert client transition [joining->available][whoola]
[INFO] [WallTime: 1400145055.187304] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][service][/adamsf2c1fa14d3bd4cc685aadba7b9913fc8/stop_rapp][/app_manager]
[INFO] [WallTime: 1400145055.204220] Interactions : loading Web Search [web_url(http://www.google.com)-Customer-/services/cafedelivery]
[INFO] [WallTime: 1400145055.204834] Interactions : loading Cafe Dorothy Delivery Order [web_app(http://chimek.yujinrobot.com/rocon/cafe_concert/webapp/cafe_Dorothy/dorothy_web_menu.html)-Customer-/services/cafedelivery]
[INFO] [WallTime: 1400145055.205196] Interactions : loading Cafe Monitor [web_app(http://chimek.yujinrobot.com/rocon/cafe_concert/cafe_viewer/www/index.html)-Cafe Manager-/services/cafedelivery]
[INFO] [WallTime: 1400145055.205480] Interactions : loading Cafe Kitchen [web_app(http://chimek.yujinrobot.com/rocon/cafe_concert/kitchen/www/index.html)-Cafe Manager-/services/cafedelivery]
[INFO] [WallTime: 1400145055.206147] Service Manager: service enabled [cafedelivery] [cafedelivery]
[INFO] [WallTime: 1400145055.206596] Service Manager : serving request to enable 'cafe_database'
[INFO] [WallTime: 1400145055.210739] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][service][/zachd312efeb7a634b6ca41ec74ee5f46b5c/stop_rapp][/app_manager]
[INFO] [WallTime: 1400145055.234303] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][service][/zachd312efeb7a634b6ca41ec74ee5f46b5c/start_rapp][/app_manager]
[INFO] [WallTime: 1400145055.475636] Hue Manager : Yes Hue...
[INFO] [WallTime: 1400145055.477610] Conductor : concert client transition [joining->available][adams]
[ INFO] [1400145055.525371490]: Create Subscriber for : whoola  Topic : /whoola/robot_pose
[ INFO] [1400145055.527147276]: Create Subscriber for : adams   Topic : /adams/robot_pose
[INFO] [WallTime: 1400145055.570891] Scheduler : new concert client [whoola]
[INFO] [WallTime: 1400145055.571428] Scheduler : new concert client [adams]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : []
  rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : []
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145055.614521] Scheduler : insufficient resources to satisfy request [0f76222f-4916-4ecd-a695-e7836d6a0670]
started roslaunch server http://192.168.0.131:59944/

SUMMARY
========

PARAMETERS
 * /rosdistro
 * /rosversion
 * /services/cafe_database/annotations_manager/filename
 * /services/cafe_database/map_server/frame_id

NODES
  /services/cafe_database/
    annotations_manager (simple_annotation_server/simple_server.py)
    dummy_map_tf_broadcaster (tf/static_transform_publisher)
    map_server (map_server/map_server)

ROS_MASTER_URI=http://192.168.0.131:11311/
core service [/rosout] found
process[services/cafe_database/dummy_map_tf_broadcaster-7]: started with pid [3922]
process[services/cafe_database/map_server-8]: started with pid [3933]
[INFO] [WallTime: 1400145056.596100] Conductor : concert client transition [joining->available][zach]
[ INFO] [1400145056.640267935]: Create Subscriber for : zach    Topic : /zach/robot_pose
[ INFO] [1400145056.666691293]: Loading map from image "/home/yujin/demos/rocon_demo_201405/src/cafe_concert/cafe_concert/maps/croom.pgm"
[ INFO] [1400145056.667518944]: Read a 169 X 177 map @ 0.050 m/cell
[INFO] [WallTime: 1400145056.686170] Scheduler : new concert client [zach]
process[services/cafe_database/annotations_manager-9]: started with pid [3952]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : []
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : []
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145056.736566] Scheduler : insufficient resources to satisfy request [0f76222f-4916-4ecd-a695-e7836d6a0670]
[INFO] [WallTime: 1400145057.160693] Interactions : loading Map Annotator [com.github.robotics_in_concert.rocon_android_apps.map_annotation.MainActivity-Cafe Manager-/services/cafe_database]
[INFO] [WallTime: 1400145057.162040] Service Manager: service enabled [cafe_database] [cafe_database]
[INFO] [WallTime: 1400145057.162624] Service Manager : serving request to enable 'vmdelivery'
[INFO] [WallTime: 1400145057.451038] Annotation Server : Initialized
[INFO] [WallTime: 1400145057.451765] Annotation Server : publish viz_markers
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : []
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : []
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145057.769280] Scheduler : insufficient resources to satisfy request [0f76222f-4916-4ecd-a695-e7836d6a0670]
started roslaunch server http://192.168.0.131:53455/

SUMMARY
========

PARAMETERS
 * /rosdistro
 * /rosversion
 * /services/vmdelivery/cafe_delivery/filename

NODES
  /services/vmdelivery/
    cafe_delivery (concert_service_link_graph/static_link_graph_service.py)

ROS_MASTER_URI=http://192.168.0.131:11311/
core service [/rosout] found
process[services/vmdelivery/cafe_delivery-10]: started with pid [4046]
[INFO] [WallTime: 1400145058.470166] Interactions : loading Vending Machine Orderer [com.github.robotics_in_concert.rocon_demo.waiterbot_order_app.CesDemoOrderApp-Customer-/services/vmdelivery]
[INFO] [WallTime: 1400145058.470966] Service Manager: service enabled [vmdelivery] [vmdelivery]
[INFO] [WallTime: 1400145058.479937] ROCON requester feedback topic: /concert/scheduler/requests_89d14bc2e67e4f139ef8eb26799a24ca
[INFO] [WallTime: 1400145058.578340] requester feedback topic: ~requests_89d14bc2e67e4f139ef8eb26799a24ca
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : []
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : []
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145058.616936] Scheduler : insufficient resources to satisfy request [0f76222f-4916-4ecd-a695-e7836d6a0670]
[INFO] [WallTime: 1400145058.732926] Conductor : new client discovered [dude7dc714b7c33d4225a327058d753a13e0]
[INFO] [WallTime: 1400145058.733994] Gateway : added pull rule [dude7dc714b7c33d4225a327058d753a13e0:(/dude7dc714b7c33d4225a327058d753a13e0/platform_info,service)]
[INFO] [WallTime: 1400145058.734610] Gateway : added pull rule [dude7dc714b7c33d4225a327058d753a13e0:(/dude7dc714b7c33d4225a327058d753a13e0/list_rapps,service)]
[INFO] [WallTime: 1400145058.735069] Gateway : added pull rule [dude7dc714b7c33d4225a327058d753a13e0:(/dude7dc714b7c33d4225a327058d753a13e0/invite,service)]
[INFO] [WallTime: 1400145058.735520] Gateway : added pull rule [dude7dc714b7c33d4225a327058d753a13e0:(/dude7dc714b7c33d4225a327058d753a13e0/status,publisher)]
Compatibility Tree
  rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
  Pruning...
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
    Pruning Resolvable Branches
      rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
  Pruned Tree
    rocon:/waiterbot/whoola#ces_rapps/waiter_isolated : ['whoola']
[INFO] [WallTime: 1400145058.773289] Scheduler : compatibility tree is valid, attempting to allocate [ad4c6b00-f910-458c-b80e-5a4f71a8a9d1]
[INFO] [WallTime: 1400145058.995414] Gateway : pulling in connection [publisher][/dude7dc714b7c33d4225a327058d753a13e0/status][/app_manager][dude7dc714b7c33d4225a327058d753a13e0]
[INFO] [WallTime: 1400145058.997816] Gateway : pulling in connection [service][/dude7dc714b7c33d4225a327058d753a13e0/platform_info][/app_manager][dude7dc714b7c33d4225a327058d753a13e0]
[INFO] [WallTime: 1400145059.023611] Gateway : pulling in connection [service][/dude7dc714b7c33d4225a327058d753a13e0/list_rapps][/app_manager][dude7dc714b7c33d4225a327058d753a13e0]
[INFO] [WallTime: 1400145059.049746] Gateway : pulling in connection [service][/dude7dc714b7c33d4225a327058d753a13e0/invite][/app_manager][dude7dc714b7c33d4225a327058d753a13e0]
[INFO] [WallTime: 1400145059.777906] Conductor : concert client transition [pending->uninvited][dude]
[INFO] [WallTime: 1400145059.779224] Gateway : removed pull rule [dude7dc714b7c33d4225a327058d753a13e0:/dude7dc714b7c33d4225a327058d753a13e0/platform_info]
[INFO] [WallTime: 1400145059.780021] Gateway : removed pull rule [dude7dc714b7c33d4225a327058d753a13e0:/dude7dc714b7c33d4225a327058d753a13e0/list_rapps]
[INFO] [WallTime: 1400145059.994937] Gateway : abandoning pulled connection [service][/dude7dc714b7c33d4225a327058d753a13e0/platform_info][/app_manager][dude7dc714b7c33d4225a327058d753a13e0]
[INFO] [WallTime: 1400145059.997786] Gateway : abandoning pulled connection [service][/dude7dc714b7c33d4225a327058d753a13e0/list_rapps][/app_manager][dude7dc714b7c33d4225a327058d753a13e0]
[INFO] [WallTime: 1400145060.933356] Conductor : concert client transition [uninvited->joining][dude]
[INFO] [WallTime: 1400145062.204882] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][service][/dude7dc714b7c33d4225a327058d753a13e0/start_rapp][/app_manager]
[INFO] [WallTime: 1400145062.225055] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][service][/dude7dc714b7c33d4225a327058d753a13e0/stop_rapp][/app_manager]
[INFO] [WallTime: 1400145063.319297] Conductor : concert client transition [joining->available][dude]
[ INFO] [1400145063.337495015]: Create Subscriber for : dude    Topic : /dude/robot_pose
[INFO] [WallTime: 1400145083.339515] Scheduler :   allocated [whoola]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : []
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : []
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145083.372404] Scheduler : insufficient resources to satisfy request [0f76222f-4916-4ecd-a695-e7836d6a0670]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : []
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : []
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145083.392735] Scheduler : insufficient resources to satisfy request [0f76222f-4916-4ecd-a695-e7836d6a0670]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : []
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : []
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145083.410621] Scheduler : insufficient resources to satisfy request [0f76222f-4916-4ecd-a695-e7836d6a0670]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : []
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : []
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: 
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : []
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145083.438444] Scheduler : insufficient resources to satisfy request [0f76222f-4916-4ecd-a695-e7836d6a0670]
[INFO] [WallTime: 1400145083.440241] Scheduler : new concert client [dude]
Compatibility Tree
  rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
  rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
  Pruning...
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruned leaves: dude
      --> pruned resolvable branches: cafe_rapps/taskcoordinator
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> no resolvable branches
    Pruning Least Valuable Leaf
      rocon:/waiterbot#cafe_rapps/waiter : ['zach', 'adams']
      --> pruning least visible leaf: adams
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['adams']
  Pruned Tree
    rocon:/pc#cafe_rapps/taskcoordinator : ['dude']
    rocon:/waiterbot#cafe_rapps/waiter : ['adams']
[INFO] [WallTime: 1400145083.468963] Scheduler : compatibility tree is valid, attempting to allocate [0f76222f-4916-4ecd-a695-e7836d6a0670]
[INFO] [WallTime: 1400145084.501996] Scheduler :   allocated [dude]
[INFO] [WallTime: 1400145085.775109] Gateway : received a flip request [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/order_cancelled][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145085.777735] Gateway : received a flip request [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/waiterbot_debug][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145085.779890] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/cafe/list_order][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145085.781696] Gateway : received a flip request [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/drink_ar][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145085.783307] Gateway : received a flip request [whoolac75e40dffeb44373a863d36dc71520a8][subscriber][/vm_order/drink_order][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145085.789189] Gateway : received a flip request [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/tray_empty][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145085.791712] Gateway : received a flip request [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/drinks_dispensed][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145088.035799] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/zach/delivery_order/status][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.040642] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/dude/waiter_2/delivery_order/result][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.045170] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/adams/delivery_order/result][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.051658] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/zach/delivery_order/result][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.055961] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/cafe/send_order/feedback][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.057897] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/cafe/send_order/status][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.059768] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/zach/delivery_order/goal][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.061720] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/dude/waiter_2/delivery_order/cancel][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.064090] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/cafe/send_order/goal][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.067794] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/dude/waiter_2/delivery_order/feedback][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.072171] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/zach/delivery_order/feedback][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.076838] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/cafe/send_order/result][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.079667] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/adams/delivery_order/status][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.084678] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/dude/waiter_2/delivery_order/status][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.089806] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/adams/delivery_order/cancel][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.092839] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/adams/delivery_order/goal][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.095875] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/dude/waiter_2/delivery_order/goal][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.099263] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/cafe/send_order/cancel][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.105665] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][subscriber][/adams/delivery_order/feedback][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145088.111167] Gateway : received a flip request [dude7dc714b7c33d4225a327058d753a13e0][publisher][/zach/delivery_order/cancel][/dude/cafe_taskcoordinator]
[INFO] [WallTime: 1400145109.481371] Scheduler :   allocated [adams]
[INFO] [WallTime: 1400145109.494355] Scheduler : releasing resources from cancelled request [[rapp: ces_rapps/waiter_isolated
id: 
  uuid: [15, 93, 125, 20, 131, 141, 77, 86, 181, 54, 199, 69, 171, 126, 6, 142]
uri: rocon:/waiterbot|turtlebot/whoolac75e40dffeb44373a863d36dc71520a8/hydro/precise
remappings: 
  - 
    remap_from: drink_order
    remap_to: /vm_order/drink_order
  - 
    remap_from: drink_ar
    remap_to: /vm_order/drink_ar
  - 
    remap_from: drinks_dispensed
    remap_to: /vm_order/drinks_dispensed
  - 
    remap_from: tray_empty
    remap_to: /vm_order/tray_empty
  - 
    remap_from: waiterbot_debug
    remap_to: /vm_order/waiterbot_debug
  - 
    remap_from: order_cancelled
    remap_to: /vm_order/order_cancelled]]
[INFO] [WallTime: 1400145109.515224] Requester : state change [pending->alive]
[INFO] [WallTime: 1400145109.516032] Requester : state change [pending->alive]
[INFO] [WallTime: 1400145111.660658] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][publisher][/adams/delivery_order/status][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145111.664034] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][subscriber][/map][/adams/amcl]
[INFO] [WallTime: 1400145111.670237] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][subscriber][/annotation/tables][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145111.677850] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][publisher][/adams/delivery_order/result][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145111.681598] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][subscriber][/adams/delivery_order/goal][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145111.689880] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][publisher][/adams/delivery_order/feedback][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145111.694245] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][publisher][/adams/robot_pose][/adams/robot_pose_publisher]
[INFO] [WallTime: 1400145111.698130] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][subscriber][/adams/delivery_order/cancel][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145111.706206] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][subscriber][/annotation/ar_markers][/adams/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145114.415651] requester feedback topic: ~requests_89d14bc2e67e4f139ef8eb26799a24ca
[INFO] [WallTime: 1400145114.417156] Scheduler : releasing resources from cancelled request [[rapp: ces_rapps/waiter_isolated
id: 
  uuid: [15, 93, 125, 20, 131, 141, 77, 86, 181, 54, 199, 69, 171, 126, 6, 142]
uri: rocon:/waiterbot/whoola#ces_rapps/waiter_isolated
remappings: 
  - 
    remap_from: drink_order
    remap_to: /vm_order/drink_order
  - 
    remap_from: drink_ar
    remap_to: /vm_order/drink_ar
  - 
    remap_from: drinks_dispensed
    remap_to: /vm_order/drinks_dispensed
  - 
    remap_from: tray_empty
    remap_to: /vm_order/tray_empty
  - 
    remap_from: waiterbot_debug
    remap_to: /vm_order/waiterbot_debug
  - 
    remap_from: order_cancelled
    remap_to: /vm_order/order_cancelled]]
Compatibility Tree
  rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  Pruning...
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
    Pruning Resolvable Branches
      rocon:/waiterbot#cafe_rapps/waiter : ['zach']
  Pruned Tree
    rocon:/waiterbot#cafe_rapps/waiter : ['zach']
[INFO] [WallTime: 1400145114.447172] Scheduler : compatibility tree is valid, attempting to allocate [4c4ec1e5-cdd5-465e-af2f-c92c16f822c7]
[INFO] [WallTime: 1400145115.707012] Gateway : unflipping received flip [whoolac75e40dffeb44373a863d36dc71520a8][subscriber][/vm_order/drink_order][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145115.712484] Gateway : unflipping received flip [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/order_cancelled][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145115.715438] Gateway : unflipping received flip [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/waiterbot_debug][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145115.718977] Gateway : unflipping received flip [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/drink_ar][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145115.721815] Gateway : unflipping received flip [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/tray_empty][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145115.727076] Gateway : unflipping received flip [whoolac75e40dffeb44373a863d36dc71520a8][publisher][/vm_order/drinks_dispensed][/whoola/waiterbot_state_manager]
[INFO] [WallTime: 1400145121.948746] Gateway : received a flip request [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][subscriber][/map][/adams/move_base]
[INFO] [WallTime: 1400145133.294067] Scheduler :   allocated [zach]
[INFO] [WallTime: 1400145134.660548] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][subscriber][/map][/zach/amcl]
[INFO] [WallTime: 1400145134.668869] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][publisher][/zach/delivery_order/result][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145134.671974] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][publisher][/zach/delivery_order/feedback][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145134.676832] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][subscriber][/zach/delivery_order/cancel][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145134.682970] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][publisher][/zach/robot_pose][/zach/robot_pose_publisher]
[INFO] [WallTime: 1400145134.685536] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][subscriber][/annotation/tables][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145134.691191] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][publisher][/zach/delivery_order/status][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145134.695159] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][subscriber][/annotation/ar_markers][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145134.701443] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][subscriber][/zach/delivery_order/goal][/zach/waiterbot_ctrl_cafe]
[INFO] [WallTime: 1400145145.300536] Gateway : received a flip request [zachd312efeb7a634b6ca41ec74ee5f46b5c][subscriber][/map][/zach/move_base]



[INFO] [WallTime: 1400145705.310626] Client connected.  1 clients total.
[INFO] [WallTime: 1400145705.538365] [Client 0] Subscribed to /cafe/list_order
[INFO] [WallTime: 1400145705.549455] [Client 0] Subscribed to /cafe/remote_order_list
[INFO] [WallTime: 1400145705.561349] [Client 0] Subscribed to /cafe/remote_order_update
[INFO] [WallTime: 1400145705.622213] [Client 0] Subscribed to /map
[INFO] [WallTime: 1400145705.726979] [Client 0] Subscribed to /annotation/tables
[INFO] [WallTime: 1400145705.749323] [Client 0] Subscribed to /annotation/ar_markers
[INFO] [WallTime: 1400145705.766839] [Client 0] Subscribed to /adams/robot_pose
[INFO] [WallTime: 1400145705.790816] [Client 0] Subscribed to /zach/robot_pose
[INFO] [WallTime: 1400145705.793039] [Client 0] Unsubscribed from /map
[INFO] [WallTime: 1400145718.656536] Client connected.  2 clients total.
[INFO] [WallTime: 1400145729.450444] [Client 1] Subscribed to /cafe/send_order/status
[INFO] [WallTime: 1400145729.467150] [Client 1] Subscribed to /cafe/send_order/feedback
[INFO] [WallTime: 1400145729.489067] [Client 1] Subscribed to /cafe/send_order/result
[INFO] [WallTime: 1400145758.157957] Gateway : unflipping received flip [zachd312efeb7a634b6ca41ec74ee5f46b5c][subscriber][/map][/zach/move_base]
[INFO] [WallTime: 1400145770.570465] Client connected.  3 clients total.
[INFO] [WallTime: 1400145770.583046] [Client 2] Subscribed to /cafe/list_order
[INFO] [WallTime: 1400145770.594903] [Client 2] Subscribed to /cafe/remote_order_list
[INFO] [WallTime: 1400145770.595886] [Client 2] Subscribed to /cafe/remote_order_update
[INFO] [WallTime: 1400145770.611824] [Client 2] Subscribed to /map
[INFO] [WallTime: 1400145770.646132] [Client 2] Subscribed to /annotation/tables
[INFO] [WallTime: 1400145770.657535] [Client 2] Subscribed to /annotation/ar_markers
[INFO] [WallTime: 1400145770.658785] [Client 2] Subscribed to /adams/robot_pose
[INFO] [WallTime: 1400145770.659586] [Client 2] Subscribed to /zach/robot_pose
[INFO] [WallTime: 1400145770.660255] [Client 2] Unsubscribed from /map
[INFO] [WallTime: 1400145905.256488] Client connected.  4 clients total.
[INFO] [WallTime: 1400145910.690174] [Client 3] Subscribed to /cafe/send_order/status
[INFO] [WallTime: 1400145910.692326] [Client 3] Subscribed to /cafe/send_order/feedback
[INFO] [WallTime: 1400145910.693558] [Client 3] Subscribed to /cafe/send_order/result
[INFO] [WallTime: 1400145925.721837] Client disconnected. 3 clients total.
[INFO] [WallTime: 1400145940.245760] Gateway : unflipping received flip [adamsf2c1fa14d3bd4cc685aadba7b9913fc8][subscriber][/map][/adams/move_base]
[INFO] [WallTime: 1400145943.411886] Client connected.  4 clients total.
[INFO] [WallTime: 1400145947.168883] [Client 4] Subscribed to /cafe/send_order/status
[INFO] [WallTime: 1400145947.171716] [Client 4] Subscribed to /cafe/send_order/feedback
[INFO] [WallTime: 1400145947.177635] [Client 4] Subscribed to /cafe/send_order/result
[INFO] [WallTime: 1400145969.941393] Door is opening.
[INFO] [WallTime: 1400145972.340904] Idling.
[INFO] [WallTime: 1400146071.512325] Door is closing.
[INFO] [WallTime: 1400146072.841827] Idling.
[INFO] [WallTime: 1400146138.615878] Interactions : new remocon connected [android_remocon_f510880da0e1432eb50d78cea0f2180c]


[WARN] [WallTime: 1400146228.768526] Rocon Hue : failed to reach a server. Reason: timed out
[INFO] [WallTime: 1400146234.699267] Rocon Hue : bridge not connect 192.168.0.100
[INFO] [WallTime: 1400146235.762715] Rocon Hue : bridge connect
^[[B^[[A^[[A^[[A^[[A

@jihoonl
Copy link
Collaborator Author

jihoonl commented May 23, 2014

Bump. @stonier When and how do you want to tackle the issue?

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@stonier @jihoonl and others