Name Theory_2363-878588-22_0
Workunit 1979760
Created 4 Feb 2020, 20:20:45 UTC
Sent 4 Feb 2020, 21:27:44 UTC
Report deadline 14 Feb 2020, 21:27:44 UTC
Received 18 Feb 2020, 18:51:02 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 3362
Run time 21 hours 26 min 3 sec
CPU time 20 hours 27 min 22 sec
Validate state Task was reported too late to validate
Credit 0.00
Device peak FLOPS 3.04 GFLOPS
Application version Theory Simulation v5.20 (vbox64_theory)
windows_x86_64
Peak working set size 72.45 MB
Peak swap size 101.48 MB
Peak disk usage 1.81 GB

Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2020-02-04 22:28:29 (2960): Detected: vboxwrapper 26197
2020-02-04 22:28:29 (2960): Detected: BOINC client v7.7
2020-02-04 22:28:30 (2960): Detected: VirtualBox VboxManage Interface (Version: 5.2.34)
2020-02-04 22:28:31 (2960): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-02-04 22:28:31 (2960): Successfully copied 'init_data.xml' to the shared directory.
2020-02-04 22:28:31 (2960): Successfully copied 'input' to the shared directory.
2020-02-04 22:28:34 (2960): Create VM. (boinc_db6b800166cd1e53, slot#5)
2020-02-04 22:28:36 (2960): Setting Memory Size for VM. (630MB)
2020-02-04 22:28:37 (2960): Setting CPU Count for VM. (1)
2020-02-04 22:28:38 (2960): Setting Chipset Options for VM.
2020-02-04 22:28:38 (2960): Setting Boot Options for VM.
2020-02-04 22:28:39 (2960): Setting Network Configuration for NAT.
2020-02-04 22:28:40 (2960): Enabling VM Network Access.
2020-02-04 22:28:41 (2960): Disabling USB Support for VM.
2020-02-04 22:28:43 (2960): Disabling COM Port Support for VM.
2020-02-04 22:28:44 (2960): Disabling LPT Port Support for VM.
2020-02-04 22:28:44 (2960): Disabling Audio Support for VM.
2020-02-04 22:28:45 (2960): Disabling Clipboard Support for VM.
2020-02-04 22:28:46 (2960): Disabling Drag and Drop Support for VM.
2020-02-04 22:28:46 (2960): Adding storage controller(s) to VM.
2020-02-04 22:28:47 (2960): Adding virtual disk drive to VM. (vm_image.vdi)
2020-02-04 22:28:48 (2960): Adding VirtualBox Guest Additions to VM.
2020-02-04 22:28:50 (2960): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-02-04 22:28:50 (2960): forwarding host port 55676 to guest port 80
2020-02-04 22:28:50 (2960): Enabling remote desktop for VM.
2020-02-04 22:28:51 (2960): Enabling shared directory for VM.
2020-02-04 22:28:52 (2960): Starting VM using VBoxManage interface. (boinc_db6b800166cd1e53, slot#5)
2020-02-04 22:29:02 (2960): Successfully started VM. (PID = '5784')
2020-02-04 22:29:02 (2960): Reporting VM Process ID to BOINC.
2020-02-04 22:29:02 (2960): Guest Log: BIOS: VirtualBox 5.2.34

2020-02-04 22:29:02 (2960): Guest Log: CPUID EDX: 0x078bfbff

2020-02-04 22:29:02 (2960): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-02-04 22:29:02 (2960): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-02-04 22:29:02 (2960): Detected: Web Application Enabled (http://localhost:55676)
2020-02-04 22:29:02 (2960): Detected: Remote Desktop Enabled (localhost:55678)
2020-02-04 22:29:02 (2960): Preference change detected
2020-02-04 22:29:02 (2960): Setting CPU throttle for VM. (100%)
2020-02-04 22:29:02 (2960): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-02-04 22:29:04 (2960): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-02-04 22:29:04 (2960): Guest Log: BIOS: Booting from Hard Disk...

2020-02-04 22:29:07 (2960): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-02-04 22:29:07 (2960): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-02-04 22:29:43 (2960): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-02-04 22:29:43 (2960): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-02-04 22:29:51 (2960): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-02-04 22:29:51 (2960): Guest Log: 00:00:00.000510 main     Log opened 2020-02-04T21:29:51.500248000Z

2020-02-04 22:29:51 (2960): Guest Log: 00:00:00.001446 main     OS Product: Linux

2020-02-04 22:29:51 (2960): Guest Log: 00:00:00.002709 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-02-04 22:29:51 (2960): Guest Log: 00:00:00.002842 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-02-04 22:29:51 (2960): Guest Log: 00:00:00.002975 main     Executable: /usr/sbin/VBoxService

2020-02-04 22:29:51 (2960): Guest Log: 00:00:00.002979 main     Process ID: 3207

2020-02-04 22:29:51 (2960): Guest Log: 00:00:00.002983 main     Package type: LINUX_64BITS_GENERIC

2020-02-04 22:29:51 (2960): Guest Log: 00:00:00.021804 main     5.2.6 r120293 started. Verbose level = 0

2020-02-04 22:30:37 (2960): Guest Log: 22:30:36 CET +01:00 2020-02-04: cranky: [INFO] Detected Theory App

2020-02-04 22:30:37 (2960): Guest Log: 22:30:36 CET +01:00 2020-02-04: cranky: [INFO] Checking CVMFS.

2020-02-04 22:31:00 (2960): Guest Log: 22:31:00 CET +01:00 2020-02-04: cranky: [INFO] Checking runc.

2020-02-04 22:31:00 (2960): Guest Log: 22:31:00 CET +01:00 2020-02-04: cranky: [INFO] Creating the filesystem.

2020-02-04 22:31:00 (2960): Guest Log: 22:31:00 CET +01:00 2020-02-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-02-04 22:31:00 (2960): Guest Log: 22:31:01 CET +01:00 2020-02-04: cranky: [INFO] Updating config.json.

2020-02-04 22:31:01 (2960): Guest Log: 22:31:01 CET +01:00 2020-02-04: cranky: [INFO] Running Container 'runc'.

2020-02-04 22:31:02 (2960): Guest Log: job: htmld=/shared/html/job

2020-02-04 22:31:03 (2960): Guest Log: 22:31:03 CET +01:00 2020-02-04: cranky: [INFO] ===> [runRivet] Tue Feb  4 21:31:02 UTC 2020 [boinc ppbar jets 1960 140 - pythia8 8.235 fischerPP2 100000 22]

2020-02-05 00:01:29 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-05 17:57:58 (2960): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_db6b800166cd1e53" resume
Output:
VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp

2020-02-05 17:57:59 (2960): Guest Log: 01:31:42.650913 timesync vgsvcTimeSyncWorker: Radical host time change: 64 586 691 000 000ns (HostNow=1 580 921 870 735 000 000 ns HostLast=1 580 857 284 044 000 000 ns)

2020-02-05 17:57:59 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-05 17:58:00 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-05 19:00:33 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-05 19:00:35 (2960): Guest Log: 01:31:52.684019 timesync vgsvcTimeSyncWorker: Radical host time change: 3 763 515 000 000ns (HostNow=1 580 925 634 250 000 000 ns HostLast=1 580 921 870 735 000 000 ns)

2020-02-05 19:00:35 (2960): Guest Log: 01:31:52.684145 timesync vgsvcTimeSyncWorker: Radical guest time change: 64 586 744 004 000ns (GuestNow=1 580 921 880 796 403 000 ns GuestLast=1 580 857 294 052 399 000 ns fSetTimeLastLoop=true )

2020-02-05 19:00:45 (2960): Guest Log: 01:32:02.685093 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 763 454 689 000ns (GuestNow=1 580 925 644 251 092 000 ns GuestLast=1 580 921 880 796 403 000 ns fSetTimeLastLoop=true )

2020-02-05 19:09:34 (2960): Status Report: Job Duration: '864000.000000'
2020-02-05 19:09:34 (2960): Status Report: Elapsed Time: '6000.000000'
2020-02-05 19:09:34 (2960): Status Report: CPU Time: '6030.687500'
2020-02-05 20:50:47 (2960): Status Report: Job Duration: '864000.000000'
2020-02-05 20:50:47 (2960): Status Report: Elapsed Time: '12000.000000'
2020-02-05 20:50:47 (2960): Status Report: CPU Time: '12099.609375'
2020-02-05 22:23:57 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-05 22:24:55 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-05 22:26:56 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-05 22:27:56 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-05 22:28:56 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-05 22:29:56 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-05 22:31:57 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-05 22:32:57 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-05 22:34:58 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-05 22:35:59 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-05 22:37:05 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-06 17:59:11 (2960): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_db6b800166cd1e53" resume
Output:
VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp

2020-02-06 17:59:11 (2960): Guest Log: 05:03:29.563352 timesync vgsvcTimeSyncWorker: Radical host time change: 69 722 902 000 000ns (HostNow=1 581 008 340 642 000 000 ns HostLast=1 580 938 617 740 000 000 ns)

2020-02-06 17:59:11 (2960): Guest Log: 05:03:39.577104 timesync vgsvcTimeSyncWorker: Radical guest time change: 70 019 526 440 000ns (GuestNow=1 581 008 350 655 767 000 ns GuestLast=1 580 938 331 129 327 000 ns fSetTimeLastLoop=true )

2020-02-06 17:59:11 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-06 17:59:12 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-09 20:11:38 (2960): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-09 20:11:46 (2960): Status Report: Job Duration: '864000.000000'
2020-02-09 20:11:46 (2960): Status Report: Elapsed Time: '18000.000000'
2020-02-09 20:11:46 (2960): Status Report: CPU Time: '18188.156250'
2020-02-09 20:11:47 (2960): Guest Log: 05:03:49.577830 timesync vgsvcTimeSyncWorker: Radical host time change: 267 155 704 000 000ns (HostNow=1 581 275 506 357 000 000 ns HostLast=1 581 008 350 653 000 000 ns)

2020-02-09 20:11:57 (2960): Guest Log: 05:03:59.581793 timesync vgsvcTimeSyncWorker: Radical guest time change: 267 155 704 545 000ns (GuestNow=1 581 275 516 360 989 000 ns GuestLast=1 581 008 360 656 444 000 ns fSetTimeLastLoop=true )

2020-02-09 20:12:31 (2960): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-12 18:52:07 (2960): Stopping VM.
2020-02-12 18:52:07 (2960): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_db6b800166cd1e53" savestate
Output:

2020-02-12 18:52:07 (2960): VM did not stop when requested.
2020-02-12 18:52:07 (2960): VM was successfully terminated.
2020-02-12 23:05:37 (2868): Detected: vboxwrapper 26197
2020-02-12 23:05:37 (2868): Detected: BOINC client v7.7
2020-02-12 23:05:39 (2868): Detected: VirtualBox VboxManage Interface (Version: 5.2.34)
2020-02-12 23:05:39 (2868): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-02-12 23:05:40 (2868): Starting VM using VBoxManage interface. (boinc_db6b800166cd1e53, slot#5)
2020-02-12 23:05:51 (2868): Successfully started VM. (PID = '3720')
2020-02-12 23:05:51 (2868): Reporting VM Process ID to BOINC.
2020-02-12 23:05:51 (2868): Guest Log: BIOS: VirtualBox 5.2.34

2020-02-12 23:05:51 (2868): Guest Log: CPUID EDX: 0x078bfbff

2020-02-12 23:05:51 (2868): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-02-12 23:05:51 (2868): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-02-12 23:05:51 (2868): Detected: Web Application Enabled (http://localhost:55676)
2020-02-12 23:05:51 (2868): Detected: Remote Desktop Enabled (localhost:55678)
2020-02-12 23:05:51 (2868): Status Report: Job Duration: '864000.000000'
2020-02-12 23:05:51 (2868): Status Report: Elapsed Time: '18041.000000'
2020-02-12 23:05:51 (2868): Status Report: CPU Time: '18228.640625'
2020-02-12 23:05:51 (2868): Preference change detected
2020-02-12 23:05:51 (2868): Setting CPU throttle for VM. (100%)
2020-02-12 23:05:52 (2868): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-02-12 23:05:53 (2868): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-02-12 23:05:53 (2868): Guest Log: BIOS: Booting from Hard Disk...

2020-02-12 23:05:56 (2868): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-02-12 23:05:56 (2868): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-02-12 23:06:39 (2868): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-02-12 23:06:39 (2868): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-02-12 23:06:48 (2868): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-02-12 23:06:48 (2868): Guest Log: 00:00:00.000319 main     Log opened 2020-02-12T22:06:47.545644000Z

2020-02-12 23:06:48 (2868): Guest Log: 00:00:00.001173 main     OS Product: Linux

2020-02-12 23:06:48 (2868): Guest Log: 00:00:00.003169 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-02-12 23:06:48 (2868): Guest Log: 00:00:00.004580 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-02-12 23:06:48 (2868): Guest Log: 00:00:00.004779 main     Executable: /usr/sbin/VBoxService

2020-02-12 23:06:48 (2868): Guest Log: 00:00:00.004784 main     Process ID: 3213

2020-02-12 23:06:48 (2868): Guest Log: 00:00:00.004787 main     Package type: LINUX_64BITS_GENERIC

2020-02-12 23:06:48 (2868): Guest Log: 00:00:00.013305 main     5.2.6 r120293 started. Verbose level = 0

2020-02-12 23:07:44 (2868): Guest Log: 23:07:43 CET +01:00 2020-02-12: cranky: [INFO] Detected Theory App

2020-02-12 23:07:44 (2868): Guest Log: 23:07:43 CET +01:00 2020-02-12: cranky: [INFO] Checking CVMFS.

2020-02-12 23:08:12 (2868): Guest Log: 23:08:11 CET +01:00 2020-02-12: cranky: [INFO] Checking runc.

2020-02-12 23:08:13 (2868): Guest Log: 23:08:12 CET +01:00 2020-02-12: cranky: [INFO] Creating the filesystem.

2020-02-12 23:08:13 (2868): Guest Log: 23:08:12 CET +01:00 2020-02-12: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-02-12 23:08:13 (2868): Guest Log: 23:08:12 CET +01:00 2020-02-12: cranky: [INFO] Updating config.json.

2020-02-12 23:08:14 (2868): Guest Log: 23:08:13 CET +01:00 2020-02-12: cranky: [INFO] Running Container 'runc'.

2020-02-12 23:08:16 (2868): Guest Log: job: htmld=/shared/html/job

2020-02-12 23:08:18 (2868): Guest Log: 23:08:17 CET +01:00 2020-02-12: cranky: [INFO] ===> [runRivet] Wed Feb 12 22:08:16 UTC 2020 [boinc ppbar jets 1960 140 - pythia8 8.235 fischerPP2 100000 22]

2020-02-12 23:09:25 (2868): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-13 18:25:43 (2868): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_db6b800166cd1e53" resume
Output:
VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp

2020-02-13 18:25:46 (2868): Guest Log: 00:02:43.542339 timesync vgsvcTimeSyncWorker: Radical host time change: 69 376 362 000 000ns (HostNow=1 581 614 734 446 000 000 ns HostLast=1 581 545 358 084 000 000 ns)

2020-02-13 18:25:47 (2868): Guest Log: 00:02:53.670986 timesync vgsvcTimeSyncWorker: Radical guest time change: 69 374 140 163 000ns (GuestNow=1 581 614 744 732 879 000 ns GuestLast=1 581 545 370 592 716 000 ns fSetTimeLastLoop=true )

2020-02-13 18:25:47 (2868): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-13 20:05:52 (2868): Status Report: Job Duration: '864000.000000'
2020-02-13 20:05:52 (2868): Status Report: Elapsed Time: '24041.140022'
2020-02-13 20:05:52 (2868): Status Report: CPU Time: '24219.218750'
2020-02-13 21:47:35 (2868): Status Report: Job Duration: '864000.000000'
2020-02-13 21:47:35 (2868): Status Report: Elapsed Time: '30041.140022'
2020-02-13 21:47:35 (2868): Status Report: CPU Time: '30077.625000'
2020-02-13 23:29:13 (2868): Status Report: Job Duration: '864000.000000'
2020-02-13 23:29:13 (2868): Status Report: Elapsed Time: '36041.140022'
2020-02-13 23:29:13 (2868): Status Report: CPU Time: '35938.328125'
2020-02-13 23:34:52 (2868): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-14 19:21:17 (2868): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_db6b800166cd1e53" resume
Output:
VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp

2020-02-14 19:21:18 (2868): Guest Log: 05:12:04.228987 timesync vgsvcTimeSyncWorker: Radical host time change: 71 187 933 000 000ns (HostNow=1 581 704 471 055 000 000 ns HostLast=1 581 633 283 122 000 000 ns)

2020-02-14 19:21:18 (2868): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-14 19:21:23 (2868): Guest Log: 05:12:14.230378 timesync vgsvcTimeSyncWorker: Radical guest time change: 71 190 094 512 000ns (GuestNow=1 581 704 483 228 268 000 ns GuestLast=1 581 633 293 133 756 000 ns fSetTimeLastLoop=true )

2020-02-14 20:57:41 (2868): Status Report: Job Duration: '864000.000000'
2020-02-14 20:57:41 (2868): Status Report: Elapsed Time: '42041.140022'
2020-02-14 20:57:41 (2868): Status Report: CPU Time: '41799.015625'
2020-02-14 22:39:16 (2868): Status Report: Job Duration: '864000.000000'
2020-02-14 22:39:16 (2868): Status Report: Elapsed Time: '48041.140022'
2020-02-14 22:39:16 (2868): Status Report: CPU Time: '47612.828125'
2020-02-14 23:14:50 (2868): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-16 13:50:24 (2868): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_db6b800166cd1e53" resume
Output:
VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp

2020-02-16 13:50:25 (2868): Guest Log: 09:05:41.501789 timesync vgsvcTimeSyncWorker: Radical host time change: 138 927 923 000 000ns (HostNow=1 581 857 408 415 000 000 ns HostLast=1 581 718 480 492 000 000 ns)

2020-02-16 13:50:25 (2868): Guest Log: 09:05:51.510473 timesync vgsvcTimeSyncWorker: Radical guest time change: 138 927 924 019 000ns (GuestNow=1 581 857 418 423 628 000 ns GuestLast=1 581 718 490 499 609 000 ns fSetTimeLastLoop=true )

2020-02-16 13:50:25 (2868): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-16 13:50:26 (2868): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-17 19:51:54 (2868): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-17 19:51:56 (2868): Guest Log: 09:06:01.511965 timesync vgsvcTimeSyncWorker: Radical host time change: 108 097 947 000 000ns (HostNow=1 581 965 516 371 000 000 ns HostLast=1 581 857 418 424 000 000 ns)

2020-02-17 19:52:06 (2868): Guest Log: 09:06:11.513418 timesync vgsvcTimeSyncWorker: Radical guest time change: 108 097 947 291 000ns (GuestNow=1 581 965 526 372 477 000 ns GuestLast=1 581 857 428 425 186 000 ns fSetTimeLastLoop=true )

2020-02-17 20:58:16 (2868): Status Report: Job Duration: '864000.000000'
2020-02-17 20:58:16 (2868): Status Report: Elapsed Time: '54041.140022'
2020-02-17 20:58:16 (2868): Status Report: CPU Time: '53456.437500'
2020-02-17 22:40:07 (2868): Status Report: Job Duration: '864000.000000'
2020-02-17 22:40:07 (2868): Status Report: Elapsed Time: '60041.140022'
2020-02-17 22:40:07 (2868): Status Report: CPU Time: '59214.203125'
2020-02-18 00:21:42 (2868): Status Report: Job Duration: '864000.000000'
2020-02-18 00:21:42 (2868): Status Report: Elapsed Time: '66041.140022'
2020-02-18 00:21:42 (2868): Status Report: CPU Time: '64874.468750'
2020-02-18 00:25:33 (2868): VM state change detected. (old = 'Running', new = 'Paused')
2020-02-18 17:10:01 (2868): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_db6b800166cd1e53" resume
Output:
VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp

2020-02-18 17:10:02 (2868): Guest Log: 13:39:43.356157 timesync vgsvcTimeSyncWorker: Radical host time change: 60 274 594 000 000ns (HostNow=1 582 042 198 445 000 000 ns HostLast=1 581 981 923 851 000 000 ns)

2020-02-18 17:10:02 (2868): VM state change detected. (old = 'Paused', new = 'Running')
2020-02-18 17:10:08 (2868): Guest Log: 13:39:53.362033 timesync vgsvcTimeSyncWorker: Radical guest time change: 60 270 235 698 000ns (GuestNow=1 582 042 208 450 892 000 ns GuestLast=1 581 981 938 215 194 000 ns fSetTimeLastLoop=true )

2020-02-18 18:47:48 (2868): Status Report: Job Duration: '864000.000000'
2020-02-18 18:47:48 (2868): Status Report: Elapsed Time: '72041.140022'
2020-02-18 18:47:48 (2868): Status Report: CPU Time: '70473.140625'
2020-02-18 19:45:36 (2868): Guest Log: job: CPU usage:

2020-02-18 19:45:36 (2868): Guest Log: 0m0.028s 0m0.044s

2020-02-18 19:45:36 (2868): Guest Log: 947m27.939s 8m37.332s

2020-02-18 19:45:37 (2868): Guest Log: 19:45:37 CET +01:00 2020-02-18: cranky: [INFO] Container 'runc' finished with status code 0.

2020-02-18 19:45:37 (2868): Guest Log: 19:45:37 CET +01:00 2020-02-18: cranky: [INFO] Preparing output.

2020-02-18 19:45:39 (2868): Guest Log: [INFO] Job Finished

2020-02-18 19:45:39 (2868): Guest Log: [INFO] Shutting Down.

2020-02-18 19:45:39 (2868): VM Completion File Detected.
2020-02-18 19:45:39 (2868): VM Completion Message: Job Finished
.
2020-02-18 19:45:39 (2868): Powering off VM.
2020-02-18 19:50:41 (2868): VM did not power off when requested.
2020-02-18 19:50:41 (2868): VM was successfully terminated.
2020-02-18 19:50:41 (2868): Deregistering VM. (boinc_db6b800166cd1e53, slot#5)
2020-02-18 19:50:43 (2868): Removing network bandwidth throttle group from VM.
2020-02-18 19:50:43 (2868): Removing VM from VirtualBox.
19:50:49 (2868): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN