Merkwürdiges Verhalten - Fortschrittsanzeige

[bbmz]

Eigentlich dachte ich, dass alle neuen VM-Tasks um 98,765 % pendeln sollen, falls diese zwar die vorhergesagte Zeit absolviert haben, aber noch nicht fertig berechnet sind.

Allerdings tun dies nur zwei der drei zur Zeit soweit fortgeschrittenen Tasks. Während die Aufgaben 6330891 und 6330833 um 98,765 % pendeln, steigt die Fortschrittsanzeige von 6330843 fröhlich weiter und ist derzeit bei 99,338 % angelangt.

Irgendetwas scheint also nur teilweise so zu funktionieren, wie gedacht...

bbmz

[ChristianB]

Das ist schon richtig. Der dritte wird bald auf 98,765% zurückspringen.

[Rasch]

Hat jemand Erfahrung wie lange die Fortschrittsanzeige bei 98,765 stehen bleibt?

Meine WU steht jetzt seit ziemlich genau 200 Stunden bei diesem Wert. Die Restlaufzeit wurde anfangs mit 39 Stunden angezeigt und hat sich in den 200 Stunden auf 37 1/2 Stunden reduziert.

[Michael H.W. Weber]

Ist normal. Einfach weiterrechnen.

Michael.

[Matthias Lehmkuhl]

Habe auch ein Problem mit dem Fortschrittsbalken,
Meiner steht bei 25,665%
Leider wird auch die Datei progress.txt seit langem nicht mehr aktualisiert, ist mir aber erst gestern aufgefallen.
Die CPU läuft für den CPU Core auf 100%, somit hatte ich mir bisher nichts dabei gedacht.
Bin aktuell bei einer CPU Laufzeit von knapp 79 Tagen.

Wenn ich mich mit Remote Desktop auf die VM verbinde, sehe ich folgende Meldung 8 mal mit 120 Sekunden Zeitabstand:
INFO: task bash:20408 blocked for more than 120 seconds
"echo 0 > /proc/sys/kernal/hung_task_timeout_secs" disables this message.

Diese Meldung wurde aber auch schon länger nicht mehr aktualisiert.
Letzter Zeiteintrag [3276329.480217]

http://www.rnaworld.de/rnaworld/result. ... d=14925024
cmsvm_GA-p[e20-30MB_Lin64f]_1_Oryza-sativa-Japonica-Group_AP008211.lin.EMBL_RF00028_Intron_gpI_1349111823_50792
cmsearch VM (VirtualBox) 1.0.2 v1.12 (vbox64)

[ChristianB]

Das schaut nicht gut aus. Von der Meldung in der VM höre ich zum ersten mal. Wenn ein Neustart des Rechners nichts bringt (progress.txt wird weiterhin nicht aktualisiert) dann bitte abbrechen.

[Matthias Lehmkuhl]

Leider hat der Neustart nichts gebracht, habe das result abgebrochen.

Dann warte ich mal auf das nächste result

[Rasch]

Meine WU hat jetzt schön 3000 Stunden lang bei 98,765 % gestanden. Hatte allerdings leider gerade einen Rechnerabsturz. Nach dem Hochfahren steht die Fortschrittsanzeige im Boinc-Manager nun bei 0 %. mittlerweile ist sie auf 0,073 % weitergewandert. Bedeutet dies dass die bisherigen 4400 Stunden "für die Katz" waren?

[ChristianB]

Kannst du mir den Auszug aus der stderr.txt Datei schicken. So 20 Zeilen vorher und nachher würden mir schon reichen. Ansonsten nehme ich auch die ganze Datei wenn die nicht zu groß ist.

[Stimpy]

Hallo, nach 60 Tagen ohne Probleme ist meine WU bis auf 98,765% hochgearbeitet. Wie oben schon beschrieben bleibt bei mir auch seit 5 Tagen der Fortschritt gleich. Die verbleibende Zeit läuft 10 sec vor und springt wieder zurück.
ABER:
Als ich in den Task schaute musste ich mit erschrecken feststellen, dass da überhaupt keine Meldung verzeichnet ist! Runtime 0.00? stderr.txt leer?
http://www.rnaworld.de/rnaworld/result. ... d=14952188
Wie ist die Expertenmeinung? Trotzdem weiter rechnen?
In der Konsole steht als letzte Meldung: "worker process with PID: 1950 started", sonst nix auffälliges.

[ChristianB]

Eine leere stderr.txt ist tatsächlich komisch. Du musst dir mal die Zeitstempel der progress.txt anschauen. Wenn sich der noch verändert dann ist alls ok. Die Meldung in der Konsole ist so auch in Ordnung.

[Stimpy]

http://www.rnaworld.de/rnaworld/result. ... d=14952188

WU läuft noch. 10 Mio sec. run time überschritten. Die letzten Zeilen der stderr sehen so aus, alles ok? Wundert mich nur, das online in der Task-Ansicht keine Einträge zu sehen sind.

