Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2024-07-01 19:56:46 (76452): vboxwrapper version 26207
2024-07-01 19:56:46 (76452): BOINC client version: 8.0.2
2024-07-01 19:56:47 (76452): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-01 19:56:48 (76452): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-01 19:56:48 (76452): Successfully copied 'init_data.xml' to the shared directory.
2024-07-01 19:56:48 (76452): Successfully copied 'input' to the shared directory.
2024-07-01 19:56:48 (76452): Create VM. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-01 19:56:48 (76452): Setting Memory Size for VM. (630MB)
2024-07-01 19:56:49 (76452): Setting CPU Count for VM. (1)
2024-07-01 19:56:49 (76452): Setting Chipset Options for VM.
2024-07-01 19:56:49 (76452): Setting Graphics Controller Options for VM.
2024-07-01 19:56:50 (76452): Setting Boot Options for VM.
2024-07-01 19:56:50 (76452): Setting Network Configuration for NAT.
2024-07-01 19:56:50 (76452): Enabling VM Network Access.
2024-07-01 19:56:50 (76452): Disabling USB Support for VM.
2024-07-01 19:56:51 (76452): Disabling COM Port Support for VM.
2024-07-01 19:56:51 (76452): Disabling LPT Port Support for VM.
2024-07-01 19:56:51 (76452): Disabling Audio Support for VM.
2024-07-01 19:56:52 (76452): Disabling Clipboard Support for VM.
2024-07-01 19:56:52 (76452): Disabling Drag and Drop Support for VM.
2024-07-01 19:56:52 (76452): Adding storage controller(s) to VM.
2024-07-01 19:56:53 (76452): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi)
2024-07-01 19:57:01 (76452): Attempts: 5
2024-07-01 19:57:01 (76452): Adding VirtualBox Guest Additions to VM.
2024-07-01 19:57:02 (76452): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-07-01 19:57:02 (76452): forwarding host port 54232 to guest port 80
2024-07-01 19:57:02 (76452): Enabling remote desktop for VM.
2024-07-01 19:57:03 (76452): Required extension pack not installed, remote desktop not enabled.
2024-07-01 19:57:03 (76452): Enabling shared directory for VM.
2024-07-01 19:57:03 (76452): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-01 19:57:11 (76452): Successfully started VM. (PID = '87688')
2024-07-01 19:57:11 (76452): Reporting VM Process ID to BOINC.
2024-07-01 19:57:11 (76452): Guest Log: BIOS: VirtualBox 7.0.18
2024-07-01 19:57:11 (76452): Guest Log: CPUID EDX: 0x178bfbff
2024-07-01 19:57:11 (76452): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-01 19:57:11 (76452): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-01 19:57:11 (76452): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-01 19:57:11 (76452): Detected: Web Application Enabled (http://localhost:54232)
2024-07-01 19:57:12 (76452): VM state change detected. (old = 'running', new = 'paused')
2024-07-01 19:57:44 (76452): Preference change detected
2024-07-01 19:57:44 (76452): Setting CPU throttle for VM. (50%)
2024-07-01 19:57:44 (76452): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-01 19:57:45 (76452): VM state change detected. (old = 'paused', new = 'running')
2024-07-01 19:57:46 (76452): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-01 19:57:46 (76452): Guest Log: BIOS: Booting from Hard Disk...
2024-07-01 19:57:47 (76452): VM state change detected. (old = 'running', new = 'paused')
2024-07-01 19:58:07 (76452): VM state change detected. (old = 'paused', new = 'running')
2024-07-01 19:58:08 (76452): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-01 19:58:08 (76452): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-07-01 19:58:37 (76452): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-01 19:58:38 (76452): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-01 19:58:42 (76452): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-01 19:58:42 (76452): Guest Log: 00:00:00.000113 main     Log opened 2024-07-01T17:58:41.547528000Z
2024-07-01 19:58:42 (76452): Guest Log: 00:00:00.000247 main     OS Product: Linux
2024-07-01 19:58:42 (76452): Guest Log: 00:00:00.000288 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-07-01 19:58:42 (76452): Guest Log: 00:00:00.000316 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-01 19:58:42 (76452): Guest Log: 00:00:00.000343 main     Executable: /usr/sbin/VBoxService
2024-07-01 19:58:42 (76452): Guest Log: 00:00:00.000343 main     Process ID: 3228
2024-07-01 19:58:42 (76452): Guest Log: 00:00:00.000344 main     Package type: LINUX_64BITS_GENERIC
2024-07-01 19:58:42 (76452): Guest Log: 00:00:00.002507 main     5.2.6 r120293 started. Verbose level = 0
2024-07-01 19:59:36 (76452): Guest Log: 19:59:35 CEST +02:00 2024-07-01: cranky: [INFO] Detected Theory App
2024-07-01 19:59:36 (76452): Guest Log: 19:59:35 CEST +02:00 2024-07-01: cranky: [INFO] Checking CVMFS.
2024-07-01 19:59:37 (76452): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-01 19:59:38 (76452): 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-01 19:59:38 (76452): Guest Log: 2.5.2.0 4153 0 28388 29823 3 1 272431 4096000 0 65024 0 0 n/a 5 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-01 19:59:40 (76452): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-01 19:59:40 (76452): 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-01 19:59:40 (76452): Guest Log: 2.5.2.0 4061 0 27532 24609 3 2 272431 4096000 0 65024 0 2 -100 7958 2302 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-01 19:59:42 (76452): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-01 19:59:42 (76452): 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-01 19:59:42 (76452): Guest Log: 2.5.2.0 4084 0 27228 272 3 1 272431 4096000 0 65024 0 0 n/a 4 7 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-01 19:59:44 (76452): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-01 19:59:44 (76452): 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-01 19:59:44 (76452): Guest Log: 2.5.2.0 4111 0 39632 19039 3 1 272431 4096000 0 65024 0 0 n/a 5547 6707 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-01 19:59:44 (76452): Guest Log: 19:59:43 CEST +02:00 2024-07-01: cranky: [INFO] Checking runc.
2024-07-01 19:59:45 (76452): Guest Log: 19:59:43 CEST +02:00 2024-07-01: cranky: [INFO] Creating the filesystem.
2024-07-01 19:59:45 (76452): Guest Log: 19:59:43 CEST +02:00 2024-07-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-01 19:59:45 (76452): Guest Log: 19:59:44 CEST +02:00 2024-07-01: cranky: [INFO] Updating config.json.
2024-07-01 19:59:45 (76452): Guest Log: 19:59:44 CEST +02:00 2024-07-01: cranky: [INFO] Running Container 'runc'.
2024-07-01 19:59:48 (76452): Guest Log: job: htmld=/shared/html/job
2024-07-01 19:59:49 (76452): Guest Log: job: unpack exitcode=0
2024-07-01 19:59:49 (76452): Guest Log: INFO: activated the work-around for ld:
2024-07-01 19:59:50 (76452): Guest Log: lrwxrwxrwx 1 0 0 15 Jul  1 17:59 /tmp/tmp.TzuaOBqITn/ld -> /usr/bin/ld.bfd
2024-07-01 19:59:51 (76452): Guest Log: 19:59:50 CEST +02:00 2024-07-01: cranky: [INFO] ===> [runRivet] Mon Jul  1 17:59:48 UTC 2024 [boinc pp jets 13000 40 - pythia6 6.428 364 100000 265]
2024-07-01 20:00:02 (76452): Stopping VM.
2024-07-01 20:00:04 (76452): Successfully stopped VM.
2024-07-01 20:03:01 (89788): vboxwrapper version 26207
2024-07-01 20:03:01 (89788): BOINC client version: 8.0.2
2024-07-01 20:03:03 (89788): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-01 20:03:03 (89788): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-01 20:03:03 (89788): Guest Log: BIOS: VirtualBox 7.0.18
2024-07-01 20:03:03 (89788): Guest Log: CPUID EDX: 0x178bfbff
2024-07-01 20:03:03 (89788): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-01 20:03:03 (89788): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-01 20:03:03 (89788): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-01 20:03:03 (89788): Guest Log: BIOS: Booting from Hard Disk...
2024-07-01 20:03:03 (89788): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-01 20:03:03 (89788): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-07-01 20:03:03 (89788): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-01 20:03:03 (89788): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-01 20:03:03 (89788): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-01 20:03:03 (89788): Guest Log: 00:00:00.000113 main     Log opened 2024-07-01T17:58:41.547528000Z
2024-07-01 20:03:03 (89788): Guest Log: 00:00:00.000247 main     OS Product: Linux
2024-07-01 20:03:03 (89788): Guest Log: 00:00:00.000288 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-07-01 20:03:03 (89788): Guest Log: 00:00:00.000316 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-01 20:03:03 (89788): Guest Log: 00:00:00.000343 main     Executable: /usr/sbin/VBoxService
2024-07-01 20:03:03 (89788): Guest Log: 00:00:00.000343 main     Process ID: 3228
2024-07-01 20:03:03 (89788): Guest Log: 00:00:00.000344 main     Package type: LINUX_64BITS_GENERIC
2024-07-01 20:03:03 (89788): Guest Log: 00:00:00.002507 main     5.2.6 r120293 started. Verbose level = 0
2024-07-01 20:03:03 (89788): Guest Log: 19:59:35 CEST +02:00 2024-07-01: cranky: [INFO] Detected Theory App
2024-07-01 20:03:03 (89788): Guest Log: 19:59:35 CEST +02:00 2024-07-01: cranky: [INFO] Checking CVMFS.
2024-07-01 20:03:03 (89788): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-01 20:03:03 (89788): 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-01 20:03:03 (89788): Guest Log: 2.5.2.0 4153 0 28388 29823 3 1 272431 4096000 0 65024 0 0 n/a 5 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-01 20:03:03 (89788): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-01 20:03:03 (89788): 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-01 20:03:03 (89788): Guest Log: 2.5.2.0 4061 0 27532 24609 3 2 272431 4096000 0 65024 0 2 -100 7958 2302 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-01 20:03:03 (89788): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-01 20:03:03 (89788): 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-01 20:03:03 (89788): Guest Log: 2.5.2.0 4084 0 27228 272 3 1 272431 4096000 0 65024 0 0 n/a 4 7 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-01 20:03:03 (89788): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-01 20:03:03 (89788): 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-01 20:03:03 (89788): Guest Log: 2.5.2.0 4111 0 39632 19039 3 1 272431 4096000 0 65024 0 0 n/a 5547 6707 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-01 20:03:03 (89788): Guest Log: 19:59:43 CEST +02:00 2024-07-01: cranky: [INFO] Checking runc.
2024-07-01 20:03:03 (89788): Guest Log: 19:59:43 CEST +02:00 2024-07-01: cranky: [INFO] Creating the filesystem.
2024-07-01 20:03:03 (89788): Guest Log: 19:59:43 CEST +02:00 2024-07-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-01 20:03:03 (89788): Guest Log: 19:59:44 CEST +02:00 2024-07-01: cranky: [INFO] Updating config.json.
2024-07-01 20:03:03 (89788): Guest Log: 19:59:44 CEST +02:00 2024-07-01: cranky: [INFO] Running Container 'runc'.
2024-07-01 20:03:03 (89788): Guest Log: job: htmld=/shared/html/job
2024-07-01 20:03:03 (89788): Guest Log: job: unpack exitcode=0
2024-07-01 20:03:03 (89788): Guest Log: INFO: activated the work-around for ld:
2024-07-01 20:03:03 (89788): Guest Log: lrwxrwxrwx 1 0 0 15 Jul  1 17:59 /tmp/tmp.TzuaOBqITn/ld -> /usr/bin/ld.bfd
2024-07-01 20:03:03 (89788): Guest Log: 19:59:50 CEST +02:00 2024-07-01: cranky: [INFO] ===> [runRivet] Mon Jul  1 17:59:48 UTC 2024 [boinc pp jets 13000 40 - pythia6 6.428 364 100000 265]
2024-07-01 20:03:03 (89788): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-01 20:06:11 (89768): vboxwrapper version 26207
2024-07-01 20:06:11 (89768): BOINC client version: 8.0.2
2024-07-01 20:06:12 (89768): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-01 20:06:12 (89768): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-01 20:06:17 (89768): VM was running
2024-07-01 20:06:17 (89768): Powering off VM.
2024-07-01 20:06:18 (89768): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_9e9cdfe762b9de06" 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-01 20:06:18 (89768): VM did not power off when requested.
2024-07-01 20:06:18 (89768): VM was NOT successfully terminated.
2024-07-01 20:06:18 (89768): Could not stop running VM
2024-07-01 20:06:18 (89768): ERROR: VM failed to start
2024-07-01 20:06:23 (89768): 
   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-02 11:50:06 (31704): vboxwrapper version 26207
2024-07-02 11:50:06 (31704): BOINC client version: 8.0.2
2024-07-02 11:50:08 (31704): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-02 11:50:08 (31704): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-02 11:50:08 (31704): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-02 11:56:23 (29764): vboxwrapper version 26207
2024-07-02 11:56:23 (29764): BOINC client version: 8.0.2
2024-07-02 11:56:23 (29764): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-02 11:56:23 (29764): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-02 11:56:29 (29764): VM was running
2024-07-02 11:56:29 (29764): Powering off VM.
2024-07-02 11:56:29 (29764): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_9e9cdfe762b9de06" 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-02 11:56:29 (29764): VM did not power off when requested.
2024-07-02 11:56:29 (29764): VM was NOT successfully terminated.
2024-07-02 11:56:29 (29764): Could not stop running VM
2024-07-02 11:56:29 (29764): ERROR: VM failed to start
2024-07-02 11:56:34 (29764): 
   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-03 11:57:11 (123144): vboxwrapper version 26207
2024-07-03 11:57:11 (123144): BOINC client version: 8.0.2
2024-07-03 11:57:12 (123144): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 11:57:13 (123144): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 11:57:13 (123144): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 11:57:23 (123144): Successfully started VM. (PID = '132272')
2024-07-03 11:57:23 (123144): Reporting VM Process ID to BOINC.
2024-07-03 11:57:23 (123144): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 11:57:23 (123144): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 11:57:23 (123144): Preference change detected
2024-07-03 11:57:23 (123144): Setting CPU throttle for VM. (50%)
2024-07-03 11:57:23 (123144): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 11:57:32 (123144): Guest Log: 00:01:30.034306 timesync vgsvcTimeSyncWorker: Radical host time change: 143 849 541 000 000ns (HostNow=1 720 000 651 545 000 000 ns HostLast=1 719 856 802 004 000 000 ns)
2024-07-03 11:57:42 (123144): Guest Log: 00:01:40.034511 timesync vgsvcTimeSyncWorker: Radical guest time change: 143 849 986 819 000ns (GuestNow=1 720 000 661 556 602 000 ns GuestLast=1 719 856 811 569 783 000 ns fSetTimeLastLoop=true )
2024-07-03 12:01:20 (123144): Stopping VM.
2024-07-03 12:01:22 (123144): Successfully stopped VM.
2024-07-03 12:04:20 (131244): vboxwrapper version 26207
2024-07-03 12:04:20 (131244): BOINC client version: 8.0.2
2024-07-03 12:04:20 (131244): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 12:04:20 (131244): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 12:04:21 (131244): Guest Log: 00:01:30.034306 timesync vgsvcTimeSyncWorker: Radical host time change: 143 849 541 000 000ns (HostNow=1 720 000 651 545 000 000 ns HostLast=1 719 856 802 004 000 000 ns)
2024-07-03 12:04:21 (131244): Guest Log: 00:01:40.034511 timesync vgsvcTimeSyncWorker: Radical guest time change: 143 849 986 819 000ns (GuestNow=1 720 000 661 556 602 000 ns GuestLast=1 719 856 811 569 783 000 ns fSetTimeLastLoop=true )
2024-07-03 12:04:21 (131244): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 12:04:29 (131244): Successfully started VM. (PID = '118532')
2024-07-03 12:04:29 (131244): Reporting VM Process ID to BOINC.
2024-07-03 12:04:29 (131244): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 12:04:29 (131244): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 12:04:29 (131244): Preference change detected
2024-07-03 12:04:29 (131244): Setting CPU throttle for VM. (50%)
2024-07-03 12:04:29 (131244): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 12:14:46 (131244): Stopping VM.
2024-07-03 12:14:48 (131244): Successfully stopped VM.
2024-07-03 12:17:45 (130860): vboxwrapper version 26207
2024-07-03 12:17:45 (130860): BOINC client version: 8.0.2
2024-07-03 12:17:45 (130860): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 12:17:45 (130860): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 12:17:46 (130860): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 12:17:54 (130860): Successfully started VM. (PID = '109192')
2024-07-03 12:17:54 (130860): Reporting VM Process ID to BOINC.
2024-07-03 12:17:54 (130860): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 12:17:54 (130860): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 12:17:54 (130860): Preference change detected
2024-07-03 12:17:54 (130860): Setting CPU throttle for VM. (50%)
2024-07-03 12:17:55 (130860): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 12:19:35 (130860): Stopping VM.
2024-07-03 12:19:38 (130860): Successfully stopped VM.
2024-07-03 12:34:37 (134764): vboxwrapper version 26207
2024-07-03 12:34:37 (134764): BOINC client version: 8.0.2
2024-07-03 12:34:38 (134764): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 12:34:38 (134764): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 12:34:39 (134764): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 12:34:47 (134764): Successfully started VM. (PID = '124216')
2024-07-03 12:34:47 (134764): Reporting VM Process ID to BOINC.
2024-07-03 12:34:47 (134764): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 12:34:47 (134764): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 12:34:47 (134764): Preference change detected
2024-07-03 12:34:47 (134764): Setting CPU throttle for VM. (50%)
2024-07-03 12:34:47 (134764): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 12:56:57 (134764): Stopping VM.
2024-07-03 12:57:00 (134764): Successfully stopped VM.
2024-07-03 12:59:58 (140088): vboxwrapper version 26207
2024-07-03 12:59:58 (140088): BOINC client version: 8.0.2
2024-07-03 12:59:59 (140088): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 12:59:59 (140088): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 13:00:00 (140088): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 13:00:08 (140088): Successfully started VM. (PID = '138296')
2024-07-03 13:00:08 (140088): Reporting VM Process ID to BOINC.
2024-07-03 13:00:08 (140088): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 13:00:08 (140088): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 13:00:08 (140088): Preference change detected
2024-07-03 13:00:08 (140088): Setting CPU throttle for VM. (50%)
2024-07-03 13:00:08 (140088): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 13:05:00 (140088): Stopping VM.
2024-07-03 13:05:03 (140088): Successfully stopped VM.
2024-07-03 13:08:00 (135472): vboxwrapper version 26207
2024-07-03 13:08:00 (135472): BOINC client version: 8.0.2
2024-07-03 13:08:01 (135472): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 13:08:02 (135472): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 13:08:02 (135472): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 13:08:11 (135472): Successfully started VM. (PID = '140080')
2024-07-03 13:08:11 (135472): Reporting VM Process ID to BOINC.
2024-07-03 13:08:11 (135472): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 13:08:11 (135472): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 13:08:11 (135472): Preference change detected
2024-07-03 13:08:11 (135472): Setting CPU throttle for VM. (50%)
2024-07-03 13:08:11 (135472): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 13:14:12 (135472): Stopping VM.
2024-07-03 13:14:14 (135472): Successfully stopped VM.
2024-07-03 13:17:12 (136448): vboxwrapper version 26207
2024-07-03 13:17:12 (136448): BOINC client version: 8.0.2
2024-07-03 13:17:13 (136448): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 13:17:13 (136448): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 13:17:13 (136448): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 13:17:22 (136448): Successfully started VM. (PID = '140380')
2024-07-03 13:17:22 (136448): Reporting VM Process ID to BOINC.
2024-07-03 13:17:22 (136448): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 13:17:22 (136448): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 13:17:22 (136448): Preference change detected
2024-07-03 13:17:22 (136448): Setting CPU throttle for VM. (50%)
2024-07-03 13:17:22 (136448): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 13:52:15 (136448): Stopping VM.
2024-07-03 13:52:18 (136448): Successfully stopped VM.
2024-07-03 13:55:16 (143540): vboxwrapper version 26207
2024-07-03 13:55:16 (143540): BOINC client version: 8.0.2
2024-07-03 13:55:17 (143540): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 13:55:17 (143540): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 13:55:18 (143540): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 13:55:26 (143540): Successfully started VM. (PID = '140776')
2024-07-03 13:55:26 (143540): Reporting VM Process ID to BOINC.
2024-07-03 13:55:26 (143540): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 13:55:26 (143540): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 13:55:26 (143540): Preference change detected
2024-07-03 13:55:26 (143540): Setting CPU throttle for VM. (50%)
2024-07-03 13:55:26 (143540): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 13:58:49 (143540): Stopping VM.
2024-07-03 13:58:52 (143540): Successfully stopped VM.
2024-07-03 14:04:47 (140072): vboxwrapper version 26207
2024-07-03 14:04:47 (140072): BOINC client version: 8.0.2
2024-07-03 14:04:49 (140072): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 14:04:49 (140072): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 14:04:50 (140072): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 14:04:58 (140072): Successfully started VM. (PID = '139076')
2024-07-03 14:04:58 (140072): Reporting VM Process ID to BOINC.
2024-07-03 14:04:58 (140072): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 14:04:58 (140072): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 14:04:58 (140072): Preference change detected
2024-07-03 14:04:58 (140072): Setting CPU throttle for VM. (50%)
2024-07-03 14:04:59 (140072): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 14:15:54 (140072): Status Report: Job Duration: '864000.000000'
2024-07-03 14:15:54 (140072): Status Report: Elapsed Time: '6000.000000'
2024-07-03 14:15:54 (140072): Status Report: CPU Time: '3548.484375'
2024-07-03 14:22:14 (140072): Stopping VM.
2024-07-03 14:22:16 (140072): Successfully stopped VM.
2024-07-03 14:25:14 (86260): vboxwrapper version 26207
2024-07-03 14:25:14 (86260): BOINC client version: 8.0.2
2024-07-03 14:25:15 (86260): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 14:25:15 (86260): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 14:25:16 (86260): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 14:25:24 (86260): Successfully started VM. (PID = '136992')
2024-07-03 14:25:24 (86260): Reporting VM Process ID to BOINC.
2024-07-03 14:25:24 (86260): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 14:25:24 (86260): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 14:25:24 (86260): Status Report: Job Duration: '864000.000000'
2024-07-03 14:25:24 (86260): Status Report: Elapsed Time: '6379.000000'
2024-07-03 14:25:24 (86260): Status Report: CPU Time: '3777.109375'
2024-07-03 14:25:24 (86260): Preference change detected
2024-07-03 14:25:24 (86260): Setting CPU throttle for VM. (50%)
2024-07-03 14:25:24 (86260): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 14:34:43 (86260): Stopping VM.
2024-07-03 14:34:45 (86260): Successfully stopped VM.
2024-07-03 14:37:43 (143296): vboxwrapper version 26207
2024-07-03 14:37:43 (143296): BOINC client version: 8.0.2
2024-07-03 14:37:44 (143296): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 14:37:44 (143296): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 14:37:44 (143296): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 14:37:53 (143296): Successfully started VM. (PID = '124452')
2024-07-03 14:37:53 (143296): Reporting VM Process ID to BOINC.
2024-07-03 14:37:53 (143296): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 14:37:53 (143296): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 14:37:53 (143296): Status Report: Job Duration: '864000.000000'
2024-07-03 14:37:53 (143296): Status Report: Elapsed Time: '6937.000000'
2024-07-03 14:37:53 (143296): Status Report: CPU Time: '4112.968750'
2024-07-03 14:37:53 (143296): Preference change detected
2024-07-03 14:37:53 (143296): Setting CPU throttle for VM. (50%)
2024-07-03 14:37:53 (143296): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 15:04:31 (143296): Stopping VM.
2024-07-03 15:04:33 (143296): Successfully stopped VM.
2024-07-03 15:07:31 (146156): vboxwrapper version 26207
2024-07-03 15:07:31 (146156): BOINC client version: 8.0.2
2024-07-03 15:07:32 (146156): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 15:07:32 (146156): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 15:07:33 (146156): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 15:07:41 (146156): Successfully started VM. (PID = '139712')
2024-07-03 15:07:41 (146156): Reporting VM Process ID to BOINC.
2024-07-03 15:07:41 (146156): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 15:07:41 (146156): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 15:07:41 (146156): Status Report: Job Duration: '864000.000000'
2024-07-03 15:07:41 (146156): Status Report: Elapsed Time: '8533.000000'
2024-07-03 15:07:41 (146156): Status Report: CPU Time: '5074.625000'
2024-07-03 15:07:41 (146156): Preference change detected
2024-07-03 15:07:41 (146156): Setting CPU throttle for VM. (50%)
2024-07-03 15:07:41 (146156): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 15:18:57 (146156): Stopping VM.
2024-07-03 15:18:59 (146156): Successfully stopped VM.
2024-07-03 15:21:56 (135232): vboxwrapper version 26207
2024-07-03 15:21:56 (135232): BOINC client version: 8.0.2
2024-07-03 15:21:57 (135232): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 15:21:57 (135232): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 15:21:58 (135232): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 15:22:06 (135232): Successfully started VM. (PID = '141892')
2024-07-03 15:22:06 (135232): Reporting VM Process ID to BOINC.
2024-07-03 15:22:06 (135232): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 15:22:06 (135232): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 15:22:06 (135232): Status Report: Job Duration: '864000.000000'
2024-07-03 15:22:06 (135232): Status Report: Elapsed Time: '9208.000000'
2024-07-03 15:22:06 (135232): Status Report: CPU Time: '5482.593750'
2024-07-03 15:22:06 (135232): Preference change detected
2024-07-03 15:22:06 (135232): Setting CPU throttle for VM. (50%)
2024-07-03 15:22:06 (135232): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 15:27:14 (135232): Stopping VM.
2024-07-03 15:27:16 (135232): Successfully stopped VM.
2024-07-03 15:30:51 (145524): vboxwrapper version 26207
2024-07-03 15:30:51 (145524): BOINC client version: 8.0.2
2024-07-03 15:30:53 (145524): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 15:30:53 (145524): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 15:30:53 (145524): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 15:31:02 (145524): Successfully started VM. (PID = '132648')
2024-07-03 15:31:02 (145524): Reporting VM Process ID to BOINC.
2024-07-03 15:31:02 (145524): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 15:31:02 (145524): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 15:31:02 (145524): Status Report: Job Duration: '864000.000000'
2024-07-03 15:31:02 (145524): Status Report: Elapsed Time: '9515.000000'
2024-07-03 15:31:02 (145524): Status Report: CPU Time: '5668.000000'
2024-07-03 15:31:02 (145524): Preference change detected
2024-07-03 15:31:02 (145524): Setting CPU throttle for VM. (50%)
2024-07-03 15:31:02 (145524): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 15:59:11 (145524): Stopping VM.
2024-07-03 15:59:13 (145524): Successfully stopped VM.
2024-07-03 16:02:10 (147480): vboxwrapper version 26207
2024-07-03 16:02:10 (147480): BOINC client version: 8.0.2
2024-07-03 16:02:11 (147480): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-03 16:02:11 (147480): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 16:02:12 (147480): Starting VM using VBoxManage interface. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 16:02:20 (147480): Successfully started VM. (PID = '148672')
2024-07-03 16:02:20 (147480): Reporting VM Process ID to BOINC.
2024-07-03 16:02:20 (147480): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 16:02:20 (147480): Detected: Web Application Enabled (http://localhost:54232)
2024-07-03 16:02:20 (147480): Status Report: Job Duration: '864000.000000'
2024-07-03 16:02:20 (147480): Status Report: Elapsed Time: '11198.000000'
2024-07-03 16:02:20 (147480): Status Report: CPU Time: '6682.953125'
2024-07-03 16:02:20 (147480): Preference change detected
2024-07-03 16:02:20 (147480): Setting CPU throttle for VM. (50%)
2024-07-03 16:02:20 (147480): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 16:32:56 (147480): Guest Log: job: run exitcode=0
2024-07-03 16:32:56 (147480): Guest Log: job: diskusage=16716
2024-07-03 16:32:56 (147480): Guest Log: job: logsize=84 k
2024-07-03 16:32:56 (147480): Guest Log: job: times=
2024-07-03 16:32:56 (147480): Guest Log: 0m0.014s 0m0.007s
2024-07-03 16:32:56 (147480): Guest Log: 209m52.696s 2m15.790s
2024-07-03 16:32:56 (147480): Guest Log: job: cpuusage=12729
2024-07-03 16:32:56 (147480): Guest Log: 16:32:55 CEST +02:00 2024-07-03: cranky: [INFO] Container 'runc' finished with status code 0.
2024-07-03 16:32:56 (147480): Guest Log: 16:32:55 CEST +02:00 2024-07-03: cranky: [INFO] Preparing output.
2024-07-03 16:32:56 (147480): Guest Log: [INFO] Job Finished
2024-07-03 16:32:56 (147480): Guest Log: [INFO] Shutting Down.
2024-07-03 16:32:56 (147480): VM Completion File Detected.
2024-07-03 16:32:56 (147480): VM Completion Message: Job Finished
.
2024-07-03 16:32:56 (147480): Powering off VM.
2024-07-03 16:32:56 (147480): Successfully stopped VM.
2024-07-03 16:32:56 (147480): Deregistering VM. (boinc_9e9cdfe762b9de06, slot#4)
2024-07-03 16:32:57 (147480): Removing network bandwidth throttle group from VM.
2024-07-03 16:32:57 (147480): Removing VM from VirtualBox.
2024-07-03 16:33:02 (147480): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN