[Fix for Issue #17413] Modified the Tx Rx port id list selection for …#17919
Merged
yejianquan merged 1 commit intosonic-net:masterfrom Apr 17, 2025
Merged
[Fix for Issue #17413] Modified the Tx Rx port id list selection for …#17919yejianquan merged 1 commit intosonic-net:masterfrom
yejianquan merged 1 commit intosonic-net:masterfrom
Conversation
…tion for all to all scenario
Collaborator
|
/azp run |
|
Azure Pipelines successfully started running 1 pipeline(s). |
Collaborator
|
/azp run |
|
Azure Pipelines successfully started running 1 pipeline(s). |
Collaborator
|
@sdszhang could you comment on why we need this PR to 202411 202405? |
Contributor
The existing test case doesn't match the test plan. It's suppose to be 2 senders/2 receivers. but current test case is using 2 senders/1 receivers. This PR fixed the logic error in test case so that we can have expected coverage. |
11 tasks
mssonicbld
pushed a commit
to mssonicbld/sonic-mgmt
that referenced
this pull request
Apr 17, 2025
…tion for all to all scenario (sonic-net#17919) Description of PR Summary: Fix for [snappi] test_multidut_pfcwd_all_to_all is not working as expected as in test plan sonic-net#17413 Fixes # (issue) sonic-net#17413 Approach What is the motivation for this PR? How did you do it? Added and if else condition to use separate tx rx port id list for all to all pattern scenario How did you verify/test it? Tested on Edgecore dut Any platform specific information? Supported testbed topology if it's a new test case? Documentation Output snappi_tests/pfcwd/test_pfcwd_a2a_with_snappi.py::test_multidut_pfcwd_all_to_all[multidut_port_info0-False] --------------------------------------------------------------------------------------------------------------------------------- live log setup ---------------------------------------------------------------------------------------------------------------------------------- 18:09:50 init.set_default L0053 INFO | Completeness level not set during test execution. Setting to default level: CompletenessLevel.basic 18:09:50 init.check_test_completeness L0151 INFO | Test has no defined levels. Continue without test completeness checks 18:09:50 conftest.enhance_inventory L0285 INFO | Inventory file: ['../ansible/snappi-sonic'] 18:09:52 ptfhost_utils.run_icmp_responder_session L0310 INFO | Skip running icmp_responder at session level, it is only for dualtor testbed with active-active mux ports. 18:09:52 init._sanity_check L0428 INFO | Skip sanity check according to command line argument 18:09:52 conftest.collect_before_test L2457 INFO | Dumping Disk and Memory Space information before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2461 INFO | Collecting core dumps before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2470 INFO | Collecting running config before test on sonic-s6100-dut1 18:09:55 conftest.temporarily_disable_route_check L2736 INFO | Skipping temporarily_disable_route_check fixture 18:09:55 conftest.generate_params_dut_hostname L1395 INFO | Using DUTs ['sonic-s6100-dut1'] in testbed 'vms-snappi-sonic' 18:09:55 conftest.set_rand_one_dut_hostname L0561 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture enable_packet_aging_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture enable_packet_aging_after_test setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossless_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossless_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossy_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossy_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture start_pfcwd_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture start_pfcwd_after_test setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_ip setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_ip setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_port setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_port setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture snappi_api setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture snappi_api setup ends -------------------- 18:09:56 conftest.rand_one_dut_front_end_hostname L0597 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:56 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossless_prio_list setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossless_prio_list setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports setup starts -------------------- 18:09:57 conftest.generate_port_lists L1464 INFO | Generate dut_port_map: {'sonic-s6100-dut1': ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76']} 18:09:57 conftest.generate_port_lists L1487 INFO | Generate port_list: ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76'] 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports_single_dut setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports_single_dut setup ends -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture prio_dscp_map setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture prio_dscp_map setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture all_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture all_prio_list setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossy_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossy_prio_list setup ends -------------------- 18:09:58 init.loganalyzer L0074 INFO | Log analyzer is disabled 18:09:58 init.memory_utilization L0108 INFO | Hostname: sonic-s6100-dut1, Hwsku: Accton-AS7726-32X, Platform: x86_64-accton_as7726_32x-r0 18:09:58 init.store_fixture_values L0020 INFO | store memory_utilization test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init._fixture_generator_decorator L0081 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup starts -------------------- 18:09:58 init._fixture_generator_decorator L0085 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup ends -------------------- 18:09:58 init.pytest_runtest_setup L0034 INFO | collect memory before test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init.pytest_runtest_setup L0054 INFO | Before test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {}}} ---------------------------------------------------------------------------------------------------------------------------------- live log call ---------------------------------------------------------------------------------------------------------------------------------- 18:09:58 test_pfcwd_a2a_with_snappi.test_multidut L0068 INFO | Running test for testbed subtype: single-dut-single-asic 18:09:58 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet72 with IP 20.1.1.0/31 18:10:00 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet64 with IP 20.1.1.2/31 18:10:01 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet68 with IP 20.1.1.4/31 18:10:02 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet76 with IP 20.1.1.6/31 18:13:52 connection._warn L0246 WARNING| Verification of certificates is disabled 18:13:52 connection._info L0243 INFO | Determining the platform and rest_port using the 10.36.77.53 address... 18:13:52 connection._warn L0246 WARNING| Unable to connect to http://10.36.77.53:11009. 18:13:52 connection._info L0243 INFO | Connection established to https://10.36.77.53:11009 on windows 18:13:52 connection._info L0243 INFO | Using IxNetwork api server version 10.20.2402.29 18:13:52 connection._info L0243 INFO | User info IxNetwork/WIN-11RK5TNKNAN/8010 18:13:52 snappi_api.info L1132 INFO | snappi-0.9.1 18:13:52 snappi_api.info L1132 INFO | snappi_ixnetwork-0.9.1 18:13:52 snappi_api.info L1132 INFO | ixnetwork_restpy-1.0.64 18:13:53 snappi_api.info L1132 INFO | Config validation 0.084s 18:13:53 snappi_api.info L1132 INFO | Ports configuration 0.059s 18:13:53 snappi_api.info L1132 INFO | Captures configuration 0.032s 18:14:03 snappi_api.info L1132 INFO | Location hosts ready [10.36.78.53] 2.057s 18:14:03 snappi_api.info L1132 INFO | Speed conversion is not require for (port.name, speed) : [('Port 0', 'novusHundredGigNonFanOut'), ('Port 1', 'novusHundredGigNonFanOut'), ('Port 2', 'novusHundredGigNonFanOut'), ('Port 3', 'novusHundredGigNonFanOut')] 18:14:03 snappi_api.info L1132 INFO | Aggregation mode speed change 0.286s 18:14:10 snappi_api.info L1132 INFO | Location preemption [10.36.78.53;6;7, 10.36.78.53;6;5, 10.36.78.53;6;6] 0.020s 18:14:56 snappi_api.info L1132 INFO | Location connect [Port 0, Port 1, Port 2] 46.208s 18:14:56 snappi_api.info L1132 INFO | Location state check [Port 0, Port 1, Port 2] 0.040s 18:14:56 snappi_api.info L1132 INFO | Location configuration 63.066s 18:15:06 snappi_api.info L1132 INFO | Layer1 configuration 10.092s 18:15:06 snappi_api.info L1132 INFO | Lag Configuration 0.008s 18:15:06 snappi_api.info L1132 INFO | Convert device config : 0.093s 18:15:06 snappi_api.info L1132 INFO | Create IxNetwork device config : 0.000s 18:15:06 snappi_api.info L1132 INFO | Push IxNetwork device config : 0.360s 18:15:06 snappi_api.info L1132 INFO | Devices configuration 0.462s 18:15:23 snappi_api.info L1132 INFO | Flows configuration 16.625s 18:15:29 snappi_api.info L1132 INFO | Start interfaces 6.336s 18:15:30 snappi_api.info L1132 INFO | IxNet - The Traffic Item was modified. Please perform a Traffic Generate to update the associated traffic Flow Groups 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0550 INFO | Wait for Arp to Resolve ... 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0553 INFO | Starting transmit on all flows ... 18:15:32 snappi_api.info L1132 INFO | Flows generate/apply 2.049s 18:15:45 snappi_api.info L1132 INFO | Flows clear statistics 12.532s 18:15:45 snappi_api.info L1132 INFO | Captures start 0.000s 18:15:49 snappi_api.info L1132 INFO | Flows start 4.009s 18:15:59 pfcwd_multi_node_helper_new.__run_traffi L0586 INFO | Stop transmit on all flows ... 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Pause Storm , Tx Frames : 596, Rx Frames : 0 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0642 INFO | PFC pause storm expected to be dropped 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet72 with ip :20.1.1.0/31 18:16:00 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet64 with ip :20.1.1.2/31 18:16:02 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet68 with ip :20.1.1.4/31 18:16:03 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet76 with ip :20.1.1.6/31 PASSED [100%] -------------------------------------------------------------------------------------------------------------------------------- live log teardown -------------------------------------------------------------------------------------------------------------------------------- 18:16:04 init.pytest_runtest_teardown L0066 INFO | collect memory after test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:16:04 init.pytest_runtest_teardown L0089 INFO | After test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 23.2}}}} 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture snappi_api teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture snappi_api teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture start_pfcwd_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture start_pfcwd_after_test teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossy_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossy_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossless_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossless_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture enable_packet_aging_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture enable_packet_aging_after_test teardown ends -------------------- 18:16:05 conftest.temporarily_disable_route_check L2738 INFO | Skipping temporarily_disable_route_check fixture 18:16:05 conftest.collect_after_test L2525 INFO | Dumping Disk and Memory Space information after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2529 INFO | Collecting core dumps after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2540 INFO | Collecting running config after test on sonic-s6100-dut1 18:16:07 conftest.core_dump_and_config_check L2681 WARNING| Core dump or config check failed for test_pfcwd_a2a_with_snappi.py, results: {"core_dump_check": {"failed": false, "new_core_dumps": {"sonic-s6100-dut1": []}}, "config_db_check": {"failed": true, "pre_only_config": {"sonic-s6100-dut1": {"null": {"VLAN_MEMBER": {"Vlan2|Ethernet64": {"tagging_mode": "untagged"}, "Vlan2|Ethernet68": {"tagging_mode": "untagged"}, "Vlan2|Ethernet72": {"tagging_mode": "untagged"}, "Vlan2|Ethernet76": {"tagging_mode": "untagged"}}}}}, "cur_only_config": {"sonic-s6100-dut1": {"null": {}}}, "inconsistent_config": {"sonic-s6100-dut1": {"null": {}}}}} 18:16:07 conftest.restore_config_db_and_config_re L2359 INFO | dut reload called on sonic-s6100-dut1 18:16:08 config_reload.config_reload L0147 INFO | reloading config_db co-authorized by: [email protected]
Collaborator
|
Cherry-pick PR to msft-202405: Azure/sonic-mgmt.msft#198 |
Collaborator
|
Cherry-pick PR to 202411: #18032 |
Merged
11 tasks
mssonicbld
added
Included in msft-202405 Branch
and removed
Created PR to msft-202405 Branch
labels
mssonicbld
pushed a commit
that referenced
this pull request
Apr 17, 2025
…all to all scenario (#17919) Description of PR Summary: Fix for [snappi] test_multidut_pfcwd_all_to_all is not working as expected as in test plan #17413 Fixes # (issue) #17413 Approach What is the motivation for this PR? How did you do it? Added and if else condition to use separate tx rx port id list for all to all pattern scenario How did you verify/test it? Tested on Edgecore dut Any platform specific information? Supported testbed topology if it's a new test case? Documentation Output snappi_tests/pfcwd/test_pfcwd_a2a_with_snappi.py::test_multidut_pfcwd_all_to_all[multidut_port_info0-False] --------------------------------------------------------------------------------------------------------------------------------- live log setup ---------------------------------------------------------------------------------------------------------------------------------- 18:09:50 init.set_default L0053 INFO | Completeness level not set during test execution. Setting to default level: CompletenessLevel.basic 18:09:50 init.check_test_completeness L0151 INFO | Test has no defined levels. Continue without test completeness checks 18:09:50 conftest.enhance_inventory L0285 INFO | Inventory file: ['../ansible/snappi-sonic'] 18:09:52 ptfhost_utils.run_icmp_responder_session L0310 INFO | Skip running icmp_responder at session level, it is only for dualtor testbed with active-active mux ports. 18:09:52 init._sanity_check L0428 INFO | Skip sanity check according to command line argument 18:09:52 conftest.collect_before_test L2457 INFO | Dumping Disk and Memory Space information before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2461 INFO | Collecting core dumps before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2470 INFO | Collecting running config before test on sonic-s6100-dut1 18:09:55 conftest.temporarily_disable_route_check L2736 INFO | Skipping temporarily_disable_route_check fixture 18:09:55 conftest.generate_params_dut_hostname L1395 INFO | Using DUTs ['sonic-s6100-dut1'] in testbed 'vms-snappi-sonic' 18:09:55 conftest.set_rand_one_dut_hostname L0561 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture enable_packet_aging_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture enable_packet_aging_after_test setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossless_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossless_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossy_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossy_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture start_pfcwd_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture start_pfcwd_after_test setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_ip setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_ip setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_port setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_port setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture snappi_api setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture snappi_api setup ends -------------------- 18:09:56 conftest.rand_one_dut_front_end_hostname L0597 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:56 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossless_prio_list setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossless_prio_list setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports setup starts -------------------- 18:09:57 conftest.generate_port_lists L1464 INFO | Generate dut_port_map: {'sonic-s6100-dut1': ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76']} 18:09:57 conftest.generate_port_lists L1487 INFO | Generate port_list: ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76'] 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports_single_dut setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports_single_dut setup ends -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture prio_dscp_map setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture prio_dscp_map setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture all_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture all_prio_list setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossy_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossy_prio_list setup ends -------------------- 18:09:58 init.loganalyzer L0074 INFO | Log analyzer is disabled 18:09:58 init.memory_utilization L0108 INFO | Hostname: sonic-s6100-dut1, Hwsku: Accton-AS7726-32X, Platform: x86_64-accton_as7726_32x-r0 18:09:58 init.store_fixture_values L0020 INFO | store memory_utilization test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init._fixture_generator_decorator L0081 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup starts -------------------- 18:09:58 init._fixture_generator_decorator L0085 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup ends -------------------- 18:09:58 init.pytest_runtest_setup L0034 INFO | collect memory before test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init.pytest_runtest_setup L0054 INFO | Before test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {}}} ---------------------------------------------------------------------------------------------------------------------------------- live log call ---------------------------------------------------------------------------------------------------------------------------------- 18:09:58 test_pfcwd_a2a_with_snappi.test_multidut L0068 INFO | Running test for testbed subtype: single-dut-single-asic 18:09:58 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet72 with IP 20.1.1.0/31 18:10:00 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet64 with IP 20.1.1.2/31 18:10:01 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet68 with IP 20.1.1.4/31 18:10:02 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet76 with IP 20.1.1.6/31 18:13:52 connection._warn L0246 WARNING| Verification of certificates is disabled 18:13:52 connection._info L0243 INFO | Determining the platform and rest_port using the 10.36.77.53 address... 18:13:52 connection._warn L0246 WARNING| Unable to connect to http://10.36.77.53:11009. 18:13:52 connection._info L0243 INFO | Connection established to https://10.36.77.53:11009 on windows 18:13:52 connection._info L0243 INFO | Using IxNetwork api server version 10.20.2402.29 18:13:52 connection._info L0243 INFO | User info IxNetwork/WIN-11RK5TNKNAN/8010 18:13:52 snappi_api.info L1132 INFO | snappi-0.9.1 18:13:52 snappi_api.info L1132 INFO | snappi_ixnetwork-0.9.1 18:13:52 snappi_api.info L1132 INFO | ixnetwork_restpy-1.0.64 18:13:53 snappi_api.info L1132 INFO | Config validation 0.084s 18:13:53 snappi_api.info L1132 INFO | Ports configuration 0.059s 18:13:53 snappi_api.info L1132 INFO | Captures configuration 0.032s 18:14:03 snappi_api.info L1132 INFO | Location hosts ready [10.36.78.53] 2.057s 18:14:03 snappi_api.info L1132 INFO | Speed conversion is not require for (port.name, speed) : [('Port 0', 'novusHundredGigNonFanOut'), ('Port 1', 'novusHundredGigNonFanOut'), ('Port 2', 'novusHundredGigNonFanOut'), ('Port 3', 'novusHundredGigNonFanOut')] 18:14:03 snappi_api.info L1132 INFO | Aggregation mode speed change 0.286s 18:14:10 snappi_api.info L1132 INFO | Location preemption [10.36.78.53;6;7, 10.36.78.53;6;5, 10.36.78.53;6;6] 0.020s 18:14:56 snappi_api.info L1132 INFO | Location connect [Port 0, Port 1, Port 2] 46.208s 18:14:56 snappi_api.info L1132 INFO | Location state check [Port 0, Port 1, Port 2] 0.040s 18:14:56 snappi_api.info L1132 INFO | Location configuration 63.066s 18:15:06 snappi_api.info L1132 INFO | Layer1 configuration 10.092s 18:15:06 snappi_api.info L1132 INFO | Lag Configuration 0.008s 18:15:06 snappi_api.info L1132 INFO | Convert device config : 0.093s 18:15:06 snappi_api.info L1132 INFO | Create IxNetwork device config : 0.000s 18:15:06 snappi_api.info L1132 INFO | Push IxNetwork device config : 0.360s 18:15:06 snappi_api.info L1132 INFO | Devices configuration 0.462s 18:15:23 snappi_api.info L1132 INFO | Flows configuration 16.625s 18:15:29 snappi_api.info L1132 INFO | Start interfaces 6.336s 18:15:30 snappi_api.info L1132 INFO | IxNet - The Traffic Item was modified. Please perform a Traffic Generate to update the associated traffic Flow Groups 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0550 INFO | Wait for Arp to Resolve ... 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0553 INFO | Starting transmit on all flows ... 18:15:32 snappi_api.info L1132 INFO | Flows generate/apply 2.049s 18:15:45 snappi_api.info L1132 INFO | Flows clear statistics 12.532s 18:15:45 snappi_api.info L1132 INFO | Captures start 0.000s 18:15:49 snappi_api.info L1132 INFO | Flows start 4.009s 18:15:59 pfcwd_multi_node_helper_new.__run_traffi L0586 INFO | Stop transmit on all flows ... 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Pause Storm , Tx Frames : 596, Rx Frames : 0 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0642 INFO | PFC pause storm expected to be dropped 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet72 with ip :20.1.1.0/31 18:16:00 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet64 with ip :20.1.1.2/31 18:16:02 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet68 with ip :20.1.1.4/31 18:16:03 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet76 with ip :20.1.1.6/31 PASSED [100%] -------------------------------------------------------------------------------------------------------------------------------- live log teardown -------------------------------------------------------------------------------------------------------------------------------- 18:16:04 init.pytest_runtest_teardown L0066 INFO | collect memory after test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:16:04 init.pytest_runtest_teardown L0089 INFO | After test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 23.2}}}} 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture snappi_api teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture snappi_api teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture start_pfcwd_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture start_pfcwd_after_test teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossy_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossy_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossless_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossless_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture enable_packet_aging_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture enable_packet_aging_after_test teardown ends -------------------- 18:16:05 conftest.temporarily_disable_route_check L2738 INFO | Skipping temporarily_disable_route_check fixture 18:16:05 conftest.collect_after_test L2525 INFO | Dumping Disk and Memory Space information after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2529 INFO | Collecting core dumps after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2540 INFO | Collecting running config after test on sonic-s6100-dut1 18:16:07 conftest.core_dump_and_config_check L2681 WARNING| Core dump or config check failed for test_pfcwd_a2a_with_snappi.py, results: {"core_dump_check": {"failed": false, "new_core_dumps": {"sonic-s6100-dut1": []}}, "config_db_check": {"failed": true, "pre_only_config": {"sonic-s6100-dut1": {"null": {"VLAN_MEMBER": {"Vlan2|Ethernet64": {"tagging_mode": "untagged"}, "Vlan2|Ethernet68": {"tagging_mode": "untagged"}, "Vlan2|Ethernet72": {"tagging_mode": "untagged"}, "Vlan2|Ethernet76": {"tagging_mode": "untagged"}}}}}, "cur_only_config": {"sonic-s6100-dut1": {"null": {}}}, "inconsistent_config": {"sonic-s6100-dut1": {"null": {}}}}} 18:16:07 conftest.restore_config_db_and_config_re L2359 INFO | dut reload called on sonic-s6100-dut1 18:16:08 config_reload.config_reload L0147 INFO | reloading config_db co-authorized by: [email protected]
mssonicbld
added
Included in 202411 branch
and removed
Created PR to 202411 branch
labels
auspham
pushed a commit
to auspham/sonic-mgmt
that referenced
this pull request
May 30, 2025
Code sync sonic-net/sonic-mgmt:202411 => 202503 ``` * 6b59eaa (HEAD -> sync/202503, origin/sync/202503) Merge remote-tracking branch 'pub_upstream/202411' into sync/202503 |\ | * c6a94a0 (pub_upstream/202411) Revert "[dualtor_io] Allow duplications for link down downstream I/O (sonic-net#17909)" (sonic-net#18192) | * de454d5 [testARPCompleted] Cleanup ptf ip after test failure (sonic-net#18170) | * 4a3d1d9 [dualtor] Refine `fdb_mac_learning_test.py` (sonic-net#18092) | * 5964a78 [dualtor_io] Fix the start marker not found issue (sonic-net#18096) | * ce40816 Extend LACP time multiplier for advanced-reboot tests with cEOS peers (sonic-net#17964) | * 0e70ba3 adjust port selection in case testQosSaiXonHysteresis for Cisco-8101 (sonic-net#18130) | * 8bb7203 [202411] Restore disable packet aging fixture 202411 (sonic-net#18103) | * 8f6d1a3 Filter out Not Applicable values in command line (sonic-net#18006) | * 9d5de5c Backport t0-118 test configs to 202411 (sonic-net#17983) | * e758401 mark xfail on generic hash test for isolated topo (sonic-net#18071) | * c65ceab [202411][dualtor] Skip pfcwd warm reboot on dualtor (sonic-net#18072) | * c509006 Improve disabling packet aging to support swap_syncd (sonic-net#17728) (sonic-net#17739) | * 9dc2244 [202411][dualtor-aa] Fix test_arp_dualtor on active-active dualtor (sonic-net#18073) | * cf12a33 fixed tacacs duplicate user issue (sonic-net#18068) | * 330a893 Fix telemetry/test_events.py for dualtor (sonic-net#18025) | * dc6fee8 Remove admin down ports in BUFFER PG check logic (sonic-net#17505) | * 805d538 Update generic hash test to support dualtor active active topology (sonic-net#16217) | * 7c31e46 [dualtor_io] Allow duplications for link down downstream I/O (sonic-net#17909) | * a7f50c6 Fix vlan vs router mac issue with test_qos_dscp_mapping.py (sonic-net#17846) (sonic-net#18003) | * 9ab1e7a Skip test_incremental_qos on Mellanox dualtor (sonic-net#17406) (sonic-net#18048) | * f42afd0 Force eos default creds to be string (sonic-net#18026) | * be542b0 Restore config after vxlan_crm from vxlan_ecmp. (sonic-net#17767) | * f0718b9 [Fix for Issue sonic-net#17413] Modified the Tx Rx port id list selection for all to all scenario (sonic-net#17919) | * 3eb4ed4 [dualtor_io] Collect syslog to debug (sonic-net#17722) | * d5bd995 Disable PFC-WD during PCBB and some wmk test improvements (sonic-net#17889) | * 2f512aa Update outer UDP sport range to exclude port 53 (sonic-net#17570) (sonic-net#17798) | * 980b373 skip test_bgp_slb advanced reboot for isolated topo (sonic-net#17470) | * 408bf9e Default the inner dscp to outer dscp map to be 1-1. (sonic-net#17860) | * 37495a1 Add dualtor fixtures to no_traffic test. (sonic-net#17916) | * a13b599 Only print the matched syslog in loganalzyer teardown check, no traceback info printed (sonic-net#17926) | * 6127f29 Revert "Skip test_vnet_decap on Cisco-8000 with 202411 (sonic-net#17776)" (sonic-net#17941) (sonic-net#17942) | * 60274db Increase timeout to 5 in verify_packet_any_port for background traffic (sonic-net#17904) ```
opcoder0
pushed a commit
to opcoder0/sonic-mgmt
that referenced
this pull request
Dec 8, 2025
…tion for all to all scenario (sonic-net#17919) Description of PR Summary: Fix for [snappi] test_multidut_pfcwd_all_to_all is not working as expected as in test plan sonic-net#17413 Fixes # (issue) sonic-net#17413 Approach What is the motivation for this PR? How did you do it? Added and if else condition to use separate tx rx port id list for all to all pattern scenario How did you verify/test it? Tested on Edgecore dut Any platform specific information? Supported testbed topology if it's a new test case? Documentation Output snappi_tests/pfcwd/test_pfcwd_a2a_with_snappi.py::test_multidut_pfcwd_all_to_all[multidut_port_info0-False] --------------------------------------------------------------------------------------------------------------------------------- live log setup ---------------------------------------------------------------------------------------------------------------------------------- 18:09:50 init.set_default L0053 INFO | Completeness level not set during test execution. Setting to default level: CompletenessLevel.basic 18:09:50 init.check_test_completeness L0151 INFO | Test has no defined levels. Continue without test completeness checks 18:09:50 conftest.enhance_inventory L0285 INFO | Inventory file: ['../ansible/snappi-sonic'] 18:09:52 ptfhost_utils.run_icmp_responder_session L0310 INFO | Skip running icmp_responder at session level, it is only for dualtor testbed with active-active mux ports. 18:09:52 init._sanity_check L0428 INFO | Skip sanity check according to command line argument 18:09:52 conftest.collect_before_test L2457 INFO | Dumping Disk and Memory Space information before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2461 INFO | Collecting core dumps before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2470 INFO | Collecting running config before test on sonic-s6100-dut1 18:09:55 conftest.temporarily_disable_route_check L2736 INFO | Skipping temporarily_disable_route_check fixture 18:09:55 conftest.generate_params_dut_hostname L1395 INFO | Using DUTs ['sonic-s6100-dut1'] in testbed 'vms-snappi-sonic' 18:09:55 conftest.set_rand_one_dut_hostname L0561 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture enable_packet_aging_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture enable_packet_aging_after_test setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossless_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossless_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossy_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossy_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture start_pfcwd_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture start_pfcwd_after_test setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_ip setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_ip setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_port setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_port setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture snappi_api setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture snappi_api setup ends -------------------- 18:09:56 conftest.rand_one_dut_front_end_hostname L0597 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:56 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossless_prio_list setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossless_prio_list setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports setup starts -------------------- 18:09:57 conftest.generate_port_lists L1464 INFO | Generate dut_port_map: {'sonic-s6100-dut1': ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76']} 18:09:57 conftest.generate_port_lists L1487 INFO | Generate port_list: ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76'] 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports_single_dut setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports_single_dut setup ends -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture prio_dscp_map setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture prio_dscp_map setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture all_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture all_prio_list setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossy_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossy_prio_list setup ends -------------------- 18:09:58 init.loganalyzer L0074 INFO | Log analyzer is disabled 18:09:58 init.memory_utilization L0108 INFO | Hostname: sonic-s6100-dut1, Hwsku: Accton-AS7726-32X, Platform: x86_64-accton_as7726_32x-r0 18:09:58 init.store_fixture_values L0020 INFO | store memory_utilization test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init._fixture_generator_decorator L0081 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup starts -------------------- 18:09:58 init._fixture_generator_decorator L0085 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup ends -------------------- 18:09:58 init.pytest_runtest_setup L0034 INFO | collect memory before test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init.pytest_runtest_setup L0054 INFO | Before test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {}}} ---------------------------------------------------------------------------------------------------------------------------------- live log call ---------------------------------------------------------------------------------------------------------------------------------- 18:09:58 test_pfcwd_a2a_with_snappi.test_multidut L0068 INFO | Running test for testbed subtype: single-dut-single-asic 18:09:58 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet72 with IP 20.1.1.0/31 18:10:00 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet64 with IP 20.1.1.2/31 18:10:01 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet68 with IP 20.1.1.4/31 18:10:02 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet76 with IP 20.1.1.6/31 18:13:52 connection._warn L0246 WARNING| Verification of certificates is disabled 18:13:52 connection._info L0243 INFO | Determining the platform and rest_port using the 10.36.77.53 address... 18:13:52 connection._warn L0246 WARNING| Unable to connect to http://10.36.77.53:11009. 18:13:52 connection._info L0243 INFO | Connection established to https://10.36.77.53:11009 on windows 18:13:52 connection._info L0243 INFO | Using IxNetwork api server version 10.20.2402.29 18:13:52 connection._info L0243 INFO | User info IxNetwork/WIN-11RK5TNKNAN/8010 18:13:52 snappi_api.info L1132 INFO | snappi-0.9.1 18:13:52 snappi_api.info L1132 INFO | snappi_ixnetwork-0.9.1 18:13:52 snappi_api.info L1132 INFO | ixnetwork_restpy-1.0.64 18:13:53 snappi_api.info L1132 INFO | Config validation 0.084s 18:13:53 snappi_api.info L1132 INFO | Ports configuration 0.059s 18:13:53 snappi_api.info L1132 INFO | Captures configuration 0.032s 18:14:03 snappi_api.info L1132 INFO | Location hosts ready [10.36.78.53] 2.057s 18:14:03 snappi_api.info L1132 INFO | Speed conversion is not require for (port.name, speed) : [('Port 0', 'novusHundredGigNonFanOut'), ('Port 1', 'novusHundredGigNonFanOut'), ('Port 2', 'novusHundredGigNonFanOut'), ('Port 3', 'novusHundredGigNonFanOut')] 18:14:03 snappi_api.info L1132 INFO | Aggregation mode speed change 0.286s 18:14:10 snappi_api.info L1132 INFO | Location preemption [10.36.78.53;6;7, 10.36.78.53;6;5, 10.36.78.53;6;6] 0.020s 18:14:56 snappi_api.info L1132 INFO | Location connect [Port 0, Port 1, Port 2] 46.208s 18:14:56 snappi_api.info L1132 INFO | Location state check [Port 0, Port 1, Port 2] 0.040s 18:14:56 snappi_api.info L1132 INFO | Location configuration 63.066s 18:15:06 snappi_api.info L1132 INFO | Layer1 configuration 10.092s 18:15:06 snappi_api.info L1132 INFO | Lag Configuration 0.008s 18:15:06 snappi_api.info L1132 INFO | Convert device config : 0.093s 18:15:06 snappi_api.info L1132 INFO | Create IxNetwork device config : 0.000s 18:15:06 snappi_api.info L1132 INFO | Push IxNetwork device config : 0.360s 18:15:06 snappi_api.info L1132 INFO | Devices configuration 0.462s 18:15:23 snappi_api.info L1132 INFO | Flows configuration 16.625s 18:15:29 snappi_api.info L1132 INFO | Start interfaces 6.336s 18:15:30 snappi_api.info L1132 INFO | IxNet - The Traffic Item was modified. Please perform a Traffic Generate to update the associated traffic Flow Groups 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0550 INFO | Wait for Arp to Resolve ... 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0553 INFO | Starting transmit on all flows ... 18:15:32 snappi_api.info L1132 INFO | Flows generate/apply 2.049s 18:15:45 snappi_api.info L1132 INFO | Flows clear statistics 12.532s 18:15:45 snappi_api.info L1132 INFO | Captures start 0.000s 18:15:49 snappi_api.info L1132 INFO | Flows start 4.009s 18:15:59 pfcwd_multi_node_helper_new.__run_traffi L0586 INFO | Stop transmit on all flows ... 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Pause Storm , Tx Frames : 596, Rx Frames : 0 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0642 INFO | PFC pause storm expected to be dropped 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet72 with ip :20.1.1.0/31 18:16:00 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet64 with ip :20.1.1.2/31 18:16:02 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet68 with ip :20.1.1.4/31 18:16:03 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet76 with ip :20.1.1.6/31 PASSED [100%] -------------------------------------------------------------------------------------------------------------------------------- live log teardown -------------------------------------------------------------------------------------------------------------------------------- 18:16:04 init.pytest_runtest_teardown L0066 INFO | collect memory after test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:16:04 init.pytest_runtest_teardown L0089 INFO | After test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 23.2}}}} 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture snappi_api teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture snappi_api teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture start_pfcwd_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture start_pfcwd_after_test teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossy_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossy_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossless_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossless_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture enable_packet_aging_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture enable_packet_aging_after_test teardown ends -------------------- 18:16:05 conftest.temporarily_disable_route_check L2738 INFO | Skipping temporarily_disable_route_check fixture 18:16:05 conftest.collect_after_test L2525 INFO | Dumping Disk and Memory Space information after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2529 INFO | Collecting core dumps after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2540 INFO | Collecting running config after test on sonic-s6100-dut1 18:16:07 conftest.core_dump_and_config_check L2681 WARNING| Core dump or config check failed for test_pfcwd_a2a_with_snappi.py, results: {"core_dump_check": {"failed": false, "new_core_dumps": {"sonic-s6100-dut1": []}}, "config_db_check": {"failed": true, "pre_only_config": {"sonic-s6100-dut1": {"null": {"VLAN_MEMBER": {"Vlan2|Ethernet64": {"tagging_mode": "untagged"}, "Vlan2|Ethernet68": {"tagging_mode": "untagged"}, "Vlan2|Ethernet72": {"tagging_mode": "untagged"}, "Vlan2|Ethernet76": {"tagging_mode": "untagged"}}}}}, "cur_only_config": {"sonic-s6100-dut1": {"null": {}}}, "inconsistent_config": {"sonic-s6100-dut1": {"null": {}}}}} 18:16:07 conftest.restore_config_db_and_config_re L2359 INFO | dut reload called on sonic-s6100-dut1 18:16:08 config_reload.config_reload L0147 INFO | reloading config_db co-authorized by: [email protected] Signed-off-by: opcoder0 <[email protected]>
AharonMalkin
pushed a commit
to AharonMalkin/sonic-mgmt
that referenced
this pull request
Dec 16, 2025
…tion for all to all scenario (sonic-net#17919) Description of PR Summary: Fix for [snappi] test_multidut_pfcwd_all_to_all is not working as expected as in test plan sonic-net#17413 Fixes # (issue) sonic-net#17413 Approach What is the motivation for this PR? How did you do it? Added and if else condition to use separate tx rx port id list for all to all pattern scenario How did you verify/test it? Tested on Edgecore dut Any platform specific information? Supported testbed topology if it's a new test case? Documentation Output snappi_tests/pfcwd/test_pfcwd_a2a_with_snappi.py::test_multidut_pfcwd_all_to_all[multidut_port_info0-False] --------------------------------------------------------------------------------------------------------------------------------- live log setup ---------------------------------------------------------------------------------------------------------------------------------- 18:09:50 init.set_default L0053 INFO | Completeness level not set during test execution. Setting to default level: CompletenessLevel.basic 18:09:50 init.check_test_completeness L0151 INFO | Test has no defined levels. Continue without test completeness checks 18:09:50 conftest.enhance_inventory L0285 INFO | Inventory file: ['../ansible/snappi-sonic'] 18:09:52 ptfhost_utils.run_icmp_responder_session L0310 INFO | Skip running icmp_responder at session level, it is only for dualtor testbed with active-active mux ports. 18:09:52 init._sanity_check L0428 INFO | Skip sanity check according to command line argument 18:09:52 conftest.collect_before_test L2457 INFO | Dumping Disk and Memory Space information before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2461 INFO | Collecting core dumps before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2470 INFO | Collecting running config before test on sonic-s6100-dut1 18:09:55 conftest.temporarily_disable_route_check L2736 INFO | Skipping temporarily_disable_route_check fixture 18:09:55 conftest.generate_params_dut_hostname L1395 INFO | Using DUTs ['sonic-s6100-dut1'] in testbed 'vms-snappi-sonic' 18:09:55 conftest.set_rand_one_dut_hostname L0561 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture enable_packet_aging_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture enable_packet_aging_after_test setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossless_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossless_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossy_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossy_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture start_pfcwd_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture start_pfcwd_after_test setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_ip setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_ip setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_port setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_port setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture snappi_api setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture snappi_api setup ends -------------------- 18:09:56 conftest.rand_one_dut_front_end_hostname L0597 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:56 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossless_prio_list setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossless_prio_list setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports setup starts -------------------- 18:09:57 conftest.generate_port_lists L1464 INFO | Generate dut_port_map: {'sonic-s6100-dut1': ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76']} 18:09:57 conftest.generate_port_lists L1487 INFO | Generate port_list: ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76'] 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports_single_dut setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports_single_dut setup ends -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture prio_dscp_map setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture prio_dscp_map setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture all_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture all_prio_list setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossy_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossy_prio_list setup ends -------------------- 18:09:58 init.loganalyzer L0074 INFO | Log analyzer is disabled 18:09:58 init.memory_utilization L0108 INFO | Hostname: sonic-s6100-dut1, Hwsku: Accton-AS7726-32X, Platform: x86_64-accton_as7726_32x-r0 18:09:58 init.store_fixture_values L0020 INFO | store memory_utilization test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init._fixture_generator_decorator L0081 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup starts -------------------- 18:09:58 init._fixture_generator_decorator L0085 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup ends -------------------- 18:09:58 init.pytest_runtest_setup L0034 INFO | collect memory before test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init.pytest_runtest_setup L0054 INFO | Before test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {}}} ---------------------------------------------------------------------------------------------------------------------------------- live log call ---------------------------------------------------------------------------------------------------------------------------------- 18:09:58 test_pfcwd_a2a_with_snappi.test_multidut L0068 INFO | Running test for testbed subtype: single-dut-single-asic 18:09:58 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet72 with IP 20.1.1.0/31 18:10:00 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet64 with IP 20.1.1.2/31 18:10:01 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet68 with IP 20.1.1.4/31 18:10:02 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet76 with IP 20.1.1.6/31 18:13:52 connection._warn L0246 WARNING| Verification of certificates is disabled 18:13:52 connection._info L0243 INFO | Determining the platform and rest_port using the 10.36.77.53 address... 18:13:52 connection._warn L0246 WARNING| Unable to connect to http://10.36.77.53:11009. 18:13:52 connection._info L0243 INFO | Connection established to https://10.36.77.53:11009 on windows 18:13:52 connection._info L0243 INFO | Using IxNetwork api server version 10.20.2402.29 18:13:52 connection._info L0243 INFO | User info IxNetwork/WIN-11RK5TNKNAN/8010 18:13:52 snappi_api.info L1132 INFO | snappi-0.9.1 18:13:52 snappi_api.info L1132 INFO | snappi_ixnetwork-0.9.1 18:13:52 snappi_api.info L1132 INFO | ixnetwork_restpy-1.0.64 18:13:53 snappi_api.info L1132 INFO | Config validation 0.084s 18:13:53 snappi_api.info L1132 INFO | Ports configuration 0.059s 18:13:53 snappi_api.info L1132 INFO | Captures configuration 0.032s 18:14:03 snappi_api.info L1132 INFO | Location hosts ready [10.36.78.53] 2.057s 18:14:03 snappi_api.info L1132 INFO | Speed conversion is not require for (port.name, speed) : [('Port 0', 'novusHundredGigNonFanOut'), ('Port 1', 'novusHundredGigNonFanOut'), ('Port 2', 'novusHundredGigNonFanOut'), ('Port 3', 'novusHundredGigNonFanOut')] 18:14:03 snappi_api.info L1132 INFO | Aggregation mode speed change 0.286s 18:14:10 snappi_api.info L1132 INFO | Location preemption [10.36.78.53;6;7, 10.36.78.53;6;5, 10.36.78.53;6;6] 0.020s 18:14:56 snappi_api.info L1132 INFO | Location connect [Port 0, Port 1, Port 2] 46.208s 18:14:56 snappi_api.info L1132 INFO | Location state check [Port 0, Port 1, Port 2] 0.040s 18:14:56 snappi_api.info L1132 INFO | Location configuration 63.066s 18:15:06 snappi_api.info L1132 INFO | Layer1 configuration 10.092s 18:15:06 snappi_api.info L1132 INFO | Lag Configuration 0.008s 18:15:06 snappi_api.info L1132 INFO | Convert device config : 0.093s 18:15:06 snappi_api.info L1132 INFO | Create IxNetwork device config : 0.000s 18:15:06 snappi_api.info L1132 INFO | Push IxNetwork device config : 0.360s 18:15:06 snappi_api.info L1132 INFO | Devices configuration 0.462s 18:15:23 snappi_api.info L1132 INFO | Flows configuration 16.625s 18:15:29 snappi_api.info L1132 INFO | Start interfaces 6.336s 18:15:30 snappi_api.info L1132 INFO | IxNet - The Traffic Item was modified. Please perform a Traffic Generate to update the associated traffic Flow Groups 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0550 INFO | Wait for Arp to Resolve ... 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0553 INFO | Starting transmit on all flows ... 18:15:32 snappi_api.info L1132 INFO | Flows generate/apply 2.049s 18:15:45 snappi_api.info L1132 INFO | Flows clear statistics 12.532s 18:15:45 snappi_api.info L1132 INFO | Captures start 0.000s 18:15:49 snappi_api.info L1132 INFO | Flows start 4.009s 18:15:59 pfcwd_multi_node_helper_new.__run_traffi L0586 INFO | Stop transmit on all flows ... 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Pause Storm , Tx Frames : 596, Rx Frames : 0 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0642 INFO | PFC pause storm expected to be dropped 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet72 with ip :20.1.1.0/31 18:16:00 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet64 with ip :20.1.1.2/31 18:16:02 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet68 with ip :20.1.1.4/31 18:16:03 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet76 with ip :20.1.1.6/31 PASSED [100%] -------------------------------------------------------------------------------------------------------------------------------- live log teardown -------------------------------------------------------------------------------------------------------------------------------- 18:16:04 init.pytest_runtest_teardown L0066 INFO | collect memory after test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:16:04 init.pytest_runtest_teardown L0089 INFO | After test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 23.2}}}} 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture snappi_api teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture snappi_api teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture start_pfcwd_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture start_pfcwd_after_test teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossy_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossy_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossless_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossless_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture enable_packet_aging_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture enable_packet_aging_after_test teardown ends -------------------- 18:16:05 conftest.temporarily_disable_route_check L2738 INFO | Skipping temporarily_disable_route_check fixture 18:16:05 conftest.collect_after_test L2525 INFO | Dumping Disk and Memory Space information after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2529 INFO | Collecting core dumps after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2540 INFO | Collecting running config after test on sonic-s6100-dut1 18:16:07 conftest.core_dump_and_config_check L2681 WARNING| Core dump or config check failed for test_pfcwd_a2a_with_snappi.py, results: {"core_dump_check": {"failed": false, "new_core_dumps": {"sonic-s6100-dut1": []}}, "config_db_check": {"failed": true, "pre_only_config": {"sonic-s6100-dut1": {"null": {"VLAN_MEMBER": {"Vlan2|Ethernet64": {"tagging_mode": "untagged"}, "Vlan2|Ethernet68": {"tagging_mode": "untagged"}, "Vlan2|Ethernet72": {"tagging_mode": "untagged"}, "Vlan2|Ethernet76": {"tagging_mode": "untagged"}}}}}, "cur_only_config": {"sonic-s6100-dut1": {"null": {}}}, "inconsistent_config": {"sonic-s6100-dut1": {"null": {}}}}} 18:16:07 conftest.restore_config_db_and_config_re L2359 INFO | dut reload called on sonic-s6100-dut1 18:16:08 config_reload.config_reload L0147 INFO | reloading config_db co-authorized by: [email protected] Signed-off-by: Aharon Malkin <[email protected]>
gshemesh2
pushed a commit
to gshemesh2/sonic-mgmt
that referenced
this pull request
Dec 21, 2025
…tion for all to all scenario (sonic-net#17919) Description of PR Summary: Fix for [snappi] test_multidut_pfcwd_all_to_all is not working as expected as in test plan sonic-net#17413 Fixes # (issue) sonic-net#17413 Approach What is the motivation for this PR? How did you do it? Added and if else condition to use separate tx rx port id list for all to all pattern scenario How did you verify/test it? Tested on Edgecore dut Any platform specific information? Supported testbed topology if it's a new test case? Documentation Output snappi_tests/pfcwd/test_pfcwd_a2a_with_snappi.py::test_multidut_pfcwd_all_to_all[multidut_port_info0-False] --------------------------------------------------------------------------------------------------------------------------------- live log setup ---------------------------------------------------------------------------------------------------------------------------------- 18:09:50 init.set_default L0053 INFO | Completeness level not set during test execution. Setting to default level: CompletenessLevel.basic 18:09:50 init.check_test_completeness L0151 INFO | Test has no defined levels. Continue without test completeness checks 18:09:50 conftest.enhance_inventory L0285 INFO | Inventory file: ['../ansible/snappi-sonic'] 18:09:52 ptfhost_utils.run_icmp_responder_session L0310 INFO | Skip running icmp_responder at session level, it is only for dualtor testbed with active-active mux ports. 18:09:52 init._sanity_check L0428 INFO | Skip sanity check according to command line argument 18:09:52 conftest.collect_before_test L2457 INFO | Dumping Disk and Memory Space information before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2461 INFO | Collecting core dumps before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2470 INFO | Collecting running config before test on sonic-s6100-dut1 18:09:55 conftest.temporarily_disable_route_check L2736 INFO | Skipping temporarily_disable_route_check fixture 18:09:55 conftest.generate_params_dut_hostname L1395 INFO | Using DUTs ['sonic-s6100-dut1'] in testbed 'vms-snappi-sonic' 18:09:55 conftest.set_rand_one_dut_hostname L0561 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture enable_packet_aging_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture enable_packet_aging_after_test setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossless_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossless_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossy_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossy_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture start_pfcwd_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture start_pfcwd_after_test setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_ip setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_ip setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_port setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_port setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture snappi_api setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture snappi_api setup ends -------------------- 18:09:56 conftest.rand_one_dut_front_end_hostname L0597 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:56 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossless_prio_list setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossless_prio_list setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports setup starts -------------------- 18:09:57 conftest.generate_port_lists L1464 INFO | Generate dut_port_map: {'sonic-s6100-dut1': ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76']} 18:09:57 conftest.generate_port_lists L1487 INFO | Generate port_list: ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76'] 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports_single_dut setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports_single_dut setup ends -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture prio_dscp_map setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture prio_dscp_map setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture all_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture all_prio_list setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossy_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossy_prio_list setup ends -------------------- 18:09:58 init.loganalyzer L0074 INFO | Log analyzer is disabled 18:09:58 init.memory_utilization L0108 INFO | Hostname: sonic-s6100-dut1, Hwsku: Accton-AS7726-32X, Platform: x86_64-accton_as7726_32x-r0 18:09:58 init.store_fixture_values L0020 INFO | store memory_utilization test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init._fixture_generator_decorator L0081 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup starts -------------------- 18:09:58 init._fixture_generator_decorator L0085 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup ends -------------------- 18:09:58 init.pytest_runtest_setup L0034 INFO | collect memory before test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init.pytest_runtest_setup L0054 INFO | Before test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {}}} ---------------------------------------------------------------------------------------------------------------------------------- live log call ---------------------------------------------------------------------------------------------------------------------------------- 18:09:58 test_pfcwd_a2a_with_snappi.test_multidut L0068 INFO | Running test for testbed subtype: single-dut-single-asic 18:09:58 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet72 with IP 20.1.1.0/31 18:10:00 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet64 with IP 20.1.1.2/31 18:10:01 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet68 with IP 20.1.1.4/31 18:10:02 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet76 with IP 20.1.1.6/31 18:13:52 connection._warn L0246 WARNING| Verification of certificates is disabled 18:13:52 connection._info L0243 INFO | Determining the platform and rest_port using the 10.36.77.53 address... 18:13:52 connection._warn L0246 WARNING| Unable to connect to http://10.36.77.53:11009. 18:13:52 connection._info L0243 INFO | Connection established to https://10.36.77.53:11009 on windows 18:13:52 connection._info L0243 INFO | Using IxNetwork api server version 10.20.2402.29 18:13:52 connection._info L0243 INFO | User info IxNetwork/WIN-11RK5TNKNAN/8010 18:13:52 snappi_api.info L1132 INFO | snappi-0.9.1 18:13:52 snappi_api.info L1132 INFO | snappi_ixnetwork-0.9.1 18:13:52 snappi_api.info L1132 INFO | ixnetwork_restpy-1.0.64 18:13:53 snappi_api.info L1132 INFO | Config validation 0.084s 18:13:53 snappi_api.info L1132 INFO | Ports configuration 0.059s 18:13:53 snappi_api.info L1132 INFO | Captures configuration 0.032s 18:14:03 snappi_api.info L1132 INFO | Location hosts ready [10.36.78.53] 2.057s 18:14:03 snappi_api.info L1132 INFO | Speed conversion is not require for (port.name, speed) : [('Port 0', 'novusHundredGigNonFanOut'), ('Port 1', 'novusHundredGigNonFanOut'), ('Port 2', 'novusHundredGigNonFanOut'), ('Port 3', 'novusHundredGigNonFanOut')] 18:14:03 snappi_api.info L1132 INFO | Aggregation mode speed change 0.286s 18:14:10 snappi_api.info L1132 INFO | Location preemption [10.36.78.53;6;7, 10.36.78.53;6;5, 10.36.78.53;6;6] 0.020s 18:14:56 snappi_api.info L1132 INFO | Location connect [Port 0, Port 1, Port 2] 46.208s 18:14:56 snappi_api.info L1132 INFO | Location state check [Port 0, Port 1, Port 2] 0.040s 18:14:56 snappi_api.info L1132 INFO | Location configuration 63.066s 18:15:06 snappi_api.info L1132 INFO | Layer1 configuration 10.092s 18:15:06 snappi_api.info L1132 INFO | Lag Configuration 0.008s 18:15:06 snappi_api.info L1132 INFO | Convert device config : 0.093s 18:15:06 snappi_api.info L1132 INFO | Create IxNetwork device config : 0.000s 18:15:06 snappi_api.info L1132 INFO | Push IxNetwork device config : 0.360s 18:15:06 snappi_api.info L1132 INFO | Devices configuration 0.462s 18:15:23 snappi_api.info L1132 INFO | Flows configuration 16.625s 18:15:29 snappi_api.info L1132 INFO | Start interfaces 6.336s 18:15:30 snappi_api.info L1132 INFO | IxNet - The Traffic Item was modified. Please perform a Traffic Generate to update the associated traffic Flow Groups 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0550 INFO | Wait for Arp to Resolve ... 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0553 INFO | Starting transmit on all flows ... 18:15:32 snappi_api.info L1132 INFO | Flows generate/apply 2.049s 18:15:45 snappi_api.info L1132 INFO | Flows clear statistics 12.532s 18:15:45 snappi_api.info L1132 INFO | Captures start 0.000s 18:15:49 snappi_api.info L1132 INFO | Flows start 4.009s 18:15:59 pfcwd_multi_node_helper_new.__run_traffi L0586 INFO | Stop transmit on all flows ... 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Pause Storm , Tx Frames : 596, Rx Frames : 0 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0642 INFO | PFC pause storm expected to be dropped 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet72 with ip :20.1.1.0/31 18:16:00 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet64 with ip :20.1.1.2/31 18:16:02 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet68 with ip :20.1.1.4/31 18:16:03 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet76 with ip :20.1.1.6/31 PASSED [100%] -------------------------------------------------------------------------------------------------------------------------------- live log teardown -------------------------------------------------------------------------------------------------------------------------------- 18:16:04 init.pytest_runtest_teardown L0066 INFO | collect memory after test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:16:04 init.pytest_runtest_teardown L0089 INFO | After test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 23.2}}}} 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture snappi_api teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture snappi_api teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture start_pfcwd_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture start_pfcwd_after_test teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossy_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossy_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossless_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossless_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture enable_packet_aging_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture enable_packet_aging_after_test teardown ends -------------------- 18:16:05 conftest.temporarily_disable_route_check L2738 INFO | Skipping temporarily_disable_route_check fixture 18:16:05 conftest.collect_after_test L2525 INFO | Dumping Disk and Memory Space information after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2529 INFO | Collecting core dumps after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2540 INFO | Collecting running config after test on sonic-s6100-dut1 18:16:07 conftest.core_dump_and_config_check L2681 WARNING| Core dump or config check failed for test_pfcwd_a2a_with_snappi.py, results: {"core_dump_check": {"failed": false, "new_core_dumps": {"sonic-s6100-dut1": []}}, "config_db_check": {"failed": true, "pre_only_config": {"sonic-s6100-dut1": {"null": {"VLAN_MEMBER": {"Vlan2|Ethernet64": {"tagging_mode": "untagged"}, "Vlan2|Ethernet68": {"tagging_mode": "untagged"}, "Vlan2|Ethernet72": {"tagging_mode": "untagged"}, "Vlan2|Ethernet76": {"tagging_mode": "untagged"}}}}}, "cur_only_config": {"sonic-s6100-dut1": {"null": {}}}, "inconsistent_config": {"sonic-s6100-dut1": {"null": {}}}}} 18:16:07 conftest.restore_config_db_and_config_re L2359 INFO | dut reload called on sonic-s6100-dut1 18:16:08 config_reload.config_reload L0147 INFO | reloading config_db co-authorized by: [email protected] Signed-off-by: Guy Shemesh <[email protected]>
gshemesh2
pushed a commit
to gshemesh2/sonic-mgmt
that referenced
this pull request
Jan 26, 2026
…tion for all to all scenario (sonic-net#17919) Description of PR Summary: Fix for [snappi] test_multidut_pfcwd_all_to_all is not working as expected as in test plan sonic-net#17413 Fixes # (issue) sonic-net#17413 Approach What is the motivation for this PR? How did you do it? Added and if else condition to use separate tx rx port id list for all to all pattern scenario How did you verify/test it? Tested on Edgecore dut Any platform specific information? Supported testbed topology if it's a new test case? Documentation Output snappi_tests/pfcwd/test_pfcwd_a2a_with_snappi.py::test_multidut_pfcwd_all_to_all[multidut_port_info0-False] --------------------------------------------------------------------------------------------------------------------------------- live log setup ---------------------------------------------------------------------------------------------------------------------------------- 18:09:50 init.set_default L0053 INFO | Completeness level not set during test execution. Setting to default level: CompletenessLevel.basic 18:09:50 init.check_test_completeness L0151 INFO | Test has no defined levels. Continue without test completeness checks 18:09:50 conftest.enhance_inventory L0285 INFO | Inventory file: ['../ansible/snappi-sonic'] 18:09:52 ptfhost_utils.run_icmp_responder_session L0310 INFO | Skip running icmp_responder at session level, it is only for dualtor testbed with active-active mux ports. 18:09:52 init._sanity_check L0428 INFO | Skip sanity check according to command line argument 18:09:52 conftest.collect_before_test L2457 INFO | Dumping Disk and Memory Space information before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2461 INFO | Collecting core dumps before test on sonic-s6100-dut1 18:09:53 conftest.collect_before_test L2470 INFO | Collecting running config before test on sonic-s6100-dut1 18:09:55 conftest.temporarily_disable_route_check L2736 INFO | Skipping temporarily_disable_route_check fixture 18:09:55 conftest.generate_params_dut_hostname L1395 INFO | Using DUTs ['sonic-s6100-dut1'] in testbed 'vms-snappi-sonic' 18:09:55 conftest.set_rand_one_dut_hostname L0561 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture enable_packet_aging_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture enable_packet_aging_after_test setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossless_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossless_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossy_prio setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossy_prio setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture start_pfcwd_after_test setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture start_pfcwd_after_test setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_ip setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_ip setup ends -------------------- 18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_port setup starts -------------------- 18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_port setup ends -------------------- 18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture snappi_api setup starts -------------------- 18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture snappi_api setup ends -------------------- 18:09:56 conftest.rand_one_dut_front_end_hostname L0597 INFO | Randomly select dut sonic-s6100-dut1 for testing 18:09:56 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossless_prio_list setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossless_prio_list setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports setup starts -------------------- 18:09:57 conftest.generate_port_lists L1464 INFO | Generate dut_port_map: {'sonic-s6100-dut1': ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76']} 18:09:57 conftest.generate_port_lists L1487 INFO | Generate port_list: ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76'] 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports_single_dut setup starts -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports_single_dut setup ends -------------------- 18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports setup ends -------------------- 18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture prio_dscp_map setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture prio_dscp_map setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture all_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture all_prio_list setup ends -------------------- 18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossy_prio_list setup starts -------------------- 18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossy_prio_list setup ends -------------------- 18:09:58 init.loganalyzer L0074 INFO | Log analyzer is disabled 18:09:58 init.memory_utilization L0108 INFO | Hostname: sonic-s6100-dut1, Hwsku: Accton-AS7726-32X, Platform: x86_64-accton_as7726_32x-r0 18:09:58 init.store_fixture_values L0020 INFO | store memory_utilization test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init._fixture_generator_decorator L0081 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup starts -------------------- 18:09:58 init._fixture_generator_decorator L0085 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup ends -------------------- 18:09:58 init.pytest_runtest_setup L0034 INFO | collect memory before test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:09:58 init.pytest_runtest_setup L0054 INFO | Before test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {}}} ---------------------------------------------------------------------------------------------------------------------------------- live log call ---------------------------------------------------------------------------------------------------------------------------------- 18:09:58 test_pfcwd_a2a_with_snappi.test_multidut L0068 INFO | Running test for testbed subtype: single-dut-single-asic 18:09:58 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet72 with IP 20.1.1.0/31 18:10:00 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet64 with IP 20.1.1.2/31 18:10:01 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet68 with IP 20.1.1.4/31 18:10:02 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet76 with IP 20.1.1.6/31 18:13:52 connection._warn L0246 WARNING| Verification of certificates is disabled 18:13:52 connection._info L0243 INFO | Determining the platform and rest_port using the 10.36.77.53 address... 18:13:52 connection._warn L0246 WARNING| Unable to connect to http://10.36.77.53:11009. 18:13:52 connection._info L0243 INFO | Connection established to https://10.36.77.53:11009 on windows 18:13:52 connection._info L0243 INFO | Using IxNetwork api server version 10.20.2402.29 18:13:52 connection._info L0243 INFO | User info IxNetwork/WIN-11RK5TNKNAN/8010 18:13:52 snappi_api.info L1132 INFO | snappi-0.9.1 18:13:52 snappi_api.info L1132 INFO | snappi_ixnetwork-0.9.1 18:13:52 snappi_api.info L1132 INFO | ixnetwork_restpy-1.0.64 18:13:53 snappi_api.info L1132 INFO | Config validation 0.084s 18:13:53 snappi_api.info L1132 INFO | Ports configuration 0.059s 18:13:53 snappi_api.info L1132 INFO | Captures configuration 0.032s 18:14:03 snappi_api.info L1132 INFO | Location hosts ready [10.36.78.53] 2.057s 18:14:03 snappi_api.info L1132 INFO | Speed conversion is not require for (port.name, speed) : [('Port 0', 'novusHundredGigNonFanOut'), ('Port 1', 'novusHundredGigNonFanOut'), ('Port 2', 'novusHundredGigNonFanOut'), ('Port 3', 'novusHundredGigNonFanOut')] 18:14:03 snappi_api.info L1132 INFO | Aggregation mode speed change 0.286s 18:14:10 snappi_api.info L1132 INFO | Location preemption [10.36.78.53;6;7, 10.36.78.53;6;5, 10.36.78.53;6;6] 0.020s 18:14:56 snappi_api.info L1132 INFO | Location connect [Port 0, Port 1, Port 2] 46.208s 18:14:56 snappi_api.info L1132 INFO | Location state check [Port 0, Port 1, Port 2] 0.040s 18:14:56 snappi_api.info L1132 INFO | Location configuration 63.066s 18:15:06 snappi_api.info L1132 INFO | Layer1 configuration 10.092s 18:15:06 snappi_api.info L1132 INFO | Lag Configuration 0.008s 18:15:06 snappi_api.info L1132 INFO | Convert device config : 0.093s 18:15:06 snappi_api.info L1132 INFO | Create IxNetwork device config : 0.000s 18:15:06 snappi_api.info L1132 INFO | Push IxNetwork device config : 0.360s 18:15:06 snappi_api.info L1132 INFO | Devices configuration 0.462s 18:15:23 snappi_api.info L1132 INFO | Flows configuration 16.625s 18:15:29 snappi_api.info L1132 INFO | Start interfaces 6.336s 18:15:30 snappi_api.info L1132 INFO | IxNet - The Traffic Item was modified. Please perform a Traffic Generate to update the associated traffic Flow Groups 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0550 INFO | Wait for Arp to Resolve ... 18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0553 INFO | Starting transmit on all flows ... 18:15:32 snappi_api.info L1132 INFO | Flows generate/apply 2.049s 18:15:45 snappi_api.info L1132 INFO | Flows clear statistics 12.532s 18:15:45 snappi_api.info L1132 INFO | Captures start 0.000s 18:15:49 snappi_api.info L1132 INFO | Flows start 4.009s 18:15:59 pfcwd_multi_node_helper_new.__run_traffi L0586 INFO | Stop transmit on all flows ... 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Pause Storm , Tx Frames : 596, Rx Frames : 0 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0642 INFO | PFC pause storm expected to be dropped 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390 18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets 18:15:59 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet72 with ip :20.1.1.0/31 18:16:00 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet64 with ip :20.1.1.2/31 18:16:02 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet68 with ip :20.1.1.4/31 18:16:03 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet76 with ip :20.1.1.6/31 PASSED [100%] -------------------------------------------------------------------------------------------------------------------------------- live log teardown -------------------------------------------------------------------------------------------------------------------------------- 18:16:04 init.pytest_runtest_teardown L0066 INFO | collect memory after test test_multidut_pfcwd_all_to_all[multidut_port_info0-False] 18:16:04 init.pytest_runtest_teardown L0089 INFO | After test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 23.2}}}} 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture snappi_api teardown starts -------------------- 18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture snappi_api teardown ends -------------------- 18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture start_pfcwd_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture start_pfcwd_after_test teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossy_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossy_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossless_prio teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossless_prio teardown ends -------------------- 18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture enable_packet_aging_after_test teardown starts -------------------- 18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture enable_packet_aging_after_test teardown ends -------------------- 18:16:05 conftest.temporarily_disable_route_check L2738 INFO | Skipping temporarily_disable_route_check fixture 18:16:05 conftest.collect_after_test L2525 INFO | Dumping Disk and Memory Space information after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2529 INFO | Collecting core dumps after test on sonic-s6100-dut1 18:16:06 conftest.collect_after_test L2540 INFO | Collecting running config after test on sonic-s6100-dut1 18:16:07 conftest.core_dump_and_config_check L2681 WARNING| Core dump or config check failed for test_pfcwd_a2a_with_snappi.py, results: {"core_dump_check": {"failed": false, "new_core_dumps": {"sonic-s6100-dut1": []}}, "config_db_check": {"failed": true, "pre_only_config": {"sonic-s6100-dut1": {"null": {"VLAN_MEMBER": {"Vlan2|Ethernet64": {"tagging_mode": "untagged"}, "Vlan2|Ethernet68": {"tagging_mode": "untagged"}, "Vlan2|Ethernet72": {"tagging_mode": "untagged"}, "Vlan2|Ethernet76": {"tagging_mode": "untagged"}}}}}, "cur_only_config": {"sonic-s6100-dut1": {"null": {}}}, "inconsistent_config": {"sonic-s6100-dut1": {"null": {}}}}} 18:16:07 conftest.restore_config_db_and_config_re L2359 INFO | dut reload called on sonic-s6100-dut1 18:16:08 config_reload.config_reload L0147 INFO | reloading config_db co-authorized by: [email protected] Signed-off-by: Guy Shemesh <[email protected]>
This file contains hidden or bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment
4 participants
Add this suggestion to a batch that can be applied as a single commit.This suggestion is invalid because no changes were made to the code.Suggestions cannot be applied while the pull request is closed.Suggestions cannot be applied while viewing a subset of changes.Only one suggestion per line can be applied in a batch.Add this suggestion to a batch that can be applied as a single commit.Applying suggestions on deleted lines is not supported.You must change the existing code in this line in order to create a valid suggestion.Outdated suggestions cannot be applied.This suggestion has been applied or marked resolved.Suggestions cannot be applied from pending reviews.Suggestions cannot be applied on multi-line comments.Suggestions cannot be applied while the pull request is queued to merge.Suggestion cannot be applied right now. Please check back later.
…all to all scenario
Description of PR
Summary: Fix for [snappi] test_multidut_pfcwd_all_to_all is not working as expected as in test plan #17413
Fixes # (issue)
#17413
Type of change
Back port request
Approach
What is the motivation for this PR?
How did you do it?
Added and if else condition to use separate tx rx port id list for all to all pattern scenario
How did you verify/test it?
Tested on Edgecore dut
Any platform specific information?
Supported testbed topology if it's a new test case?
Documentation
Output
snappi_tests/pfcwd/test_pfcwd_a2a_with_snappi.py::test_multidut_pfcwd_all_to_all[multidut_port_info0-False]
--------------------------------------------------------------------------------------------------------------------------------- live log setup ----------------------------------------------------------------------------------------------------------------------------------
18:09:50 init.set_default L0053 INFO | Completeness level not set during test execution. Setting to default level: CompletenessLevel.basic
18:09:50 init.check_test_completeness L0151 INFO | Test has no defined levels. Continue without test completeness checks
18:09:50 conftest.enhance_inventory L0285 INFO | Inventory file: ['../ansible/snappi-sonic']
18:09:52 ptfhost_utils.run_icmp_responder_session L0310 INFO | Skip running icmp_responder at session level, it is only for dualtor testbed with active-active mux ports.
18:09:52 init._sanity_check L0428 INFO | Skip sanity check according to command line argument
18:09:52 conftest.collect_before_test L2457 INFO | Dumping Disk and Memory Space information before test on sonic-s6100-dut1
18:09:53 conftest.collect_before_test L2461 INFO | Collecting core dumps before test on sonic-s6100-dut1
18:09:53 conftest.collect_before_test L2470 INFO | Collecting running config before test on sonic-s6100-dut1
18:09:55 conftest.temporarily_disable_route_check L2736 INFO | Skipping temporarily_disable_route_check fixture
18:09:55 conftest.generate_params_dut_hostname L1395 INFO | Using DUTs ['sonic-s6100-dut1'] in testbed 'vms-snappi-sonic'
18:09:55 conftest.set_rand_one_dut_hostname L0561 INFO | Randomly select dut sonic-s6100-dut1 for testing
18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture enable_packet_aging_after_test setup starts --------------------
18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture enable_packet_aging_after_test setup ends --------------------
18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossless_prio setup starts --------------------
18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossless_prio setup ends --------------------
18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture rand_lossy_prio setup starts --------------------
18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture rand_lossy_prio setup ends --------------------
18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture start_pfcwd_after_test setup starts --------------------
18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture start_pfcwd_after_test setup ends --------------------
18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_ip setup starts --------------------
18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_ip setup ends --------------------
18:09:55 init._fixture_func_decorator L0069 INFO | -------------------- fixture snappi_api_serv_port setup starts --------------------
18:09:55 init._fixture_func_decorator L0076 INFO | -------------------- fixture snappi_api_serv_port setup ends --------------------
18:09:55 init._fixture_generator_decorator L0081 INFO | -------------------- fixture snappi_api setup starts --------------------
18:09:55 init._fixture_generator_decorator L0085 INFO | -------------------- fixture snappi_api setup ends --------------------
18:09:56 conftest.rand_one_dut_front_end_hostname L0597 INFO | Randomly select dut sonic-s6100-dut1 for testing
18:09:56 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossless_prio_list setup starts --------------------
18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossless_prio_list setup ends --------------------
18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports setup starts --------------------
18:09:57 conftest.generate_port_lists L1464 INFO | Generate dut_port_map: {'sonic-s6100-dut1': ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76']}
18:09:57 conftest.generate_port_lists L1487 INFO | Generate port_list: ['sonic-s6100-dut1|Ethernet64', 'sonic-s6100-dut1|Ethernet68', 'sonic-s6100-dut1|Ethernet72', 'sonic-s6100-dut1|Ethernet76']
18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture get_snappi_ports_single_dut setup starts --------------------
18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports_single_dut setup ends --------------------
18:09:57 init._fixture_func_decorator L0076 INFO | -------------------- fixture get_snappi_ports setup ends --------------------
18:09:57 init._fixture_func_decorator L0069 INFO | -------------------- fixture prio_dscp_map setup starts --------------------
18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture prio_dscp_map setup ends --------------------
18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture all_prio_list setup starts --------------------
18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture all_prio_list setup ends --------------------
18:09:58 init._fixture_func_decorator L0069 INFO | -------------------- fixture lossy_prio_list setup starts --------------------
18:09:58 init._fixture_func_decorator L0076 INFO | -------------------- fixture lossy_prio_list setup ends --------------------
18:09:58 init.loganalyzer L0074 INFO | Log analyzer is disabled
18:09:58 init.memory_utilization L0108 INFO | Hostname: sonic-s6100-dut1, Hwsku: Accton-AS7726-32X, Platform: x86_64-accton_as7726_32x-r0
18:09:58 init.store_fixture_values L0020 INFO | store memory_utilization test_multidut_pfcwd_all_to_all[multidut_port_info0-False]
18:09:58 init._fixture_generator_decorator L0081 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup starts --------------------
18:09:58 init._fixture_generator_decorator L0085 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 setup ends --------------------
18:09:58 init.pytest_runtest_setup L0034 INFO | collect memory before test test_multidut_pfcwd_all_to_all[multidut_port_info0-False]
18:09:58 init.pytest_runtest_setup L0054 INFO | Before test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {}}}
---------------------------------------------------------------------------------------------------------------------------------- live log call ----------------------------------------------------------------------------------------------------------------------------------
18:09:58 test_pfcwd_a2a_with_snappi.test_multidut L0068 INFO | Running test for testbed subtype: single-dut-single-asic
18:09:58 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet72 with IP 20.1.1.0/31
18:10:00 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet64 with IP 20.1.1.2/31
18:10:01 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet68 with IP 20.1.1.4/31
18:10:02 snappi_fixtures.__intf_config_multidut L0853 INFO | Configuring Dut: sonic-s6100-dut1 with port Ethernet76 with IP 20.1.1.6/31
18:13:52 connection._warn L0246 WARNING| Verification of certificates is disabled
18:13:52 connection._info L0243 INFO | Determining the platform and rest_port using the 10.36.77.53 address...
18:13:52 connection._warn L0246 WARNING| Unable to connect to http://10.36.77.53:11009.
18:13:52 connection._info L0243 INFO | Connection established to
https://10.36.77.53:11009 on windows18:13:52 connection._info L0243 INFO | Using IxNetwork api server version 10.20.2402.29
18:13:52 connection._info L0243 INFO | User info IxNetwork/WIN-11RK5TNKNAN/8010
18:13:52 snappi_api.info L1132 INFO | snappi-0.9.1
18:13:52 snappi_api.info L1132 INFO | snappi_ixnetwork-0.9.1
18:13:52 snappi_api.info L1132 INFO | ixnetwork_restpy-1.0.64
18:13:53 snappi_api.info L1132 INFO | Config validation 0.084s
18:13:53 snappi_api.info L1132 INFO | Ports configuration 0.059s
18:13:53 snappi_api.info L1132 INFO | Captures configuration 0.032s
18:14:03 snappi_api.info L1132 INFO | Location hosts ready [10.36.78.53] 2.057s
18:14:03 snappi_api.info L1132 INFO | Speed conversion is not require for (port.name, speed) : [('Port 0', 'novusHundredGigNonFanOut'), ('Port 1', 'novusHundredGigNonFanOut'), ('Port 2', 'novusHundredGigNonFanOut'), ('Port 3', 'novusHundredGigNonFanOut')]
18:14:03 snappi_api.info L1132 INFO | Aggregation mode speed change 0.286s
18:14:10 snappi_api.info L1132 INFO | Location preemption [10.36.78.53;6;7, 10.36.78.53;6;5, 10.36.78.53;6;6] 0.020s
18:14:56 snappi_api.info L1132 INFO | Location connect [Port 0, Port 1, Port 2] 46.208s
18:14:56 snappi_api.info L1132 INFO | Location state check [Port 0, Port 1, Port 2] 0.040s
18:14:56 snappi_api.info L1132 INFO | Location configuration 63.066s
18:15:06 snappi_api.info L1132 INFO | Layer1 configuration 10.092s
18:15:06 snappi_api.info L1132 INFO | Lag Configuration 0.008s
18:15:06 snappi_api.info L1132 INFO | Convert device config : 0.093s
18:15:06 snappi_api.info L1132 INFO | Create IxNetwork device config : 0.000s
18:15:06 snappi_api.info L1132 INFO | Push IxNetwork device config : 0.360s
18:15:06 snappi_api.info L1132 INFO | Devices configuration 0.462s
18:15:23 snappi_api.info L1132 INFO | Flows configuration 16.625s
18:15:29 snappi_api.info L1132 INFO | Start interfaces 6.336s
18:15:30 snappi_api.info L1132 INFO | IxNet - The Traffic Item was modified. Please perform a Traffic Generate to update the associated traffic Flow Groups
18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0550 INFO | Wait for Arp to Resolve ...
18:15:30 pfcwd_multi_node_helper_new.__run_traffi L0553 INFO | Starting transmit on all flows ...
18:15:32 snappi_api.info L1132 INFO | Flows generate/apply 2.049s
18:15:45 snappi_api.info L1132 INFO | Flows clear statistics 12.532s
18:15:45 snappi_api.info L1132 INFO | Captures start 0.000s
18:15:49 snappi_api.info L1132 INFO | Flows start 4.009s
18:15:59 pfcwd_multi_node_helper_new.__run_traffi L0586 INFO | Stop transmit on all flows ...
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 0 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 1 -> 2 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 0 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Warm Up Traffic 2 -> 1 Prio 3 , Tx Frames : 1795977, Rx Frames : 1795977
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Pause Storm , Tx Frames : 596, Rx Frames : 0
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0642 INFO | PFC pause storm expected to be dropped
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 0 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 1 -> 2 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 0 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0680 INFO | This test flow is delayed by PFC storm
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0681 INFO | Tx and Rx should not have any dropped packet
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Test Flow 2 -> 1 Prio 3 , Tx Frames : 3591954, Rx Frames : 3591954
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 0 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 1 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 5 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 6 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 2 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 1 -> 2 Prio 0 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 1 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 5 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 6 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 2 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 0 Prio 0 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 1 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 5 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 6 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 2 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0638 INFO | Flow Name : Background Flow 2 -> 1 Prio 0 , Tx Frames : 718390, Rx Frames : 718390
18:15:59 pfcwd_multi_node_helper_new.__verify_res L0648 INFO | Background flows expected not to have any dropped packets
18:15:59 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet72 with ip :20.1.1.0/31
18:16:00 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet64 with ip :20.1.1.2/31
18:16:02 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet68 with ip :20.1.1.4/31
18:16:03 snappi_fixtures.cleanup_config L0943 INFO | Removing Configuration on Dut: sonic-s6100-dut1 with port Ethernet76 with ip :20.1.1.6/31
PASSED [100%]
-------------------------------------------------------------------------------------------------------------------------------- live log teardown --------------------------------------------------------------------------------------------------------------------------------
18:16:04 init.pytest_runtest_teardown L0066 INFO | collect memory after test test_multidut_pfcwd_all_to_all[multidut_port_info0-False]
18:16:04 init.pytest_runtest_teardown L0089 INFO | After test: collected memory_values {'before_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 22.7}}}, 'after_test': {'sonic-s6100-dut1': {'monit': {'memory_usage': 23.2}}}}
18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown starts --------------------
18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture ignore_route_check_for_cisco_8000 teardown ends --------------------
18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture snappi_api teardown starts --------------------
18:16:04 init._fixture_generator_decorator L0102 INFO | -------------------- fixture snappi_api teardown ends --------------------
18:16:04 init._fixture_generator_decorator L0093 INFO | -------------------- fixture start_pfcwd_after_test teardown starts --------------------
18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture start_pfcwd_after_test teardown ends --------------------
18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossy_prio teardown starts --------------------
18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossy_prio teardown ends --------------------
18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture rand_lossless_prio teardown starts --------------------
18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture rand_lossless_prio teardown ends --------------------
18:16:05 init._fixture_generator_decorator L0093 INFO | -------------------- fixture enable_packet_aging_after_test teardown starts --------------------
18:16:05 init._fixture_generator_decorator L0102 INFO | -------------------- fixture enable_packet_aging_after_test teardown ends --------------------
18:16:05 conftest.temporarily_disable_route_check L2738 INFO | Skipping temporarily_disable_route_check fixture
18:16:05 conftest.collect_after_test L2525 INFO | Dumping Disk and Memory Space information after test on sonic-s6100-dut1
18:16:06 conftest.collect_after_test L2529 INFO | Collecting core dumps after test on sonic-s6100-dut1
18:16:06 conftest.collect_after_test L2540 INFO | Collecting running config after test on sonic-s6100-dut1
18:16:07 conftest.core_dump_and_config_check L2681 WARNING| Core dump or config check failed for test_pfcwd_a2a_with_snappi.py, results: {"core_dump_check": {"failed": false, "new_core_dumps": {"sonic-s6100-dut1": []}}, "config_db_check": {"failed": true, "pre_only_config": {"sonic-s6100-dut1": {"null": {"VLAN_MEMBER": {"Vlan2|Ethernet64": {"tagging_mode": "untagged"}, "Vlan2|Ethernet68": {"tagging_mode": "untagged"}, "Vlan2|Ethernet72": {"tagging_mode": "untagged"}, "Vlan2|Ethernet76": {"tagging_mode": "untagged"}}}}}, "cur_only_config": {"sonic-s6100-dut1": {"null": {}}}, "inconsistent_config": {"sonic-s6100-dut1": {"null": {}}}}}
18:16:07 conftest.restore_config_db_and_config_re L2359 INFO | dut reload called on sonic-s6100-dut1
18:16:08 config_reload.config_reload L0147 INFO | reloading config_db