Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2024-05-30 14:58:35 (12244): vboxwrapper version 26207
2024-05-30 14:58:35 (12244): BOINC client version: 8.0.2
2024-05-30 14:58:36 (12244): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-05-30 14:58:36 (12244): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-05-30 14:58:36 (12244): Successfully copied 'init_data.xml' to the shared directory.
2024-05-30 14:58:36 (12244): Successfully copied 'input' to the shared directory.
2024-05-30 14:58:36 (12244): Feature: Checkpoint interval offset (132 seconds)
2024-05-30 14:58:36 (12244): Detected: Minimum checkpoint interval (600.000000 seconds)
2024-05-30 14:58:37 (12244): Create VM. (boinc_87d9909d3328db9a, slot#1)
2024-05-30 14:58:37 (12244): Setting Memory Size for VM. (768MB)
2024-05-30 14:58:37 (12244): Setting CPU Count for VM. (1)
2024-05-30 14:58:38 (12244): Setting Chipset Options for VM.
2024-05-30 14:58:38 (12244): Setting Graphics Controller Options for VM.
2024-05-30 14:58:38 (12244): Setting Boot Options for VM.
2024-05-30 14:58:38 (12244): Setting Network Configuration for NAT.
2024-05-30 14:58:39 (12244): Enabling VM Network Access.
2024-05-30 14:58:39 (12244): Disabling USB Support for VM.
2024-05-30 14:58:39 (12244): Disabling COM Port Support for VM.
2024-05-30 14:58:40 (12244): Disabling LPT Port Support for VM.
2024-05-30 14:58:40 (12244): Disabling Audio Support for VM.
2024-05-30 14:58:40 (12244): Disabling Clipboard Support for VM.
2024-05-30 14:58:40 (12244): Disabling Drag and Drop Support for VM.
2024-05-30 14:58:41 (12244): Adding storage controller(s) to VM.
2024-05-30 14:58:41 (12244): Adding virtual disk drive to VM. (Theory_2024_04_26_dev.vdi)
2024-05-30 14:58:43 (12244): Adding VirtualBox Guest Additions to VM.
2024-05-30 14:58:43 (12244): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-05-30 14:58:44 (12244): forwarding host port 56366 to guest port 80
2024-05-30 14:58:44 (12244): Enabling remote desktop for VM.
2024-05-30 14:58:44 (12244): Enabling shared directory for VM.
2024-05-30 14:58:45 (12244): Starting VM using VBoxManage interface. (boinc_87d9909d3328db9a, slot#1)
2024-05-30 14:58:53 (12244): Successfully started VM. (PID = '10740')
2024-05-30 14:58:53 (12244): Reporting VM Process ID to BOINC.
2024-05-30 14:58:53 (12244): Guest Log: BIOS: VirtualBox 7.0.18
2024-05-30 14:58:53 (12244): Guest Log: CPUID EDX: 0x178bfbff
2024-05-30 14:58:53 (12244): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-05-30 14:58:53 (12244): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-05-30 14:58:53 (12244): VM state change detected. (old = 'poweredoff', new = 'running')
2024-05-30 14:58:53 (12244): Detected: Web Application Enabled (http://localhost:56366)
2024-05-30 14:58:53 (12244): Detected: Remote Desktop Enabled (localhost:56367)
2024-05-30 14:58:53 (12244): Preference change detected
2024-05-30 14:58:53 (12244): Setting CPU throttle for VM. (100%)
2024-05-30 14:58:53 (12244): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-30 14:58:55 (12244): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-05-30 14:58:55 (12244): Guest Log: BIOS: Booting from Hard Disk...
2024-05-30 14:58:58 (12244): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-05-30 14:58:58 (12244): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-05-30 14:59:17 (12244): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-05-30 14:59:17 (12244): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-05-30 14:59:21 (12244): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-05-30 14:59:21 (12244): Guest Log: 00:00:00.000139 main     Log opened 2024-05-30T12:59:20.671955000Z
2024-05-30 14:59:21 (12244): Guest Log: 00:00:00.000289 main     OS Product: Linux
2024-05-30 14:59:21 (12244): Guest Log: 00:00:00.000341 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-05-30 14:59:21 (12244): Guest Log: 00:00:00.000385 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-05-30 14:59:21 (12244): Guest Log: 00:00:00.000441 main     Executable: /usr/sbin/VBoxService
2024-05-30 14:59:21 (12244): Guest Log: 00:00:00.000442 main     Process ID: 3239
2024-05-30 14:59:21 (12244): Guest Log: 00:00:00.000443 main     Package type: LINUX_64BITS_GENERIC
2024-05-30 14:59:21 (12244): Guest Log: 00:00:00.004262 main     5.2.6 r120293 started. Verbose level = 0
2024-05-30 14:59:46 (12244): Guest Log: 14:59:46 CEST +02:00 2024-05-30: cranky: [INFO] Detected Theory App
2024-05-30 14:59:46 (12244): Guest Log: 14:59:46 CEST +02:00 2024-05-30: cranky: [INFO] Checking CVMFS.
2024-05-30 14:59:47 (12244): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-05-30 14:59:48 (12244): 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-05-30 14:59:48 (12244): Guest Log: 2.5.2.0 4141 0 28256 29451 3 1 271745 4096000 0 65024 0 0 n/a 5 3 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-05-30 14:59:49 (12244): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-05-30 14:59:49 (12244): 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-05-30 14:59:49 (12244): Guest Log: 2.5.2.0 4072 0 25448 24341 3 2 271745 4096000 0 65024 0 2 -100 7959 2432 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-05-30 14:59:50 (12244): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-05-30 14:59:51 (12244): 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-05-30 14:59:51 (12244): Guest Log: 2.5.2.0 4114 0 25256 268 3 1 271745 4096000 0 65024 0 0 n/a 4 2 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-05-30 14:59:52 (12244): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-05-30 14:59:53 (12244): 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-05-30 14:59:53 (12244): Guest Log: 2.5.2.0 4093 0 39656 18784 3 1 271745 4096000 0 65024 0 0 n/a 5303 2381 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-05-30 14:59:53 (12244): Guest Log: 14:59:52 CEST +02:00 2024-05-30: cranky: [INFO] Checking runc.
2024-05-30 14:59:53 (12244): Guest Log: 14:59:53 CEST +02:00 2024-05-30: cranky: [INFO] Creating the filesystem.
2024-05-30 14:59:53 (12244): Guest Log: 14:59:53 CEST +02:00 2024-05-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-05-30 14:59:53 (12244): Guest Log: 14:59:53 CEST +02:00 2024-05-30: cranky: [INFO] Updating config.json.
2024-05-30 14:59:53 (12244): Guest Log: 14:59:53 CEST +02:00 2024-05-30: cranky: [INFO] Running Container 'runc'.
2024-05-30 14:59:57 (12244): Guest Log: job: htmld=/shared/html/job
2024-05-30 14:59:58 (12244): Guest Log: job: unpack exitcode=0
2024-05-30 14:59:58 (12244): Guest Log: INFO: activated the work-around for ld:
2024-05-30 14:59:58 (12244): Guest Log: lrwxrwxrwx 1 0 0 15 May 30 12:59 /tmp/tmp.HYnRqhgZsv/ld -> /usr/bin/ld.bfd
2024-05-30 14:59:59 (12244): Guest Log: 14:59:59 CEST +02:00 2024-05-30: cranky: [INFO] ===> [runRivet] Thu May 30 12:59:58 UTC 2024 [boinc pp jets 13000 550 - pythia8 8.308 dire-default 37000 223]
2024-05-30 15:11:07 (12244): Creating new snapshot for VM.
2024-05-30 15:11:11 (12244): Checkpoint completed.
2024-05-30 15:21:07 (12244): Creating new snapshot for VM.
2024-05-30 15:21:12 (12244): Deleting stale snapshot.
2024-05-30 15:21:13 (12244): Checkpoint completed.
2024-05-30 15:23:14 (12244): Preference change detected
2024-05-30 15:23:14 (12244): Setting CPU throttle for VM. (100%)
2024-05-30 15:23:14 (12244): Setting checkpoint interval to 720 seconds. (Higher value of (Preference: 720 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-30 15:33:09 (12244): Creating new snapshot for VM.
2024-05-30 15:33:13 (12244): Deleting stale snapshot.
2024-05-30 15:33:14 (12244): Checkpoint completed.
2024-05-30 15:45:21 (12244): Creating new snapshot for VM.
2024-05-30 15:45:25 (12244): Deleting stale snapshot.
2024-05-30 15:45:26 (12244): Checkpoint completed.
2024-05-30 15:57:30 (12244): Creating new snapshot for VM.
2024-05-30 15:57:34 (12244): Deleting stale snapshot.
2024-05-30 15:57:35 (12244): Checkpoint completed.
2024-05-30 16:09:41 (12244): Creating new snapshot for VM.
2024-05-30 16:09:45 (12244): Deleting stale snapshot.
2024-05-30 16:09:45 (12244): Checkpoint completed.
2024-05-30 16:21:52 (12244): Creating new snapshot for VM.
2024-05-30 16:21:56 (12244): Deleting stale snapshot.
2024-05-30 16:21:56 (12244): Checkpoint completed.
2024-05-30 16:34:05 (12244): Creating new snapshot for VM.
2024-05-30 16:34:10 (12244): Deleting stale snapshot.
2024-05-30 16:34:10 (12244): Checkpoint completed.
2024-05-30 16:39:01 (12244): Status Report: Elapsed Time: '6000.911505'
2024-05-30 16:39:01 (12244): Status Report: CPU Time: '5698.562500'
2024-05-30 16:46:17 (12244): Creating new snapshot for VM.
2024-05-30 16:46:21 (12244): Deleting stale snapshot.
2024-05-30 16:46:22 (12244): Checkpoint completed.
2024-05-30 16:58:41 (12244): Creating new snapshot for VM.
2024-05-30 16:58:45 (12244): Deleting stale snapshot.
2024-05-30 16:58:45 (12244): Checkpoint completed.
2024-05-30 17:10:53 (12244): Creating new snapshot for VM.
2024-05-30 17:10:58 (12244): Deleting stale snapshot.
2024-05-30 17:10:58 (12244): Checkpoint completed.
2024-05-30 17:23:03 (12244): Creating new snapshot for VM.
2024-05-30 17:23:07 (12244): Deleting stale snapshot.
2024-05-30 17:23:07 (12244): Checkpoint completed.
2024-05-30 17:35:12 (12244): Creating new snapshot for VM.
2024-05-30 17:35:16 (12244): Deleting stale snapshot.
2024-05-30 17:35:17 (12244): Checkpoint completed.
2024-05-30 17:47:20 (12244): Creating new snapshot for VM.
2024-05-30 17:47:25 (12244): Deleting stale snapshot.
2024-05-30 17:47:25 (12244): Checkpoint completed.
2024-05-30 17:59:29 (12244): Creating new snapshot for VM.
2024-05-30 17:59:33 (12244): Deleting stale snapshot.
2024-05-30 17:59:34 (12244): Checkpoint completed.
2024-05-30 18:11:37 (12244): Creating new snapshot for VM.
2024-05-30 18:11:41 (12244): Deleting stale snapshot.
2024-05-30 18:11:42 (12244): Checkpoint completed.
2024-05-30 18:19:08 (12244): Status Report: Elapsed Time: '12001.411329'
2024-05-30 18:19:08 (12244): Status Report: CPU Time: '11647.984375'
2024-05-30 18:23:45 (12244): Creating new snapshot for VM.
2024-05-30 18:23:49 (12244): Deleting stale snapshot.
2024-05-30 18:23:49 (12244): Checkpoint completed.
2024-05-30 18:35:53 (12244): Creating new snapshot for VM.
2024-05-30 18:35:57 (12244): Deleting stale snapshot.
2024-05-30 18:35:57 (12244): Checkpoint completed.
2024-05-30 18:48:01 (12244): Creating new snapshot for VM.
2024-05-30 18:48:05 (12244): Deleting stale snapshot.
2024-05-30 18:48:05 (12244): Checkpoint completed.
2024-05-30 19:00:10 (12244): Creating new snapshot for VM.
2024-05-30 19:00:13 (12244): Deleting stale snapshot.
2024-05-30 19:00:14 (12244): Checkpoint completed.
2024-05-30 19:12:22 (12244): Creating new snapshot for VM.
2024-05-30 19:12:27 (12244): Deleting stale snapshot.
2024-05-30 19:12:27 (12244): Checkpoint completed.
2024-05-30 19:24:39 (12244): Creating new snapshot for VM.
2024-05-30 19:24:44 (12244): Deleting stale snapshot.
2024-05-30 19:24:45 (12244): Checkpoint completed.
2024-05-30 19:36:51 (12244): Creating new snapshot for VM.
2024-05-30 19:36:56 (12244): Deleting stale snapshot.
2024-05-30 19:36:56 (12244): Checkpoint completed.
2024-05-30 19:49:02 (12244): Creating new snapshot for VM.
2024-05-30 19:49:08 (12244): Deleting stale snapshot.
2024-05-30 19:49:08 (12244): Checkpoint completed.
2024-05-30 19:59:15 (12244): Status Report: Elapsed Time: '18001.428988'
2024-05-30 19:59:15 (12244): Status Report: CPU Time: '17577.000000'
2024-05-30 20:01:17 (12244): Creating new snapshot for VM.
2024-05-30 20:01:22 (12244): Deleting stale snapshot.
2024-05-30 20:01:23 (12244): Checkpoint completed.
2024-05-30 20:13:27 (12244): Creating new snapshot for VM.
2024-05-30 20:13:32 (12244): Deleting stale snapshot.
2024-05-30 20:13:32 (12244): Checkpoint completed.
2024-05-30 20:25:36 (12244): Creating new snapshot for VM.
2024-05-30 20:25:40 (12244): Deleting stale snapshot.
2024-05-30 20:25:41 (12244): Checkpoint completed.
2024-05-30 20:37:45 (12244): Creating new snapshot for VM.
2024-05-30 20:37:50 (12244): Deleting stale snapshot.
2024-05-30 20:37:50 (12244): Checkpoint completed.
2024-05-30 20:49:53 (12244): Creating new snapshot for VM.
2024-05-30 20:49:58 (12244): Deleting stale snapshot.
2024-05-30 20:49:58 (12244): Checkpoint completed.
2024-05-30 21:02:03 (12244): Creating new snapshot for VM.
2024-05-30 21:02:07 (12244): Deleting stale snapshot.
2024-05-30 21:02:07 (12244): Checkpoint completed.
2024-05-30 21:14:12 (12244): Creating new snapshot for VM.
2024-05-30 21:14:16 (12244): Deleting stale snapshot.
2024-05-30 21:14:16 (12244): Checkpoint completed.
2024-05-30 21:16:23 (12244): Preference change detected
2024-05-30 21:16:23 (12244): Setting CPU throttle for VM. (100%)
2024-05-30 21:16:23 (12244): Setting checkpoint interval to 720 seconds. (Higher value of (Preference: 720 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-30 21:16:57 (12244): Preference change detected
2024-05-30 21:16:57 (12244): Setting CPU throttle for VM. (100%)
2024-05-30 21:16:57 (12244): Setting checkpoint interval to 720 seconds. (Higher value of (Preference: 720 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-30 21:26:24 (12244): Creating new snapshot for VM.
2024-05-30 21:26:29 (12244): Deleting stale snapshot.
2024-05-30 21:26:29 (12244): Checkpoint completed.
2024-05-30 21:38:36 (12244): Creating new snapshot for VM.
2024-05-30 21:38:42 (12244): Deleting stale snapshot.
2024-05-30 21:38:42 (12244): Checkpoint completed.
2024-05-30 21:39:20 (12244): Status Report: Elapsed Time: '24002.134394'
2024-05-30 21:39:20 (12244): Status Report: CPU Time: '23525.843750'
2024-05-30 21:50:50 (12244): Creating new snapshot for VM.
2024-05-30 21:50:55 (12244): Deleting stale snapshot.
2024-05-30 21:50:55 (12244): Checkpoint completed.
2024-05-30 22:03:00 (12244): Creating new snapshot for VM.
2024-05-30 22:03:04 (12244): Deleting stale snapshot.
2024-05-30 22:03:05 (12244): Checkpoint completed.
2024-05-30 22:11:47 (12244): Preference change detected
2024-05-30 22:11:47 (12244): Setting CPU throttle for VM. (100%)
2024-05-30 22:11:47 (12244): Setting checkpoint interval to 720 seconds. (Higher value of (Preference: 720 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-30 22:15:11 (12244): Creating new snapshot for VM.
2024-05-30 22:15:16 (12244): Deleting stale snapshot.
2024-05-30 22:15:16 (12244): Checkpoint completed.
2024-05-30 22:15:20 (12244): Creating new snapshot for VM.
2024-05-30 22:15:25 (12244): Deleting stale snapshot.
2024-05-30 22:15:25 (12244): Checkpoint completed.
2024-05-30 22:15:25 (12244): Stopping VM.
2024-05-30 22:15:30 (12244): Successfully stopped VM.
2024-05-31 07:13:44 (8840): vboxwrapper version 26207
2024-05-31 07:13:44 (8840): BOINC client version: 8.0.2
2024-05-31 07:13:44 (8840): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-05-31 07:13:45 (8840): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-05-31 07:13:45 (8840): Feature: Checkpoint interval offset (529 seconds)
2024-05-31 07:13:45 (8840): Detected: Minimum checkpoint interval (600.000000 seconds)
2024-05-31 07:13:47 (8840): Guest Log: BIOS: VirtualBox 7.0.18
2024-05-31 07:13:47 (8840): Guest Log: CPUID EDX: 0x178bfbff
2024-05-31 07:13:47 (8840): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-05-31 07:13:47 (8840): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-05-31 07:13:47 (8840): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-05-31 07:13:47 (8840): Guest Log: BIOS: Booting from Hard Disk...
2024-05-31 07:13:47 (8840): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-05-31 07:13:47 (8840): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-05-31 07:13:47 (8840): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-05-31 07:13:47 (8840): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-05-31 07:13:47 (8840): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-05-31 07:13:47 (8840): Guest Log: 00:00:00.000139 main     Log opened 2024-05-30T12:59:20.671955000Z
2024-05-31 07:13:47 (8840): Guest Log: 00:00:00.000289 main     OS Product: Linux
2024-05-31 07:13:47 (8840): Guest Log: 00:00:00.000341 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-05-31 07:13:47 (8840): Guest Log: 00:00:00.000385 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-05-31 07:13:47 (8840): Guest Log: 00:00:00.000441 main     Executable: /usr/sbin/VBoxService
2024-05-31 07:13:47 (8840): Guest Log: 00:00:00.000442 main     Process ID: 3239
2024-05-31 07:13:47 (8840): Guest Log: 00:00:00.000443 main     Package type: LINUX_64BITS_GENERIC
2024-05-31 07:13:47 (8840): Guest Log: 00:00:00.004262 main     5.2.6 r120293 started. Verbose level = 0
2024-05-31 07:13:47 (8840): Guest Log: 14:59:46 CEST +02:00 2024-05-30: cranky: [INFO] Detected Theory App
2024-05-31 07:13:47 (8840): Guest Log: 14:59:46 CEST +02:00 2024-05-30: cranky: [INFO] Checking CVMFS.
2024-05-31 07:13:47 (8840): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-05-31 07:13:47 (8840): 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-05-31 07:13:47 (8840): Guest Log: 2.5.2.0 4141 0 28256 29451 3 1 271745 4096000 0 65024 0 0 n/a 5 3 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-05-31 07:13:47 (8840): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-05-31 07:13:47 (8840): 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-05-31 07:13:47 (8840): Guest Log: 2.5.2.0 4072 0 25448 24341 3 2 271745 4096000 0 65024 0 2 -100 7959 2432 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-05-31 07:13:47 (8840): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-05-31 07:13:47 (8840): 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-05-31 07:13:47 (8840): Guest Log: 2.5.2.0 4114 0 25256 268 3 1 271745 4096000 0 65024 0 0 n/a 4 2 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-05-31 07:13:47 (8840): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-05-31 07:13:47 (8840): 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-05-31 07:13:47 (8840): Guest Log: 2.5.2.0 4093 0 39656 18784 3 1 271745 4096000 0 65024 0 0 n/a 5303 2381 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-05-31 07:13:47 (8840): Guest Log: 14:59:52 CEST +02:00 2024-05-30: cranky: [INFO] Checking runc.
2024-05-31 07:13:47 (8840): Guest Log: 14:59:53 CEST +02:00 2024-05-30: cranky: [INFO] Creating the filesystem.
2024-05-31 07:13:47 (8840): Guest Log: 14:59:53 CEST +02:00 2024-05-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-05-31 07:13:47 (8840): Guest Log: 14:59:53 CEST +02:00 2024-05-30: cranky: [INFO] Updating config.json.
2024-05-31 07:13:47 (8840): Guest Log: 14:59:53 CEST +02:00 2024-05-30: cranky: [INFO] Running Container 'runc'.
2024-05-31 07:13:47 (8840): Guest Log: job: htmld=/shared/html/job
2024-05-31 07:13:47 (8840): Guest Log: job: unpack exitcode=0
2024-05-31 07:13:47 (8840): Guest Log: INFO: activated the work-around for ld:
2024-05-31 07:13:47 (8840): Guest Log: lrwxrwxrwx 1 0 0 15 May 30 12:59 /tmp/tmp.HYnRqhgZsv/ld -> /usr/bin/ld.bfd
2024-05-31 07:13:47 (8840): Guest Log: 14:59:59 CEST +02:00 2024-05-30: cranky: [INFO] ===> [runRivet] Thu May 30 12:59:58 UTC 2024 [boinc pp jets 13000 550 - pythia8 8.308 dire-default 37000 223]
2024-05-31 07:13:47 (8840): Restore from previously saved snapshot.
2024-05-31 07:13:47 (8840): Restore completed.
2024-05-31 07:13:47 (8840): Starting VM using VBoxManage interface. (boinc_87d9909d3328db9a, slot#1)
2024-05-31 07:14:01 (8840): Successfully started VM. (PID = '5824')
2024-05-31 07:14:01 (8840): Reporting VM Process ID to BOINC.
2024-05-31 07:14:01 (8840): VM state change detected. (old = 'poweredoff', new = 'running')
2024-05-31 07:14:01 (8840): Detected: Web Application Enabled (http://localhost:56366)
2024-05-31 07:14:01 (8840): Detected: Remote Desktop Enabled (localhost:56367)
2024-05-31 07:14:01 (8840): Status Report: Elapsed Time: '26160.000839'
2024-05-31 07:14:01 (8840): Status Report: CPU Time: '25631.953125'
2024-05-31 07:14:01 (8840): Preference change detected
2024-05-31 07:14:01 (8840): Setting CPU throttle for VM. (100%)
2024-05-31 07:14:01 (8840): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-31 07:14:02 (8840): Guest Log: 07:13:47.155402 timesync vgsvcTimeSyncWorker: Radical host time change: 32 333 629 000 000ns (HostNow=1 717 132 441 394 000 000 ns HostLast=1 717 100 107 765 000 000 ns)
2024-05-31 07:14:12 (8840): Guest Log: 07:13:57.179583 timesync vgsvcTimeSyncWorker: Radical guest time change: 32 463 685 453 000ns (GuestNow=1 717 132 451 421 652 000 ns GuestLast=1 717 099 987 736 199 000 ns fSetTimeLastLoop=true )
2024-05-31 07:33:01 (8840): Creating new snapshot for VM.
2024-05-31 07:33:05 (8840): Deleting stale snapshot.
2024-05-31 07:33:06 (8840): Checkpoint completed.
2024-05-31 07:43:01 (8840): Creating new snapshot for VM.
2024-05-31 07:43:05 (8840): Deleting stale snapshot.
2024-05-31 07:43:06 (8840): Checkpoint completed.
2024-05-31 07:53:02 (8840): Creating new snapshot for VM.
2024-05-31 07:53:06 (8840): Deleting stale snapshot.
2024-05-31 07:53:07 (8840): Checkpoint completed.
2024-05-31 08:03:03 (8840): Creating new snapshot for VM.
2024-05-31 08:03:07 (8840): Deleting stale snapshot.
2024-05-31 08:03:07 (8840): Checkpoint completed.
2024-05-31 08:13:04 (8840): Creating new snapshot for VM.
2024-05-31 08:13:08 (8840): Deleting stale snapshot.
2024-05-31 08:13:08 (8840): Checkpoint completed.
2024-05-31 08:23:05 (8840): Creating new snapshot for VM.
2024-05-31 08:23:09 (8840): Deleting stale snapshot.
2024-05-31 08:23:09 (8840): Checkpoint completed.
2024-05-31 08:33:06 (8840): Creating new snapshot for VM.
2024-05-31 08:33:10 (8840): Deleting stale snapshot.
2024-05-31 08:33:10 (8840): Checkpoint completed.
2024-05-31 08:43:07 (8840): Creating new snapshot for VM.
2024-05-31 08:43:13 (8840): Deleting stale snapshot.
2024-05-31 08:43:13 (8840): Checkpoint completed.
2024-05-31 08:53:08 (8840): Creating new snapshot for VM.
2024-05-31 08:53:12 (8840): Deleting stale snapshot.
2024-05-31 08:53:12 (8840): Checkpoint completed.
2024-05-31 08:54:14 (8840): Status Report: Elapsed Time: '32160.148422'
2024-05-31 08:54:14 (8840): Status Report: CPU Time: '31597.031250'
2024-05-31 09:02:46 (8840): Preference change detected
2024-05-31 09:02:46 (8840): Setting CPU throttle for VM. (100%)
2024-05-31 09:02:46 (8840): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-31 09:03:09 (8840): Creating new snapshot for VM.
2024-05-31 09:03:13 (8840): Deleting stale snapshot.
2024-05-31 09:03:14 (8840): Checkpoint completed.
2024-05-31 09:03:19 (8840): Preference change detected
2024-05-31 09:03:19 (8840): Setting CPU throttle for VM. (100%)
2024-05-31 09:03:19 (8840): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-31 09:13:10 (8840): Creating new snapshot for VM.
2024-05-31 09:13:15 (8840): Deleting stale snapshot.
2024-05-31 09:13:15 (8840): Checkpoint completed.
2024-05-31 09:23:12 (8840): Creating new snapshot for VM.
2024-05-31 09:23:17 (8840): Deleting stale snapshot.
2024-05-31 09:23:17 (8840): Checkpoint completed.
2024-05-31 09:33:14 (8840): Creating new snapshot for VM.
2024-05-31 09:33:20 (8840): Deleting stale snapshot.
2024-05-31 09:33:21 (8840): Checkpoint completed.
2024-05-31 09:43:15 (8840): Creating new snapshot for VM.
2024-05-31 09:43:20 (8840): Deleting stale snapshot.
2024-05-31 09:43:20 (8840): Checkpoint completed.
2024-05-31 09:53:17 (8840): Creating new snapshot for VM.
2024-05-31 09:53:21 (8840): Deleting stale snapshot.
2024-05-31 09:53:22 (8840): Checkpoint completed.
2024-05-31 10:03:18 (8840): Creating new snapshot for VM.
2024-05-31 10:03:22 (8840): Deleting stale snapshot.
2024-05-31 10:03:23 (8840): Checkpoint completed.
2024-05-31 10:13:19 (8840): Creating new snapshot for VM.
2024-05-31 10:13:24 (8840): Deleting stale snapshot.
2024-05-31 10:13:24 (8840): Checkpoint completed.
2024-05-31 10:23:21 (8840): Creating new snapshot for VM.
2024-05-31 10:23:25 (8840): Deleting stale snapshot.
2024-05-31 10:23:26 (8840): Checkpoint completed.
2024-05-31 10:33:21 (8840): Creating new snapshot for VM.
2024-05-31 10:33:25 (8840): Deleting stale snapshot.
2024-05-31 10:33:26 (8840): Checkpoint completed.
2024-05-31 10:34:21 (8840): Status Report: Elapsed Time: '38160.251398'
2024-05-31 10:34:21 (8840): Status Report: CPU Time: '37531.937500'
2024-05-31 10:43:22 (8840): Creating new snapshot for VM.
2024-05-31 10:43:26 (8840): Deleting stale snapshot.
2024-05-31 10:43:27 (8840): Checkpoint completed.
2024-05-31 10:53:24 (8840): Creating new snapshot for VM.
2024-05-31 10:53:28 (8840): Deleting stale snapshot.
2024-05-31 10:53:28 (8840): Checkpoint completed.
2024-05-31 11:03:24 (8840): Creating new snapshot for VM.
2024-05-31 11:03:29 (8840): Deleting stale snapshot.
2024-05-31 11:03:29 (8840): Checkpoint completed.
2024-05-31 11:13:25 (8840): Creating new snapshot for VM.
2024-05-31 11:13:30 (8840): Deleting stale snapshot.
2024-05-31 11:13:30 (8840): Checkpoint completed.
2024-05-31 11:21:59 (8840): Preference change detected
2024-05-31 11:21:59 (8840): Setting CPU throttle for VM. (100%)
2024-05-31 11:21:59 (8840): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-31 11:23:26 (8840): Creating new snapshot for VM.
2024-05-31 11:23:30 (8840): Deleting stale snapshot.
2024-05-31 11:23:31 (8840): Checkpoint completed.
2024-05-31 11:33:27 (8840): Creating new snapshot for VM.
2024-05-31 11:33:32 (8840): Deleting stale snapshot.
2024-05-31 11:33:32 (8840): Checkpoint completed.
2024-05-31 11:43:28 (8840): Creating new snapshot for VM.
2024-05-31 11:43:34 (8840): Deleting stale snapshot.
2024-05-31 11:43:34 (8840): Checkpoint completed.
2024-05-31 11:53:29 (8840): Creating new snapshot for VM.
2024-05-31 11:53:34 (8840): Deleting stale snapshot.
2024-05-31 11:53:34 (8840): Checkpoint completed.
2024-05-31 12:02:06 (8840): Preference change detected
2024-05-31 12:02:06 (8840): Setting CPU throttle for VM. (100%)
2024-05-31 12:02:06 (8840): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-31 12:03:30 (8840): Creating new snapshot for VM.
2024-05-31 12:03:34 (8840): Deleting stale snapshot.
2024-05-31 12:03:35 (8840): Checkpoint completed.
2024-05-31 12:03:40 (8840): Creating new snapshot for VM.
2024-05-31 12:03:44 (8840): Deleting stale snapshot.
2024-05-31 12:03:44 (8840): Checkpoint completed.
2024-05-31 12:03:44 (8840): Stopping VM.
2024-05-31 12:03:49 (8840): Successfully stopped VM.
2024-05-31 12:54:03 (11056): vboxwrapper version 26207
2024-05-31 12:54:03 (11056): BOINC client version: 8.0.2
2024-05-31 12:54:03 (11056): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-05-31 12:54:04 (11056): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-05-31 12:54:04 (11056): Feature: Checkpoint interval offset (61 seconds)
2024-05-31 12:54:04 (11056): Detected: Minimum checkpoint interval (600.000000 seconds)
2024-05-31 12:54:05 (11056): Guest Log: 07:13:47.155402 timesync vgsvcTimeSyncWorker: Radical host time change: 32 333 629 000 000ns (HostNow=1 717 132 441 394 000 000 ns HostLast=1 717 100 107 765 000 000 ns)
2024-05-31 12:54:05 (11056): Guest Log: 07:13:57.179583 timesync vgsvcTimeSyncWorker: Radical guest time change: 32 463 685 453 000ns (GuestNow=1 717 132 451 421 652 000 ns GuestLast=1 717 099 987 736 199 000 ns fSetTimeLastLoop=true )
2024-05-31 12:54:05 (11056): Restore from previously saved snapshot.
2024-05-31 12:54:05 (11056): Restore completed.
2024-05-31 12:54:05 (11056): Starting VM using VBoxManage interface. (boinc_87d9909d3328db9a, slot#1)
2024-05-31 12:54:16 (11056): Successfully started VM. (PID = '12636')
2024-05-31 12:54:16 (11056): Reporting VM Process ID to BOINC.
2024-05-31 12:54:16 (11056): VM state change detected. (old = 'poweredoff', new = 'running')
2024-05-31 12:54:16 (11056): Detected: Web Application Enabled (http://localhost:56366)
2024-05-31 12:54:16 (11056): Detected: Remote Desktop Enabled (localhost:56367)
2024-05-31 12:54:16 (11056): Status Report: Elapsed Time: '43514.492235'
2024-05-31 12:54:16 (11056): Status Report: CPU Time: '42834.156250'
2024-05-31 12:54:16 (11056): Preference change detected
2024-05-31 12:54:16 (11056): Setting CPU throttle for VM. (100%)
2024-05-31 12:54:16 (11056): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2024-05-31 12:54:22 (11056): Guest Log: 12:01:43.284633 timesync vgsvcTimeSyncWorker: Radical host time change: 3 045 424 000 000ns (HostNow=1 717 152 861 676 000 000 ns HostLast=1 717 149 816 252 000 000 ns)
2024-05-31 12:54:32 (11056): Guest Log: 12:01:53.290601 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 154 155 272 000ns (GuestNow=1 717 152 871 681 981 000 ns GuestLast=1 717 149 717 526 709 000 ns fSetTimeLastLoop=true )
2024-05-31 13:05:19 (11056): Creating new snapshot for VM.
2024-05-31 13:05:23 (11056): Deleting stale snapshot.
2024-05-31 13:05:24 (11056): Checkpoint completed.
2024-05-31 13:15:20 (11056): Creating new snapshot for VM.
2024-05-31 13:15:26 (11056): Deleting stale snapshot.
2024-05-31 13:15:27 (11056): Checkpoint completed.
2024-05-31 13:16:06 (11056): Guest Log: job: run exitcode=0
2024-05-31 13:16:06 (11056): Guest Log: job: diskusage=3692
2024-05-31 13:16:06 (11056): Guest Log: job: logsize=52 k
2024-05-31 13:16:06 (11056): Guest Log: job: times=
2024-05-31 13:16:06 (11056): Guest Log: 0m0.014s 0m0.022s
2024-05-31 13:16:06 (11056): Guest Log: 727m45.994s 3m55.635s
2024-05-31 13:16:06 (11056): Guest Log: job: cpuusage=43902
2024-05-31 13:16:09 (11056): Guest Log: 13:15:59 CEST +02:00 2024-05-31: cranky: [INFO] Container 'runc' finished with status code 0.
2024-05-31 13:16:09 (11056): Guest Log: 13:15:59 CEST +02:00 2024-05-31: cranky: [INFO] Preparing output.
2024-05-31 13:16:09 (11056): Guest Log: [INFO] Job Finished
2024-05-31 13:16:09 (11056): Guest Log: [INFO] Shutting Down.
2024-05-31 13:16:09 (11056): VM Completion File Detected.
2024-05-31 13:16:09 (11056): VM Completion Message: Job Finished
.
2024-05-31 13:16:09 (11056): Powering off VM.
2024-05-31 13:16:09 (11056): Successfully stopped VM.
2024-05-31 13:16:09 (11056): Deregistering VM. (boinc_87d9909d3328db9a, slot#1)
2024-05-31 13:16:09 (11056): Deleting stale snapshot.
2024-05-31 13:16:10 (11056): Removing network bandwidth throttle group from VM.
2024-05-31 13:16:10 (11056): Removing VM from VirtualBox.
2024-05-31 13:16:15 (11056): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN