root@dc1core> show log dhcp Nov 27 06:46:28.759123 [DEBUG] jdhcpd_trace_get_settings: Tracing configured from DHCP-Service Nov 27 06:46:28.760298 [INFO] jdhcpd_process_global_cfg: Global config from system process dhcp-service is set Nov 27 06:46:28.760332 === Configuration CHECK[18293] === Nov 27 06:46:28.760502 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:OPT-1, application SERVER, action 1 Nov 27 06:46:28.760544 Failed to read instance-type for (default.OPT-1) Nov 27 06:46:28.760567 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.760581 jdhcpd_cfg_do_top_by_af: default OPT-1 app SERVER action 1 Nov 27 06:46:28.760592 Failed to read instance-type for (default.OPT-1) Nov 27 06:46:28.760609 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89d4000), index 0 set APP_CFG Nov 27 06:46:28.760629 No pool-match-order Nov 27 06:46:28.760643 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.760656 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.760666 forward-snooped-clients NOT SET Nov 27 06:46:28.760687 No Server Groups Nov 27 06:46:28.760710 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.760724 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.760734 No Option-82 overrides Nov 27 06:46:28.760745 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.760754 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.760788 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.760799 No active-server-group configured Nov 27 06:46:28.760808 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.760818 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.760827 No dynamic-profile configured Nov 27 06:46:28.760840 No service-profile configured Nov 27 06:46:28.760851 No authentication Nov 27 06:46:28.760860 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.760872 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.760899 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.760911 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation root@dc1core> show log dhcp Nov 27 06:46:28.759123 [DEBUG] jdhcpd_trace_get_settings: Tracing configured from DHCP-Service Nov 27 06:46:28.760298 [INFO] jdhcpd_process_global_cfg: Global config from system process dhcp-service is set Nov 27 06:46:28.760332 === Configuration CHECK[18293] === Nov 27 06:46:28.760502 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:OPT-1, application SERVER, action 1 Nov 27 06:46:28.760544 Failed to read instance-type for (default.OPT-1) Nov 27 06:46:28.760567 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.760581 jdhcpd_cfg_do_top_by_af: default OPT-1 app SERVER action 1 Nov 27 06:46:28.760592 Failed to read instance-type for (default.OPT-1) Nov 27 06:46:28.760609 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89d4000), index 0 set APP_CFG Nov 27 06:46:28.760629 No pool-match-order Nov 27 06:46:28.760643 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.760656 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.760666 forward-snooped-clients NOT SET Nov 27 06:46:28.760687 No Server Groups Nov 27 06:46:28.760710 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.760724 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.760734 No Option-82 overrides Nov 27 06:46:28.760745 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.760754 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.760788 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.760799 No active-server-group configured Nov 27 06:46:28.760808 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.760818 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.760827 No dynamic-profile configured Nov 27 06:46:28.760840 No service-profile configured Nov 27 06:46:28.760851 No authentication Nov 27 06:46:28.760860 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.760872 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.760899 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.760911 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.760927 Have Config Groups Nov 27 06:46:28.760936 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.760956 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.760987 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.760998 No Option-82 overrides Nov 27 06:46:28.761008 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.761017 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.761027 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.761036 No active-server-group configured Nov 27 06:46:28.761045 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.761054 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.761063 No dynamic-profile configured Nov 27 06:46:28.761073 No service-profile configured Nov 27 06:46:28.761082 No authentication Nov 27 06:46:28.761091 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.761102 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.761113 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.761123 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.761135 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.761146 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.761156 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.761265 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.761275 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.761286 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.761350 Got interface ae0.1021 with action 1 Nov 27 06:46:28.761367 NO interface exclude Nov 27 06:46:28.761377 NO interface trace Nov 27 06:46:28.761415 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.761452 [DEBUG] rcdb_activate: Activate LR default RI OPT-1 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.761475 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:OPT-2, application SERVER, action 1 Nov 27 06:46:28.761488 Failed to read instance-type for (default.OPT-2) Nov 27 06:46:28.761505 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.761517 jdhcpd_cfg_do_top_by_af: default OPT-2 app SERVER action 1 Nov 27 06:46:28.761528 Failed to read instance-type for (default.OPT-2) Nov 27 06:46:28.761544 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89d8000), index 0 set APP_CFG Nov 27 06:46:28.761555 No pool-match-order Nov 27 06:46:28.761566 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.761577 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.761587 forward-snooped-clients NOT SET Nov 27 06:46:28.761596 No Server Groups Nov 27 06:46:28.761608 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.761620 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.761629 No Option-82 overrides Nov 27 06:46:28.761640 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.761648 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.761658 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.761667 No active-server-group configured Nov 27 06:46:28.761676 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.761686 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.761695 No dynamic-profile configured Nov 27 06:46:28.761704 No service-profile configured Nov 27 06:46:28.761713 No authentication Nov 27 06:46:28.761726 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.761738 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.761749 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.761760 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.761771 Have Config Groups Nov 27 06:46:28.761779 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.761793 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.761814 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.761824 No Option-82 overrides Nov 27 06:46:28.761835 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.761843 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.761854 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.761862 No active-server-group configured Nov 27 06:46:28.761871 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.761880 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.761890 No dynamic-profile configured Nov 27 06:46:28.761899 No service-profile configured Nov 27 06:46:28.761908 No authentication Nov 27 06:46:28.761917 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.762000 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.762011 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.762022 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.762033 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.762043 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.762053 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.762063 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.762072 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.762087 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.762122 Got interface ae0.1022 with action 1 Nov 27 06:46:28.762134 NO interface exclude Nov 27 06:46:28.762143 NO interface trace Nov 27 06:46:28.762155 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.762167 [DEBUG] rcdb_activate: Activate LR default RI OPT-2 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.762185 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:OPT-3, application SERVER, action 1 Nov 27 06:46:28.762197 Failed to read instance-type for (default.OPT-3) Nov 27 06:46:28.762213 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.762225 jdhcpd_cfg_do_top_by_af: default OPT-3 app SERVER action 1 Nov 27 06:46:28.762236 Failed to read instance-type for (default.OPT-3) Nov 27 06:46:28.762252 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89db000), index 0 set APP_CFG Nov 27 06:46:28.762263 No pool-match-order Nov 27 06:46:28.762273 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.762285 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.762294 forward-snooped-clients NOT SET Nov 27 06:46:28.762303 No Server Groups Nov 27 06:46:28.762315 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.762327 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.762336 No Option-82 overrides Nov 27 06:46:28.762347 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.762355 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.762369 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.762378 No active-server-group configured Nov 27 06:46:28.762387 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.762396 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.762406 No dynamic-profile configured Nov 27 06:46:28.762419 No service-profile configured Nov 27 06:46:28.762428 No authentication Nov 27 06:46:28.762437 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.762448 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.762459 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.762470 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.762481 Have Config Groups Nov 27 06:46:28.762490 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.762504 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.762525 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.762535 No Option-82 overrides Nov 27 06:46:28.762546 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.762554 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.762564 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.762573 No active-server-group configured Nov 27 06:46:28.762650 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.762660 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.762669 No dynamic-profile configured Nov 27 06:46:28.762678 No service-profile configured Nov 27 06:46:28.762687 No authentication Nov 27 06:46:28.762696 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.762707 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.762718 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.762729 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.762740 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.762750 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.762760 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.762770 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.762784 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.762795 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.762829 Got interface ae0.1023 with action 1 Nov 27 06:46:28.762840 NO interface exclude Nov 27 06:46:28.762849 NO interface trace Nov 27 06:46:28.762866 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.762877 [DEBUG] rcdb_activate: Activate LR default RI OPT-3 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.762896 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:OPT-4, application SERVER, action 1 Nov 27 06:46:28.762908 Failed to read instance-type for (default.OPT-4) Nov 27 06:46:28.762924 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.762937 jdhcpd_cfg_do_top_by_af: default OPT-4 app SERVER action 1 Nov 27 06:46:28.762947 Failed to read instance-type for (default.OPT-4) Nov 27 06:46:28.762963 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89df000), index 0 set APP_CFG Nov 27 06:46:28.762974 No pool-match-order Nov 27 06:46:28.762985 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.762996 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.763006 forward-snooped-clients NOT SET Nov 27 06:46:28.763015 No Server Groups Nov 27 06:46:28.763027 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.763039 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.763048 No Option-82 overrides Nov 27 06:46:28.763059 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.763067 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.763077 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.763086 No active-server-group configured Nov 27 06:46:28.763095 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.763109 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.763119 No dynamic-profile configured Nov 27 06:46:28.763128 No service-profile configured Nov 27 06:46:28.763137 No authentication Nov 27 06:46:28.763146 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.763157 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.763168 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.763179 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.763190 Have Config Groups Nov 27 06:46:28.763199 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.763213 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.763301 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.763312 No Option-82 overrides Nov 27 06:46:28.763322 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.763331 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.763341 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.763350 No active-server-group configured Nov 27 06:46:28.763359 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.763405 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.763416 No dynamic-profile configured Nov 27 06:46:28.763425 No service-profile configured Nov 27 06:46:28.763434 No authentication Nov 27 06:46:28.763443 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.763454 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.763465 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.763476 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.763487 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.763540 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.763584 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.763594 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.763604 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.763614 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.763650 Got interface ae0.1024 with action 1 Nov 27 06:46:28.763662 NO interface exclude Nov 27 06:46:28.763671 NO interface trace Nov 27 06:46:28.763683 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.763694 [DEBUG] rcdb_activate: Activate LR default RI OPT-4 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.763713 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:OPT-5, application SERVER, action 1 Nov 27 06:46:28.763725 Failed to read instance-type for (default.OPT-5) Nov 27 06:46:28.763740 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.763752 jdhcpd_cfg_do_top_by_af: default OPT-5 app SERVER action 1 Nov 27 06:46:28.763763 Failed to read instance-type for (default.OPT-5) Nov 27 06:46:28.763779 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89e2000), index 0 set APP_CFG Nov 27 06:46:28.763789 No pool-match-order Nov 27 06:46:28.763800 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.763811 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.763820 forward-snooped-clients NOT SET Nov 27 06:46:28.763830 No Server Groups Nov 27 06:46:28.763841 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.763853 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.763862 No Option-82 overrides Nov 27 06:46:28.763873 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.763881 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.763891 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.763909 No active-server-group configured Nov 27 06:46:28.763918 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.763928 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.763937 No dynamic-profile configured Nov 27 06:46:28.763946 No service-profile configured Nov 27 06:46:28.763955 No authentication Nov 27 06:46:28.763964 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.764054 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.764065 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.764076 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.764087 Have Config Groups Nov 27 06:46:28.764096 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.764110 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.764131 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.764141 No Option-82 overrides Nov 27 06:46:28.764151 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.764159 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.764170 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.764179 No active-server-group configured Nov 27 06:46:28.764187 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.764196 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.764206 No dynamic-profile configured Nov 27 06:46:28.764215 No service-profile configured Nov 27 06:46:28.764224 No authentication Nov 27 06:46:28.764232 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.764243 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.764254 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.764265 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.764276 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.764291 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.764301 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.764310 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.764320 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.764330 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.764367 Got interface ae0.1025 with action 1 Nov 27 06:46:28.764379 NO interface exclude Nov 27 06:46:28.764388 NO interface trace Nov 27 06:46:28.764403 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.764415 [DEBUG] rcdb_activate: Activate LR default RI OPT-5 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.764437 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c0, application SERVER, action 1 Nov 27 06:46:28.764448 Failed to read instance-type for (default.c0) Nov 27 06:46:28.764465 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.764477 jdhcpd_cfg_do_top_by_af: default c0 app SERVER action 1 Nov 27 06:46:28.764487 Failed to read instance-type for (default.c0) Nov 27 06:46:28.764503 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89e6000), index 0 set APP_CFG Nov 27 06:46:28.764514 No pool-match-order Nov 27 06:46:28.764524 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.764536 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.764545 forward-snooped-clients NOT SET Nov 27 06:46:28.764554 No Server Groups Nov 27 06:46:28.764566 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.764578 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.764587 No Option-82 overrides Nov 27 06:46:28.764597 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.764605 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.764620 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.764629 No active-server-group configured Nov 27 06:46:28.764706 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.764715 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.764725 No dynamic-profile configured Nov 27 06:46:28.764734 No service-profile configured Nov 27 06:46:28.764743 No authentication Nov 27 06:46:28.764752 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.764763 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.764774 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.764785 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.764796 Have Config Groups Nov 27 06:46:28.764804 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.764818 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.764839 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.764849 No Option-82 overrides Nov 27 06:46:28.764860 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.764868 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.764878 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.764887 No active-server-group configured Nov 27 06:46:28.764896 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.764905 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.764914 No dynamic-profile configured Nov 27 06:46:28.764923 No service-profile configured Nov 27 06:46:28.764932 No authentication Nov 27 06:46:28.764941 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.764952 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.764963 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.764974 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.764989 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.765000 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.765009 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.765019 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.765029 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.765039 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.765073 Got interface ae0.1030 with action 1 Nov 27 06:46:28.765084 NO interface exclude Nov 27 06:46:28.765093 NO interface trace Nov 27 06:46:28.765106 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.765117 [DEBUG] rcdb_activate: Activate LR default RI c0 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.765135 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c1-Q2, application SERVER, action 1 Nov 27 06:46:28.765147 Failed to read instance-type for (default.c1-Q2) Nov 27 06:46:28.765162 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.765175 jdhcpd_cfg_do_top_by_af: default c1-Q2 app SERVER action 1 Nov 27 06:46:28.765185 Failed to read instance-type for (default.c1-Q2) Nov 27 06:46:28.765201 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89e9000), index 0 set APP_CFG Nov 27 06:46:28.765212 No pool-match-order Nov 27 06:46:28.765223 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.765234 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.765243 forward-snooped-clients NOT SET Nov 27 06:46:28.765252 No Server Groups Nov 27 06:46:28.765264 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.765344 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.765353 No Option-82 overrides Nov 27 06:46:28.765376 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.765385 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.765396 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.765405 No active-server-group configured Nov 27 06:46:28.765414 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.765423 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.765433 No dynamic-profile configured Nov 27 06:46:28.765442 No service-profile configured Nov 27 06:46:28.765451 No authentication Nov 27 06:46:28.765460 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.765471 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.765482 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.765493 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.765504 Have Config Groups Nov 27 06:46:28.765513 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.765527 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.765548 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.765558 No Option-82 overrides Nov 27 06:46:28.765569 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.765577 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.765587 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.765596 No active-server-group configured Nov 27 06:46:28.765605 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.765614 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.765623 No dynamic-profile configured Nov 27 06:46:28.765632 No service-profile configured Nov 27 06:46:28.765641 No authentication Nov 27 06:46:28.765650 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.765661 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.765672 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.765688 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.765699 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.765710 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.765719 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.765729 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.765739 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.765749 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.765783 Got interface ae0.1032 with action 1 Nov 27 06:46:28.765794 NO interface exclude Nov 27 06:46:28.765804 NO interface trace Nov 27 06:46:28.765820 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.765832 [DEBUG] rcdb_activate: Activate LR default RI c1-Q2 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.765851 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c1-QJ, application SERVER, action 1 Nov 27 06:46:28.765873 Failed to read instance-type for (default.c1-QJ) Nov 27 06:46:28.765890 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.765902 jdhcpd_cfg_do_top_by_af: default c1-QJ app SERVER action 1 Nov 27 06:46:28.765913 Failed to read instance-type for (default.c1-QJ) Nov 27 06:46:28.765929 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89ed000), index 0 set APP_CFG Nov 27 06:46:28.766008 No pool-match-order Nov 27 06:46:28.766019 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.766030 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.766040 forward-snooped-clients NOT SET Nov 27 06:46:28.766049 No Server Groups Nov 27 06:46:28.766061 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.766073 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.766086 No Option-82 overrides Nov 27 06:46:28.766098 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.766106 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.766116 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.766125 No active-server-group configured Nov 27 06:46:28.766134 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.766143 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.766153 No dynamic-profile configured Nov 27 06:46:28.766162 No service-profile configured Nov 27 06:46:28.766171 No authentication Nov 27 06:46:28.766180 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.766191 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.766202 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.766213 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.766224 Have Config Groups Nov 27 06:46:28.766232 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.766247 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.766268 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.766278 No Option-82 overrides Nov 27 06:46:28.766288 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.766296 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.766307 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.766316 No active-server-group configured Nov 27 06:46:28.766325 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.766334 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.766343 No dynamic-profile configured Nov 27 06:46:28.766352 No service-profile configured Nov 27 06:46:28.766364 No authentication Nov 27 06:46:28.766374 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.766385 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.766439 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.766451 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.766462 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.766472 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.766481 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.766491 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.766500 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.766510 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.766545 Got interface ae0.1031 with action 1 Nov 27 06:46:28.766556 NO interface exclude Nov 27 06:46:28.766565 NO interface trace Nov 27 06:46:28.766577 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.766589 [DEBUG] rcdb_activate: Activate LR default RI c1-QJ flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.766674 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c10, application SERVER, action 1 Nov 27 06:46:28.766686 Failed to read instance-type for (default.c10) Nov 27 06:46:28.766702 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.766714 jdhcpd_cfg_do_top_by_af: default c10 app SERVER action 1 Nov 27 06:46:28.766725 Failed to read instance-type for (default.c10) Nov 27 06:46:28.766741 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89f0000), index 0 set APP_CFG Nov 27 06:46:28.766751 No pool-match-order Nov 27 06:46:28.766762 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.766773 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.766783 forward-snooped-clients NOT SET Nov 27 06:46:28.766792 No Server Groups Nov 27 06:46:28.766804 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.766823 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.766833 No Option-82 overrides Nov 27 06:46:28.766843 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.766852 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.766862 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.766871 No active-server-group configured Nov 27 06:46:28.766880 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.766889 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.766898 No dynamic-profile configured Nov 27 06:46:28.766907 No service-profile configured Nov 27 06:46:28.766916 No authentication Nov 27 06:46:28.766925 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.766936 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.766947 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.766957 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.766968 Have Config Groups Nov 27 06:46:28.766977 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.766991 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.767012 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.767022 No Option-82 overrides Nov 27 06:46:28.767032 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.767040 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.767051 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.767060 No active-server-group configured Nov 27 06:46:28.767068 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.767077 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.767086 No dynamic-profile configured Nov 27 06:46:28.767095 No service-profile configured Nov 27 06:46:28.767104 No authentication Nov 27 06:46:28.767113 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.767128 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.767140 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.767150 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.767162 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.767172 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.767181 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.767191 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.767201 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.767278 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.767312 Got interface ae0.1040 with action 1 Nov 27 06:46:28.767324 NO interface exclude Nov 27 06:46:28.767333 NO interface trace Nov 27 06:46:28.767349 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.767364 [DEBUG] rcdb_activate: Activate LR default RI c10 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.767387 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c3-QR, application SERVER, action 1 Nov 27 06:46:28.767399 Failed to read instance-type for (default.c3-QR) Nov 27 06:46:28.767416 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.767428 jdhcpd_cfg_do_top_by_af: default c3-QR app SERVER action 1 Nov 27 06:46:28.767439 Failed to read instance-type for (default.c3-QR) Nov 27 06:46:28.767454 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89f4000), index 0 set APP_CFG Nov 27 06:46:28.767465 No pool-match-order Nov 27 06:46:28.767476 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.767487 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.767497 forward-snooped-clients NOT SET Nov 27 06:46:28.767510 No Server Groups Nov 27 06:46:28.767522 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.767534 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.767543 No Option-82 overrides Nov 27 06:46:28.767554 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.767562 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.767572 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.767581 No active-server-group configured Nov 27 06:46:28.767590 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.767599 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.767608 No dynamic-profile configured Nov 27 06:46:28.767617 No service-profile configured Nov 27 06:46:28.767626 No authentication Nov 27 06:46:28.767635 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.767646 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.767657 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.767667 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.767678 Have Config Groups Nov 27 06:46:28.767687 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.767701 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.767721 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.767731 No Option-82 overrides Nov 27 06:46:28.767742 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.767750 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.767760 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.767769 No active-server-group configured Nov 27 06:46:28.767778 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.767787 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.767796 No dynamic-profile configured Nov 27 06:46:28.767809 No service-profile configured Nov 27 06:46:28.767819 No authentication Nov 27 06:46:28.767828 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.767839 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.767849 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.767928 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.767940 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.767950 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.767960 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.767969 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.767979 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.767989 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.768023 Got interface ae0.1033 with action 1 Nov 27 06:46:28.768034 NO interface exclude Nov 27 06:46:28.768043 NO interface trace Nov 27 06:46:28.768056 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.768067 [DEBUG] rcdb_activate: Activate LR default RI c3-QR flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.768085 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c5, application SERVER, action 1 Nov 27 06:46:28.768097 Failed to read instance-type for (default.c5) Nov 27 06:46:28.768112 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.768125 jdhcpd_cfg_do_top_by_af: default c5 app SERVER action 1 Nov 27 06:46:28.768135 Failed to read instance-type for (default.c5) Nov 27 06:46:28.768151 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89f7000), index 0 set APP_CFG Nov 27 06:46:28.768162 No pool-match-order Nov 27 06:46:28.768173 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.768184 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.768198 forward-snooped-clients NOT SET Nov 27 06:46:28.768207 No Server Groups Nov 27 06:46:28.768219 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.768231 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.768240 No Option-82 overrides Nov 27 06:46:28.768251 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.768259 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.768270 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.768279 No active-server-group configured Nov 27 06:46:28.768288 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.768297 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.768306 No dynamic-profile configured Nov 27 06:46:28.768315 No service-profile configured Nov 27 06:46:28.768324 No authentication Nov 27 06:46:28.768333 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.768344 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.768355 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.768383 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.768395 Have Config Groups Nov 27 06:46:28.768404 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.768418 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.768439 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.768449 No Option-82 overrides Nov 27 06:46:28.768460 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.768468 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.768478 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.768487 No active-server-group configured Nov 27 06:46:28.768496 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.768505 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.768587 No dynamic-profile configured Nov 27 06:46:28.768596 No service-profile configured Nov 27 06:46:28.768606 No authentication Nov 27 06:46:28.768614 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.768625 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.768636 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.768647 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.768659 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.768669 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.768679 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.768688 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.768698 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.768708 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.768742 Got interface ae0.1035 with action 1 Nov 27 06:46:28.768753 NO interface exclude Nov 27 06:46:28.768762 NO interface trace Nov 27 06:46:28.768779 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.768790 [DEBUG] rcdb_activate: Activate LR default RI c5 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.768809 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c6, application SERVER, action 1 Nov 27 06:46:28.768821 Failed to read instance-type for (default.c6) Nov 27 06:46:28.768838 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.768850 jdhcpd_cfg_do_top_by_af: default c6 app SERVER action 1 Nov 27 06:46:28.768861 Failed to read instance-type for (default.c6) Nov 27 06:46:28.768877 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89fb000), index 0 set APP_CFG Nov 27 06:46:28.768888 No pool-match-order Nov 27 06:46:28.768898 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.768914 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.768924 forward-snooped-clients NOT SET Nov 27 06:46:28.768933 No Server Groups Nov 27 06:46:28.768945 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.768957 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.768966 No Option-82 overrides Nov 27 06:46:28.768977 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.768985 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.768996 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.769005 No active-server-group configured Nov 27 06:46:28.769014 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.769023 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.769033 No dynamic-profile configured Nov 27 06:46:28.769042 No service-profile configured Nov 27 06:46:28.769051 No authentication Nov 27 06:46:28.769060 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.769071 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.769082 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.769093 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.769104 Have Config Groups Nov 27 06:46:28.769113 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.769127 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.769147 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.769158 No Option-82 overrides Nov 27 06:46:28.769235 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.769244 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.769254 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.769263 No active-server-group configured Nov 27 06:46:28.769301 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.769311 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.769321 No dynamic-profile configured Nov 27 06:46:28.769329 No service-profile configured Nov 27 06:46:28.769338 No authentication Nov 27 06:46:28.769347 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.769358 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.769372 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.769383 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.769394 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.769404 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.769414 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.769423 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.769433 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.769443 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.769477 Got interface ae0.1036 with action 1 Nov 27 06:46:28.769488 NO interface exclude Nov 27 06:46:28.769497 NO interface trace Nov 27 06:46:28.769509 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.769521 [DEBUG] rcdb_activate: Activate LR default RI c6 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.769539 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c7, application SERVER, action 1 Nov 27 06:46:28.769551 Failed to read instance-type for (default.c7) Nov 27 06:46:28.769567 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.769579 jdhcpd_cfg_do_top_by_af: default c7 app SERVER action 1 Nov 27 06:46:28.769589 Failed to read instance-type for (default.c7) Nov 27 06:46:28.769605 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (89fe000), index 0 set APP_CFG Nov 27 06:46:28.769624 No pool-match-order Nov 27 06:46:28.769635 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.769646 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.769656 forward-snooped-clients NOT SET Nov 27 06:46:28.769665 No Server Groups Nov 27 06:46:28.769677 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.769688 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.769698 No Option-82 overrides Nov 27 06:46:28.769708 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.769716 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.769727 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.769736 No active-server-group configured Nov 27 06:46:28.769745 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.769754 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.769763 No dynamic-profile configured Nov 27 06:46:28.769772 No service-profile configured Nov 27 06:46:28.769781 No authentication Nov 27 06:46:28.769790 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.769801 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.769812 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.769891 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.769902 Have Config Groups Nov 27 06:46:28.769910 top_walk->af_type is JDHCPD_AF_INET Nov 27 06:46:28.769924 [INFO] jdhcpd_walk_group_cb: **** START group g1 op 1 **** Nov 27 06:46:28.769945 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.769955 No Option-82 overrides Nov 27 06:46:28.769966 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.769974 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.769984 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.769997 No active-server-group configured Nov 27 06:46:28.770007 No DHCPv6: relay-agent-interface-id Nov 27 06:46:28.770016 No DHCPv6: relay-agent-remote-id Nov 27 06:46:28.770025 No dynamic-profile configured Nov 27 06:46:28.770034 No service-profile configured Nov 27 06:46:28.770043 No authentication Nov 27 06:46:28.770052 No Config reconfigure, clearing reconfigure Nov 27 06:46:28.770062 [DEBUG] jdhcpd_process_liveness_detection: No liveness-detection configured Nov 27 06:46:28.770073 [DEBUG] jdhcpd_process_route_suppression: No ROUTE-SUPPRESSION configured Nov 27 06:46:28.770084 [DEBUG] jdhcpd_process_lease_time_validation: Dont Have lease-time-validation Nov 27 06:46:28.770095 [INFO] jdhcpd_walk_group_cb: Group g1 using base active-server-group Nov 27 06:46:28.770105 [INFO] jdhcpd_walk_group_cb: Group g1 using base DHCPv6 active-server-group Nov 27 06:46:28.770115 [DEBUG] jdhcpd_walk_group_cb: Group g1 using base liveness-detection Nov 27 06:46:28.770124 [INFO] jdhcpd_walk_group_cb: Group g1 using base dynamic-profile: Nov 27 06:46:28.770134 [INFO] jdhcpd_walk_group_cb: Group g1 using base route_suppression 0 Nov 27 06:46:28.770144 [INFO] jdhcpd_walk_group_cb: Group g1 using base service-profile: Nov 27 06:46:28.770177 Got interface ae0.1037 with action 1 Nov 27 06:46:28.770189 NO interface exclude Nov 27 06:46:28.770198 NO interface trace Nov 27 06:46:28.770214 [INFO] jdhcpd_walk_group_cb: **** STOP group g1 **** Nov 27 06:46:28.770225 [DEBUG] rcdb_activate: Activate LR default RI c7 flags 200800, ADDR_FAM 0, rtt_af 1 Nov 27 06:46:28.770244 jdhcpd_cfg_do_top_cb: Process top configuration: LS:default RI:c8, application SERVER, action 1 Nov 27 06:46:28.770255 Failed to read instance-type for (default.c8) Nov 27 06:46:28.770272 jdhcpd_cfg_do_top_cb: Processing a CHANGE for DHCPv4 Nov 27 06:46:28.770284 jdhcpd_cfg_do_top_by_af: default c8 app SERVER action 1 Nov 27 06:46:28.770294 Failed to read instance-type for (default.c8) Nov 27 06:46:28.770314 [INFO] jdhcpd_cfg_do_top_by_af: RC_RTB (8a02000), index 0 set APP_CFG Nov 27 06:46:28.770325 No pool-match-order Nov 27 06:46:28.770336 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-on-interface NOT SET Nov 27 06:46:28.770347 [INFO] jdhcpd_process_duplicate_clients_on_intf: duplicate-clients-in-subnet NOT SET Nov 27 06:46:28.770356 forward-snooped-clients NOT SET Nov 27 06:46:28.770369 No Server Groups Nov 27 06:46:28.770381 [INFO] jdhcpd_process_requested_ip_network_matc: requested-ip network match prefix = 8 Nov 27 06:46:28.770393 [INFO] jdhcpd_process_forward_only_to_rc: No config forward-only-to-rc Nov 27 06:46:28.770402 No Option-82 overrides Nov 27 06:46:28.770412 [INFO] jdhcpd_process_relay_option60: No Option-60 Nov 27 06:46:28.770420 jdhcpd_process_relay_generic_option(): af_type is JDHCPD_AF_INET Nov 27 06:46:28.770431 [INFO] jdhcpd_process_relay_generic_option: No relay-option Nov 27 06:46:28.770440 No active-server-group configured Nov 27 06:46:28.770449 No DHCPv6: relay-agent-interface-id root@dc1core> | ^ unknown command. root@dc1core> show log dhcp | last 100 Nov 27 20:24:29.656184 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:24:29.656208 [INFO] [default:drive][SVR][INET][irb.1034][SID=10555] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:24:29.656221 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:24:29.656234 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10555 Nov 27 20:24:29.656280 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10555 Nov 27 20:24:29.656295 Failure (status 2) when deleting baseline stats for 10555 (client index 71610) Nov 27 20:24:29.656794 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10555] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10555 Nov 27 20:24:34.364209 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:24:34.364427 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:24:34.364442 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:24:34.364459 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:24:34.364481 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:24:34.364503 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:24:34.364515 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:24:34.364527 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:24:34.364537 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:24:34.364561 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:24:34.364575 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:24:34.364588 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 8000 ]-- Nov 27 20:24:34.364602 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:24:34.364615 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 1ac8b9e1 ]-- Nov 27 20:24:34.364628 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 1280, flags == 8000 ]-- Nov 27 20:24:34.364643 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:24:34.364657 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:24:34.364671 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:24:34.364685 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:24:34.364711 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 4d 68 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:24:34.364724 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:24:34.364738 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:24:34.364753 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:24:34.364771 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 4d 68 ]-- Nov 27 20:24:34.364788 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 7, data 4b 44 56 4d 30 30 31 ]-- Nov 27 20:24:34.364805 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:24:34.364824 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 12, data 01 0f 03 06 2c 2e 2f 1f 21 79 f9 2b ]-- Nov 27 20:24:34.364838 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:24:34.364862 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 4d 68, mac 01 00 50 56 96 4d 68, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:24:34.364878 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:24:34.364895 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 4d 68 Nov 27 20:24:34.364909 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:24:34.364925 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:24:34.364941 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:24:34.364957 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:24:34.364980 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71611 Nov 27 20:24:34.364993 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:24:34.365014 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:24:34.365037 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:24:34.365054 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:24:34.365074 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:24:34.365092 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:24:34.365292 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:24:34.365309 Service_get NO service name Nov 27 20:24:34.365321 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:24:34.365336 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:24:34.365533 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:24:34.365546 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:24:34.365556 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:24:34.365570 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:4d:68 Nov 27 20:24:34.365585 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:24:34.365620 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 4d 68 0c 07 4b 44 56 4d 30 30 31 3c 08 4d 53 46 54 20 35 2e 30 37 0c 01 0f 03 06 2c 2e 2f 1f 21 79 f9 2b Nov 27 20:24:34.365637 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:24:34.365651 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:24:34.366037 jdhcpd_sdb_create_session: session DB create got INET entry id 10556 Nov 27 20:24:34.366055 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:24:34.366071 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:24:34.366089 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10556) Nov 27 20:24:34.366106 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:24:34.366122 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:24:34.366137 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:24:34.366152 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:24:34.366168 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:24:34.366183 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:24:34.366231 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:24:34.366255 jdhcpd_auth_request: auth-request attempt initiated for session 10556: flags1:0x20000; flags2:0 Nov 27 20:24:34.366268 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:24:34.366278 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:24:34.366287 Added client w/ session_id 10556 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:24:34.366298 Using Service-Profile-Name Nov 27 20:24:34.366951 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71611- (session Id 10556) Nov 27 20:24:34.366964 Request to remove client w. session_id 10556 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:24:34.366975 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:24:34.366986 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6074 Nov 27 20:24:34.367117 jdhcpd_authenticate_rply_proc: auth login reply status for session 10556: result:9; flags1:0x20000; flags2:0 Nov 27 20:24:34.367179 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:24:34.367190 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:24:34.367214 [INFO] [default:drive][SVR][INET][irb.1034][SID=10556] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:24:34.367227 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:24:34.367240 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10556 Nov 27 20:24:34.367291 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10556 Nov 27 20:24:34.367306 Failure (status 2) when deleting baseline stats for 10556 (client index 71611) Nov 27 20:24:34.367720 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10556] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10556 root@dc1core> edit Entering configuration mode [edit] root@dc1core# edit tra ^ syntax error, expecting or . root@dc1core# edit system [edit system] root@dc1core# show host-name dc1core; root-authentication { encrypted-password "$1$9W/jj/HN$b5chKJpC4HNOZ2Bh4BGDJ1"; ## SECRET-DATA } login { user ionetworks { uid 2004; class super-user; authentication { encrypted-password "$1$l8NYIsbO$XxbDolCsbSWuqVS8zgAhw0"; ## SECRET-DATA } } user optadmin { uid 2005; class super-user; authentication { encrypted-password "$1$UCz4/2Um$1FIjyLpA86/I6asejb8oD0"; ## SECRET-DATA } } } services { ftp; ssh; } syslog { user * { any emergency; } file messages { any notice; authorization info; } file interactive-commands { interactive-commands any; } } processes { dhcp-service { traceoptions { file dhcp size 500000000 world-readable; level all; flag all; } } } [edit system] root@dc1core# [edit system] root@dc1core# [edit system] root@dc1core# [edit system] root@dc1core# [edit system] root@dc1core# exit [edit] root@dc1core# top warning: already at top of configuration; use 'exit' to exit [edit] root@dc1core# exit Exiting configuration mode root@dc1core> show log dhcp | last 1000 Nov 27 20:39:06.324654 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6152 Nov 27 20:39:06.324681 jdhcpd_authenticate_rply_proc: auth login reply status for session 10634: result:9; flags1:0x20000; flags2:0 Nov 27 20:39:06.324741 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:39:06.324752 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:39:06.324776 [INFO] [default:drive][SVR][INET][irb.1034][SID=10634] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:39:06.324789 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:39:06.324801 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10634 Nov 27 20:39:06.324850 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10634 Nov 27 20:39:06.324865 Failure (status 2) when deleting baseline stats for 10634 (client index 71689) Nov 27 20:39:06.326580 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10634] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10634 Nov 27 20:39:16.716370 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:39:16.716430 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:39:16.716444 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 463, dpi_rtbl=0 Nov 27 20:39:16.716461 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 463, using the L3 interface Nov 27 20:39:16.716483 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:39:16.716504 security-packet-handle sus_l2:ae0.1034 Nov 27 20:39:16.716517 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:39:16.716528 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:39:16.716538 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:39:16.716561 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:39:16.716576 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:39:16.716589 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 8000 ]-- Nov 27 20:39:16.716602 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:39:16.716615 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == dd6d2e79 ]-- Nov 27 20:39:16.716629 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 7680, flags == 8000 ]-- Nov 27 20:39:16.716643 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:39:16.716657 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:39:16.716671 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:39:16.716692 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:39:16.716716 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 a1 52 a5 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:39:16.716730 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:39:16.716743 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:39:16.716758 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:39:16.716776 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 a1 52 a5 ]-- Nov 27 20:39:16.716797 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 15, data 44 45 53 4b 54 4f 50 2d 34 4e 42 4d 4d 4c 33 ]-- Nov 27 20:39:16.716814 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:39:16.716834 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:39:16.716848 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:39:16.716871 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 a1 52 a5, mac 01 00 50 56 a1 52 a5, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:39:16.716887 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:39:16.716905 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 a1 52 a5 Nov 27 20:39:16.716919 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:39:16.716935 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:39:16.716950 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:39:16.716967 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:39:16.716989 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71690 Nov 27 20:39:16.717002 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:39:16.717023 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:39:16.717045 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:39:16.717061 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 463, bd index 18, L3 ifindex 352 Nov 27 20:39:16.717081 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:39:16.717099 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:39:16.717440 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:39:16.717458 Service_get NO service name Nov 27 20:39:16.717470 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:39:16.717668 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:39:16.717682 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:39:16.717694 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:39:16.717705 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:39:16.717718 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:a1:52:a5 Nov 27 20:39:16.717733 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:39:16.717771 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 54, data 35 01 01 3d 07 01 00 50 56 a1 52 a5 0c 0f 44 45 53 4b 54 4f 50 2d 34 4e 42 4d 4d 4c 33 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:39:16.717788 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:39:16.717803 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:39:16.718153 jdhcpd_sdb_create_session: session DB create got INET entry id 10635 Nov 27 20:39:16.718171 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:39:16.718187 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: L2 interface name ae0.1034, length 8 Nov 27 20:39:16.718205 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 114 (sizeof(client->session_id) is 10635) Nov 27 20:39:16.718223 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:39:16.718239 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name ae0.1034, length 8 Nov 27 20:39:16.718254 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:39:16.718268 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:39:16.718285 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:39:16.718300 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:39:16.718348 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 198 Nov 27 20:39:16.718373 jdhcpd_auth_request: auth-request attempt initiated for session 10635: flags1:0x20000; flags2:0 Nov 27 20:39:16.718386 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:16.718396 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:16.718406 Added client w/ session_id 10635 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:16.718417 Using Service-Profile-Name Nov 27 20:39:16.718993 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71690- (session Id 10635) Nov 27 20:39:16.719033 Request to remove client w. session_id 10635 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:16.719045 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:39:16.719056 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6153 Nov 27 20:39:16.719170 jdhcpd_authenticate_rply_proc: auth login reply status for session 10635: result:9; flags1:0x20000; flags2:0 Nov 27 20:39:16.719230 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:39:16.719241 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:39:16.719265 [INFO] [default:drive][SVR][INET][irb.1034][SID=10635] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:39:16.719278 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:39:16.719291 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10635 Nov 27 20:39:16.719341 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10635 Nov 27 20:39:16.719356 Failure (status 2) when deleting baseline stats for 10635 (client index 71690) Nov 27 20:39:16.719785 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10635] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10635 Nov 27 20:39:17.825460 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:39:17.825659 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:39:17.825673 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 463, dpi_rtbl=0 Nov 27 20:39:17.825690 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 463, using the L3 interface Nov 27 20:39:17.825712 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:39:17.825733 security-packet-handle sus_l2:ae0.1034 Nov 27 20:39:17.825745 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:39:17.825757 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:39:17.825766 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:39:17.825790 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:39:17.825804 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:39:17.825817 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 8000 ]-- Nov 27 20:39:17.825830 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:39:17.825843 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 3a274205 ]-- Nov 27 20:39:17.825857 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 6912, flags == 8000 ]-- Nov 27 20:39:17.825871 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:39:17.825885 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:39:17.825899 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:39:17.825913 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:39:17.825935 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 0c 29 96 d2 67 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:39:17.825948 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:39:17.826067 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:39:17.826083 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:39:17.826101 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 0c 29 96 d2 67 ]-- Nov 27 20:39:17.826121 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 15, data 44 45 53 4b 54 4f 50 2d 48 36 36 38 39 44 36 ]-- Nov 27 20:39:17.826139 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:39:17.826159 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:39:17.826172 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:39:17.826195 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 0c 29 96 d2 67, mac 01 00 0c 29 96 d2 67, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:39:17.826211 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:39:17.826228 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 0c 29 96 d2 67 Nov 27 20:39:17.826242 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:39:17.826258 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:39:17.826273 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:39:17.826289 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:39:17.826311 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71691 Nov 27 20:39:17.826324 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:39:17.826345 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:39:17.826367 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:39:17.826383 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 463, bd index 18, L3 ifindex 352 Nov 27 20:39:17.826402 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:39:17.826420 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:39:17.826579 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:39:17.826596 Service_get NO service name Nov 27 20:39:17.826608 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:39:17.826622 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:39:17.826632 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:39:17.826644 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:39:17.826654 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:39:17.826668 jdhcpd_sdb_create_session: INET, setting MAC addr 00:0c:29:96:d2:67 Nov 27 20:39:17.826682 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:39:17.826720 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 54, data 35 01 01 3d 07 01 00 0c 29 96 d2 67 0c 0f 44 45 53 4b 54 4f 50 2d 48 36 36 38 39 44 36 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:39:17.826737 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:39:17.826751 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:39:17.827190 jdhcpd_sdb_create_session: session DB create got INET entry id 10636 Nov 27 20:39:17.827208 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:39:17.827223 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: L2 interface name ae0.1034, length 8 Nov 27 20:39:17.827241 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 114 (sizeof(client->session_id) is 10636) Nov 27 20:39:17.827258 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:39:17.827274 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name ae0.1034, length 8 Nov 27 20:39:17.827288 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:39:17.827303 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:39:17.827319 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:39:17.827334 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:39:17.827383 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 198 Nov 27 20:39:17.827407 jdhcpd_auth_request: auth-request attempt initiated for session 10636: flags1:0x20000; flags2:0 Nov 27 20:39:17.827420 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:17.827429 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:17.827439 Added client w/ session_id 10636 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:17.827450 Using Service-Profile-Name Nov 27 20:39:17.828015 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71691- (session Id 10636) Nov 27 20:39:17.828028 Request to remove client w. session_id 10636 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:17.828039 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:39:17.828051 jdhcpd_authenticate_rply_proc: auth login reply status for session 10636: result:9; flags1:0x20000; flags2:0 Nov 27 20:39:17.828110 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:39:17.828121 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:39:17.828144 [INFO] [default:drive][SVR][INET][irb.1034][SID=10636] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:39:17.828156 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:39:17.828169 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10636 Nov 27 20:39:17.828216 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10636 Nov 27 20:39:17.828231 Failure (status 2) when deleting baseline stats for 10636 (client index 71691) Nov 27 20:39:17.828745 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10636] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10636 Nov 27 20:39:40.702783 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:39:40.702840 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:39:40.702854 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:39:40.702870 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:39:40.702892 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:39:40.702914 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:39:40.702928 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:39:40.702940 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:39:40.702950 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:39:40.702973 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:39:40.702987 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:39:40.703001 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 0 ]-- Nov 27 20:39:40.703014 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:39:40.703027 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 1f8eb932 ]-- Nov 27 20:39:40.703040 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 0, flags == 0000 ]-- Nov 27 20:39:40.703054 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:39:40.703068 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:39:40.703082 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:39:40.703096 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:39:40.703118 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:39:40.703132 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:39:40.703144 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:39:40.703169 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:39:40.703187 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:39:40.703204 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:39:40.703221 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:39:40.703241 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:39:40.703254 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:39:40.703277 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:39:40.703293 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:39:40.703310 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:39:40.703324 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:39:40.703340 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:39:40.703355 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:39:40.703371 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:39:40.703393 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71692 Nov 27 20:39:40.703406 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:39:40.703427 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:39:40.703482 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:39:40.703500 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:39:40.703520 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:39:40.703539 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:39:40.703962 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:39:40.704158 Service_get NO service name Nov 27 20:39:40.704172 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:39:40.704186 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:39:40.704197 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:39:40.704360 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:39:40.704371 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:39:40.704386 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:39:40.704400 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:39:40.704435 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:39:40.704452 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:39:40.704467 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:39:40.704838 jdhcpd_sdb_create_session: session DB create got INET entry id 10637 Nov 27 20:39:40.704856 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:39:40.704872 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:39:40.704890 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10637) Nov 27 20:39:40.704907 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:39:40.704923 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:39:40.704942 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:39:40.704957 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:39:40.704974 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:39:40.704989 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:39:40.705038 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:39:40.705063 jdhcpd_auth_request: auth-request attempt initiated for session 10637: flags1:0x20000; flags2:0 Nov 27 20:39:40.705076 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:40.705086 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:40.705095 Added client w/ session_id 10637 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:40.705107 Using Service-Profile-Name Nov 27 20:39:40.705778 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71692- (session Id 10637) Nov 27 20:39:40.705791 Request to remove client w. session_id 10637 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:40.705802 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:39:40.705814 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6155 Nov 27 20:39:40.705842 jdhcpd_authenticate_rply_proc: auth login reply status for session 10637: result:9; flags1:0x20000; flags2:0 Nov 27 20:39:40.705902 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:39:40.705987 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:39:40.706011 [INFO] [default:drive][SVR][INET][irb.1034][SID=10637] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:39:40.706024 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:39:40.706037 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10637 Nov 27 20:39:40.706087 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10637 Nov 27 20:39:40.706102 Failure (status 2) when deleting baseline stats for 10637 (client index 71692) Nov 27 20:39:40.706530 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10637] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10637 Nov 27 20:39:43.954443 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:39:43.954504 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:39:43.954518 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:39:43.954535 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:39:43.954557 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:39:43.954578 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:39:43.954590 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:39:43.954602 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:39:43.954612 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:39:43.954635 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:39:43.954649 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:39:43.954663 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 0 ]-- Nov 27 20:39:43.954676 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:39:43.954689 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 1f8eb932 ]-- Nov 27 20:39:43.954702 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 0, flags == 0000 ]-- Nov 27 20:39:43.954717 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:39:43.954731 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:39:43.954745 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:39:43.954759 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:39:43.954782 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:39:43.954795 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:39:43.954808 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:39:43.954824 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:39:43.955015 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:39:43.955032 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:39:43.955050 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:39:43.955069 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:39:43.955083 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:39:43.955107 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:39:43.955123 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:39:43.955140 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:39:43.955154 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:39:43.955170 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:39:43.955185 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:39:43.955201 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:39:43.955223 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71693 Nov 27 20:39:43.955236 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:39:43.955257 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:39:43.955280 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:39:43.955296 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:39:43.955316 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:39:43.955334 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:39:43.955519 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:39:43.955537 Service_get NO service name Nov 27 20:39:43.955549 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:39:43.955563 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:39:43.955573 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:39:43.955585 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:39:43.955596 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:39:43.955610 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:39:43.955623 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:39:43.955658 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:39:43.955675 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:39:43.955689 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:39:43.956041 jdhcpd_sdb_create_session: session DB create got INET entry id 10638 Nov 27 20:39:43.956139 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:39:43.956155 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:39:43.956173 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10638) Nov 27 20:39:43.956190 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:39:43.956206 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:39:43.956222 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:39:43.956236 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:39:43.956253 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:39:43.956268 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:39:43.956317 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:39:43.956342 jdhcpd_auth_request: auth-request attempt initiated for session 10638: flags1:0x20000; flags2:0 Nov 27 20:39:43.956354 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:43.956364 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:43.956374 Added client w/ session_id 10638 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:43.956385 Using Service-Profile-Name Nov 27 20:39:43.958542 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71693- (session Id 10638) Nov 27 20:39:43.958556 Request to remove client w. session_id 10638 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:43.958567 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:39:43.958580 jdhcpd_authenticate_rply_proc: auth login reply status for session 10638: result:9; flags1:0x20000; flags2:0 Nov 27 20:39:43.958640 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:39:43.958651 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:39:43.958676 [INFO] [default:drive][SVR][INET][irb.1034][SID=10638] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:39:43.958689 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:39:43.958702 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10638 Nov 27 20:39:43.958754 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10638 Nov 27 20:39:43.958769 Failure (status 2) when deleting baseline stats for 10638 (client index 71693) Nov 27 20:39:43.959305 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10638] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10638 Nov 27 20:39:48.956070 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:39:48.956135 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:39:48.956179 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:39:48.956197 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:39:48.956218 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:39:48.956239 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:39:48.956252 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:39:48.956263 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:39:48.956273 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:39:48.956296 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:39:48.956311 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:39:48.956324 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 0 ]-- Nov 27 20:39:48.956337 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:39:48.956350 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 1f8eb932 ]-- Nov 27 20:39:48.956363 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 1280, flags == 0000 ]-- Nov 27 20:39:48.956378 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:39:48.956392 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:39:48.956406 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:39:48.956420 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:39:48.956443 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:39:48.956456 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:39:48.956469 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:39:48.956484 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:39:48.956502 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:39:48.956519 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:39:48.956536 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:39:48.956556 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:39:48.956570 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:39:48.956593 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:39:48.956609 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:39:48.956626 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:39:48.956643 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:39:48.956660 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:39:48.956675 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:39:48.956692 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:39:48.956714 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71694 Nov 27 20:39:48.956727 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:39:48.956747 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:39:48.956770 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:39:48.956786 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:39:48.956806 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:39:48.956824 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:39:48.957030 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:39:48.957047 Service_get NO service name Nov 27 20:39:48.957059 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:39:48.957073 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:39:48.957083 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:39:48.957095 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:39:48.957106 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:39:48.957300 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:39:48.957314 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:39:48.957349 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:39:48.957366 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:39:48.957380 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:39:48.957744 jdhcpd_sdb_create_session: session DB create got INET entry id 10639 Nov 27 20:39:48.957762 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:39:48.957777 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:39:48.957796 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10639) Nov 27 20:39:48.957813 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:39:48.957829 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:39:48.957843 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:39:48.957858 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:39:48.957875 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:39:48.957890 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:39:48.957938 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:39:48.957963 jdhcpd_auth_request: auth-request attempt initiated for session 10639: flags1:0x20000; flags2:0 Nov 27 20:39:48.957976 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:48.957986 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:48.957995 Added client w/ session_id 10639 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:48.958006 Using Service-Profile-Name Nov 27 20:39:48.958591 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71694- (session Id 10639) Nov 27 20:39:48.958605 Request to remove client w. session_id 10639 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:48.958616 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:39:48.958626 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6157 Nov 27 20:39:48.958665 jdhcpd_authenticate_rply_proc: auth login reply status for session 10639: result:9; flags1:0x20000; flags2:0 Nov 27 20:39:48.958726 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:39:48.958737 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:39:48.958761 [INFO] [default:drive][SVR][INET][irb.1034][SID=10639] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:39:48.958862 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:39:48.958876 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10639 Nov 27 20:39:48.958925 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10639 Nov 27 20:39:48.958940 Failure (status 2) when deleting baseline stats for 10639 (client index 71694) Nov 27 20:39:48.959362 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10639] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10639 Nov 27 20:39:56.335826 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:39:56.335880 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:39:56.335894 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:39:56.335911 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:39:56.335933 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:39:56.335955 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:39:56.335967 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:39:56.335979 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:39:56.335989 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:39:56.336012 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:39:56.336026 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:39:56.336040 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 0 ]-- Nov 27 20:39:56.336053 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:39:56.336067 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 1f8eb932 ]-- Nov 27 20:39:56.336080 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 3072, flags == 0000 ]-- Nov 27 20:39:56.336095 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:39:56.336109 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:39:56.336123 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:39:56.336137 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:39:56.336161 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:39:56.336174 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:39:56.336187 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:39:56.336202 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:39:56.336220 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:39:56.336237 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:39:56.336420 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:39:56.336440 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:39:56.336454 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:39:56.336477 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:39:56.336497 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:39:56.336514 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:39:56.336528 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:39:56.336544 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:39:56.336560 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:39:56.336576 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:39:56.336599 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71695 Nov 27 20:39:56.336612 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:39:56.336633 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:39:56.336655 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:39:56.336671 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:39:56.336691 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:39:56.336710 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:39:56.336954 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:39:56.336971 Service_get NO service name Nov 27 20:39:56.336984 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:39:56.336998 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:39:56.337008 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:39:56.337020 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:39:56.337031 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:39:56.337044 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:39:56.337058 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:39:56.337093 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:39:56.337264 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:39:56.337281 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:39:56.338973 jdhcpd_sdb_create_session: session DB create got INET entry id 10640 Nov 27 20:39:56.338991 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:39:56.339007 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:39:56.339119 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10640) Nov 27 20:39:56.339137 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:39:56.339153 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:39:56.339168 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:39:56.339183 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:39:56.339200 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:39:56.339214 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:39:56.339266 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:39:56.339292 jdhcpd_auth_request: auth-request attempt initiated for session 10640: flags1:0x20000; flags2:0 Nov 27 20:39:56.339304 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:56.339314 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:39:56.339324 Added client w/ session_id 10640 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:56.339335 Using Service-Profile-Name Nov 27 20:39:56.340004 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71695- (session Id 10640) Nov 27 20:39:56.340017 Request to remove client w. session_id 10640 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:39:56.340029 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:39:56.340040 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6158 Nov 27 20:39:56.340067 jdhcpd_authenticate_rply_proc: auth login reply status for session 10640: result:9; flags1:0x20000; flags2:0 Nov 27 20:39:56.340127 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:39:56.340138 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:39:56.340176 [INFO] [default:drive][SVR][INET][irb.1034][SID=10640] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:39:56.340189 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:39:56.340201 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10640 Nov 27 20:39:56.340252 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10640 Nov 27 20:39:56.340266 Failure (status 2) when deleting baseline stats for 10640 (client index 71695) Nov 27 20:39:56.342092 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10640] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10640 Nov 27 20:40:13.169668 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:40:13.169710 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:40:13.169723 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:40:13.169740 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:40:13.169762 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:40:13.169784 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:40:13.169796 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:40:13.169807 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:40:13.169817 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:40:13.169841 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:40:13.169858 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:40:13.169872 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 0 ]-- Nov 27 20:40:13.169885 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:40:13.169898 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 1f8eb932 ]-- Nov 27 20:40:13.169911 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 7424, flags == 0000 ]-- Nov 27 20:40:13.169926 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:40:13.169940 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:40:13.169955 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:40:13.169969 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:40:13.169991 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:40:13.170005 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:40:13.170018 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:40:13.170033 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:40:13.170051 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:40:13.170068 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:40:13.170085 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:40:13.170105 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:40:13.170119 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:40:13.170142 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:40:13.170158 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:40:13.170176 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:40:13.170190 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:40:13.170206 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:40:13.170221 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:40:13.170237 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:40:13.170260 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71696 Nov 27 20:40:13.170273 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:40:13.170294 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:40:13.170315 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:40:13.170332 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:40:13.170351 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:40:13.170369 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:40:13.170720 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:40:13.170916 Service_get NO service name Nov 27 20:40:13.170930 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:40:13.170944 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:40:13.170955 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:40:13.170967 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:40:13.170978 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:40:13.170992 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:40:13.171156 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:40:13.171191 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:40:13.171208 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:40:13.171223 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:40:13.171569 jdhcpd_sdb_create_session: session DB create got INET entry id 10641 Nov 27 20:40:13.171587 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:40:13.171603 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:40:13.171621 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10641) Nov 27 20:40:13.171638 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:40:13.171654 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:40:13.171669 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:40:13.171684 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:40:13.171701 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:40:13.171716 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:40:13.171764 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:40:13.171788 jdhcpd_auth_request: auth-request attempt initiated for session 10641: flags1:0x20000; flags2:0 Nov 27 20:40:13.171801 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:40:13.171811 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:40:13.171821 Added client w/ session_id 10641 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:40:13.171832 Using Service-Profile-Name Nov 27 20:40:13.172451 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71696- (session Id 10641) Nov 27 20:40:13.172465 Request to remove client w. session_id 10641 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:40:13.172476 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:40:13.172487 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6159 Nov 27 20:40:13.172513 jdhcpd_authenticate_rply_proc: auth login reply status for session 10641: result:9; flags1:0x20000; flags2:0 Nov 27 20:40:13.172574 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:40:13.172585 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:40:13.172609 [INFO] [default:drive][SVR][INET][irb.1034][SID=10641] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:40:13.172622 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:40:13.172726 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10641 Nov 27 20:40:13.172778 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10641 Nov 27 20:40:13.172793 Failure (status 2) when deleting baseline stats for 10641 (client index 71696) Nov 27 20:40:13.173223 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10641] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10641 Nov 27 20:40:45.176518 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:40:45.176573 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:40:45.176587 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:40:45.176604 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:40:45.176626 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:40:45.176647 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:40:45.176659 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:40:45.176671 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:40:45.176680 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:40:45.176703 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:40:45.176717 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:40:45.176730 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 8000 ]-- Nov 27 20:40:45.176744 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:40:45.176757 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 4e5360f2 ]-- Nov 27 20:40:45.176797 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 0, flags == 8000 ]-- Nov 27 20:40:45.176814 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:40:45.176828 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:40:45.176845 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:40:45.176860 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:40:45.176882 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:40:45.176896 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:40:45.176909 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:40:45.176924 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:40:45.176942 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:40:45.176959 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:40:45.176976 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:40:45.177159 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:40:45.177173 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:40:45.177197 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:40:45.177213 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:40:45.177230 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:40:45.177244 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:40:45.177260 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:40:45.177275 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:40:45.177292 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:40:45.177314 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71697 Nov 27 20:40:45.177327 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:40:45.177349 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:40:45.177371 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:40:45.177387 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:40:45.177407 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:40:45.177425 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:40:45.177960 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:40:45.178136 Service_get NO service name Nov 27 20:40:45.178150 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:40:45.178164 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:40:45.178175 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:40:45.178187 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:40:45.178198 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:40:45.178212 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:40:45.178226 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:40:45.178260 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:40:45.178277 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:40:45.178292 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:40:45.178636 jdhcpd_sdb_create_session: session DB create got INET entry id 10642 Nov 27 20:40:45.178654 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:40:45.178670 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:40:45.178688 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10642) Nov 27 20:40:45.178787 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:40:45.178804 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:40:45.178819 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:40:45.178834 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:40:45.178853 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:40:45.178868 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:40:45.178918 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:40:45.178943 jdhcpd_auth_request: auth-request attempt initiated for session 10642: flags1:0x20000; flags2:0 Nov 27 20:40:45.178955 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:40:45.178965 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:40:45.178975 Added client w/ session_id 10642 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:40:45.178986 Using Service-Profile-Name Nov 27 20:40:45.179568 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71697- (session Id 10642) Nov 27 20:40:45.179581 Request to remove client w. session_id 10642 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:40:45.179592 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:40:45.179603 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6160 Nov 27 20:40:45.179628 jdhcpd_authenticate_rply_proc: auth login reply status for session 10642: result:9; flags1:0x20000; flags2:0 Nov 27 20:40:45.179689 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:40:45.179700 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:40:45.179724 [INFO] [default:drive][SVR][INET][irb.1034][SID=10642] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:40:45.179737 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:40:45.179750 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10642 Nov 27 20:40:45.179798 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10642 Nov 27 20:40:45.179812 Failure (status 2) when deleting baseline stats for 10642 (client index 71697) Nov 27 20:40:45.180298 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10642] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10642 Nov 27 20:40:49.146182 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:40:49.146377 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:40:49.146390 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:40:49.146407 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:40:49.146429 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:40:49.146451 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:40:49.146463 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:40:49.146475 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:40:49.146485 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:40:49.146508 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:40:49.146522 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:40:49.146535 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 8000 ]-- Nov 27 20:40:49.146549 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:40:49.146562 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 4e5360f2 ]-- Nov 27 20:40:49.146576 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 768, flags == 8000 ]-- Nov 27 20:40:49.146590 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:40:49.146604 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:40:49.146618 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:40:49.146632 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:40:49.146655 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:40:49.146668 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:40:49.146681 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:40:49.146696 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:40:49.146714 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:40:49.146731 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:40:49.146748 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:40:49.146768 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:40:49.146782 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:40:49.146805 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:40:49.146821 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:40:49.146838 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:40:49.146852 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:40:49.146868 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:40:49.146884 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:40:49.146900 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:40:49.146922 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71698 Nov 27 20:40:49.146935 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:40:49.146957 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:40:49.146979 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:40:49.146995 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:40:49.147015 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:40:49.147033 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:40:49.147232 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:40:49.147250 Service_get NO service name Nov 27 20:40:49.147261 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:40:49.147276 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:40:49.147286 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:40:49.147298 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:40:49.147309 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:40:49.147323 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:40:49.147337 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:40:49.147448 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:40:49.147465 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:40:49.147480 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:40:49.147854 jdhcpd_sdb_create_session: session DB create got INET entry id 10643 Nov 27 20:40:49.147872 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:40:49.147888 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:40:49.147906 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10643) Nov 27 20:40:49.147923 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:40:49.147940 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:40:49.147983 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:40:49.147999 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:40:49.148015 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:40:49.148030 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:40:49.148080 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:40:49.148105 jdhcpd_auth_request: auth-request attempt initiated for session 10643: flags1:0x20000; flags2:0 Nov 27 20:40:49.148118 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:40:49.148128 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:40:49.148137 Added client w/ session_id 10643 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:40:49.148148 Using Service-Profile-Name Nov 27 20:40:49.148715 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71698- (session Id 10643) Nov 27 20:40:49.148729 Request to remove client w. session_id 10643 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:40:49.148740 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:40:49.148751 jdhcpd_authenticate_rply_proc: auth login reply status for session 10643: result:9; flags1:0x20000; flags2:0 Nov 27 20:40:49.148810 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:40:49.148822 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:40:49.148845 [INFO] [default:drive][SVR][INET][irb.1034][SID=10643] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:40:49.148858 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:40:49.148871 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10643 Nov 27 20:40:49.148918 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10643 Nov 27 20:40:49.149020 Failure (status 2) when deleting baseline stats for 10643 (client index 71698) Nov 27 20:40:49.149462 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10643] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10643 Nov 27 20:40:56.976704 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:40:56.976757 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:40:56.976771 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:40:56.976787 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:40:56.976809 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:40:56.976830 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:40:56.976842 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:40:56.976854 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:40:56.976863 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:40:56.976886 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:40:56.976900 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:40:56.976913 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 8000 ]-- Nov 27 20:40:56.976926 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:40:56.976939 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 4e5360f2 ]-- Nov 27 20:40:56.976953 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 2816, flags == 8000 ]-- Nov 27 20:40:56.976967 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:40:56.976981 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:40:56.976998 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:40:56.977012 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:40:56.977035 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:40:56.977048 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:40:56.977061 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:40:56.977076 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:40:56.977094 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:40:56.977110 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:40:56.977127 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:40:56.977147 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:40:56.977161 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:40:56.977339 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:40:56.977355 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:40:56.977372 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:40:56.977385 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:40:56.977401 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:40:56.977416 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:40:56.977433 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:40:56.977454 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71699 Nov 27 20:40:56.977467 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:40:56.977488 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:40:56.977510 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:40:56.977526 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:40:56.977545 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:40:56.977563 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:40:56.977804 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:40:56.977820 Service_get NO service name Nov 27 20:40:56.977832 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:40:56.977846 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:40:56.977856 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:40:56.977868 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:40:56.977878 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:40:56.977892 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:40:56.977906 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:40:56.977940 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:40:56.977957 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:40:56.977971 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:40:56.978329 jdhcpd_sdb_create_session: session DB create got INET entry id 10644 Nov 27 20:40:56.978347 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:40:56.978362 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:40:56.978380 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10644) Nov 27 20:40:56.978397 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:40:56.978413 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:40:56.978511 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:40:56.978526 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:40:56.978542 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:40:56.978557 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:40:56.978606 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:40:56.978630 jdhcpd_auth_request: auth-request attempt initiated for session 10644: flags1:0x20000; flags2:0 Nov 27 20:40:56.978643 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:40:56.978652 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:40:56.978662 Added client w/ session_id 10644 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:40:56.978673 Using Service-Profile-Name Nov 27 20:40:56.979251 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71699- (session Id 10644) Nov 27 20:40:56.979264 Request to remove client w. session_id 10644 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:40:56.979275 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:40:56.979285 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6162 Nov 27 20:40:56.979311 jdhcpd_authenticate_rply_proc: auth login reply status for session 10644: result:9; flags1:0x20000; flags2:0 Nov 27 20:40:56.979371 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:40:56.979382 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:40:56.979406 [INFO] [default:drive][SVR][INET][irb.1034][SID=10644] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:40:56.979418 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:40:56.979431 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10644 Nov 27 20:40:56.979479 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10644 Nov 27 20:40:56.979494 Failure (status 2) when deleting baseline stats for 10644 (client index 71699) Nov 27 20:40:56.979912 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10644] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10644 Nov 27 20:41:13.979709 [DEBUG] jdhcpd_io_pfe_reader: Entered Nov 27 20:41:13.979852 [NOTE] jdhcpd_packet_info_new: successful malloc of new_pkt !! Nov 27 20:41:13.979867 [INFO] jdhcpd_io_pfe_reader: jdhcpd_pfe_pkt_hdr_t: pfe packet 328 bytes: L3ifindex = 352, L2ifindex = 473, dpi_rtbl=0 Nov 27 20:41:13.980061 [INFO] [irb.1034] jdhcpd_io_get_ifs: The L3 interface is 352 and L2 interface is 473, using the L3 interface Nov 27 20:41:13.980084 [INFO] [default:drive][SVR][INET][irb.1034] jdhcpd_io_pfe_packet: LOCAL : recv sa 0.0.0.0 da 255.255.255.255, src_port 68, dst_port 67 if name irb.1034 len 300 Nov 27 20:41:13.980105 security-packet-handle sus_l2:xe-2/2/3.0 Nov 27 20:41:13.980117 [INFO] jdhcpd_security_packet_handle: security-packet-handle sus_l3:irb.1034 Nov 27 20:41:13.980128 [INFO] jdhcpd_security_packet_handle: security-packet-handle input bd drive Nov 27 20:41:13.980138 security-packet-handle default/default-switch/drive dhcp-security not configured Nov 27 20:41:13.980162 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP from == 0.0.0.0, port == 68 ]-- Nov 27 20:41:13.980176 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP size == 300, op == 1 ]-- Nov 27 20:41:13.980189 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP flags == 8000 ]-- Nov 27 20:41:13.980203 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP htype == 1, hlen == 6 ]-- Nov 27 20:41:13.980216 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP hops == 0, xid == 4e5360f2 ]-- Nov 27 20:41:13.980229 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP secs == 7168, flags == 8000 ]-- Nov 27 20:41:13.980243 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP ciaddr == 0.0.0.0 ]-- Nov 27 20:41:13.980257 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP yiaddr == 0.0.0.0 ]-- Nov 27 20:41:13.980270 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP siaddr == 0.0.0.0 ]-- Nov 27 20:41:13.980284 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP giaddr == 0.0.0.0 ]-- Nov 27 20:41:13.980306 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP chaddr == 00 50 56 96 40 d7 00 00 00 00 00 00 00 00 00 00 ]-- Nov 27 20:41:13.980319 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP sname == ]-- Nov 27 20:41:13.980336 [INFO] [default:drive][SVR][INET][irb.1034] --[ DHCP/BOOTP file == ]-- Nov 27 20:41:13.980367 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 53, len 1, data DHCP-DISCOVER ]-- Nov 27 20:41:13.980385 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 61, len 7, data 01 00 50 56 96 40 d7 ]-- Nov 27 20:41:13.980402 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 12, len 6, data 49 54 56 4d 30 32 ]-- Nov 27 20:41:13.980419 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 60, len 8, data 4d 53 46 54 20 35 2e 30 ]-- Nov 27 20:41:13.980439 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 55, len 13, data 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc ]-- Nov 27 20:41:13.980452 [INFO] [default:drive][SVR][INET][irb.1034] --[ OPTION code 255, len 0 ]-- Nov 27 20:41:13.980538 [DEBUG] client_key_compose: Composing key (0x8e40e00) for cid_l 7, cid 01 00 50 56 96 40 d7, mac 01 00 50 56 96 40 d7, htype 1, subnet 10.1.34.1, ifindx 0, opt82_l 0, opt82 NULL Nov 27 20:41:13.980567 [DEBUG] client_key_compose: Successfully composed CK_TYPE_CLIENT_ID_ON_SUBNET (1) client key object. Nov 27 20:41:13.980584 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1): subnet 10.1.34.1, Clientid_len 7, 01 00 50 56 96 40 d7 Nov 27 20:41:13.980598 [DEBUG] client_key_print: key_type CK_TYPE_CLIENT_ID_ON_SUBNET (1) other fields: subnet 10.1.34.1, ifindex 0, opt82_len 0, -) Nov 27 20:41:13.980614 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_find_client_from_client_pdu: BOOTPREQUEST could not find client table ent Nov 27 20:41:13.980630 [NOTE] jdhcpd_packet_handle: RECEIVE DISCOVER: stats_safd 0x0 , safd 0x8e2c800 irb.1034 Nov 27 20:41:13.980646 [DEBUG][default:drive][SVR][INET][irb.1034] jdhcpd_process_forward_only_or_drop: Returning ... forward-only flags not set (flags=deaddead, rc_flags a4080d) for routing context 22 Nov 27 20:41:13.980668 [INFO] cedb_entry_new: New client (0x8da7400), family=INET, index=71700 Nov 27 20:41:13.980682 [DEBUG] cedb_entry_new: DHCPv4 client entry ADDED, app_type 1 routing context default:drive Nov 27 20:41:13.980704 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: new client table entry created for ifindex 352 Nov 27 20:41:13.980727 [DEBUG] jdhcpd_name_2_const: ifl irb.1034 fpc 4294967295 pic 4294967295 port 4294967295 Nov 27 20:41:13.980743 [DEBUG][default:drive][SVR][INET][SID=0] jdhcpd_packet_handle: Client on L2 ifindex 473, bd index 18, L3 ifindex 352 Nov 27 20:41:13.980763 [INFO] [default:drive][SVR][INET][SID=0] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_DISCOVER_PDU in state LOCAL_SERVER_STATE_INIT Nov 27 20:41:13.980782 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_profile_get: No snapshot handle to recover SDB profile name Nov 27 20:41:13.981136 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_decline_new_client_session: Incremented global in-flight logins - count is 1, session id 0 Nov 27 20:41:13.981325 Service_get NO service name Nov 27 20:41:13.981393 jdhcpd_sdb_create_session: phy device name irb Nov 27 20:41:13.981421 jdhcpd_sdb_create_session: INET, setting LR name default Nov 27 20:41:13.981431 jdhcpd_sdb_create_session: INET, setting RI name drive Nov 27 20:41:13.981443 jdhcpd_sdb_create_session: INET, setting underlying interface irb.1034 Nov 27 20:41:13.981454 jdhcpd_sdb_create_session: INET, setting logical if name irb.1034 Nov 27 20:41:13.981468 jdhcpd_sdb_create_session: INET, setting MAC addr 00:50:56:96:40:d7 Nov 27 20:41:13.981482 jdhcpd_session_db_create_v4_session_attributes: INET, setting IP addr Key 10.1.34.1 Nov 27 20:41:13.981517 jdhcpd_session_db_create_v4_session_attributes: INET, dhcp_options len 45, data 35 01 01 3d 07 01 00 50 56 96 40 d7 0c 06 49 54 56 4d 30 32 3c 08 4d 53 46 54 20 35 2e 30 37 0d 01 03 06 0f 1f 21 2b 2c 2e 2f 79 f9 fc Nov 27 20:41:13.981534 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting physical interface name irb Nov 27 20:41:13.981638 [DEBUG][default:drive][SVR][INET][irb.1034][SID=0] jdhcpd_sdb_create_session: setting authd phy ifd name irb Nov 27 20:41:13.981989 jdhcpd_sdb_create_session: session DB create got INET entry id 10645 Nov 27 20:41:13.982008 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: Mirroring disabled (ha_graceful_switchover false) 0.0.0.0 Nov 27 20:41:13.982023 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: L2 interface name xe-2/2/3.0, length 10 Nov 27 20:41:13.982042 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: Allocated memory to store in SDB, sizeof(jdhcpd_ha_client_header_t) 84 + total_tlvs_len 116 (sizeof(client->session_id) is 10645) Nov 27 20:41:13.982059 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: Saved NON-DEMUX interface name irb.1034 into mirroring ha_info Nov 27 20:41:13.982075 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: Aded TLV for L2 interface name xe-2/2/3.0, length 10 Nov 27 20:41:13.982090 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: Aded TLV for BD name drive, length 5 Nov 27 20:41:13.982105 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: Added TLV for DHCPv4 CLIENT ID from client key, length 7 Nov 27 20:41:13.982121 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE LR name default length 7 Nov 27 20:41:13.982136 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_fill_client_sdb_private_data: ++++Added TLV for WHOLESALE RI name drive length 5 Nov 27 20:41:13.982184 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] jdhcpd_mirrorsdb_add_client: Successfully saved private data for 0.0.0.0 in SDB, length 200 Nov 27 20:41:13.982209 jdhcpd_auth_request: auth-request attempt initiated for session 10645: flags1:0x20000; flags2:0 Nov 27 20:41:13.982222 Before adding to teardown list, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:41:13.982232 LIST IS EMPTY, jdhcpd_inst.authd_restart_teardown_count 0 Nov 27 20:41:13.982242 Added client w/ session_id 10645 in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ, to authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:41:13.982253 Using Service-Profile-Name Nov 27 20:41:13.982879 jdhcpd_authenticate_rply_proc: Got reply for auth_request, reply auth_rqst_id = 71700- (session Id 10645) Nov 27 20:41:13.982892 Request to remove client w. session_id 10645 in state 1 from authd_restart_teardown list, count authd_restart_teardown_count 1 Nov 27 20:41:13.982903 Removed LAST client from authd_restart teardown list, zero out COUNT authd_restart_teardown_count Nov 27 20:41:13.982914 DH_SVC_AUTHENTICATE_LICENSE: Authentication failed due to license error. Total license failures 6163 Nov 27 20:41:13.982940 jdhcpd_authenticate_rply_proc: auth login reply status for session 10645: result:9; flags1:0x20000; flags2:0 Nov 27 20:41:13.983001 got ls name jdhcpd_session_db_client_info_get default Nov 27 20:41:13.983012 got ri name jdhcpd_session_db_client_info_get drive Nov 27 20:41:13.983036 [INFO] [default:drive][SVR][INET][irb.1034][SID=10645] JDHCPD_CLIENT_EVENT: Client(0x8da7400) got event CLIENT_EVENT_AUTH_REQ_ACK in state LOCAL_SERVER_STATE_WAIT_AUTH_REQ Nov 27 20:41:13.983049 auth request reply failed err: 9 LOCAL_SERVER_STATE_WAIT_AUTH_REQ ip 0 Nov 27 20:41:13.983062 [INFO] jdhcpd_request_delete_baseline_stats: ATTEMPT TO DELETE libstats; session_id = 10645 Nov 27 20:41:13.983112 [ERROR] jdhcpd_request_delete_baseline_stats: libstats delete: failed; error 3, session_id = 10645 Nov 27 20:41:13.983127 Failure (status 2) when deleting baseline stats for 10645 (client index 71700) Nov 27 20:41:13.983722 [DEBUG][default:drive][SVR][INET][irb.1034][SID=10645] safd_num_clients_bound_dec: Decremented global in-flight logins - count is 0, session id 10645 root@dc1core>