Task 402862222

Name	Theory_2390-1099503-1066_1
Workunit	217821584
Created	10 Dec 2023, 20:17:11 UTC
Sent	11 Dec 2023, 1:19:16 UTC
Report deadline	22 Dec 2023, 1:19:16 UTC
Received	22 Dec 2023, 22:33:14 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	10840326
Run time	34 min 53 sec
CPU time	13 min 43 sec
Validate state	Valid
Credit	4.85
Device peak FLOPS	1.00 GFLOPS
Application version	Theory Simulation v300.07 (vbox64_theory) windows_x86_64
Peak working set size	72.28 MB
Peak swap size	75.97 MB
Peak disk usage	1.90 GB
Stderr output

<core_client_version>7.24.1</core_client_version>
<![CDATA[
<stderr_txt>
2023-12-14 12:07:19 (10816): Detected: vboxwrapper 26206
2023-12-14 12:07:19 (10816): Detected: BOINC client v7.24.1
2023-12-14 12:07:21 (10816): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2023-12-14 12:07:22 (10816): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-14 12:07:22 (10816): Successfully copied 'init_data.xml' to the shared directory.
2023-12-14 12:07:22 (10816): Successfully copied 'input' to the shared directory.
2023-12-14 12:07:23 (10816): Create VM. (boinc_9c655296553f5701, slot#3)
2023-12-14 12:07:24 (10816): Setting Memory Size for VM. (630MB)
2023-12-14 12:07:24 (10816): Setting CPU Count for VM. (1)
2023-12-14 12:07:24 (10816): Setting Chipset Options for VM.
2023-12-14 12:07:25 (10816): Setting Graphics Controller Options for VM.
2023-12-14 12:07:25 (10816): Setting Boot Options for VM.
2023-12-14 12:07:25 (10816): Setting Network Configuration for NAT.
2023-12-14 12:07:25 (10816): Enabling VM Network Access.
2023-12-14 12:07:26 (10816): Disabling USB Support for VM.
2023-12-14 12:07:26 (10816): Disabling COM Port Support for VM.
2023-12-14 12:07:26 (10816): Disabling LPT Port Support for VM.
2023-12-14 12:07:27 (10816): Disabling Audio Support for VM.
2023-12-14 12:07:27 (10816): Disabling Clipboard Support for VM.
2023-12-14 12:07:27 (10816): Disabling Drag and Drop Support for VM.
2023-12-14 12:07:27 (10816): Adding storage controller(s) to VM.
2023-12-14 12:07:28 (10816): Adding virtual disk drive to VM. (vm_image.vdi)
2023-12-14 12:07:28 (10816): Adding VirtualBox Guest Additions to VM.
2023-12-14 12:07:28 (10816): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-12-14 12:07:28 (10816): forwarding host port 59700 to guest port 80
2023-12-14 12:07:29 (10816): Enabling remote desktop for VM.
2023-12-14 12:07:29 (10816): Required extension pack not installed, remote desktop not enabled.
2023-12-14 12:07:29 (10816): Enabling shared directory for VM.
2023-12-14 12:07:29 (10816): Starting VM using VBoxManage interface. (boinc_9c655296553f5701, slot#3)
2023-12-14 12:07:36 (10816): Successfully started VM. (PID = '14244')
2023-12-14 12:07:36 (10816): Reporting VM Process ID to BOINC.
2023-12-14 12:07:36 (10816): Guest Log: BIOS: VirtualBox 7.0.6
2023-12-14 12:07:36 (10816): Guest Log: CPUID EDX: 0x178bfbff
2023-12-14 12:07:36 (10816): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-12-14 12:07:36 (10816): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-12-14 12:07:36 (10816): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-14 12:07:37 (10816): Detected: Web Application Enabled (http://localhost:59700)
2023-12-14 12:07:37 (10816): Preference change detected
2023-12-14 12:07:37 (10816): Setting CPU throttle for VM. (50%)
2023-12-14 12:07:37 (10816): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-14 12:07:39 (10816): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-12-14 12:07:39 (10816): Guest Log: BIOS: Booting from Hard Disk...
2023-12-14 12:07:42 (10816): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-12-14 12:07:42 (10816): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-12-14 12:08:08 (10816): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-12-14 12:08:08 (10816): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-12-14 12:08:12 (10816): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-12-14 12:08:12 (10816): Guest Log: 00:00:00.000084 main     Log opened 2023-12-14T17:08:17.936608000Z
2023-12-14 12:08:12 (10816): Guest Log: 00:00:00.000258 main     OS Product: Linux
2023-12-14 12:08:12 (10816): Guest Log: 00:00:00.000293 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-12-14 12:08:12 (10816): Guest Log: 00:00:00.000311 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-12-14 12:08:12 (10816): Guest Log: 00:00:00.000327 main     Executable: /usr/sbin/VBoxService
2023-12-14 12:08:12 (10816): Guest Log: 00:00:00.000327 main     Process ID: 3228
2023-12-14 12:08:12 (10816): Guest Log: 00:00:00.000328 main     Package type: LINUX_64BITS_GENERIC
2023-12-14 12:08:12 (10816): Guest Log: 00:00:00.016711 main     5.2.6 r120293 started. Verbose level = 0
2023-12-14 12:08:33 (10816): Guest Log: 18:08:39 CET +01:00 2023-12-14: cranky: [INFO] Detected Theory App
2023-12-14 12:08:33 (10816): Guest Log: 18:08:39 CET +01:00 2023-12-14: cranky: [INFO] Checking CVMFS.
2023-12-14 12:08:34 (10816): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-12-14 12:08:34 (10816): 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
2023-12-14 12:08:34 (10816): Guest Log: 2.5.2.0 4056 0 27216 27903 3 1 269980 4096000 0 65024 0 0 n/a 5 9 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-12-14 12:08:35 (10816): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-12-14 12:08:35 (10816): 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
2023-12-14 12:08:35 (10816): Guest Log: 2.5.2.0 4098 0 25448 22963 3 2 269980 4096000 0 65024 0 2 -100 7840 5268 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-12-14 12:08:36 (10816): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-12-14 12:08:36 (10816): 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
2023-12-14 12:08:36 (10816): Guest Log: 2.5.2.0 4125 0 25492 268 3 1 269980 4096000 0 65024 0 0 n/a 4 5 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-12-14 12:08:37 (10816): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-12-14 12:08:38 (10816): 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
2023-12-14 12:08:38 (10816): Guest Log: 2.5.2.0 4078 0 36836 17393 3 1 269980 4096000 0 65024 0 0 n/a 4824 2395 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-12-14 12:08:38 (10816): Guest Log: 18:08:43 CET +01:00 2023-12-14: cranky: [INFO] Checking runc.
2023-12-14 12:08:38 (10816): Guest Log: 18:08:43 CET +01:00 2023-12-14: cranky: [INFO] Creating the filesystem.
2023-12-14 12:08:38 (10816): Guest Log: 18:08:43 CET +01:00 2023-12-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-12-14 12:08:38 (10816): Guest Log: 18:08:44 CET +01:00 2023-12-14: cranky: [INFO] Updating config.json.
2023-12-14 12:08:38 (10816): Guest Log: 18:08:44 CET +01:00 2023-12-14: cranky: [INFO] Running Container 'runc'.
2023-12-14 12:08:40 (10816): Guest Log: job: htmld=/shared/html/job
2023-12-14 12:08:40 (10816): Guest Log: job: unpack exitcode=0
2023-12-14 12:08:42 (10816): Guest Log: 18:08:48 CET +01:00 2023-12-14: cranky: [INFO] ===> [runRivet] Thu Dec 14 17:08:46 UTC 2023 [boinc ppbar ue 1800 15 - pythia8 8.209 default-noCR 100000 1066]
2023-12-14 16:08:05 (10816): Guest Log: 03:59:39.818124 timesync vgsvcTimeSyncWorker: Radical host time change: 14 336 954 000 000ns (HostNow=1 702 588 078 557 000 000 ns HostLast=1 702 573 741 603 000 000 ns)
2023-12-14 16:08:05 (10816): Guest Log: 03:59:40.224680 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 329 786 839 000ns (GuestNow=1 702 588 077 754 596 000 ns GuestLast=1 702 573 747 967 757 000 ns fSetTimeLastLoop=false)
2023-12-14 17:10:12 (10816): Guest Log: 05:01:44.205897 timesync vgsvcTimeSyncWorker: Radical host time change: 3 719 794 000 000ns (HostNow=1 702 591 804 797 000 000 ns HostLast=1 702 588 085 003 000 000 ns)
2023-12-14 17:10:12 (10816): Guest Log: 05:01:44.205999 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 713 980 722 000ns (GuestNow=1 702 591 802 142 406 000 ns GuestLast=1 702 588 088 161 684 000 ns fSetTimeLastLoop=false)
2023-12-14 21:05:16 (10816): Guest Log: 08:56:38.517783 timesync vgsvcTimeSyncWorker: Radical host time change: 13 989 718 000 000ns (HostNow=1 702 605 904 657 000 000 ns HostLast=1 702 591 914 939 000 000 ns)
2023-12-14 21:05:16 (10816): Guest Log: 08:56:38.522042 timesync vgsvcTimeSyncWorker: Radical guest time change: 13 972 443 249 000ns (GuestNow=1 702 605 894 975 602 000 ns GuestLast=1 702 591 922 532 353 000 ns fSetTimeLastLoop=false)
2023-12-14 21:05:16 (10816): Stopping VM.
2023-12-14 21:05:52 (10816): Successfully stopped VM.
2023-12-20 16:05:19 (11792): Detected: vboxwrapper 26206
2023-12-20 16:05:19 (11792): Detected: BOINC client v7.24.1
2023-12-20 17:07:49 (11792): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2023-12-20 17:07:50 (11792): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-20 17:07:50 (11792): Guest Log: BIOS: VirtualBox 7.0.6
2023-12-20 17:07:50 (11792): Guest Log: CPUID EDX: 0x178bfbff
2023-12-20 17:07:50 (11792): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-12-20 17:07:50 (11792): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-12-20 17:07:50 (11792): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-12-20 17:07:50 (11792): Guest Log: BIOS: Booting from Hard Disk...
2023-12-20 17:07:50 (11792): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-12-20 17:07:50 (11792): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-12-20 17:07:50 (11792): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-12-20 17:07:50 (11792): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-12-20 17:07:50 (11792): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-12-20 17:07:50 (11792): Guest Log: 00:00:00.000084 main     Log opened 2023-12-14T17:08:17.936608000Z
2023-12-20 17:07:50 (11792): Guest Log: 00:00:00.000258 main     OS Product: Linux
2023-12-20 17:07:50 (11792): Guest Log: 00:00:00.000293 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-12-20 17:07:50 (11792): Guest Log: 00:00:00.000311 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-12-20 17:07:50 (11792): Guest Log: 00:00:00.000327 main     Executable: /usr/sbin/VBoxService
2023-12-20 17:07:50 (11792): Guest Log: 00:00:00.000327 main     Process ID: 3228
2023-12-20 17:07:50 (11792): Guest Log: 00:00:00.000328 main     Package type: LINUX_64BITS_GENERIC
2023-12-20 17:07:50 (11792): Guest Log: 00:00:00.016711 main     5.2.6 r120293 started. Verbose level = 0
2023-12-20 17:07:50 (11792): Guest Log: 18:08:39 CET +01:00 2023-12-14: cranky: [INFO] Detected Theory App
2023-12-20 17:07:50 (11792): Guest Log: 18:08:39 CET +01:00 2023-12-14: cranky: [INFO] Checking CVMFS.
2023-12-20 17:07:50 (11792): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-12-20 17:07:50 (11792): 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
2023-12-20 17:07:50 (11792): Guest Log: 2.5.2.0 4056 0 27216 27903 3 1 269980 4096000 0 65024 0 0 n/a 5 9 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-12-20 17:07:50 (11792): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-12-20 17:07:50 (11792): 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
2023-12-20 17:07:50 (11792): Guest Log: 2.5.2.0 4098 0 25448 22963 3 2 269980 4096000 0 65024 0 2 -100 7840 5268 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-12-20 17:07:50 (11792): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-12-20 17:07:50 (11792): 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
2023-12-20 17:07:50 (11792): Guest Log: 2.5.2.0 4125 0 25492 268 3 1 269980 4096000 0 65024 0 0 n/a 4 5 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-12-20 17:07:50 (11792): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-12-20 17:07:50 (11792): 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
2023-12-20 17:07:50 (11792): Guest Log: 2.5.2.0 4078 0 36836 17393 3 1 269980 4096000 0 65024 0 0 n/a 4824 2395 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-12-20 17:07:50 (11792): Guest Log: 18:08:43 CET +01:00 2023-12-14: cranky: [INFO] Checking runc.
2023-12-20 17:07:50 (11792): Guest Log: 18:08:43 CET +01:00 2023-12-14: cranky: [INFO] Creating the filesystem.
2023-12-20 17:07:50 (11792): Guest Log: 18:08:43 CET +01:00 2023-12-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-12-20 17:07:50 (11792): Guest Log: 18:08:44 CET +01:00 2023-12-14: cranky: [INFO] Updating config.json.
2023-12-20 17:07:50 (11792): Guest Log: 18:08:44 CET +01:00 2023-12-14: cranky: [INFO] Running Container 'runc'.
2023-12-20 17:07:50 (11792): Guest Log: job: htmld=/shared/html/job
2023-12-20 17:07:50 (11792): Guest Log: job: unpack exitcode=0
2023-12-20 17:07:50 (11792): Guest Log: 18:08:48 CET +01:00 2023-12-14: cranky: [INFO] ===> [runRivet] Thu Dec 14 17:08:46 UTC 2023 [boinc ppbar ue 1800 15 - pythia8 8.209 default-noCR 100000 1066]
2023-12-20 17:07:50 (11792): Guest Log: 03:59:39.818124 timesync vgsvcTimeSyncWorker: Radical host time change: 14 336 954 000 000ns (HostNow=1 702 588 078 557 000 000 ns HostLast=1 702 573 741 603 000 000 ns)
2023-12-20 17:07:50 (11792): Guest Log: 03:59:40.224680 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 329 786 839 000ns (GuestNow=1 702 588 077 754 596 000 ns GuestLast=1 702 573 747 967 757 000 ns fSetTimeLastLoop=false)
2023-12-20 17:07:50 (11792): Guest Log: 05:01:44.205897 timesync vgsvcTimeSyncWorker: Radical host time change: 3 719 794 000 000ns (HostNow=1 702 591 804 797 000 000 ns HostLast=1 702 588 085 003 000 000 ns)
2023-12-20 17:07:50 (11792): Guest Log: 05:01:44.205999 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 713 980 722 000ns (GuestNow=1 702 591 802 142 406 000 ns GuestLast=1 702 588 088 161 684 000 ns fSetTimeLastLoop=false)
2023-12-20 17:07:50 (11792): Guest Log: 08:56:38.517783 timesync vgsvcTimeSyncWorker: Radical host time change: 13 989 718 000 000ns (HostNow=1 702 605 904 657 000 000 ns HostLast=1 702 591 914 939 000 000 ns)
2023-12-20 17:07:50 (11792): Guest Log: 08:56:38.522042 timesync vgsvcTimeSyncWorker: Radical guest time change: 13 972 443 249 000ns (GuestNow=1 702 605 894 975 602 000 ns GuestLast=1 702 591 922 532 353 000 ns fSetTimeLastLoop=false)
2023-12-20 17:07:50 (11792): Starting VM using VBoxManage interface. (boinc_9c655296553f5701, slot#3)
2023-12-20 17:08:03 (11792): Successfully started VM. (PID = '14696')
2023-12-20 17:08:03 (11792): Reporting VM Process ID to BOINC.
2023-12-20 17:08:03 (11792): Guest Log: 08:57:19.083237 timesync vgsvcTimeSyncWorker: Radical host time change: 504 138 336 000 000ns (HostNow=1 703 110 062 324 000 000 ns HostLast=1 702 605 923 988 000 000 ns)
2023-12-20 17:08:03 (11792): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-20 17:08:03 (11792): Detected: Web Application Enabled (http://localhost:59700)
2023-12-20 17:08:03 (11792): Preference change detected
2023-12-20 17:08:03 (11792): Setting CPU throttle for VM. (50%)
2023-12-20 17:08:03 (11792): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-20 17:08:12 (11792): Guest Log: 08:57:29.087277 timesync vgsvcTimeSyncWorker: Radical guest time change: 504 135 395 978 000ns (GuestNow=1 703 110 072 327 988 000 ns GuestLast=1 702 605 936 932 010 000 ns fSetTimeLastLoop=true )
2023-12-21 02:11:59 (11792): Guest Log: 18:01:22.961860 timesync vgsvcTimeSyncWorker: Radical host time change: 32 387 240 000 000ns (HostNow=1 703 142 708 862 000 000 ns HostLast=1 703 110 321 622 000 000 ns)
2023-12-21 02:11:59 (11792): Guest Log: 18:01:23.298856 timesync vgsvcTimeSyncWorker: Radical guest time change: 32 403 521 306 000ns (GuestNow=1 703 142 706 202 639 000 ns GuestLast=1 703 110 302 681 333 000 ns fSetTimeLastLoop=false)
2023-12-21 12:13:07 (11792): Guest Log: 18:50:22.896117 timesync vgsvcTimeSyncWorker: Radical host time change: 2 921 809 000 000ns (HostNow=1 703 145 648 154 000 000 ns HostLast=1 703 142 726 345 000 000 ns)
2023-12-21 12:13:08 (11792): Guest Log: 18:50:23.440492 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 919 591 649 000ns (GuestNow=1 703 145 646 136 889 000 ns GuestLast=1 703 142 726 545 240 000 ns fSetTimeLastLoop=false)
2023-12-21 12:13:08 (11792): Guest Log: 28:02:44.449034 timesync vgsvcTimeSyncWorker: Radical host time change: 33 125 004 000 000ns (HostNow=1 703 178 773 158 000 000 ns HostLast=1 703 145 648 154 000 000 ns)
2023-12-21 12:13:08 (11792): Guest Log: 28:02:44.868229 timesync vgsvcTimeSyncWorker: Radical guest time change: 33 141 552 922 000ns (GuestNow=1 703 178 787 689 811 000 ns GuestLast=1 703 145 646 136 889 000 ns fSetTimeLastLoop=false)
2023-12-21 16:13:29 (11792): Guest Log: 32:02:57.936412 timesync vgsvcTimeSyncWorker: Radical host time change: 14 258 930 000 000ns (HostNow=1 703 193 193 278 000 000 ns HostLast=1 703 178 934 348 000 000 ns)
2023-12-21 16:13:29 (11792): Guest Log: 32:02:58.141416 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 222 795 997 000ns (GuestNow=1 703 193 201 176 994 000 ns GuestLast=1 703 178 978 380 997 000 ns fSetTimeLastLoop=false)
2023-12-21 17:16:25 (11792): Guest Log: 33:05:54.749490 timesync vgsvcTimeSyncWorker: Radical host time change: 3 744 167 000 000ns (HostNow=1 703 196 972 627 000 000 ns HostLast=1 703 193 228 460 000 000 ns)
2023-12-21 17:16:25 (11792): Guest Log: 33:05:54.832972 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 736 548 825 000ns (GuestNow=1 703 196 977 990 267 000 ns GuestLast=1 703 193 241 441 442 000 ns fSetTimeLastLoop=false)
2023-12-22 02:21:05 (11792): Guest Log: 42:10:22.479604 timesync vgsvcTimeSyncWorker: Radical host time change: 32 484 400 000 000ns (HostNow=1 703 229 656 729 000 000 ns HostLast=1 703 197 172 329 000 000 ns)
2023-12-22 02:21:05 (11792): Guest Log: 42:10:23.266049 timesync vgsvcTimeSyncWorker: Radical guest time change: 32 467 397 156 000ns (GuestNow=1 703 229 645 720 370 000 ns GuestLast=1 703 197 178 323 214 000 ns fSetTimeLastLoop=false)
2023-12-22 02:21:05 (11792): Stopping VM.
2023-12-22 02:23:57 (11512): Detected: vboxwrapper 26206
2023-12-22 02:23:57 (11512): Detected: BOINC client v7.24.1
2023-12-22 04:05:25 (11512): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2023-12-22 12:11:54 (11512): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-22 12:11:57 (11512): Guest Log: 08:57:19.083237 timesync vgsvcTimeSyncWorker: Radical host time change: 504 138 336 000 000ns (HostNow=1 703 110 062 324 000 000 ns HostLast=1 702 605 923 988 000 000 ns)
2023-12-22 12:11:57 (11512): Guest Log: 08:57:29.087277 timesync vgsvcTimeSyncWorker: Radical guest time change: 504 135 395 978 000ns (GuestNow=1 703 110 072 327 988 000 ns GuestLast=1 702 605 936 932 010 000 ns fSetTimeLastLoop=true )
2023-12-22 12:11:57 (11512): Guest Log: 18:01:22.961860 timesync vgsvcTimeSyncWorker: Radical host time change: 32 387 240 000 000ns (HostNow=1 703 142 708 862 000 000 ns HostLast=1 703 110 321 622 000 000 ns)
2023-12-22 12:11:57 (11512): Guest Log: 18:01:23.298856 timesync vgsvcTimeSyncWorker: Radical guest time change: 32 403 521 306 000ns (GuestNow=1 703 142 706 202 639 000 ns GuestLast=1 703 110 302 681 333 000 ns fSetTimeLastLoop=false)
2023-12-22 12:11:57 (11512): Guest Log: 18:50:22.896117 timesync vgsvcTimeSyncWorker: Radical host time change: 2 921 809 000 000ns (HostNow=1 703 145 648 154 000 000 ns HostLast=1 703 142 726 345 000 000 ns)
2023-12-22 12:11:57 (11512): Guest Log: 18:50:23.440492 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 919 591 649 000ns (GuestNow=1 703 145 646 136 889 000 ns GuestLast=1 703 142 726 545 240 000 ns fSetTimeLastLoop=false)
2023-12-22 12:11:57 (11512): Guest Log: 28:02:44.449034 timesync vgsvcTimeSyncWorker: Radical host time change: 33 125 004 000 000ns (HostNow=1 703 178 773 158 000 000 ns HostLast=1 703 145 648 154 000 000 ns)
2023-12-22 12:11:57 (11512): Guest Log: 28:02:44.868229 timesync vgsvcTimeSyncWorker: Radical guest time change: 33 141 552 922 000ns (GuestNow=1 703 178 787 689 811 000 ns GuestLast=1 703 145 646 136 889 000 ns fSetTimeLastLoop=false)
2023-12-22 12:11:57 (11512): Guest Log: 32:02:57.936412 timesync vgsvcTimeSyncWorker: Radical host time change: 14 258 930 000 000ns (HostNow=1 703 193 193 278 000 000 ns HostLast=1 703 178 934 348 000 000 ns)
2023-12-22 12:11:57 (11512): Guest Log: 32:02:58.141416 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 222 795 997 000ns (GuestNow=1 703 193 201 176 994 000 ns GuestLast=1 703 178 978 380 997 000 ns fSetTimeLastLoop=false)
2023-12-22 12:11:57 (11512): Guest Log: 33:05:54.749490 timesync vgsvcTimeSyncWorker: Radical host time change: 3 744 167 000 000ns (HostNow=1 703 196 972 627 000 000 ns HostLast=1 703 193 228 460 000 000 ns)
2023-12-22 12:11:57 (11512): Guest Log: 33:05:54.832972 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 736 548 825 000ns (GuestNow=1 703 196 977 990 267 000 ns GuestLast=1 703 193 241 441 442 000 ns fSetTimeLastLoop=false)
2023-12-22 12:11:57 (11512): Guest Log: 42:10:22.479604 timesync vgsvcTimeSyncWorker: Radical host time change: 32 484 400 000 000ns (HostNow=1 703 229 656 729 000 000 ns HostLast=1 703 197 172 329 000 000 ns)
2023-12-22 12:11:57 (11512): Guest Log: 42:10:23.266049 timesync vgsvcTimeSyncWorker: Radical guest time change: 32 467 397 156 000ns (GuestNow=1 703 229 645 720 370 000 ns GuestLast=1 703 197 178 323 214 000 ns fSetTimeLastLoop=false)
2023-12-22 12:11:57 (11512): Starting VM using VBoxManage interface. (boinc_9c655296553f5701, slot#3)
2023-12-22 12:12:06 (11512): Successfully started VM. (PID = '11828')
2023-12-22 12:12:06 (11512): Reporting VM Process ID to BOINC.
2023-12-22 12:12:06 (11512): Guest Log: BIOS: VirtualBox 7.0.6
2023-12-22 12:12:06 (11512): Guest Log: CPUID EDX: 0x178bfbff
2023-12-22 12:12:06 (11512): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-12-22 12:12:06 (11512): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-12-22 12:12:06 (11512): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-22 12:12:06 (11512): Detected: Web Application Enabled (http://localhost:59700)
2023-12-22 12:12:06 (11512): Preference change detected
2023-12-22 12:12:06 (11512): Setting CPU throttle for VM. (50%)
2023-12-22 12:12:06 (11512): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-22 12:12:08 (11512): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-12-22 12:12:08 (11512): Guest Log: BIOS: Booting from Hard Disk...
2023-12-22 12:12:11 (11512): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-12-22 12:12:11 (11512): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-12-22 12:12:34 (11512): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-12-22 12:12:34 (11512): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-12-22 12:12:39 (11512): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-12-22 12:12:39 (11512): Guest Log: 00:00:00.000115 main     Log opened 2023-12-22T17:12:30.986716000Z
2023-12-22 12:12:39 (11512): Guest Log: 00:00:00.000361 main     OS Product: Linux
2023-12-22 12:12:39 (11512): Guest Log: 00:00:00.000409 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-12-22 12:12:39 (11512): Guest Log: 00:00:00.000443 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-12-22 12:12:39 (11512): Guest Log: 00:00:00.000477 main     Executable: /usr/sbin/VBoxService
2023-12-22 12:12:39 (11512): Guest Log: 00:00:00.000478 main     Process ID: 3229
2023-12-22 12:12:39 (11512): Guest Log: 00:00:00.000478 main     Package type: LINUX_64BITS_GENERIC
2023-12-22 12:12:39 (11512): Guest Log: 00:00:00.012600 main     5.2.6 r120293 started. Verbose level = 0
2023-12-22 12:13:07 (11512): Guest Log: 18:12:58 CET +01:00 2023-12-22: cranky: [INFO] Detected Theory App
2023-12-22 12:13:07 (11512): Guest Log: 18:12:58 CET +01:00 2023-12-22: cranky: [INFO] Checking CVMFS.
2023-12-22 12:13:07 (11512): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-12-22 12:13:08 (11512): 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
2023-12-22 12:13:08 (11512): Guest Log: 2.5.2.0 4081 0 26500 27987 3 1 1063121 4096000 0 65024 0 0 n/a 5 3 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-12-22 12:13:08 (11512): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-12-22 12:13:09 (11512): 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
2023-12-22 12:13:09 (11512): Guest Log: 2.5.2.0 4128 0 27408 23031 3 2 1063121 4096000 0 65024 0 2 0 5698 3935 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-12-22 12:13:10 (11512): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-12-22 12:13:11 (11512): 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
2023-12-22 12:13:11 (11512): Guest Log: 2.5.2.0 4101 0 27216 268 3 1 1063121 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-12-22 12:13:11 (11512): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-12-22 12:13:12 (11512): 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
2023-12-22 12:13:12 (11512): Guest Log: 2.5.2.0 4059 0 38640 17466 3 1 1063121 4096000 0 65024 0 0 n/a 4865 1830 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-12-22 12:13:12 (11512): Guest Log: 18:13:04 CET +01:00 2023-12-22: cranky: [INFO] Checking runc.
2023-12-22 12:13:12 (11512): Guest Log: 18:13:04 CET +01:00 2023-12-22: cranky: [INFO] Creating the filesystem.
2023-12-22 12:13:12 (11512): Guest Log: 18:13:04 CET +01:00 2023-12-22: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-12-22 12:13:12 (11512): Guest Log: 18:13:04 CET +01:00 2023-12-22: cranky: [INFO] Updating config.json.
2023-12-22 12:13:12 (11512): Guest Log: 18:13:04 CET +01:00 2023-12-22: cranky: [INFO] Running Container 'runc'.
2023-12-22 12:13:13 (11512): Guest Log: job: htmld=/shared/html/job
2023-12-22 12:13:13 (11512): Guest Log: job: unpack exitcode=0
2023-12-22 12:13:14 (11512): Guest Log: 18:13:06 CET +01:00 2023-12-22: cranky: [INFO] ===> [runRivet] Fri Dec 22 17:13:05 UTC 2023 [boinc ppbar ue 1800 15 - pythia8 8.209 default-noCR 100000 1066]
2023-12-22 16:11:57 (11512): Guest Log: 03:59:18.868191 timesync vgsvcTimeSyncWorker: Radical host time change: 14 261 294 000 000ns (HostNow=1 703 279 510 063 000 000 ns HostLast=1 703 265 248 769 000 000 ns)
2023-12-22 16:11:57 (11512): Guest Log: 03:59:18.960943 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 268 420 435 000ns (GuestNow=1 703 279 509 630 900 000 ns GuestLast=1 703 265 241 210 465 000 ns fSetTimeLastLoop=false)
2023-12-22 17:15:35 (11512): Guest Log: 05:02:44.561484 timesync vgsvcTimeSyncWorker: Radical host time change: 3 773 466 000 000ns (HostNow=1 703 283 317 797 000 000 ns HostLast=1 703 279 544 331 000 000 ns)
2023-12-22 17:15:35 (11512): Guest Log: 05:02:44.565391 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 765 480 932 000ns (GuestNow=1 703 283 315 490 463 000 ns GuestLast=1 703 279 550 009 531 000 ns fSetTimeLastLoop=false)
2023-12-22 17:32:56 (11512): Guest Log: job: run exitcode=0
2023-12-22 17:32:56 (11512): Guest Log: job: diskusage=2484
2023-12-22 17:32:56 (11512): Guest Log: job: logsize=68 k
2023-12-22 17:32:56 (11512): Guest Log: job: times=
2023-12-22 17:32:56 (11512): Guest Log: 0m0.005s 0m0.013s
2023-12-22 17:32:56 (11512): Guest Log: 78m42.945s 2m6.534s
2023-12-22 17:32:56 (11512): Guest Log: job: cpuusage=4849
2023-12-22 17:32:57 (11512): Guest Log: 23:32:53 CET +01:00 2023-12-22: cranky: [INFO] Container 'runc' finished with status code 0.
2023-12-22 17:32:57 (11512): Guest Log: 23:32:53 CET +01:00 2023-12-22: cranky: [INFO] Preparing output.
2023-12-22 17:33:00 (11512): Guest Log: [INFO] Job Finished
2023-12-22 17:33:00 (11512): Guest Log: [INFO] Shutting Down.
2023-12-22 17:33:00 (11512): VM Completion File Detected.
2023-12-22 17:33:00 (11512): VM Completion Message: Job Finished
.
2023-12-22 17:33:00 (11512): Powering off VM.
2023-12-22 17:33:02 (11512): Successfully stopped VM.
2023-12-22 17:33:02 (11512): Deregistering VM. (boinc_9c655296553f5701, slot#3)
2023-12-22 17:33:02 (11512): Removing network bandwidth throttle group from VM.
2023-12-22 17:33:02 (11512): Removing VM from VirtualBox.
17:33:08 (11512): called boinc_finish(0)

</stderr_txt>
]]>
LHC@home

Stderr output
