maidsafe-archive / MaidSafe

This is the super-project in which each MaidSafe library resides. Some information is common to all libraries, and is detailed here. Library-specific information can be found in each library's wiki.
Other
583 stars 102 forks source link

API test OneUserApiTest.FUNC_ChangeCredentials fails on clean network. #82

Closed ghost closed 11 years ago

ghost commented 11 years ago

As per https://basecamp.com/2074288/projects/1592290-lifestuff-dev/todos/23749552-23749552-determine

Run test once on clean network and with clean lifestuff_mgr. Failed on 6th logout (MID result -200003, which is kRemoteChunkStoreFailure).

[==========] Running 1 test from 1 test case.
[----------] Global test environment set-up.
[==========] 1 test from OneUserApiTest
[ RUN      ] OneUserApiTest.FUNC_ChangeCredentials
I 1 11:33:55.059811 lifestuff/rcs_helper.cc:80] Started PD client node.
I 1 11:33:57.162837 lifestuff/detail/user_credentials_impl.cc:602] ANMID: 0, ANSMID: 0, ANTMID: 0, PMID path: 0
I 1 11:33:58.039720 lifestuff/detail/user_credentials_impl.cc:771] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:34:03.061898 lifestuff/lifestuff_impl.cc:291] user_credentials_->CreateUser success.
I 1 11:34:03.679817 lifestuff/lifestuff_impl.cc:301] CreateVaultInLocalMachine success.
I 1 11:34:04.840626 lifestuff/lifestuff_impl.cc:310] SetValidPmidAndInitialisePublicComponents success.
I 1 11:34:04.918877 lifestuff/tests/api/api_test_resources.cc:339] About to stop messages and intros
I 1 11:34:04.918984 lifestuff/tests/api/api_test_resources.cc:346] About to unmount drive
I 1 11:34:04.975542 lifestuff/tests/api/api_test_resources.cc:353] About to log out
I 1 11:34:04.975635 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:34:29.836857 lifestuff/detail/user_credentials_impl.cc:867] MID: 0, SMID: 0, TMID: 0, STMID: 0
S 1 11:34:29.836952 lifestuff/detail/user_credentials_impl.cc:883] Success in SaveSession.
I 1 11:34:30.411248 lifestuff/detail/routings_handler.cc:171] RoutingsHandler::DeleteRoutingObject erased: 1, out of: 1
I 1 11:34:30.424836 lifestuff/detail/routings_handler.cc:83] Cleared objects

I 1 11:34:30.688912 lifestuff/rcs_helper.cc:80] Started PD client node.
I 1 11:34:31.138952 lifestuff/detail/user_credentials_impl.cc:322] mid_tmid_result: 0 - false - false
I 1 11:34:31.139020 lifestuff/detail/user_credentials_impl.cc:324] smid_stmid_result: 0 - false - false
I 1 11:34:31.139094 lifestuff/detail/session.cc:343] ParseDataAtlas - Has drive data.
I 1 11:34:36.437032 lifestuff/detail/routings_handler.cc:222] sender: d7ba9c..479768, receiver: d7ba9c..479768
I 3 11:34:36.447213 lifestuff/detail/routings_handler.cc:292] receiver: d7ba9c..479768, sender: d7ba9c..479768
I 3 11:34:36.453018 lifestuff/lifestuff_impl.cc:1307] It's our own message that has been received. Ignoring...
I 4 11:34:46.437153 lifestuff/detail/routings_handler.cc:210] Message count: 0
E 1 11:34:46.437230 lifestuff/detail/routings_handler.cc:241] Message from d7ba9c..479768 is empty. Probably timed out in routing.
W 1 11:34:46.437282 lifestuff/detail/user_credentials_impl.cc:195] Timed out. Not necessarily a failure.
I 1 11:34:56.976289 lifestuff/lifestuff_impl.cc:537] Won't check for messages/intros because there is no public ID.
I 1 11:34:56.976411 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:34:57.814285 lifestuff/detail/user_credentials_impl.cc:771] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:34:58.097421 lifestuff/detail/user_credentials_impl.cc:1002] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:34:58.097600 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:34:58.840873 lifestuff/detail/user_credentials_impl.cc:771] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:34:59.121520 lifestuff/detail/user_credentials_impl.cc:1002] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:34:59.121615 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:34:59.709152 lifestuff/detail/user_credentials_impl.cc:1113] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:34:59.877174 lifestuff/detail/user_credentials_impl.cc:1147] TMID: 0, STMID: 0
I 1 11:34:59.877244 lifestuff/tests/api/api_test_resources.cc:339] About to stop messages and intros
I 1 11:34:59.877289 lifestuff/tests/api/api_test_resources.cc:346] About to unmount drive
I 1 11:34:59.910542 lifestuff/tests/api/api_test_resources.cc:353] About to log out
I 1 11:34:59.910681 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:35:00.464038 lifestuff/detail/user_credentials_impl.cc:867] MID: 0, SMID: 0, TMID: 0, STMID: 0
S 1 11:35:00.464125 lifestuff/detail/user_credentials_impl.cc:883] Success in SaveSession.
I 1 11:35:00.528138 lifestuff/detail/routings_handler.cc:171] RoutingsHandler::DeleteRoutingObject erased: 1, out of: 1
I 1 11:35:00.542135 lifestuff/detail/routings_handler.cc:83] Cleared objects

