src/test/results/voltha/ponsim/test_subscriber_with_voltha_for_igmp_change_to_block_src_list_verifying_traffic

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_change_to_block_src_list_verifying_traffic
# Host [172.17.0.2]:8101 found: line 3 type RSA
onoscli: eof exception found
onoscli:     logout

Connection to 172.17.0.2 closed.

result.ok, result.status_code are False and 409
ONOS app cord-config, version 2.0-SNAPSHOT installed
result.ok, result.status_code are False and 409
ONOS app aaa, version 2.0-SNAPSHOT installed
result.ok, result.status_code are False and 409
ONOS app igmp, version 2.0-SNAPSHOT installed
Controller IP [u'172.17.0.2'], Test type voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_change_to_block_src_list_verifying_traffic
Installing cord tester ONOS app /home/ubuntu/cord-tester/src/test/apps/ciena-cordigmp-multitable-3.0-SNAPSHOT.oar
result.ok, result.status_code are False and 409
WARNING: The DOCKER_HOST_IP variable is not set. Defaulting to a blank string.
compose_zookeeper_1 is up-to-date
compose_fluentd_1 is up-to-date
compose_consul_1 is up-to-date
compose_registrator_1 is up-to-date
compose_kafka_1 is up-to-date
IP 172.18.0.3 for service consul
IP 172.18.0.5 for service kafka
IP 172.18.0.4 for service zookeeper
IP 172.18.0.6 for service registrator
IP 172.18.0.2 for service fluentd
Chameleon voltha sevice is already running. Skipped start
VOLTHA core is already running. Skipped start
VOLTHA ofagent is already running. Skipped start
PONSIM already running. Skipped start
Radius server running with IP 172.17.0.3
Running ['voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_change_to_block_src_list_verifying_traffic'] tests across 1 containers in parallel
Modifying scapy tool files before running a test: ['voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_change_to_block_src_list_verifying_traffic']
Running tests: ['voltha:voltha_exchange.test_subscriber_with_voltha_for_igmp_change_to_block_src_list_verifying_traffic']
WARNING: No route found for IPv6 destination :: (no default route?)
Connecting to controller at 172.17.0.2
onoscli: Trying to connect to 172.17.0.2
# Host [172.17.0.2]:8101 found: line 1 type RSA
Spawning pexpect for ip 172.17.0.2
ssh connection asked for password, gave password
Command 'summary -j' sent to onoscli.
onoscli: eof exception found
onoscli:     logout

Connection to 172.17.0.2 closed.

Installing the multi table app /root/test/src/test/voltha/../apps/ciena-cordigmp-multitable-3.0-SNAPSHOT.oar for subscriber test
Test Method: ... Enabling ponsim olt
Pre-provisioning ponsim_olt with address 172.17.0.1:50060
Enabling device 7c2303617024
Checking operational status for device 7c2303617024
Installing OLT app
Adding subscribers through OLT app
Adding group 225.0.0.1
All subscribers have joined the channel
Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0
Subscriber on port veth0 timed out
Leaving channel 0 for subscriber on port veth0 from specific source address 2.3.4.5 and waited till GMI timer expires
Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0
Packet received for group 225.0.0.1, subscriber, port veth0 and from source ip 3.4.5.6 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=36 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x91ce src=3.4.5.6 dst=225.0.0.1 options=[] |<Raw  load='291999.028163464' |>>>>
Packet received in 291999067076.457 usecs for group 225.0.0.1 after join
Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0
Packet received for group 225.0.0.1, subscriber, port veth0 and from source ip 2.3.4.5 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=36 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x93d0 src=2.3.4.5 dst=225.0.0.1 options=[] |<Raw  load='291999.096106458' |>>>>
Packet received in 291999143102.993 usecs for group 225.0.0.1 after join
This service is failed and other services will not run for this subscriber
This Subscriber is tested for multiple service eligibility
Deleted subscriber for device of:0000000000000001 on port  128
Deleted subscriber for device of:0000000000000001 on port  129
Deleted subscriber for device of:0000000000000001 on port  130
Deleted subscriber for device of:0000000000000001 on port  131
Deleted subscriber for device of:0000000000000001 on port  132
Deleted subscriber for device of:0000000000000001 on port  133
Deleted subscriber for device of:0000000000000001 on port  134
Deleted subscriber for device of:0000000000000001 on port  135
Deleted subscriber for device of:0000000000000001 on port  136
Deleted subscriber for device of:0000000000000001 on port  137
Deleted subscriber for device of:0000000000000001 on port  138
Disabling device 7c2303617024
Deleting device 7c2303617024
Uninstalling OLT app
FAIL
Installing back the cord igmp app /root/test/src/test/voltha/../apps/ciena-cordigmp-3.0-SNAPSHOT.oar for subscriber test on exit

