Project

General

Profile

Bug #1707

Updated by lazlo almost 8 years ago

When the osmo-gsm-tester has run more than one session, "events" like received SMS will be dispatched to test cases of previous test sessions. 

 This does not lead to the failure of the current session but is irritating and simply a bug. 

 An example for this situation can be seen in the log output of the tester 

 <pre> 
 20160427185631     DEBUG: "TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790>" on_tick called (ttl 145 seconds) 
 20160427185631     DEBUG: IN tick_scenario(): tests total 1 tests complete 0 test failed 0 
 20160427185633     DEBUG: IN tick_scenario(): steps total 1 steps complete 0 
 20160427185633     DEBUG: "TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790>" on_tick called (ttl 143 seconds) 
 20160427185633     DEBUG: IN tick_scenario(): tests total 1 tests complete 0 test failed 0 
 20160427185634     DEBUG: Message: test message from TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790> (rand_token=0.744257599003) 
 20160427185634     DEBUG: Path: /wavecom_3 
 20160427185634     DEBUG: Interface: org.ofono.MessageManager 
 20160427185634     DEBUG:       LocalSentTime = 2016-04-27T18:56:30+0200 
 20160427185634     DEBUG:       SentTime = 2016-04-27T16:56:30+0000 
 20160427185634     DEBUG:       Sender = 7803 
 20160427185634     DEBUG: "TestSession<tmp.xHnW1CNJVu-build-302>:StandardTestScenario<0xe02910>:SendMOSmsTestCase<0xe02b90>" received message (not sure yet if it is for this test case) 
 20160427185634     DEBUG: Message: test message from TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790> (rand_token=0.744257599003) 
 20160427185634     DEBUG: Path: /wavecom_3 
 20160427185634     DEBUG: Interface: org.ofono.MessageManager 
 20160427185634     DEBUG:       LocalSentTime = 2016-04-27T18:56:30+0200 
 20160427185634     DEBUG:       SentTime = 2016-04-27T16:56:30+0000 
 20160427185634     DEBUG:       Sender = 7803 
 20160427185634     DEBUG: "TestSession<tmp.xHnW1CNJVu-build-302>:StandardTestScenario<0xe02910>:SendMOSmsTestCase<0xe02bd0>" received message (not sure yet if it is for this test case) 
 20160427185634     DEBUG: "TestSession<tmp.xHnW1CNJVu-build-302>:StandardTestScenario<0xe02910>:SendMOSmsTestCase<0xe02bd0>" message was directed our jenkins at 'to_modem' (/wavecom_3) 
 20160427185634     DEBUG: "TestSession<tmp.xHnW1CNJVu-build-302>:StandardTestScenario<0xe02910>:SendMOSmsTestCase<0xe02bd0>" state = failure 
 20160427185634      INFO: "TestSession<tmp.xHnW1CNJVu-build-302>:StandardTestScenario<0xe02910>:SendMOSmsTestCase<0xe02bd0>" failure! random token mismatch (expected 0.460211981162) 
 20160427185634     DEBUG: Message: test message from TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790> (rand_token=0.744257599003) 
 20160427185634     DEBUG: Path: /wavecom_3 
 20160427185634     DEBUG: Interface: org.ofono.MessageManager 
 20160427185634     DEBUG:       LocalSentTime = 2016-04-27T18:56:30+0200 
 20160427185634     DEBUG:       SentTime = 2016-04-27T16:56:30+0000 
 20160427185634     DEBUG:       Sender = 7803 
 20160427185634     DEBUG: "TestSession<tmp.32HecBvzWT-build-303>:StandardTestScenario<0xe0c890>:SendMOSmsTestCase<0xe0c950>" received message (not sure yet if it is for this test case) 
 20160427185634     DEBUG: Message: test message from TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790> (rand_token=0.744257599003) 
 20160427185634     DEBUG: Path: /wavecom_3 
 20160427185634     DEBUG: Interface: org.ofono.MessageManager 
 20160427185634     DEBUG:       LocalSentTime = 2016-04-27T18:56:30+0200 
 20160427185634     DEBUG:       SentTime = 2016-04-27T16:56:30+0000 
 20160427185634     DEBUG:       Sender = 7803 
 20160427185634     DEBUG: "TestSession<tmp.32HecBvzWT-build-303>:StandardTestScenario<0xe0c890>:SendMOSmsTestCase<0xe0c990>" received message (not sure yet if it is for this test case) 
 20160427185634     DEBUG: "TestSession<tmp.32HecBvzWT-build-303>:StandardTestScenario<0xe0c890>:SendMOSmsTestCase<0xe0c990>" message was directed at 'to_modem' (/wavecom_3) 
 20160427185634     DEBUG: "TestSession<tmp.32HecBvzWT-build-303>:StandardTestScenario<0xe0c890>:SendMOSmsTestCase<0xe0c990>" state = failure 
 20160427185634      INFO: "TestSession<tmp.32HecBvzWT-build-303>:StandardTestScenario<0xe0c890>:SendMOSmsTestCase<0xe0c990>" failure! random token mismatch (expected 0.184061419514) 
 20160427185634     DEBUG: Message: test message from TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790> (rand_token=0.744257599003) 
 20160427185634     DEBUG: Path: /wavecom_3 
 20160427185634     DEBUG: Interface: org.ofono.MessageManager 
 20160427185634     DEBUG:       LocalSentTime = 2016-04-27T18:56:30+0200 
 20160427185634     DEBUG:       SentTime = 2016-04-27T16:56:30+0000 
 20160427185634     DEBUG:       Sender = 7803 
 20160427185634     DEBUG: "TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09750>" received message (not sure yet if it is for this test case) 
 20160427185634     DEBUG: Message: test message from TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790> (rand_token=0.744257599003) 
 20160427185634     DEBUG: Path: /wavecom_3 
 20160427185634     DEBUG: Interface: org.ofono.MessageManager 
 20160427185634     DEBUG:       LocalSentTime = 2016-04-27T18:56:30+0200 
 20160427185634     DEBUG:       SentTime = 2016-04-27T16:56:30+0000 
 20160427185634     DEBUG:       Sender = 7803 
 20160427185634     DEBUG: "TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790>" received message (not sure yet if it is for this test case) 
 20160427185634     DEBUG: "TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790>" message was directed at 'to_modem' (/wavecom_3) 
 20160427185634     DEBUG: "TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790>" state = success 
 20160427185634      INFO: "TestSession<tmp.BRUwIH6e9z-build-304>:StandardTestScenario<0xf09690>:SendMOSmsTestCase<0xf09790>" success! took 37 seconds to deliver SMS to 7804 
 20160427185635     DEBUG: IN tick_scenario(): steps total 1 steps complete 0 
 </pre> http://10.9.1.103/job/openbsc/label=Debian7-AMD64/304/console 

 Note that this jenkins build job failed not because of the tester but because the final "ssh rm -rf" failed. 

 <pre> 
 + ssh root@10.9.1.190 rm -rf /var/tmp/osmo-gsm-tester/tmp.BRUwIH6e9z-build-304 
 rm: cannot remove `/var/tmp/osmo-gsm-tester/tmp.BRUwIH6e9z-build-304': Directory not empty 
 Build step 'Execute shell' marked build as failure 
 [WARNINGS] Skipping publisher since build result is FAILURE 
 Recording test results 
 Archiving artifacts 
 Finished: FAILURE 
 </pre> 


 Reproduce the bug run at least two test sessions and you will notice that an SMS that originates from a test case of the current test session will be dispatched to test cases of the previous test sessions (see TestSession<some-unique-value> in the log output) and these test cases will be marked as "failure" (which does not change the outcome of the current test session).

Back

Add picture from clipboard (Maximum size: 48.8 MB)