View Issue Details
| ID | Project | Category | View Status | Date Submitted | Last Update |
|---|---|---|---|---|---|
| 0004574 | secushare | social | public | 2016-06-09 14:20 | 2019-02-12 09:19 |
| Reporter | lynX | Assigned To | lynX | ||
| Priority | normal | Severity | block | Reproducibility | always |
| Status | closed | Resolution | fixed | ||
| Summary | 0004574: --host-enter and --guest-enter both terminate with ERROR --ego missing or invalid | ||||
| Description | This bug report is a fork from 0004542. After noticing that it doesn't work that way, I am now running gnunet in unified configuration on just one uid. This will have some disadvantages for testing, but it doesn't actually get that far: After running all necessary services, > gnunet-social -e 0A9RPQ1VDZB3M67XEBP9MVF6ZHKA4TP3YS99FMVG9JF4TQ3C9SXG --follow --host-enter --welcome and > gnunet-social --guest-enter --follow -e 0A9RPQ1VDZB3M67XEBP9MVF6ZHKA4TP3YS99FMVG9JF4TQ3C9SXG -p RG3RY7FTTT6128V1HGZQCQ89Q5APTHSP2JD9WKGH4T2N7KQZFVQG -i TVV54YYR29KRDKM30ZC3014JXHDGPVT7KFQGA44CEV2YQSEVFDAG both give several lines of output like this: gnunet-social-31186 ERROR Failure to obtain ego. Is identity service running? gnunet-social-31186 ERROR Assertion failed at social_api.c:962. The "Is identity service running?" is wrong - I made a mistake to add it into the code at that point. Then the CLI program terminates with error code after printing this line: gnunet-social-31186 ERROR --ego missing or invalid The ego keydress is correct however, as gnunet-identity -d shows: vonlynX - 0A9RPQ1VDZB3M67XEBP9MVF6ZHKA4TP3YS99FMVG9JF4TQ3C9SXG | ||||
| Steps To Reproduce | The initial procedure is similar to what I posted in 0004573. Only that one time I run a --host-enter and the next time I ran a --guest-enter as shown above. | ||||
| Additional Information | The IPC log for --host-enter looks like this: Jun 09 13:07:11-451216 main -> core CORE_INIT (8) Jun 09 13:07:11-460864 core -> main CORE_INIT_REPLY (40) Jun 09 13:07:11-461695 main -> namestore NAMESTORE_MONITOR_START (40) Jun 09 13:07:11-496205 main -> cadet CADET_LOCAL_CONNECT (8) Jun 09 13:07:11-541137 main -> identity IDENTITY_START (4) Jun 09 13:07:11-544598 main -> identity IDENTITY_GET_DEFAULT (22) Jun 09 13:07:11-735061 namestore -> main NAMESTORE_MONITOR_SYNC (4) Jun 09 13:07:11-735713 main -> namestore NAMESTORE_ZONE_ITERATION_START (40) Jun 09 13:07:11-736356 namestore -> main NAMESTORE_RECORD_RESULT (48) Jun 09 13:07:11-740874 main -> statistics STATISTICS_SET (60) Jun 09 13:07:11-741581 main -> statistics STATISTICS_SET (46) Jun 09 13:07:11-742020 main -> statistics STATISTICS_SET (52) Jun 09 13:07:11-804499 identity -> main IDENTITY_UPDATE (48) Jun 09 13:07:11-830025 identity -> main IDENTITY_UPDATE (40) Jun 09 13:07:11-830267 identity -> main IDENTITY_RESULT_CODE (25) Jun 09 13:17:38-431325 main -> core CORE_INIT (8) Jun 09 13:17:38-549953 main -> identity IDENTITY_START (4) Jun 09 13:17:38-552054 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-578651 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-579093 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-579585 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-579988 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-580479 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-580894 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-589771 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-590227 main -> psyc PSYC_MASTER_START (40) Jun 09 13:17:38-590389 core -> main CORE_INIT_REPLY (40) Jun 09 13:17:38-612373 identity -> main IDENTITY_UPDATE (48) Jun 09 13:17:38-773585 identity -> main IDENTITY_UPDATE (40) Jun 09 13:17:39-098524 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-104818 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-109491 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-112340 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-113133 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-115104 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-118456 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-119214 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-121349 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-128867 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-139688 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-141772 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-141932 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-142752 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-144888 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-147754 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-148552 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-158665 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-159246 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-162409 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-163187 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-165224 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-165829 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-181401 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-181562 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-128867 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-139688 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-141772 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-141932 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-142752 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-144888 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-147754 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-148552 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-158665 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-159246 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-162409 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-163187 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:17:39-165224 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-165829 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-181401 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-181562 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-182493 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-185334 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-186054 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-186618 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-198008 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-198893 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-199522 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-213656 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:17:39-214468 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:17:39-215126 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:17:39-226831 main -> multicast MULTICAST_ORIGIN_START (48) The one for --guest-enter goes like this: Jun 09 13:24:47-647539 main -> core CORE_INIT (8) Jun 09 13:24:47-648340 core -> main CORE_INIT_REPLY (40) Jun 09 13:24:47-683418 main -> cadet CADET_LOCAL_CONNECT (8) Jun 09 13:24:47-720338 main -> namestore NAMESTORE_MONITOR_START (40) Jun 09 13:24:47-766922 main -> identity IDENTITY_START (4) Jun 09 13:24:47-767304 main -> identity IDENTITY_GET_DEFAULT (22) Jun 09 13:24:47-954586 namestore -> main NAMESTORE_MONITOR_SYNC (4) Jun 09 13:24:47-955342 main -> namestore NAMESTORE_ZONE_ITERATION_START (40) Jun 09 13:24:47-960519 namestore -> main NAMESTORE_RECORD_RESULT (48) Jun 09 13:24:47-969035 main -> statistics STATISTICS_SET (60) Jun 09 13:24:47-971604 main -> statistics STATISTICS_SET (46) Jun 09 13:24:47-972037 main -> statistics STATISTICS_SET (52) Jun 09 13:24:47-995386 identity -> main IDENTITY_UPDATE (48) Jun 09 13:24:48-021248 identity -> main IDENTITY_UPDATE (40) Jun 09 13:24:48-021453 identity -> main IDENTITY_RESULT_CODE (25) Jun 09 13:25:06-620940 main -> core CORE_INIT (8) Jun 09 13:25:06-711847 main -> identity IDENTITY_START (4) Jun 09 13:25:06-718320 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-729617 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-730007 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-730415 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-730807 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-738417 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-738899 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-739451 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-739929 main -> psyc PSYC_MASTER_START (40) Jun 09 13:25:06-740092 core -> main CORE_INIT_REPLY (40) Jun 09 13:25:06-755632 identity -> main IDENTITY_UPDATE (48) Jun 09 13:25:06-901609 identity -> main IDENTITY_UPDATE (40) Jun 09 13:25:07-172229 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-177958 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-182116 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-186714 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-187515 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-189492 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-199871 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-200721 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-202838 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-210776 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-214178 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-221718 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-221883 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-222692 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-225073 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-228339 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-229122 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-238656 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-239332 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-250431 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-251103 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-252941 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-253525 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-258006 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-258175 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-210776 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-214178 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-221718 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-221883 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-222692 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-225073 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-228339 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-229122 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-238656 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-239332 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-250431 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-251103 main -> psycstore PSYCSTORE_COUNTERS_GET (48) Jun 09 13:25:07-252941 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-253525 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-258006 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-258175 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-269475 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-293393 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-303809 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-304453 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-307595 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-308472 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-309102 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-321245 psycstore -> main PSYCSTORE_RESULT_COUNTERS (48) Jun 09 13:25:07-322101 main -> multicast MULTICAST_ORIGIN_START (48) Jun 09 13:25:07-322792 psyc -> main PSYC_MASTER_START_ACK (16) Jun 09 13:25:07-326121 main -> multicast MULTICAST_ORIGIN_START (48) The byte count for both logs is 4228. | ||||
| Tags | No tags attached. | ||||
|
|
I changed social_api.c to show me the ego it is looking up. Now I get this output: => gnunet-social --guest-enter --follow -e 0A9RPQ1VDZB3M67XEBP9MVF6ZHKA4TP3YS99FMVG9JF4TQ3C9SXG -p RG3RY7FTTT6128V1HGZQCQ89Q5APTHSP2JD9WKGH4T2N7KQZFVQG -i TVV54YYR29KRDKM30ZC3014JXHDGPVT7KFQGA44CEV2YQSEVFDAG Jun 09 16:25:58-830209 gnunet-social-22277 ERROR Failure to obtain ego 80TJ5W77. Jun 09 16:25:58-830767 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-832309 gnunet-social-22277 ERROR Failure to obtain ego 80TJ5W77. Jun 09 16:25:58-832450 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-937390 gnunet-social-22277 ERROR Failure to obtain ego 80TJ5W77. Jun 09 16:25:58-937503 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-943694 gnunet-social-22277 ERROR Failure to obtain ego 80TJ5W77. Jun 09 16:25:58-943786 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-945542 gnunet-social-22277 ERROR Failure to obtain ego 80TJ5W77. Jun 09 16:25:58-945670 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-948086 gnunet-social-22277 ERROR Failure to obtain ego VCYTZS41. Jun 09 16:25:58-948239 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-950210 gnunet-social-22277 ERROR Failure to obtain ego 80TJ5W77. Jun 09 16:25:58-950318 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-953901 gnunet-social-22277 ERROR Failure to obtain ego VCYTZS41. Jun 09 16:25:58-953993 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-955621 gnunet-social-22277 ERROR Failure to obtain ego 80TJ5W77. Jun 09 16:25:58-955704 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-958313 gnunet-social-22277 ERROR Failure to obtain ego 80TJ5W77. Jun 09 16:25:58-958443 gnunet-social-22277 ERROR Assertion failed at social_api.c:964. Jun 09 16:25:58-961059 gnunet-social-22277 ERROR --ego missing or invalid child died with signal 11, without coredump |
|
|
gnunet-social-31186 ERROR Assertion failed at social_api.c:962. this happens when trying to load a previously saved place, but the ego that used to enter the place does not exist anymore, or for some reason not sent to the client. some more information would be necessary for debugging: - full output of the client, including the list of egos & places it receives - IPC logs with messages for social |
|
|
It's a combination of unexpected persistence of data during testing with the crash resulting from 0004573. Will produce a new report that gets to the point of the actual remaining problem. |
|
|
Problem solved by bug fixes + better understanding of the API… |
| Date Modified | Username | Field | Change |
|---|---|---|---|
| 2016-06-09 14:20 | lynX | New Issue | |
| 2016-06-09 14:20 | lynX | Status | new => assigned |
| 2016-06-09 14:20 | lynX | Assigned To | => tg |
| 2016-06-09 16:34 | lynX | Note Added: 0010883 | |
| 2016-06-11 15:24 | tg | Note Added: 0010888 | |
| 2016-07-30 07:54 | lynX | Note Added: 0010997 | |
| 2016-07-30 07:54 | lynX | Status | assigned => feedback |
| 2016-07-30 07:54 | lynX | Resolution | open => won't fix |
| 2017-02-08 01:22 | lynX | Assigned To | tg => lynX |
| 2017-02-08 01:22 | lynX | Status | feedback => resolved |
| 2017-02-08 01:22 | lynX | Resolution | won't fix => fixed |
| 2017-02-08 01:22 | lynX | Fixed in Version | => Git master |
| 2017-02-08 01:22 | lynX | Note Added: 0011705 | |
| 2017-02-26 02:17 | Christian Grothoff | Product Version | => Git master |
| 2017-02-26 02:17 | Christian Grothoff | Fixed in Version | Git master => 0.11.0pre66 |
| 2017-02-26 02:17 | Christian Grothoff | Target Version | => 0.11.0pre66 |
| 2018-06-07 00:24 | Christian Grothoff | Status | resolved => closed |
| 2019-02-12 09:17 | Christian Grothoff | Project | GNUnet => secushare |
| 2019-02-12 09:17 | Christian Grothoff | Category | social service => General |
| 2019-02-12 09:19 | Christian Grothoff | Category | General => social |