======================================================================
FAIL: Test Method:
----------------------------------------------------------------------
Traceback (most recent call last):
  File "/root/test/src/test/voltha/volthaTest.py", line 4784, in test_subscriber_with_voltha_for_igmp_change_to_block_src_list_verifying_traffic
    num_channels = num_channels)
  File "/root/test/src/test/voltha/volthaTest.py", line 1425, in voltha_subscribers
    assert_equal(test_status, True)
AssertionError: False != True
-------------------- >> begin captured stdout << ---------------------
result.ok, result.status_code are True and 200

--------------------- >> end captured stdout << ----------------------
-------------------- >> begin captured logging << --------------------
scapy.runtime: WARNING: No route found for IPv6 destination :: (no default route?)
docker.auth.auth: DEBUG: Trying paths: ['/root/.docker/config.json', '/root/.dockercfg']
docker.auth.auth: DEBUG: No config file found
docker.auth.auth: DEBUG: Trying paths: ['/root/.docker/config.json', '/root/.dockercfg']
docker.auth.auth: DEBUG: No config file found
cordTester: INFO: Connecting to controller at 172.17.0.2
cordTester: INFO: onoscli: Trying to connect to 172.17.0.2
onoscli: INFO:
cordTester: INFO: Spawning pexpect for ip 172.17.0.2
cordTester: INFO: ssh connection asked for password, gave password
cordTester: INFO: Command 'summary -j' sent to onoscli.
cordTester: ERROR: onoscli: eof exception found
cordTester: ERROR: onoscli:     logout

Connection to 172.17.0.2 closed.

cordTester: INFO: Installing the multi table app /root/test/src/test/voltha/../apps/ciena-cordigmp-multitable-3.0-SNAPSHOT.oar for subscriber test
cordTester: INFO: Enabling ponsim olt
cordTester: INFO: Pre-provisioning ponsim_olt with address 172.17.0.1:50060
cordTester: INFO: Enabling device 7c2303617024
cordTester: INFO: Checking operational status for device 7c2303617024
cordTester: INFO: Installing OLT app
cordTester: INFO: Adding subscribers through OLT app
cordTester: DEBUG: Adding group 225.0.0.1
cordTester: INFO: All subscribers have joined the channel
cordTester: INFO: Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0
cordTester: INFO: Subscriber on port veth0 timed out
cordTester: INFO: Leaving channel 0 for subscriber on port veth0 from specific source address 2.3.4.5 and waited till GMI timer expires
cordTester: INFO: Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0
cordTester: INFO: Packet received for group 225.0.0.1, subscriber, port veth0 and from source ip 3.4.5.6 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=36 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x91ce src=3.4.5.6 dst=225.0.0.1 options=[] |<Raw  load='291999.028163464' |>>>>
cordTester: DEBUG: Packet received in 291999067076.457 usecs for group 225.0.0.1 after join
cordTester: INFO: Subscriber on port veth0 checking data traffic receiving from group 225.0.0.1, channel 0
cordTester: INFO: Packet received for group 225.0.0.1, subscriber, port veth0 and from source ip 2.3.4.5 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=36 id=1 flags= frag=0L ttl=64 proto=hopopt chksum=0x93d0 src=2.3.4.5 dst=225.0.0.1 options=[] |<Raw  load='291999.096106458' |>>>>
cordTester: DEBUG: Packet received in 291999143102.993 usecs for group 225.0.0.1 after join
cordTester: INFO: This service is failed and other services will not run for this subscriber
cordTester: INFO: This Subscriber is tested for multiple service eligibility
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  128
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  129
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  130
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  131
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  132
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  133
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  134
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  135
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  136
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  137
cordTester: INFO: Deleted subscriber for device of:0000000000000001 on port  138
cordTester: INFO: Disabling device 7c2303617024
cordTester: INFO: Deleting device 7c2303617024
cordTester: INFO: Uninstalling OLT app
--------------------- >> end captured logging << ---------------------

----------------------------------------------------------------------
Ran 1 test in 158.464s

FAILED (failures=1)
Test volthaTest.py:voltha_exchange.test_subscriber_with_voltha_for_igmp_change_to_block_src_list_verifying_traffic Failure
Done running tests
ubuntu@cord-rs-s8:~/cord-tester/src/test/setup$