I 1 11:35:01.040147 lifestuff/rcs_helper.cc:80] Started PD client node.
I 1 11:35:01.417640 lifestuff/detail/user_credentials_impl.cc:322] mid_tmid_result: 0 - false - false
I 1 11:35:01.417706 lifestuff/detail/user_credentials_impl.cc:324] smid_stmid_result: 0 - false - false
I 1 11:35:01.417760 lifestuff/detail/session.cc:343] ParseDataAtlas - Has drive data.
I 1 11:35:06.652668 lifestuff/detail/routings_handler.cc:222] sender: d7ba9c..479768, receiver: d7ba9c..479768
I 6 11:35:06.664595 lifestuff/detail/routings_handler.cc:292] receiver: d7ba9c..479768, sender: d7ba9c..479768
I 6 11:35:06.667800 lifestuff/lifestuff_impl.cc:1307] It's our own message that has been received. Ignoring...
I 7 11:35:16.652799 lifestuff/detail/routings_handler.cc:210] Message count: 0
E 1 11:35:16.652923 lifestuff/detail/routings_handler.cc:241] Message from d7ba9c..479768 is empty. Probably timed out in routing.
W 1 11:35:16.653005 lifestuff/detail/user_credentials_impl.cc:195] Timed out. Not necessarily a failure.
I 1 11:35:17.408568 lifestuff/lifestuff_impl.cc:537] Won't check for messages/intros because there is no public ID.
I 1 11:35:17.408768 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:35:18.097378 lifestuff/detail/user_credentials_impl.cc:771] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:35:18.393658 lifestuff/detail/user_credentials_impl.cc:1002] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:35:18.393732 lifestuff/tests/api/api_test_resources.cc:339] About to stop messages and intros
I 1 11:35:18.393787 lifestuff/tests/api/api_test_resources.cc:346] About to unmount drive
I 1 11:35:18.454446 lifestuff/tests/api/api_test_resources.cc:353] About to log out
I 1 11:35:18.454530 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:35:19.084512 lifestuff/detail/user_credentials_impl.cc:867] MID: 0, SMID: 0, TMID: 0, STMID: 0
S 1 11:35:19.084578 lifestuff/detail/user_credentials_impl.cc:883] Success in SaveSession.
I 1 11:35:19.158618 lifestuff/detail/routings_handler.cc:171] RoutingsHandler::DeleteRoutingObject erased: 1, out of: 1
I 1 11:35:19.170700 lifestuff/detail/routings_handler.cc:83] Cleared objects

