Task 3031237

Name	Theory_2390-1128493-214_0
Workunit	2134708
Created	12 Oct 2021, 22:00:13 UTC
Sent	15 Oct 2021, 2:12:38 UTC
Report deadline	25 Oct 2021, 2:12:38 UTC
Received	15 Oct 2021, 10:48:08 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4484
Run time	5 hours 12 min 57 sec
CPU time	5 hours 10 min 5 sec
Validate state	Valid
Credit	191.53
Device peak FLOPS	4.41 GFLOPS
Application version	Theory Simulation v5.21 (vbox64_theory) windows_x86_64
Peak working set size	61.54 MB
Peak swap size	78.86 MB
Peak disk usage	2.21 GB
Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2021-10-14 21:44:00 (7784): Detected: vboxwrapper 26197
2021-10-14 21:44:00 (7784): Detected: BOINC client v7.7
2021-10-14 21:44:01 (7784): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2021-10-14 21:44:01 (7784): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-10-14 21:44:01 (7784): Successfully copied 'init_data.xml' to the shared directory.
2021-10-14 21:44:01 (7784): Successfully copied 'input' to the shared directory.
2021-10-14 21:44:02 (7784): Create VM. (boinc_a6afe8ec0613c89a, slot#2)
2021-10-14 21:44:02 (7784): Setting Memory Size for VM. (630MB)
2021-10-14 21:44:03 (7784): Setting CPU Count for VM. (1)
2021-10-14 21:44:03 (7784): Setting Chipset Options for VM.
2021-10-14 21:44:03 (7784): Setting Boot Options for VM.
2021-10-14 21:44:03 (7784): Setting Network Configuration for NAT.
2021-10-14 21:44:04 (7784): Enabling VM Network Access.
2021-10-14 21:44:04 (7784): Disabling USB Support for VM.
2021-10-14 21:44:04 (7784): Disabling COM Port Support for VM.
2021-10-14 21:44:05 (7784): Disabling LPT Port Support for VM.
2021-10-14 21:44:05 (7784): Disabling Audio Support for VM.
2021-10-14 21:44:05 (7784): Disabling Clipboard Support for VM.
2021-10-14 21:44:05 (7784): Disabling Drag and Drop Support for VM.
2021-10-14 21:44:06 (7784): Adding storage controller(s) to VM.
2021-10-14 21:44:06 (7784): Adding virtual disk drive to VM. (vm_image.vdi)
2021-10-14 21:44:06 (7784): Adding VirtualBox Guest Additions to VM.
2021-10-14 21:44:06 (7784): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-10-14 21:44:07 (7784): forwarding host port 54016 to guest port 80
2021-10-14 21:44:07 (7784): Enabling remote desktop for VM.
2021-10-14 21:44:07 (7784): Enabling shared directory for VM.
2021-10-14 21:44:08 (7784): Starting VM using VBoxManage interface. (boinc_a6afe8ec0613c89a, slot#2)
2021-10-14 21:44:12 (7784): Successfully started VM. (PID = '6612')
2021-10-14 21:44:12 (7784): Reporting VM Process ID to BOINC.
2021-10-14 21:44:12 (7784): Guest Log: BIOS: VirtualBox 6.1.26

2021-10-14 21:44:12 (7784): Guest Log: CPUID EDX: 0x178bfbff

2021-10-14 21:44:12 (7784): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-10-14 21:44:12 (7784): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-10-14 21:44:12 (7784): Detected: Web Application Enabled (http://localhost:54016)
2021-10-14 21:44:12 (7784): Detected: Remote Desktop Enabled (localhost:54017)
2021-10-14 21:44:12 (7784): Preference change detected
2021-10-14 21:44:12 (7784): Setting CPU throttle for VM. (100%)
2021-10-14 21:44:12 (7784): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 600 seconds))
2021-10-14 21:44:14 (7784): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-10-14 21:44:14 (7784): Guest Log: BIOS: Booting from Hard Disk...

2021-10-14 21:44:16 (7784): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-10-14 21:44:16 (7784): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-10-14 21:44:44 (7784): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-10-14 21:44:44 (7784): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-10-14 21:44:46 (7784): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2021-10-14 21:44:46 (7784): Guest Log: 00:00:00.000074 main     Log opened 2021-10-15T02:44:51.783606000Z

2021-10-14 21:44:46 (7784): Guest Log: 00:00:00.000161 main     OS Product: Linux

2021-10-14 21:44:46 (7784): Guest Log: 00:00:00.000189 main     OS Release: 4.14.76-13.cernvm.x86_64

2021-10-14 21:44:46 (7784): Guest Log: 00:00:00.000213 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2021-10-14 21:44:46 (7784): Guest Log: 00:00:00.000245 main     Executable: /usr/sbin/VBoxService

2021-10-14 21:44:46 (7784): Guest Log: 00:00:00.000246 main     Process ID: 3195

2021-10-14 21:44:46 (7784): Guest Log: 00:00:00.000246 main     Package type: LINUX_64BITS_GENERIC

2021-10-14 21:44:46 (7784): Guest Log: 00:00:00.003144 main     5.2.6 r120293 started. Verbose level = 0

2021-10-14 21:45:09 (7784): Guest Log: 21:45:14 CDT -05:00 2021-10-14: cranky: [INFO] Detected Theory App

2021-10-14 21:45:09 (7784): Guest Log: 21:45:14 CDT -05:00 2021-10-14: cranky: [INFO] Checking CVMFS.

2021-10-14 21:45:10 (7784): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2021-10-14 21:45:10 (7784): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE

2021-10-14 21:45:10 (7784): Guest Log: 2.5.2.0 4049 0 28328 21260 3 1 266573 4096000 0 65024 0 0 n/a 5 4 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2021-10-14 21:45:11 (7784): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2021-10-14 21:45:12 (7784): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE

2021-10-14 21:45:12 (7784): Guest Log: 2.5.2.0 4027 0 27520 16481 3 2 266573 4096000 0 65024 0 2 -100 6415 1982 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2021-10-14 21:45:12 (7784): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2021-10-14 21:45:13 (7784): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE

2021-10-14 21:45:13 (7784): Guest Log: 2.5.2.0 4097 0 25192 268 3 1 266573 4096000 0 65024 0 0 n/a 4 2 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2021-10-14 21:45:14 (7784): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2021-10-14 21:45:14 (7784): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE

2021-10-14 21:45:14 (7784): Guest Log: 2.5.2.0 4071 0 31444 10547 3 1 266573 4096000 0 65024 0 0 n/a 5350 1777 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2021-10-14 21:45:14 (7784): Guest Log: 21:45:19 CDT -05:00 2021-10-14: cranky: [INFO] Checking runc.

2021-10-14 21:45:14 (7784): Guest Log: 21:45:19 CDT -05:00 2021-10-14: cranky: [INFO] Creating the filesystem.

2021-10-14 21:45:14 (7784): Guest Log: 21:45:19 CDT -05:00 2021-10-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2021-10-14 21:45:14 (7784): Guest Log: 21:45:19 CDT -05:00 2021-10-14: cranky: [INFO] Updating config.json.

2021-10-14 21:45:14 (7784): Guest Log: 21:45:19 CDT -05:00 2021-10-14: cranky: [INFO] Running Container 'runc'.

2021-10-14 21:45:36 (7784): Guest Log: job: htmld=/shared/html/job

2021-10-14 21:45:36 (7784): Guest Log: job: unpack exitcode=0

2021-10-14 21:45:36 (7784): Guest Log: 21:45:42 CDT -05:00 2021-10-14: cranky: [INFO] ===> [runRivet] Fri Oct 15 02:45:41 UTC 2021 [boinc pp jets 7000 80,-,1460 - pythia8 8.243 default-MBR 100000 214]

2021-10-14 22:39:18 (7784): Stopping VM.
2021-10-14 22:40:09 (7784): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_a6afe8ec0613c89a" savestate
Output:

2021-10-14 22:40:09 (7784): VM did not stop when requested.
2021-10-14 22:40:09 (7784): VM was successfully terminated.
2021-10-14 23:12:07 (6916): Detected: vboxwrapper 26197
2021-10-14 23:12:07 (6916): Detected: BOINC client v7.7
2021-10-14 23:12:08 (6916): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2021-10-14 23:12:08 (6916): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-10-14 23:12:08 (6916): Starting VM using VBoxManage interface. (boinc_a6afe8ec0613c89a, slot#2)
2021-10-14 23:12:12 (6916): Successfully started VM. (PID = '764')
2021-10-14 23:12:12 (6916): Reporting VM Process ID to BOINC.
2021-10-14 23:12:12 (6916): Guest Log: BIOS: VirtualBox 6.1.26

2021-10-14 23:12:12 (6916): Guest Log: CPUID EDX: 0x178bfbff

2021-10-14 23:12:13 (6916): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-10-14 23:12:13 (6916): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-10-14 23:12:13 (6916): Detected: Web Application Enabled (http://localhost:54016)
2021-10-14 23:12:13 (6916): Detected: Remote Desktop Enabled (localhost:54017)
2021-10-14 23:12:13 (6916): Preference change detected
2021-10-14 23:12:13 (6916): Setting CPU throttle for VM. (100%)
2021-10-14 23:12:13 (6916): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 600 seconds))
2021-10-14 23:12:15 (6916): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-10-14 23:12:15 (6916): Guest Log: BIOS: Booting from Hard Disk...

2021-10-14 23:12:18 (6916): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-10-14 23:12:18 (6916): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-10-14 23:12:43 (6916): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-10-14 23:12:43 (6916): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-10-14 23:12:46 (6916): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2021-10-14 23:12:46 (6916): Guest Log: 00:00:00.000132 main     Log opened 2021-10-15T04:12:51.626401000Z

2021-10-14 23:12:46 (6916): Guest Log: 00:00:00.000252 main     OS Product: Linux

2021-10-14 23:12:46 (6916): Guest Log: 00:00:00.000283 main     OS Release: 4.14.76-13.cernvm.x86_64

2021-10-14 23:12:46 (6916): Guest Log: 00:00:00.000306 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2021-10-14 23:12:46 (6916): Guest Log: 00:00:00.000329 main     Executable: /usr/sbin/VBoxService

2021-10-14 23:12:46 (6916): Guest Log: 00:00:00.000330 main     Process ID: 3192

2021-10-14 23:12:46 (6916): Guest Log: 00:00:00.000330 main     Package type: LINUX_64BITS_GENERIC

2021-10-14 23:12:46 (6916): Guest Log: 00:00:00.002934 main     5.2.6 r120293 started. Verbose level = 0

2021-10-14 23:13:09 (6916): Guest Log: 23:13:14 CDT -05:00 2021-10-14: cranky: [INFO] Detected Theory App

2021-10-14 23:13:09 (6916): Guest Log: 23:13:14 CDT -05:00 2021-10-14: cranky: [INFO] Checking CVMFS.

2021-10-14 23:13:10 (6916): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2021-10-14 23:13:10 (6916): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE

2021-10-14 23:13:10 (6916): Guest Log: 2.5.2.0 4094 0 28408 21260 3 1 1460279 4096000 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2021-10-14 23:13:11 (6916): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2021-10-14 23:13:14 (6916): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE

2021-10-14 23:13:14 (6916): Guest Log: 2.5.2.0 4067 0 25448 16481 3 2 1460279 4096000 0 65024 0 2 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2021-10-14 23:13:15 (6916): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2021-10-14 23:13:15 (6916): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE

2021-10-14 23:13:15 (6916): Guest Log: 2.5.2.0 4019 0 25180 268 3 1 1460279 4096000 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2021-10-14 23:13:16 (6916): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2021-10-14 23:13:16 (6916): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE

2021-10-14 23:13:16 (6916): Guest Log: 2.5.2.0 4042 0 34496 10548 3 1 1460279 4096000 0 65024 0 0 n/a 5350 2550 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2021-10-14 23:13:16 (6916): Guest Log: 23:13:22 CDT -05:00 2021-10-14: cranky: [INFO] Checking runc.

2021-10-14 23:13:17 (6916): Guest Log: 23:13:22 CDT -05:00 2021-10-14: cranky: [INFO] Creating the filesystem.

2021-10-14 23:13:17 (6916): Guest Log: 23:13:22 CDT -05:00 2021-10-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2021-10-14 23:13:17 (6916): Guest Log: 23:13:22 CDT -05:00 2021-10-14: cranky: [INFO] Updating config.json.

2021-10-14 23:13:17 (6916): Guest Log: 23:13:22 CDT -05:00 2021-10-14: cranky: [INFO] Running Container 'runc'.

2021-10-14 23:13:17 (6916): Guest Log: job: htmld=/shared/html/job

2021-10-14 23:13:17 (6916): Guest Log: job: unpack exitcode=0

2021-10-14 23:13:19 (6916): Guest Log: 23:13:24 CDT -05:00 2021-10-14: cranky: [INFO] ===> [runRivet] Fri Oct 15 04:13:22 UTC 2021 [boinc pp jets 7000 80,-,1460 - pythia8 8.243 default-MBR 100000 214]

2021-10-14 23:59:27 (6916): Status Report: Job Duration: '864000.000000'
2021-10-14 23:59:27 (6916): Status Report: Elapsed Time: '6000.491190'
2021-10-14 23:59:27 (6916): Status Report: CPU Time: '5733.531250'
2021-10-15 00:46:57 (6916): Stopping VM.
2021-10-15 01:19:57 (9400): Detected: vboxwrapper 26197
2021-10-15 01:19:57 (9400): Detected: BOINC client v7.7
2021-10-15 01:19:57 (9400): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2021-10-15 01:19:58 (9400): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-10-15 01:19:58 (9400): Starting VM using VBoxManage interface. (boinc_a6afe8ec0613c89a, slot#2)
2021-10-15 01:20:04 (9400): Successfully started VM. (PID = '4576')
2021-10-15 01:20:04 (9400): Reporting VM Process ID to BOINC.
2021-10-15 01:20:04 (9400): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-10-15 01:20:04 (9400): Detected: Web Application Enabled (http://localhost:54016)
2021-10-15 01:20:04 (9400): Detected: Remote Desktop Enabled (localhost:54017)
2021-10-15 01:20:04 (9400): Status Report: Job Duration: '864000.000000'
2021-10-15 01:20:04 (9400): Status Report: Elapsed Time: '8815.427586'
2021-10-15 01:20:04 (9400): Status Report: CPU Time: '8572.093750'
2021-10-15 01:20:04 (9400): Preference change detected
2021-10-15 01:20:04 (9400): Setting CPU throttle for VM. (100%)
2021-10-15 01:20:04 (9400): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 600 seconds))
2021-10-15 01:20:07 (9400): Guest Log: 01:34:12.121920 timesync vgsvcTimeSyncWorker: Radical host time change: 1 996 229 000 000ns (HostNow=1 634 278 807 226 000 000 ns HostLast=1 634 276 810 997 000 000 ns)

2021-10-15 01:20:17 (9400): Guest Log: 01:34:22.137991 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 993 575 684 000ns (GuestNow=1 634 278 817 253 079 000 ns GuestLast=1 634 276 823 677 395 000 ns fSetTimeLastLoop=true )

2021-10-15 01:53:54 (9400): Stopping VM.
2021-10-15 02:25:47 (8004): Detected: vboxwrapper 26197
2021-10-15 02:25:47 (8004): Detected: BOINC client v7.7
2021-10-15 02:25:48 (8004): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2021-10-15 02:25:48 (8004): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-10-15 02:25:48 (8004): Starting VM using VBoxManage interface. (boinc_a6afe8ec0613c89a, slot#2)
2021-10-15 02:25:54 (8004): Successfully started VM. (PID = '3136')
2021-10-15 02:25:54 (8004): Reporting VM Process ID to BOINC.
2021-10-15 02:25:54 (8004): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-10-15 02:25:54 (8004): Detected: Web Application Enabled (http://localhost:54016)
2021-10-15 02:25:54 (8004): Detected: Remote Desktop Enabled (localhost:54017)
2021-10-15 02:25:54 (8004): Status Report: Job Duration: '864000.000000'
2021-10-15 02:25:54 (8004): Status Report: Elapsed Time: '10779.003699'
2021-10-15 02:25:54 (8004): Status Report: CPU Time: '10593.921875'
2021-10-15 02:25:54 (8004): Preference change detected
2021-10-15 02:25:54 (8004): Setting CPU throttle for VM. (100%)
2021-10-15 02:25:55 (8004): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 600 seconds))
2021-10-15 02:25:56 (8004): Guest Log: 02:08:02.814460 timesync vgsvcTimeSyncWorker: Radical host time change: 1 928 717 000 000ns (HostNow=1 634 282 756 696 000 000 ns HostLast=1 634 280 827 979 000 000 ns)

2021-10-15 02:26:06 (8004): Guest Log: 02:08:12.823751 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 928 775 779 000ns (GuestNow=1 634 282 766 705 305 000 ns GuestLast=1 634 280 837 929 526 000 ns fSetTimeLastLoop=true )

2021-10-15 02:27:42 (8004): Stopping VM.
2021-10-15 02:56:17 (4436): Detected: vboxwrapper 26197
2021-10-15 02:56:17 (4436): Detected: BOINC client v7.7
2021-10-15 02:56:17 (4436): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2021-10-15 02:56:18 (4436): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-10-15 02:56:18 (4436): Starting VM using VBoxManage interface. (boinc_a6afe8ec0613c89a, slot#2)
2021-10-15 02:56:24 (4436): Successfully started VM. (PID = '5648')
2021-10-15 02:56:24 (4436): Reporting VM Process ID to BOINC.
2021-10-15 02:56:24 (4436): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-10-15 02:56:24 (4436): Detected: Web Application Enabled (http://localhost:54016)
2021-10-15 02:56:24 (4436): Detected: Remote Desktop Enabled (localhost:54017)
2021-10-15 02:56:24 (4436): Status Report: Job Duration: '864000.000000'
2021-10-15 02:56:24 (4436): Status Report: Elapsed Time: '10885.003699'
2021-10-15 02:56:24 (4436): Status Report: CPU Time: '10697.562500'
2021-10-15 02:56:24 (4436): Preference change detected
2021-10-15 02:56:24 (4436): Setting CPU throttle for VM. (100%)
2021-10-15 02:56:24 (4436): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 600 seconds))
2021-10-15 02:58:24 (4436): Stopping VM.
2021-10-15 03:32:33 (4356): Detected: vboxwrapper 26197
2021-10-15 03:32:33 (4356): Detected: BOINC client v7.7
2021-10-15 03:32:33 (4356): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2021-10-15 03:32:34 (4356): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-10-15 03:32:34 (4356): Starting VM using VBoxManage interface. (boinc_a6afe8ec0613c89a, slot#2)
2021-10-15 03:32:40 (4356): Successfully started VM. (PID = '8032')
2021-10-15 03:32:40 (4356): Reporting VM Process ID to BOINC.
2021-10-15 03:32:40 (4356): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-10-15 03:32:40 (4356): Detected: Web Application Enabled (http://localhost:54016)
2021-10-15 03:32:40 (4356): Detected: Remote Desktop Enabled (localhost:54017)
2021-10-15 03:32:40 (4356): Status Report: Job Duration: '864000.000000'
2021-10-15 03:32:40 (4356): Status Report: Elapsed Time: '11003.003699'
2021-10-15 03:32:40 (4356): Status Report: CPU Time: '10811.546875'
2021-10-15 03:32:40 (4356): Preference change detected
2021-10-15 03:32:40 (4356): Setting CPU throttle for VM. (100%)
2021-10-15 03:32:40 (4356): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 600 seconds))
2021-10-15 03:32:42 (4356): Guest Log: 02:11:52.885313 timesync vgsvcTimeSyncWorker: Radical host time change: 2 065 029 000 000ns (HostNow=1 634 286 762 547 000 000 ns HostLast=1 634 284 697 518 000 000 ns)

2021-10-15 03:32:52 (4356): Guest Log: 02:12:02.886300 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 065 022 629 000ns (GuestNow=1 634 286 772 547 991 000 ns GuestLast=1 634 284 707 525 362 000 ns fSetTimeLastLoop=true )

2021-10-15 05:14:59 (4356): Status Report: Job Duration: '864000.000000'
2021-10-15 05:14:59 (4356): Status Report: Elapsed Time: '17003.494515'
2021-10-15 05:14:59 (4356): Status Report: CPU Time: '16942.421875'
2021-10-15 05:42:51 (4356): Guest Log: job: run exitcode=0

2021-10-15 05:42:51 (4356): Guest Log: job: diskusage=2124

2021-10-15 05:42:51 (4356): Guest Log: job: logsize=80 k

2021-10-15 05:42:51 (4356): Guest Log: job: times=

2021-10-15 05:42:51 (4356): Guest Log: 0m0.005s 0m0.008s

2021-10-15 05:42:51 (4356): Guest Log: 259m37.847s 0m34.885s

2021-10-15 05:42:51 (4356): Guest Log: job: cpuusage=15613

2021-10-15 05:42:51 (4356): Guest Log: 05:42:50 CDT -05:00 2021-10-15: cranky: [INFO] Container 'runc' finished with status code 0.

2021-10-15 05:42:51 (4356): Guest Log: 05:42:50 CDT -05:00 2021-10-15: cranky: [INFO] Preparing output.

2021-10-15 05:42:51 (4356): Guest Log: [INFO] Job Finished

2021-10-15 05:42:51 (4356): Guest Log: [INFO] Shutting Down.

2021-10-15 05:42:51 (4356): VM Completion File Detected.
2021-10-15 05:42:51 (4356): VM Completion Message: Job Finished
.
2021-10-15 05:42:51 (4356): Powering off VM.
2021-10-15 05:47:51 (4356): VM did not power off when requested.
2021-10-15 05:47:51 (4356): VM was successfully terminated.
2021-10-15 05:47:51 (4356): Deregistering VM. (boinc_a6afe8ec0613c89a, slot#2)
2021-10-15 05:47:51 (4356): Removing network bandwidth throttle group from VM.
2021-10-15 05:47:52 (4356): Removing VM from VirtualBox.
05:47:57 (4356): called boinc_finish(0)

</stderr_txt>
]]>
Development for LHC@home

Stderr output