2017-01-22 10:19:30 (3752): vboxwrapper (7.7.26184): starting
2017-01-22 10:19:30 (3752): Feature: Checkpoint interval offset (304 seconds)
2017-01-22 10:19:30 (3752): Feature: Enabling trickle-ups (Interval: 14400.000000)
2017-01-22 10:19:30 (3752): Detected: VirtualBox COM Interface (Version: 5.0.28)
2017-01-22 10:19:30 (3752): Detected: Minimum checkpoint interval (1800.000000 seconds)
2017-01-22 10:19:30 (3752): Restore from previously saved snapshot.
2017-01-22 10:19:30 (3752): Restore completed.
2017-01-22 10:19:30 (3752): Starting VM. (boinc_04ede23e58e1c884, slot#15)
2017-01-22 10:19:49 (3752): Successfully started VM. (PID = '5216')
2017-01-22 10:19:49 (3752): Reporting VM Process ID to BOINC.
2017-01-22 10:19:59 (3752): VM state change detected. (old = 'poweroff', new = 'running')
2017-01-22 10:20:09 (3752): Detected: Remote Desktop Enabled (localhost:63055)
2017-01-22 10:20:19 (3752): Status Report: Elapsed Time: '10044902.972509'
2017-01-22 10:20:19 (3752): Status Report: CPU Time: '10004445.232999'
2017-01-22 10:20:19 (3752): Status Report: Trickle-Up Event.
2017-01-22 10:20:19 (3752): Preference change detected
2017-01-22 10:20:19 (3752): Setting CPU throttle for VM. (100%)
2017-01-22 10:20:19 (3752): Setting network throttle for VM. (700KB)
2017-01-22 10:20:19 (3752): Setting checkpoint interval to 1800 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 1800 seconds))
2017-01-22 10:55:31 (3752): Creating new snapshot for VM.
2017-01-22 10:55:47 (3752): Deleting stale snapshot.
2017-01-22 10:55:47 (3752): Checkpoint completed.
2017-01-22 11:25:39 (3752): Creating new snapshot for VM.
2017-01-22 11:25:55 (3752): Deleting stale snapshot.
2017-01-22 11:25:55 (3752): Checkpoint completed.
2017-01-22 11:55:47 (3752): Creating new snapshot for VM.
2017-01-22 11:56:03 (3752): Deleting stale snapshot.
2017-01-22 11:56:03 (3752): Checkpoint completed.
2017-01-22 12:00:24 (3752): Status Report: Elapsed Time: '10050907.690002'
2017-01-22 12:00:24 (3752): Status Report: CPU Time: '10010385.264249'
2017-01-22 12:25:56 (3752): Creating new snapshot for VM.
2017-01-22 12:26:12 (3752): Deleting stale snapshot.
2017-01-22 12:26:12 (3752): Checkpoint completed.
2017-01-22 12:56:04 (3752): Creating new snapshot for VM.
2017-01-22 12:56:20 (3752): Deleting stale snapshot.
2017-01-22 12:56:20 (3752): Checkpoint completed.
2017-01-22 13:26:13 (3752): Creating new snapshot for VM.
2017-01-22 13:26:28 (3752): Deleting stale snapshot.
2017-01-22 13:26:29 (3752): Checkpoint completed.
2017-01-22 13:40:30 (3752): Status Report: Elapsed Time: '10056913.799081'
2017-01-22 13:40:30 (3752): Status Report: CPU Time: '10016411.107999'
2017-01-22 13:56:21 (3752): Creating new snapshot for VM.
2017-01-22 13:56:36 (3752): Deleting stale snapshot.
2017-01-22 13:56:37 (3752): Checkpoint completed.
2017-01-22 14:20:28 (3752): Status Report: Trickle-Up Event.
2017-01-22 14:26:29 (3752): Creating new snapshot for VM.
2017-01-22 14:26:45 (3752): Deleting stale snapshot.
2017-01-22 14:26:45 (3752): Checkpoint completed.
2017-01-22 14:56:37 (3752): Creating new snapshot for VM.
2017-01-22 14:56:52 (3752): Deleting stale snapshot.
2017-01-22 14:56:53 (3752): Checkpoint completed.
2017-01-22 15:20:34 (3752): Status Report: Elapsed Time: '10062918.490356'
2017-01-22 15:20:34 (3752): Status Report: CPU Time: '10022350.607999'
2017-01-22 15:26:45 (3752): Creating new snapshot for VM.
2017-01-22 15:27:00 (3752): Deleting stale snapshot.
2017-01-22 15:27:01 (3752): Checkpoint completed.
2017-01-22 15:56:53 (3752): Creating new snapshot for VM.
2017-01-22 15:57:09 (3752): Deleting stale snapshot.
2017-01-22 15:57:09 (3752): Checkpoint completed.
2017-01-22 16:27:01 (3752): Creating new snapshot for VM.
2017-01-22 16:27:17 (3752): Deleting stale snapshot.
2017-01-22 16:27:17 (3752): Checkpoint completed.
2017-01-22 16:57:09 (3752): Creating new snapshot for VM.
2017-01-22 16:57:25 (3752): Deleting stale snapshot.
2017-01-22 16:57:25 (3752): Checkpoint completed.
2017-01-22 17:00:35 (3752): Status Report: Elapsed Time: '10068919.427551'
2017-01-22 17:00:35 (3752): Status Report: CPU Time: '10028311.545499'
2017-01-22 17:27:17 (3752): Creating new snapshot for VM.
2017-01-22 17:27:33 (3752): Deleting stale snapshot.
2017-01-22 17:27:33 (3752): Checkpoint completed.
2017-01-22 17:57:26 (3752): Creating new snapshot for VM.
2017-01-22 17:57:41 (3752): Deleting stale snapshot.
2017-01-22 17:57:42 (3752): Checkpoint completed.
2017-01-22 18:20:33 (3752): Status Report: Trickle-Up Event.