Chetan Gaonker | a58c258 | 2017-08-02 00:02:04 +0000 | [diff] [blame] | 1 | ubuntu@cord-rs-s8:~/cord-tester/src/test/setup$ sudo ./cord-test.py run -m manifest-ponsim.json -t voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_5_groups_joins_verifying_traffic |
| 2 | # Host [172.17.0.2]:8101 found: line 3 type RSA |
| 3 | onoscli: eof exception found |
| 4 | onoscli: logout |
| 5 | |
| 6 | Connection to 172.17.0.2 closed. |
| 7 | |
| 8 | result.ok, result.status_code are False and 409 |
| 9 | ONOS app cord-config, version 2.0-SNAPSHOT installed |
| 10 | result.ok, result.status_code are False and 409 |
| 11 | ONOS app aaa, version 2.0-SNAPSHOT installed |
| 12 | result.ok, result.status_code are False and 409 |
| 13 | ONOS app igmp, version 2.0-SNAPSHOT installed |
| 14 | Controller IP [u'172.17.0.2'], Test type voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_5_groups_joins_verifying_traffic |
| 15 | Installing cord tester ONOS app /home/ubuntu/cord-tester/src/test/apps/ciena-cordigmp-multitable-3.0-SNAPSHOT.oar |
| 16 | result.ok, result.status_code are False and 409 |
| 17 | WARNING: The DOCKER_HOST_IP variable is not set. Defaulting to a blank string. |
| 18 | compose_fluentd_1 is up-to-date |
| 19 | compose_consul_1 is up-to-date |
| 20 | compose_zookeeper_1 is up-to-date |
| 21 | compose_registrator_1 is up-to-date |
| 22 | compose_kafka_1 is up-to-date |
| 23 | IP 172.18.0.2 for service consul |
| 24 | IP 172.18.0.5 for service kafka |
| 25 | IP 172.18.0.4 for service zookeeper |
| 26 | IP 172.18.0.6 for service registrator |
| 27 | IP 172.18.0.3 for service fluentd |
| 28 | Chameleon voltha sevice is already running. Skipped start |
| 29 | VOLTHA core is already running. Skipped start |
| 30 | VOLTHA ofagent is already running. Skipped start |
| 31 | PONSIM already running. Skipped start |
| 32 | Radius server running with IP 172.17.0.3 |
| 33 | Running ['voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_5_groups_joins_verifying_traffic'] tests across 1 containers in parallel |
| 34 | Modifying scapy tool files before running a test: ['voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_5_groups_joins_verifying_traffic'] |
| 35 | Running tests: ['voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_5_groups_joins_verifying_traffic'] |
| 36 | WARNING: No route found for IPv6 destination :: (no default route?) |
| 37 | Connecting to controller at 172.17.0.2 |
| 38 | onoscli: Trying to connect to 172.17.0.2 |
| 39 | # Host [172.17.0.2]:8101 found: line 1 type RSA |
| 40 | Spawning pexpect for ip 172.17.0.2 |
| 41 | ssh connection asked for password, gave password |
| 42 | Command 'summary -j' sent to onoscli. |
| 43 | onoscli: eof exception found |
| 44 | onoscli: logout |
| 45 | |
| 46 | Connection to 172.17.0.2 closed. |
| 47 | |
| 48 | Installing the multi table app /root/test/src/test/voltha/../apps/ciena-cordigmp-multitable-3.0-SNAPSHOT.oar for subscriber test |
| 49 | Test Method: ... Enabling ponsim olt |
| 50 | Pre-provisioning ponsim_olt with address 172.17.0.1:50060 |
| 51 | Enabling device 6d94a5a49527 |
| 52 | Checking operational status for device 6d94a5a49527 |
| 53 | Installing OLT app |
| 54 | Adding subscribers through OLT app |
| 55 | Adding group 225.0.0.1 |
| 56 | Adding group 225.0.0.2 |
| 57 | Adding group 225.0.0.3 |
| 58 | Adding group 225.0.0.4 |
| 59 | Adding group 225.0.0.5 |
| 60 | All subscribers have joined the channel |
| 61 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0 |
| 62 | Packet received for group 225.0.0.1, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d3 src=1.2.3.4 dst=225.0.0.1 options=[] |<Raw load='28312.012086531' |>>>> |
| 63 | Packet received in 2724053.106 usecs for group 225.0.0.1 after join |
| 64 | All subscribers have joined the channel |
| 65 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.2, channel 1 |
| 66 | Packet received for group 225.0.0.2, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d2 src=1.2.3.4 dst=225.0.0.2 options=[] |<Raw load='28325.204115582' |>>>> |
| 67 | Packet received in 6089229.310 usecs for group 225.0.0.2 after join |
| 68 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0 |
| 69 | Subscriber on port veth0 timed out |
| 70 | Subscriber on port veth0 not received 0 packets |
| 71 | All subscribers have joined the channel |
| 72 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.3, channel 2 |
| 73 | Packet received for group 225.0.0.3, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d1 src=1.2.3.4 dst=225.0.0.3 options=[] |<Raw load='28344.748141759' |>>>> |
| 74 | Packet received in 7441608.994 usecs for group 225.0.0.3 after join |
| 75 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.2, channel 1 |
| 76 | Subscriber on port veth0 timed out |
| 77 | Subscriber on port veth0 not received 0 packets |
| 78 | All subscribers have joined the channel |
| 79 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.4, channel 3 |
| 80 | Subscriber on port veth0 timed out |
| 81 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.3, channel 2 |
| 82 | Subscriber on port veth0 timed out |
| 83 | Subscriber on port veth0 not received 0 packets |
| 84 | All subscribers have joined the channel |
| 85 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.5, channel 4 |
| 86 | Packet received for group 225.0.0.5, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95cf src=1.2.3.4 dst=225.0.0.5 options=[] |<Raw load='28379.132114277' |>>>> |
| 87 | Packet received in 2630788.196 usecs for group 225.0.0.5 after join |
| 88 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.4, channel 3 |
| 89 | Subscriber on port veth0 timed out |
| 90 | Subscriber on port veth0 not received 0 packets |
| 91 | All subscribers have joined the channel |
| 92 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0 |
| 93 | Packet received for group 225.0.0.1, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d3 src=1.2.3.4 dst=225.0.0.1 options=[] |<Raw load='28393.892107487' |>>>> |
| 94 | Packet received in 2659734.116 usecs for group 225.0.0.1 after join |
| 95 | All subscribers have joined the channel |
| 96 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.2, channel 1 |
| 97 | Packet received for group 225.0.0.2, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d2 src=1.2.3.4 dst=225.0.0.2 options=[] |<Raw load='28403.576125853' |>>>> |
| 98 | Packet received in 2629052.085 usecs for group 225.0.0.2 after join |
| 99 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0 |
| 100 | Subscriber on port veth0 timed out |
| 101 | Subscriber on port veth0 not received 0 packets |
| 102 | All subscribers have joined the channel |
| 103 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.3, channel 2 |
| 104 | Packet received for group 225.0.0.3, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d1 src=1.2.3.4 dst=225.0.0.3 options=[] |<Raw load='28418.256111493' |>>>> |
| 105 | Packet received in 2563747.333 usecs for group 225.0.0.3 after join |
| 106 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.2, channel 1 |
| 107 | Subscriber on port veth0 timed out |
| 108 | Subscriber on port veth0 not received 0 packets |
| 109 | All subscribers have joined the channel |
| 110 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.4, channel 3 |
| 111 | Packet received for group 225.0.0.4, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d0 src=1.2.3.4 dst=225.0.0.4 options=[] |<Raw load='28433.020127298' |>>>> |
| 112 | Packet received in 2638333.265 usecs for group 225.0.0.4 after join |
| 113 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.3, channel 2 |
| 114 | Subscriber on port veth0 timed out |
| 115 | Subscriber on port veth0 not received 0 packets |
| 116 | All subscribers have joined the channel |
| 117 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.5, channel 4 |
| 118 | Packet received for group 225.0.0.5, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=34 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d0 src=1.2.3.4 dst=225.0.0.5 options=[] |<Raw load='28447.68811653' |>>>> |
| 119 | Packet received in 2578036.697 usecs for group 225.0.0.5 after join |
| 120 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.4, channel 3 |
| 121 | Subscriber on port veth0 timed out |
| 122 | Subscriber on port veth0 not received 0 packets |
| 123 | All subscribers have joined the channel |
| 124 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0 |
| 125 | Packet received for group 225.0.0.1, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d3 src=1.2.3.4 dst=225.0.0.1 options=[] |<Raw load='28462.456127131' |>>>> |
| 126 | Packet received in 2638852.107 usecs for group 225.0.0.1 after join |
| 127 | All subscribers have joined the channel |
| 128 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.2, channel 1 |
| 129 | Packet received for group 225.0.0.2, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d2 src=1.2.3.4 dst=225.0.0.2 options=[] |<Raw load='28472.036110591' |>>>> |
| 130 | Packet received in 2618532.062 usecs for group 225.0.0.2 after join |
| 131 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0 |
| 132 | Subscriber on port veth0 timed out |
| 133 | Subscriber on port veth0 not received 0 packets |
| 134 | All subscribers have joined the channel |
| 135 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.3, channel 2 |
| 136 | Packet received for group 225.0.0.3, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=34 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d2 src=1.2.3.4 dst=225.0.0.3 options=[] |<Raw load='28486.82808718' |>>>> |
| 137 | Packet received in 2574205.690 usecs for group 225.0.0.3 after join |
| 138 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.2, channel 1 |
| 139 | Subscriber on port veth0 timed out |
| 140 | Subscriber on port veth0 not received 0 packets |
| 141 | All subscribers have joined the channel |
| 142 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.4, channel 3 |
| 143 | Packet received for group 225.0.0.4, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=35 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d0 src=1.2.3.4 dst=225.0.0.4 options=[] |<Raw load='28501.540146584' |>>>> |
| 144 | Packet received in 2633957.728 usecs for group 225.0.0.4 after join |
| 145 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.3, channel 2 |
| 146 | Subscriber on port veth0 timed out |
| 147 | Subscriber on port veth0 not received 0 packets |
| 148 | All subscribers have joined the channel |
| 149 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.5, channel 4 |
| 150 | Packet received for group 225.0.0.5, subscriber, port veth0 showing full packet <bound method Ether.show of <Ether dst=01:00:5e:00:01:01 src=02:88:b4:e4:90:77 type=0x800 |<IP version=4L ihl=5L tos=0x0 len=34 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x95d0 src=1.2.3.4 dst=225.0.0.5 options=[] |<Raw load='28516.30416742' |>>>> |
| 151 | Packet received in 2625209.951 usecs for group 225.0.0.5 after join |
| 152 | Subscriber on port veth0 checking data traffic receiving from group 225.0.0.4, channel 3 |
| 153 | Subscriber on port veth0 timed out |
| 154 | Subscriber on port veth0 not received 0 packets |
| 155 | This Subscriber is tested for multiple service eligibility |
| 156 | Deleted subscriber for device of:0000000000000001 on port 128 |
| 157 | Deleted subscriber for device of:0000000000000001 on port 129 |
| 158 | Deleted subscriber for device of:0000000000000001 on port 130 |
| 159 | Deleted subscriber for device of:0000000000000001 on port 131 |
| 160 | Deleted subscriber for device of:0000000000000001 on port 132 |
| 161 | Deleted subscriber for device of:0000000000000001 on port 133 |
| 162 | Deleted subscriber for device of:0000000000000001 on port 134 |
| 163 | Deleted subscriber for device of:0000000000000001 on port 135 |
| 164 | Deleted subscriber for device of:0000000000000001 on port 136 |
| 165 | Deleted subscriber for device of:0000000000000001 on port 137 |
| 166 | Deleted subscriber for device of:0000000000000001 on port 138 |
| 167 | Disabling device 6d94a5a49527 |
| 168 | Deleting device 6d94a5a49527 |
| 169 | Uninstalling OLT app |
| 170 | ok |
| 171 | Installing back the cord igmp app /root/test/src/test/voltha/../apps/ciena-cordigmp-3.0-SNAPSHOT.oar for subscriber test on exit |
| 172 | |
| 173 | ---------------------------------------------------------------------- |
| 174 | Ran 1 test in 303.426s |
| 175 | |
| 176 | OK |
| 177 | Test volthaTest.py:voltha_exchange.test_subscriber_with_voltha_for_igmp_5_groups_joins_verifying_traffic Success |
| 178 | Done running tests |
| 179 | ubuntu@cord-rs-s8:~/cord-tester/src/test/setup$ |
| 180 | ubuntu@cord-rs-s8:~/cord-tester/src/test/setup$ |
| 181 | |