I 1 11:35:19.901080 lifestuff/rcs_helper.cc:80] Started PD client node.
I 1 11:35:20.302371 lifestuff/detail/user_credentials_impl.cc:322] mid_tmid_result: 0 - false - false
I 1 11:35:20.302465 lifestuff/detail/user_credentials_impl.cc:324] smid_stmid_result: 0 - false - false
I 1 11:35:20.302563 lifestuff/detail/session.cc:343] ParseDataAtlas - Has drive data.
I 1 11:35:25.653491 lifestuff/detail/routings_handler.cc:222] sender: d7ba9c..479768, receiver: d7ba9c..479768
I 9 11:35:25.663922 lifestuff/detail/routings_handler.cc:292] receiver: d7ba9c..479768, sender: d7ba9c..479768
I 9 11:35:25.669757 lifestuff/lifestuff_impl.cc:1307] It's our own message that has been received. Ignoring...
I 10 11:35:35.653628 lifestuff/detail/routings_handler.cc:210] Message count: 0
E 1 11:35:35.653741 lifestuff/detail/routings_handler.cc:241] Message from d7ba9c..479768 is empty. Probably timed out in routing.
W 1 11:35:35.653819 lifestuff/detail/user_credentials_impl.cc:195] Timed out. Not necessarily a failure.
I 1 11:35:36.427185 lifestuff/lifestuff_impl.cc:537] Won't check for messages/intros because there is no public ID.
I 1 11:35:36.427292 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:35:37.169822 lifestuff/detail/user_credentials_impl.cc:771] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:35:37.448405 lifestuff/detail/user_credentials_impl.cc:1002] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:35:37.448476 lifestuff/tests/api/api_test_resources.cc:339] About to stop messages and intros
I 1 11:35:37.448526 lifestuff/tests/api/api_test_resources.cc:346] About to unmount drive
I 1 11:35:37.751045 lifestuff/tests/api/api_test_resources.cc:353] About to log out
I 1 11:35:37.751295 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:35:38.311780 lifestuff/detail/user_credentials_impl.cc:867] MID: 0, SMID: 0, TMID: 0, STMID: 0
S 1 11:35:38.311866 lifestuff/detail/user_credentials_impl.cc:883] Success in SaveSession.
I 1 11:35:38.375299 lifestuff/detail/routings_handler.cc:171] RoutingsHandler::DeleteRoutingObject erased: 1, out of: 1
I 1 11:35:38.388447 lifestuff/detail/routings_handler.cc:83] Cleared objects

I 1 11:35:38.810012 lifestuff/rcs_helper.cc:80] Started PD client node.
I 1 11:35:39.226050 lifestuff/detail/user_credentials_impl.cc:322] mid_tmid_result: 0 - false - false
I 1 11:35:39.226137 lifestuff/detail/user_credentials_impl.cc:324] smid_stmid_result: 0 - false - false
I 1 11:35:39.226221 lifestuff/detail/session.cc:343] ParseDataAtlas - Has drive data.
I 1 11:35:44.526079 lifestuff/detail/routings_handler.cc:222] sender: d7ba9c..479768, receiver: d7ba9c..479768
I 12 11:35:44.539520 lifestuff/detail/routings_handler.cc:292] receiver: d7ba9c..479768, sender: d7ba9c..479768
I 12 11:35:44.542784 lifestuff/lifestuff_impl.cc:1307] It's our own message that has been received. Ignoring...
I 13 11:35:54.526261 lifestuff/detail/routings_handler.cc:210] Message count: 0
E 1 11:35:54.526349 lifestuff/detail/routings_handler.cc:241] Message from d7ba9c..479768 is empty. Probably timed out in routing.
W 1 11:35:54.526397 lifestuff/detail/user_credentials_impl.cc:195] Timed out. Not necessarily a failure.
I 1 11:35:55.318531 lifestuff/lifestuff_impl.cc:537] Won't check for messages/intros because there is no public ID.
I 1 11:35:55.318661 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:35:55.891631 lifestuff/detail/user_credentials_impl.cc:1113] MID: 0, SMID: 0, TMID: 0, STMID: 0
I 1 11:35:56.052472 lifestuff/detail/user_credentials_impl.cc:1147] TMID: 0, STMID: 0
I 1 11:35:56.052580 lifestuff/tests/api/api_test_resources.cc:339] About to stop messages and intros
I 1 11:35:56.052656 lifestuff/tests/api/api_test_resources.cc:346] About to unmount drive
I 1 11:35:56.102541 lifestuff/tests/api/api_test_resources.cc:353] About to log out
I 1 11:35:56.102618 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:35:56.708674 lifestuff/detail/user_credentials_impl.cc:867] MID: 0, SMID: 0, TMID: 0, STMID: 0
S 1 11:35:56.708764 lifestuff/detail/user_credentials_impl.cc:883] Success in SaveSession.
I 1 11:35:56.772322 lifestuff/detail/routings_handler.cc:171] RoutingsHandler::DeleteRoutingObject erased: 1, out of: 1
I 1 11:35:56.784205 lifestuff/detail/routings_handler.cc:83] Cleared objects

