Name Theory_2743-2835391-257_2
Workunit 223808732
Created 2 Jul 2024, 19:37:45 UTC
Sent 2 Jul 2024, 23:02:58 UTC
Report deadline 13 Jul 2024, 23:02:58 UTC
Received 7 Jul 2024, 10:37:16 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10849187
Run time 4 hours 43 min 50 sec
CPU time 2 hours 18 min 42 sec
Validate state Valid
Credit 148.91
Device peak FLOPS 3.78 GFLOPS
Application version Theory Simulation v300.30 (vbox64_theory)
windows_x86_64
Peak working set size 82.63 MB
Peak swap size 77.61 MB
Peak disk usage 1.62 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2024-07-04 12:55:07 (8616): vboxwrapper version 26207
2024-07-04 12:55:07 (8616): BOINC client version: 7.16.11
2024-07-04 12:55:08 (8616): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-04 12:55:08 (8616): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-04 12:55:08 (8616): Successfully copied 'init_data.xml' to the shared directory.
2024-07-04 12:55:08 (8616): Successfully copied 'input' to the shared directory.
2024-07-04 12:55:08 (8616): Create VM. (boinc_1dace813c422f749, slot#1)
2024-07-04 12:55:09 (8616): Setting Memory Size for VM. (630MB)
2024-07-04 12:55:09 (8616): Setting CPU Count for VM. (1)
2024-07-04 12:55:10 (8616): Setting Chipset Options for VM.
2024-07-04 12:55:10 (8616): Setting Graphics Controller Options for VM.
2024-07-04 12:55:10 (8616): Setting Boot Options for VM.
2024-07-04 12:55:10 (8616): Setting Network Configuration for NAT.
2024-07-04 12:55:11 (8616): Enabling VM Network Access.
2024-07-04 12:55:11 (8616): Disabling USB Support for VM.
2024-07-04 12:55:11 (8616): Disabling COM Port Support for VM.
2024-07-04 12:55:11 (8616): Disabling LPT Port Support for VM.
2024-07-04 12:55:12 (8616): Disabling Audio Support for VM.
2024-07-04 12:55:12 (8616): Disabling Clipboard Support for VM.
2024-07-04 12:55:12 (8616): Disabling Drag and Drop Support for VM.
2024-07-04 12:55:12 (8616): Adding storage controller(s) to VM.
2024-07-04 12:55:13 (8616): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi)
2024-07-04 12:55:13 (8616): Adding VirtualBox Guest Additions to VM.
2024-07-04 12:55:14 (8616): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-07-04 12:55:14 (8616): forwarding host port 58302 to guest port 80
2024-07-04 12:55:14 (8616): Enabling remote desktop for VM.
2024-07-04 12:55:14 (8616): Required extension pack not installed, remote desktop not enabled.
2024-07-04 12:55:14 (8616): Enabling shared directory for VM.
2024-07-04 12:55:15 (8616): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-04 12:55:23 (8616): Successfully started VM. (PID = '20288')
2024-07-04 12:55:23 (8616): Reporting VM Process ID to BOINC.
2024-07-04 12:55:23 (8616): Guest Log: BIOS: VirtualBox 7.0.14
2024-07-04 12:55:23 (8616): Guest Log: CPUID EDX: 0x178bfbff
2024-07-04 12:55:23 (8616): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-04 12:55:23 (8616): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-04 12:55:23 (8616): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-04 12:55:23 (8616): Detected: Web Application Enabled (http://localhost:58302)
2024-07-04 12:55:23 (8616): Preference change detected
2024-07-04 12:55:23 (8616): Setting CPU throttle for VM. (60%)
2024-07-04 12:55:23 (8616): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-04 12:55:25 (8616): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-04 12:55:25 (8616): Guest Log: BIOS: Booting from Hard Disk...
2024-07-04 12:55:28 (8616): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-04 12:55:28 (8616): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-07-04 12:55:55 (8616): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-04 12:55:55 (8616): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-04 12:56:01 (8616): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-04 12:56:01 (8616): Guest Log: 00:00:00.000161 main     Log opened 2024-07-04T16:56:01.502549000Z
2024-07-04 12:56:01 (8616): Guest Log: 00:00:00.000366 main     OS Product: Linux
2024-07-04 12:56:01 (8616): Guest Log: 00:00:00.000443 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-07-04 12:56:01 (8616): Guest Log: 00:00:00.000501 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-04 12:56:01 (8616): Guest Log: 00:00:00.000574 main     Executable: /usr/sbin/VBoxService
2024-07-04 12:56:01 (8616): Guest Log: 00:00:00.000576 main     Process ID: 3225
2024-07-04 12:56:01 (8616): Guest Log: 00:00:00.000576 main     Package type: LINUX_64BITS_GENERIC
2024-07-04 12:56:01 (8616): Guest Log: 00:00:00.004812 main     5.2.6 r120293 started. Verbose level = 0
2024-07-04 12:57:34 (8616): Guest Log: 12:57:34 EDT -04:00 2024-07-04: cranky: [INFO] Detected Theory App
2024-07-04 12:57:34 (8616): Guest Log: 12:57:34 EDT -04:00 2024-07-04: cranky: [INFO] Checking CVMFS.
2024-07-04 12:57:37 (8616): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-04 12:57:39 (8616): 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
2024-07-04 12:57:39 (8616): Guest Log: 2.5.2.0 4156 1 28108 29848 3 1 272470 4096000 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-04 12:57:43 (8616): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-04 12:57:45 (8616): 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
2024-07-04 12:57:45 (8616): Guest Log: 2.5.2.0 4112 1 25508 24633 3 2 272470 4096000 0 65024 0 2 -100 7957 6865 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-04 12:57:48 (8616): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-04 12:57:50 (8616): 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
2024-07-04 12:57:50 (8616): Guest Log: 2.5.2.0 4083 1 27240 272 2 1 272470 4096000 0 65024 0 0 n/a 4 3 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-04 12:57:54 (8616): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-04 12:57:56 (8616): 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
2024-07-04 12:57:56 (8616): Guest Log: 2.5.2.0 4192 1 39632 19063 3 1 272470 4096000 0 65024 0 0 n/a 5563 112 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-04 12:57:56 (8616): Guest Log: 12:57:56 EDT -04:00 2024-07-04: cranky: [INFO] Checking runc.
2024-07-04 12:58:00 (8616): Guest Log: 12:58:00 EDT -04:00 2024-07-04: cranky: [INFO] Creating the filesystem.
2024-07-04 12:58:00 (8616): Guest Log: 12:58:00 EDT -04:00 2024-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-04 12:58:00 (8616): Guest Log: 12:58:00 EDT -04:00 2024-07-04: cranky: [INFO] Updating config.json.
2024-07-04 12:58:00 (8616): Guest Log: 12:58:01 EDT -04:00 2024-07-04: cranky: [INFO] Running Container 'runc'.
2024-07-04 12:58:15 (8616): Guest Log: job: htmld=/shared/html/job
2024-07-04 12:58:16 (8616): Guest Log: job: unpack exitcode=0
2024-07-04 12:58:16 (8616): Guest Log: INFO: activated the work-around for ld:
2024-07-04 12:58:16 (8616): Guest Log: lrwxrwxrwx 1 0 0 15 Jul  4 16:58 /tmp/tmp.iDOiMWSx2N/ld -> /usr/bin/ld.bfd
2024-07-04 12:58:17 (8616): Guest Log: 12:58:17 EDT -04:00 2024-07-04: cranky: [INFO] ===> [runRivet] Thu Jul  4 16:58:16 UTC 2024 [boinc pp winclusive 7000 - - pythia8 8.308 tune-CUETP8S1 100000 257]
2024-07-04 13:03:12 (8616): Stopping VM.
2024-07-04 13:03:26 (8616): Successfully stopped VM.
2024-07-04 13:09:52 (20156): vboxwrapper version 26207
2024-07-04 13:09:52 (20156): BOINC client version: 7.16.11
2024-07-04 13:09:53 (20156): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-04 13:09:53 (20156): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-04 13:09:53 (20156): Guest Log: BIOS: VirtualBox 7.0.14
2024-07-04 13:09:53 (20156): Guest Log: CPUID EDX: 0x178bfbff
2024-07-04 13:09:53 (20156): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-04 13:09:53 (20156): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-04 13:09:53 (20156): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-04 13:09:53 (20156): Guest Log: BIOS: Booting from Hard Disk...
2024-07-04 13:09:53 (20156): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-04 13:09:53 (20156): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-07-04 13:09:53 (20156): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-04 13:09:53 (20156): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-04 13:09:53 (20156): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-04 13:09:53 (20156): Guest Log: 00:00:00.000161 main     Log opened 2024-07-04T16:56:01.502549000Z
2024-07-04 13:09:53 (20156): Guest Log: 00:00:00.000366 main     OS Product: Linux
2024-07-04 13:09:53 (20156): Guest Log: 00:00:00.000443 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-07-04 13:09:53 (20156): Guest Log: 00:00:00.000501 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-04 13:09:53 (20156): Guest Log: 00:00:00.000574 main     Executable: /usr/sbin/VBoxService
2024-07-04 13:09:53 (20156): Guest Log: 00:00:00.000576 main     Process ID: 3225
2024-07-04 13:09:53 (20156): Guest Log: 00:00:00.000576 main     Package type: LINUX_64BITS_GENERIC
2024-07-04 13:09:53 (20156): Guest Log: 00:00:00.004812 main     5.2.6 r120293 started. Verbose level = 0
2024-07-04 13:09:53 (20156): Guest Log: 12:57:34 EDT -04:00 2024-07-04: cranky: [INFO] Detected Theory App
2024-07-04 13:09:53 (20156): Guest Log: 12:57:34 EDT -04:00 2024-07-04: cranky: [INFO] Checking CVMFS.
2024-07-04 13:09:53 (20156): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-04 13:09:53 (20156): 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
2024-07-04 13:09:53 (20156): Guest Log: 2.5.2.0 4156 1 28108 29848 3 1 272470 4096000 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-04 13:09:53 (20156): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-04 13:09:53 (20156): 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
2024-07-04 13:09:53 (20156): Guest Log: 2.5.2.0 4112 1 25508 24633 3 2 272470 4096000 0 65024 0 2 -100 7957 6865 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-04 13:09:53 (20156): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-04 13:09:53 (20156): 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
2024-07-04 13:09:53 (20156): Guest Log: 2.5.2.0 4083 1 27240 272 2 1 272470 4096000 0 65024 0 0 n/a 4 3 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-04 13:09:53 (20156): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-04 13:09:53 (20156): 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
2024-07-04 13:09:53 (20156): Guest Log: 2.5.2.0 4192 1 39632 19063 3 1 272470 4096000 0 65024 0 0 n/a 5563 112 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-04 13:09:53 (20156): Guest Log: 12:57:56 EDT -04:00 2024-07-04: cranky: [INFO] Checking runc.
2024-07-04 13:09:53 (20156): Guest Log: 12:58:00 EDT -04:00 2024-07-04: cranky: [INFO] Creating the filesystem.
2024-07-04 13:09:53 (20156): Guest Log: 12:58:00 EDT -04:00 2024-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-04 13:09:53 (20156): Guest Log: 12:58:00 EDT -04:00 2024-07-04: cranky: [INFO] Updating config.json.
2024-07-04 13:09:53 (20156): Guest Log: 12:58:01 EDT -04:00 2024-07-04: cranky: [INFO] Running Container 'runc'.
2024-07-04 13:09:53 (20156): Guest Log: job: htmld=/shared/html/job
2024-07-04 13:09:53 (20156): Guest Log: job: unpack exitcode=0
2024-07-04 13:09:53 (20156): Guest Log: INFO: activated the work-around for ld:
2024-07-04 13:09:53 (20156): Guest Log: lrwxrwxrwx 1 0 0 15 Jul  4 16:58 /tmp/tmp.iDOiMWSx2N/ld -> /usr/bin/ld.bfd
2024-07-04 13:09:53 (20156): Guest Log: 12:58:17 EDT -04:00 2024-07-04: cranky: [INFO] ===> [runRivet] Thu Jul  4 16:58:16 UTC 2024 [boinc pp winclusive 7000 - - pythia8 8.308 tune-CUETP8S1 100000 257]
2024-07-04 13:09:53 (20156): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-04 13:10:04 (20156): Successfully started VM. (PID = '19708')
2024-07-04 13:10:04 (20156): Reporting VM Process ID to BOINC.
2024-07-04 13:10:04 (20156): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-04 13:10:04 (20156): Detected: Web Application Enabled (http://localhost:58302)
2024-07-04 13:10:04 (20156): Preference change detected
2024-07-04 13:10:04 (20156): Setting CPU throttle for VM. (60%)
2024-07-04 13:10:04 (20156): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-04 13:43:59 (20156): Stopping VM.
2024-07-04 13:44:04 (20156): Successfully stopped VM.
2024-07-04 14:05:48 (17384): vboxwrapper version 26207
2024-07-04 14:05:48 (17384): BOINC client version: 7.16.11
2024-07-04 14:05:49 (17384): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-04 14:05:49 (17384): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-04 14:05:50 (17384): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-04 14:25:01 (10792): vboxwrapper version 26207
2024-07-04 14:25:01 (10792): BOINC client version: 7.16.11
2024-07-04 14:25:02 (10792): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-04 14:25:02 (10792): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-04 14:25:08 (10792): VM was running
2024-07-04 14:25:08 (10792): Powering off VM.
2024-07-04 14:25:08 (10792): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_1dace813c422f749" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp

2024-07-04 14:25:08 (10792): VM did not power off when requested.
2024-07-04 14:25:08 (10792): VM was NOT successfully terminated.
2024-07-04 14:25:08 (10792): Could not stop running VM
2024-07-04 14:25:08 (10792): ERROR: VM failed to start
2024-07-04 14:25:13 (10792): 
   NOTE: VM was already running.
               BOINC will be notified that it needs to clean up the environment.
               This might be a temporary problem and so this job will be rescheduled for another time.

2024-07-04 14:25:20 (7572): vboxwrapper version 26207
2024-07-04 14:25:20 (7572): BOINC client version: 7.16.11
2024-07-04 14:25:21 (7572): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-04 14:25:21 (7572): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-04 14:25:27 (7572): VM was running
2024-07-04 14:25:27 (7572): Powering off VM.
2024-07-04 14:25:27 (7572): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_1dace813c422f749" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp

2024-07-04 14:25:27 (7572): VM did not power off when requested.
2024-07-04 14:25:27 (7572): VM was NOT successfully terminated.
2024-07-04 14:25:27 (7572): Could not stop running VM
2024-07-04 14:25:27 (7572): ERROR: VM failed to start
2024-07-04 14:25:32 (7572): 
   NOTE: VM was already running.
               BOINC will be notified that it needs to clean up the environment.
               This might be a temporary problem and so this job will be rescheduled for another time.

2024-07-06 17:40:41 (1516): vboxwrapper version 26207
2024-07-06 17:40:41 (1516): BOINC client version: 7.16.11
2024-07-06 17:40:42 (1516): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-06 17:40:42 (1516): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-06 17:40:43 (1516): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-06 17:40:58 (1516): Successfully started VM. (PID = '15340')
2024-07-06 17:40:58 (1516): Reporting VM Process ID to BOINC.
2024-07-06 17:40:58 (1516): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-06 17:40:58 (1516): Detected: Web Application Enabled (http://localhost:58302)
2024-07-06 17:40:59 (1516): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 17:41:02 (1516): Preference change detected
2024-07-06 17:41:02 (1516): Setting CPU throttle for VM. (60%)
2024-07-06 17:41:02 (1516): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-06 17:41:03 (1516): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 17:41:09 (1516): Guest Log: 00:41:16.826080 timesync vgsvcTimeSyncWorker: Radical host time change: 187 031 736 000 000ns (HostNow=1 720 302 068 246 000 000 ns HostLast=1 720 115 036 510 000 000 ns)
2024-07-06 17:41:19 (1516): Guest Log: 00:41:26.910960 timesync vgsvcTimeSyncWorker: Radical guest time change: 187 031 864 163 000ns (GuestNow=1 720 302 078 469 328 000 ns GuestLast=1 720 115 046 605 165 000 ns fSetTimeLastLoop=true )
2024-07-06 17:47:18 (1516): Stopping VM.
2024-07-06 17:47:21 (1516): Successfully stopped VM.
2024-07-06 18:18:55 (12812): vboxwrapper version 26207
2024-07-06 18:18:55 (12812): BOINC client version: 8.0.2
2024-07-06 18:18:55 (12812): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-06 18:18:56 (12812): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-06 18:18:56 (12812): Guest Log: 00:41:16.826080 timesync vgsvcTimeSyncWorker: Radical host time change: 187 031 736 000 000ns (HostNow=1 720 302 068 246 000 000 ns HostLast=1 720 115 036 510 000 000 ns)
2024-07-06 18:18:56 (12812): Guest Log: 00:41:26.910960 timesync vgsvcTimeSyncWorker: Radical guest time change: 187 031 864 163 000ns (GuestNow=1 720 302 078 469 328 000 ns GuestLast=1 720 115 046 605 165 000 ns fSetTimeLastLoop=true )
2024-07-06 18:18:56 (12812): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-06 18:19:14 (12812): Successfully started VM. (PID = '9604')
2024-07-06 18:19:14 (12812): Reporting VM Process ID to BOINC.
2024-07-06 18:19:14 (12812): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-06 18:19:14 (12812): Detected: Web Application Enabled (http://localhost:58302)
2024-07-06 18:19:15 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:19:32 (12812): Preference change detected
2024-07-06 18:19:32 (12812): Setting CPU throttle for VM. (60%)
2024-07-06 18:19:32 (12812): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-06 18:19:32 (12812): Guest Log: 00:47:28.973069 timesync vgsvcTimeSyncWorker: Radical host time change: 1 941 850 000 000ns (HostNow=1 720 304 371 905 000 000 ns HostLast=1 720 302 430 055 000 000 ns)
2024-07-06 18:19:32 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:19:42 (12812): Guest Log: 00:47:39.136918 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 942 243 286 000ns (GuestNow=1 720 304 382 409 791 000 ns GuestLast=1 720 302 440 166 505 000 ns fSetTimeLastLoop=true )
2024-07-06 18:20:24 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:20:44 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:21:04 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:21:24 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:22:35 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:22:55 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:39:08 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:39:28 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:46:10 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:46:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:46:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:46:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:47:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:47:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:47:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:47:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:48:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:48:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:48:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:48:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:49:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:49:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:49:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:49:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:50:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:50:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:50:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:50:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:51:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:51:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:51:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:51:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:52:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:52:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:52:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:52:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:53:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:53:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:53:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:53:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:54:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:54:29 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:54:39 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:54:59 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:55:09 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:55:30 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:55:40 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:56:00 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:56:20 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:56:40 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:57:00 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:57:20 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:57:30 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:57:50 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 18:58:00 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 18:58:01 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:08:53 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:09:12 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:09:22 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:09:42 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:09:52 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:10:12 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:10:22 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:10:42 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:10:52 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:11:12 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:11:22 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:11:42 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:11:52 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:12:12 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:12:32 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:12:52 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:13:13 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:13:33 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:15:03 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:15:23 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:16:23 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:16:43 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:17:53 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:18:13 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:19:14 (12812): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 19:19:34 (12812): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 19:19:35 (12812): Stopping VM.
2024-07-06 19:19:52 (12812): Successfully stopped VM.
2024-07-06 23:05:43 (8544): vboxwrapper version 26207
2024-07-06 23:05:43 (8544): BOINC client version: 8.0.2
2024-07-06 23:05:44 (8544): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-06 23:05:44 (8544): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-06 23:05:45 (8544): Guest Log: 00:47:28.973069 timesync vgsvcTimeSyncWorker: Radical host time change: 1 941 850 000 000ns (HostNow=1 720 304 371 905 000 000 ns HostLast=1 720 302 430 055 000 000 ns)
2024-07-06 23:05:45 (8544): Guest Log: 00:47:39.136918 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 942 243 286 000ns (GuestNow=1 720 304 382 409 791 000 ns GuestLast=1 720 302 440 166 505 000 ns fSetTimeLastLoop=true )
2024-07-06 23:05:45 (8544): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-06 23:05:57 (8544): Successfully started VM. (PID = '8232')
2024-07-06 23:05:57 (8544): Reporting VM Process ID to BOINC.
2024-07-06 23:05:57 (8544): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-06 23:05:57 (8544): Detected: Web Application Enabled (http://localhost:58302)
2024-07-06 23:05:58 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:06:14 (8544): Preference change detected
2024-07-06 23:06:14 (8544): Setting CPU throttle for VM. (60%)
2024-07-06 23:06:15 (8544): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-06 23:06:15 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:06:20 (8544): Guest Log: 01:34:29.782606 timesync vgsvcTimeSyncWorker: Radical host time change: 13 628 117 000 000ns (HostNow=1 720 321 580 114 000 000 ns HostLast=1 720 307 951 997 000 000 ns)
2024-07-06 23:06:24 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:06:45 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:06:51 (8544): Guest Log: 01:34:39.782874 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 397 061 486 000ns (GuestNow=1 720 321 590 132 124 000 ns GuestLast=1 720 307 193 070 638 000 ns fSetTimeLastLoop=true )
2024-07-06 23:06:54 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:07:15 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:08:24 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:08:45 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:09:04 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:09:25 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:13:45 (8544): Status Report: Job Duration: '864000.000000'
2024-07-06 23:13:45 (8544): Status Report: Elapsed Time: '6000.019300'
2024-07-06 23:13:45 (8544): Status Report: CPU Time: '998.843750'
2024-07-06 23:16:16 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:16:17 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:31:17 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:31:37 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:31:47 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:32:07 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:32:17 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:32:37 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:46:19 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:46:39 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:46:59 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:47:20 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-06 23:51:19 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-06 23:51:39 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:01:21 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 00:01:41 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:05:57 (8544): Preference change detected
2024-07-07 00:05:57 (8544): Setting CPU throttle for VM. (60%)
2024-07-07 00:05:57 (8544): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-07 00:09:22 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 00:09:42 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:16:23 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 00:16:43 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:31:14 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 00:31:34 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:36:15 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 00:36:35 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:46:17 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 00:46:37 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:46:57 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 00:47:17 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:51:17 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 00:51:37 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 00:58:47 (8544): Status Report: Job Duration: '864000.000000'
2024-07-07 00:58:47 (8544): Status Report: Elapsed Time: '12000.019300'
2024-07-07 00:58:47 (8544): Status Report: CPU Time: '4679.484375'
2024-07-07 01:01:18 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 01:01:38 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 01:09:30 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 01:09:50 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 01:16:20 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 01:16:40 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 01:21:20 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 01:21:40 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 01:31:22 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 01:31:42 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 01:46:24 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 01:46:44 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 01:46:54 (8544): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 01:47:14 (8544): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 01:51:13 (8544): Stopping VM.
2024-07-07 01:51:19 (8544): Successfully stopped VM.
2024-07-07 03:18:40 (14052): vboxwrapper version 26207
2024-07-07 03:18:40 (14052): BOINC client version: 8.0.2
2024-07-07 03:18:40 (14052): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-07 03:18:40 (14052): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-07 03:18:41 (14052): Guest Log: 01:34:29.782606 timesync vgsvcTimeSyncWorker: Radical host time change: 13 628 117 000 000ns (HostNow=1 720 321 580 114 000 000 ns HostLast=1 720 307 951 997 000 000 ns)
2024-07-07 03:18:41 (14052): Guest Log: 01:34:39.782874 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 397 061 486 000ns (GuestNow=1 720 321 590 132 124 000 ns GuestLast=1 720 307 193 070 638 000 ns fSetTimeLastLoop=true )
2024-07-07 03:18:41 (14052): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-07 03:18:55 (14052): Successfully started VM. (PID = '17352')
2024-07-07 03:18:55 (14052): Reporting VM Process ID to BOINC.
2024-07-07 03:18:55 (14052): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-07 03:18:55 (14052): Detected: Web Application Enabled (http://localhost:58302)
2024-07-07 03:18:55 (14052): Stopping VM.
2024-07-07 03:18:59 (14052): Successfully stopped VM.
2024-07-07 03:19:15 (16528): vboxwrapper version 26207
2024-07-07 03:19:15 (16528): BOINC client version: 8.0.2
2024-07-07 03:19:15 (16528): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-07 03:19:16 (16528): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-07 03:19:16 (16528): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-07 03:19:26 (16528): Successfully started VM. (PID = '10792')
2024-07-07 03:19:26 (16528): Reporting VM Process ID to BOINC.
2024-07-07 03:19:26 (16528): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-07 03:19:26 (16528): Detected: Web Application Enabled (http://localhost:58302)
2024-07-07 03:19:26 (16528): Stopping VM.
2024-07-07 03:19:29 (16528): Successfully stopped VM.
2024-07-07 04:37:36 (1372): vboxwrapper version 26207
2024-07-07 04:37:36 (1372): BOINC client version: 8.0.2
2024-07-07 04:37:37 (1372): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-07-07 04:37:37 (1372): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-07 04:37:38 (1372): Starting VM using VBoxManage interface. (boinc_1dace813c422f749, slot#1)
2024-07-07 04:37:52 (1372): Successfully started VM. (PID = '20040')
2024-07-07 04:37:52 (1372): Reporting VM Process ID to BOINC.
2024-07-07 04:37:52 (1372): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-07 04:37:52 (1372): Detected: Web Application Enabled (http://localhost:58302)
2024-07-07 04:37:53 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:38:08 (1372): Status Report: Job Duration: '864000.000000'
2024-07-07 04:38:08 (1372): Status Report: Elapsed Time: '14996.019300'
2024-07-07 04:38:08 (1372): Status Report: CPU Time: '6514.468750'
2024-07-07 04:38:08 (1372): Preference change detected
2024-07-07 04:38:08 (1372): Setting CPU throttle for VM. (60%)
2024-07-07 04:38:08 (1372): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-07 04:38:08 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:38:11 (1372): Guest Log: 04:11:11.021862 timesync vgsvcTimeSyncWorker: Radical host time change: 10 020 591 000 000ns (HostNow=1 720 341 491 192 000 000 ns HostLast=1 720 331 470 601 000 000 ns)
2024-07-07 04:38:18 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:38:38 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:38:41 (1372): Guest Log: 04:11:21.046145 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 519 845 182 000ns (GuestNow=1 720 341 501 216 280 000 ns GuestLast=1 720 330 981 371 098 000 ns fSetTimeLastLoop=true )
2024-07-07 04:38:58 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:39:18 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:39:28 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:39:48 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:39:58 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:40:18 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:40:28 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:40:48 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:40:58 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:41:18 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:41:59 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:42:19 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:42:29 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:42:49 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:42:59 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:43:19 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:43:29 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:43:49 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:43:59 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:44:19 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:44:29 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:44:49 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:44:59 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:45:19 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:45:29 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:45:49 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:45:59 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:46:19 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:46:29 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:46:49 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:47:00 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:47:20 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:47:40 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:48:00 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:48:10 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:48:30 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:48:50 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:49:10 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:49:30 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:49:50 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:50:00 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:50:20 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:50:30 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:50:50 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:51:10 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:51:30 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:51:40 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:52:00 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:52:10 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:52:30 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:52:40 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:53:00 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:53:10 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:53:30 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:53:40 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:54:00 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:54:10 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:54:30 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:54:50 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:55:10 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:55:30 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:55:50 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:56:20 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:56:40 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:57:01 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:57:20 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:57:30 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:57:50 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:58:00 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:58:20 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:58:30 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:58:50 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:59:00 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:59:20 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 04:59:30 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 04:59:50 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:00:00 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:00:20 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:00:40 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:01:00 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:01:10 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:01:30 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:01:40 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:02:00 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:02:10 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:02:30 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:02:50 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:03:10 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:03:20 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:03:40 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:04:00 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:04:20 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:04:40 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:05:00 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:05:20 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:05:42 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:06:01 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:06:21 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:06:31 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:06:52 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:07:11 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:07:31 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:07:41 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:08:01 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:08:21 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:08:41 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:09:11 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:09:31 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:09:51 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:10:31 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:11:01 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:11:21 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:11:41 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:12:01 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:12:22 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:12:42 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:13:03 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:13:04 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:14:53 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:15:13 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:15:33 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:15:53 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:16:13 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:16:33 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:16:43 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:17:03 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:17:23 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:17:43 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:18:03 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:18:23 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:18:43 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:19:03 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:19:33 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:19:53 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:20:13 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:20:33 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:20:43 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:21:03 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:21:13 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:21:33 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:21:43 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:22:03 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:22:13 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:22:33 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:22:43 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:23:03 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:23:13 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:23:33 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:23:43 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:24:03 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:24:13 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:24:34 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:25:13 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:25:34 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:25:53 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:26:13 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:26:23 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:26:44 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:27:03 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:27:24 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:27:44 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:28:04 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:28:24 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:28:45 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:29:05 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:29:25 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:29:45 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:30:05 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:30:45 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:31:05 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:31:25 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:31:45 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:31:55 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:32:15 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:32:25 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:32:45 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:33:05 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:33:06 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:37:05 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:37:26 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:37:36 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:37:56 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:38:16 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:38:36 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:39:36 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:39:56 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:41:16 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:41:36 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:41:56 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:42:16 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:42:36 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:42:56 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:43:06 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:43:26 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:44:06 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:44:26 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:44:56 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:45:16 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:45:36 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:45:56 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:46:16 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:46:36 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:46:46 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:47:06 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:50:07 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:50:28 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:51:28 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:51:48 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:52:38 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:52:58 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:53:18 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:53:38 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:54:08 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:54:28 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:54:48 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:55:08 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:55:58 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:56:18 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:56:38 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:56:58 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:57:18 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:57:38 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:57:58 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:58:18 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 05:58:28 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 05:58:48 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 06:00:08 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 06:00:28 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 06:00:58 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 06:01:18 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 06:03:28 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 06:03:48 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 06:04:58 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 06:05:18 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 06:05:38 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 06:05:58 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 06:06:08 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 06:06:28 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 06:06:38 (1372): VM state change detected. (old = 'running', new = 'paused')
2024-07-07 06:06:58 (1372): VM state change detected. (old = 'paused', new = 'running')
2024-07-07 06:07:56 (1372): Guest Log: job: run exitcode=0
2024-07-07 06:07:56 (1372): Guest Log: job: diskusage=4244
2024-07-07 06:07:56 (1372): Guest Log: job: logsize=76 k
2024-07-07 06:07:56 (1372): Guest Log: job: times=
2024-07-07 06:07:56 (1372): Guest Log: 0m0.030s 0m0.023s
2024-07-07 06:07:56 (1372): Guest Log: 201m55.915s 1m59.564s
2024-07-07 06:07:56 (1372): Guest Log: job: cpuusage=12236
2024-07-07 06:07:56 (1372): Guest Log: 05:48:25 EDT -04:00 2024-07-07: cranky: [INFO] Container 'runc' finished with status code 0.
2024-07-07 06:07:56 (1372): Guest Log: 05:48:25 EDT -04:00 2024-07-07: cranky: [INFO] Preparing output.
2024-07-07 06:07:57 (1372): Guest Log: [INFO] Job Finished
2024-07-07 06:07:57 (1372): Guest Log: [INFO] Shutting Down.
2024-07-07 06:07:57 (1372): VM Completion File Detected.
2024-07-07 06:07:57 (1372): VM Completion Message: Job Finished
.
2024-07-07 06:07:57 (1372): Powering off VM.
2024-07-07 06:07:59 (1372): Successfully stopped VM.
2024-07-07 06:07:59 (1372): Deregistering VM. (boinc_1dace813c422f749, slot#1)
2024-07-07 06:07:59 (1372): Removing network bandwidth throttle group from VM.
2024-07-07 06:07:59 (1372): Removing VM from VirtualBox.
2024-07-07 06:08:04 (1372): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN