View Issue Details
| ID | Project | Category | View Status | Date Submitted | Last Update |
|---|---|---|---|---|---|
| 0002263 | GNUnet | core service | public | 2012-04-12 15:25 | 2012-06-02 19:15 |
| Reporter | Bart Polot | Assigned To | Christian Grothoff | ||
| Priority | normal | Severity | minor | Reproducibility | sometimes |
| Status | closed | Resolution | fixed | ||
| Product Version | Git master | ||||
| Target Version | 0.9.3 | Fixed in Version | 0.9.3 | ||
| Summary | 0002263: High CPU causes problems with core | ||||
| Description | I thought I reported this already, but I can't find it. [bart@saturn ~/svn/gnunet/src/nse]$ ./gnunet-nse-profiler -c nse_profiler_test.conf Hostkeys created Progress: [0%............25%............50%.............75%............100%] Peers started Progress: [0%............25%............50%.............75%............100%] Peer connection Progress: [0%............25%............50%.............75%............100%] Apr 12 13:14:38-829032 nse-profiler-5949 WARNING Have 33404 connections Apr 12 13:15:08-216630 arm-api-18263 WARNING Error receiving response to `START' request from ARM for service `nse' Error communicating with ARM service. Apr 12 13:15:21-753711 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 0 Apr 12 13:15:21-753850 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 400 Apr 12 13:15:21-753918 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 800 Apr 12 13:15:21-753957 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1200 Apr 12 13:15:21-753997 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1600 Apr 12 13:15:21-754055 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2000 Apr 12 13:15:21-754110 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2400 Apr 12 13:15:21-754148 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2800 Apr 12 13:15:21-754228 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3200 Apr 12 13:15:21-754261 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3600 Apr 12 13:47:25-796196 nse-profiler-5949 WARNING Round 1, doing nothing! Apr 12 13:47:25-796421 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 0 Apr 12 13:47:25-796722 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 400 Apr 12 13:47:25-796932 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 800 Apr 12 13:47:25-797093 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1200 Apr 12 13:47:25-797192 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1600 Apr 12 13:47:25-797294 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2000 Apr 12 13:47:25-797379 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2400 Apr 12 13:47:25-797455 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2800 Apr 12 13:47:25-797579 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3200 Apr 12 13:47:25-797639 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3600 Apr 12 14:19:25-799328 nse-profiler-5949 WARNING Round 2, doing nothing! Apr 12 14:19:25-800190 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 0 Apr 12 14:19:25-800714 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 400 Apr 12 14:19:25-800889 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 800 Apr 12 14:19:25-801075 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1200 Apr 12 14:19:25-801284 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1600 Apr 12 14:19:25-801480 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2000 Apr 12 14:19:25-801714 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2400 Apr 12 14:19:25-801879 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2800 Apr 12 14:19:25-802079 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3200 Apr 12 14:19:25-802256 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3600 Apr 12 14:39:38-172727 core-6813 ERROR Received PING from ` P7LL' for different identity: I am `QDBU', PONG identity: ` 0A0F' Apr 12 14:39:38-276535 core-6813 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:39:39-153218 core-11094 ERROR Received PING from ` Q501' for different identity: I am `KMSD', PONG identity: ` NC30' Apr 12 14:39:39-173486 core-11094 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:39:42-655317 core-27332 ERROR Received PING from ` R7AC' for different identity: I am `PUFO', PONG identity: ` 8V7F' Apr 12 14:39:42-677191 core-27332 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:39:47-217706 core-10229 ERROR Received PING from ` Q5H0' for different identity: I am `ILUF', PONG identity: ` EJP5' Apr 12 14:39:47-217985 core-10229 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:41:00-698496 core-19955 ERROR Received PING from ` S959' for different identity: I am `7EN5', PONG identity: ` UJOA' Apr 12 14:41:00-698551 core-19955 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:41:02-308687 core-31121 ERROR Received PING from ` RRPC' for different identity: I am `AJ7L', PONG identity: ` 9A7M' Apr 12 14:41:02-339676 core-31121 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:42:13-307191 core-15149 ERROR Received PING from ` QNKU' for different identity: I am `H5GH', PONG identity: ` 4N0V' Apr 12 14:42:13-349603 core-15149 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:42:21-855336 core-11423 ERROR Received PING from ` 96T8' for different identity: I am `4NO4', PONG identity: ` P7O9' Apr 12 14:42:21-858590 core-11423 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:42:39-583592 core-20510 ERROR Received PING from ` LARQ' for different identity: I am `44KR', PONG identity: ` 2KD6' Apr 12 14:42:39-583650 core-20510 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:42:44-031509 core-14142 ERROR Received PING from ` 8LDI' for different identity: I am `JEQ2', PONG identity: ` 4JR7' Apr 12 14:42:44-037717 core-14142 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:42:45-142017 core-6250 ERROR Received PING from ` PDSJ' for different identity: I am `TPAO', PONG identity: ` S3B1' Apr 12 14:42:45-163016 core-6250 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:43:36-850264 core-9124 ERROR Received PING from ` 2JS8' for different identity: I am `NTQN', PONG identity: ` TCVA' Apr 12 14:43:36-926110 core-9124 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:44:16-407342 core-31542 ERROR Received PING from ` P49F' for different identity: I am `NCDO', PONG identity: ` TQOV' Apr 12 14:44:16-414806 core-31542 WARNING External protocol violation detected at gnunet-service-core_kx.c:962. Apr 12 14:51:25-822971 nse-profiler-5949 WARNING Round 3, doing nothing! Apr 12 14:51:25-823227 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 0 Apr 12 14:51:25-823479 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 400 Apr 12 14:51:25-823627 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 800 Apr 12 14:51:25-823701 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1200 Apr 12 14:51:25-823799 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1600 Apr 12 14:51:25-823910 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2000 Apr 12 14:51:25-824003 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2400 Apr 12 14:51:25-824103 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2800 Apr 12 14:51:25-824303 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3200 Apr 12 14:51:25-824387 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3600 Apr 12 15:23:25-849453 nse-profiler-5949 WARNING Round 4, doing nothing! Apr 12 15:23:25-849629 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 0 Apr 12 15:23:25-849738 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 400 Apr 12 15:23:25-849819 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 800 Apr 12 15:23:25-849875 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1200 Apr 12 15:23:25-849938 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 1600 Apr 12 15:23:25-850010 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2000 Apr 12 15:23:25-850081 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2400 Apr 12 15:23:25-850137 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 2800 Apr 12 15:23:25-850233 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3200 Apr 12 15:23:25-850280 nse-profiler-5949 WARNING nse-profiler: connecting to nse service of peer 3600 As it shows, some rounds it happen, some rounds it doesn't. It seems to happen only the PCU peaks to 100% for longer than ~5 seconds. | ||||
| Steps To Reproduce | Run nse_profiles with 4000 peers, wait. | ||||
| Tags | No tags attached. | ||||
| related to | 0001969 | closed | Christian Grothoff | Assertion in crypto & core |
|
|
Last sencence was supposed to read "longer that approx 5 seconds." |
|
|
This is actually most likely not core. The error says that peer A got a message (PONG) which was for peer B. So either testing/ messed up with setting up unique paths/port numbers or (just as likely) transport messed up the transmission. Naturally, both are really bad. |
|
|
See 0001969, same fix should apply here (bug from peerinfo) |
| Date Modified | Username | Field | Change |
|---|---|---|---|
| 2012-04-12 15:25 | Bart Polot | New Issue | |
| 2012-04-12 15:25 | Bart Polot | Status | new => assigned |
| 2012-04-12 15:25 | Bart Polot | Assigned To | => Christian Grothoff |
| 2012-04-12 15:26 | Bart Polot | Note Added: 0005713 | |
| 2012-04-18 15:46 | Christian Grothoff | Relationship added | related to 0001969 |
| 2012-04-18 15:47 | Christian Grothoff | Note Added: 0005721 | |
| 2012-04-18 15:47 | Christian Grothoff | Assigned To | Christian Grothoff => |
| 2012-04-18 15:47 | Christian Grothoff | Status | assigned => acknowledged |
| 2012-05-06 20:45 | Christian Grothoff | Note Added: 0005794 | |
| 2012-05-06 20:45 | Christian Grothoff | Status | acknowledged => resolved |
| 2012-05-06 20:45 | Christian Grothoff | Fixed in Version | => 0.9.3 |
| 2012-05-06 20:45 | Christian Grothoff | Resolution | open => fixed |
| 2012-05-06 20:45 | Christian Grothoff | Assigned To | => Christian Grothoff |
| 2012-05-06 20:45 | Christian Grothoff | Target Version | => 0.9.3 |
| 2012-06-02 19:15 | Christian Grothoff | Status | resolved => closed |