I 1 11:35:57.495254 lifestuff/rcs_helper.cc:80] Started PD client node.
I 1 11:35:57.883527 lifestuff/detail/user_credentials_impl.cc:322] mid_tmid_result: 0 - false - false
I 1 11:35:57.883585 lifestuff/detail/user_credentials_impl.cc:324] smid_stmid_result: 0 - false - false
I 1 11:35:57.883666 lifestuff/detail/session.cc:343] ParseDataAtlas - Has drive data.
I 1 11:36:03.128443 lifestuff/detail/routings_handler.cc:222] sender: d7ba9c..479768, receiver: d7ba9c..479768
I 15 11:36:03.136765 lifestuff/detail/routings_handler.cc:292] receiver: d7ba9c..479768, sender: d7ba9c..479768
I 15 11:36:03.140993 lifestuff/lifestuff_impl.cc:1307] It's our own message that has been received. Ignoring...
I 16 11:36:13.128625 lifestuff/detail/routings_handler.cc:210] Message count: 0
E 1 11:36:13.128724 lifestuff/detail/routings_handler.cc:241] Message from d7ba9c..479768 is empty. Probably timed out in routing.
W 1 11:36:13.128823 lifestuff/detail/user_credentials_impl.cc:195] Timed out. Not necessarily a failure.
I 1 11:36:13.882455 lifestuff/lifestuff_impl.cc:537] Won't check for messages/intros because there is no public ID.
I 1 11:36:13.882552 lifestuff/lifestuff_impl.cc:584] Same value for old and new.
I 1 11:36:13.882621 lifestuff/lifestuff_impl.cc:609] Same value for old and new.
I 1 11:36:13.882691 lifestuff/lifestuff_impl.cc:635] Same value for old and new.
I 1 11:36:13.882761 lifestuff/tests/api/api_test_resources.cc:339] About to stop messages and intros
I 1 11:36:13.882835 lifestuff/tests/api/api_test_resources.cc:346] About to unmount drive
I 1 11:36:13.930577 lifestuff/tests/api/api_test_resources.cc:353] About to log out
I 1 11:36:13.930678 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:36:14.599117 lifestuff/detail/user_credentials_impl.cc:867] MID: -200003, SMID: 0, TMID: 0, STMID: 0
E 1 11:36:14.599203 lifestuff/detail/user_credentials_impl.cc:874] One of the operations for Identity Packets failed. Turn on INFO for feedback on which one. 
E 1 11:36:14.599274 lifestuff/detail/user_credentials_impl.cc:252] Failed to save session on Logout with result -207018
E 1 11:36:14.599341 lifestuff/lifestuff_impl.cc:432] Failed to log out with result -207018
E 1 11:36:14.599409 lifestuff/tests/api/api_test_resources.cc:356] Failed to create log out: -201009
/home/alison/Development/Workspace/MaidSafe/src/lifestuff/src/maidsafe/lifestuff/tests/api/api_user_credentials_test.cc:116: Failure
Value of: DoFullLogOut(test_elements)
  Actual: -201009
Expected: kSuccess
Which is: 0
I 1 11:36:14.599572 lifestuff/detail/session.cc:401] SerialiseDataAtlas - Has drive data.
I 1 11:36:15.120723 lifestuff/detail/user_credentials_impl.cc:867] MID: -200003, SMID: 0, TMID: 0, STMID: 0
E 1 11:36:15.120811 lifestuff/detail/user_credentials_impl.cc:874] One of the operations for Identity Packets failed. Turn on INFO for feedback on which one. 
E 1 11:36:15.120891 lifestuff/detail/user_credentials_impl.cc:252] Failed to save session on Logout with result -207018
E 1 11:36:15.120962 lifestuff/lifestuff_impl.cc:432] Failed to log out with result -207018
W 1 11:36:15.121031 lifestuff/lifestuff_impl.cc:188] Should log out, but failed: -201009
W 1 11:36:15.121100 lifestuff/lifestuff_impl.cc:152] Quitting has failed in one of the clean up tasks: -201009
I 1 11:36:15.156836 lifestuff/detail/routings_handler.cc:83] Cleared objects

Segmentation fault (core dumped)