Task 402561900

Name	Theory_2390-1119508-1012_1
Workunit	217613946
Created	4 Dec 2023, 9:17:08 UTC
Sent	4 Dec 2023, 13:52:15 UTC
Report deadline	15 Dec 2023, 13:52:15 UTC
Received	16 Dec 2023, 10:32:28 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	10637905
Run time	9 hours 28 min 6 sec
CPU time	9 hours 18 min 9 sec
Validate state	Valid
Credit	351.35
Device peak FLOPS	4.45 GFLOPS
Application version	Theory Simulation v300.07 (vbox64_theory) windows_x86_64
Peak working set size	81.16 MB
Peak swap size	77.63 MB
Peak disk usage	1.88 GB
Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2023-12-11 22:12:13 (17468): Detected: vboxwrapper 26206
2023-12-11 22:12:13 (17468): Detected: BOINC client v7.16.11
2023-12-11 22:12:14 (17468): Detected: VirtualBox VboxManage Interface (Version: 6.1.28)
2023-12-11 22:12:14 (17468): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-11 22:12:14 (17468): Successfully copied 'init_data.xml' to the shared directory.
2023-12-11 22:12:14 (17468): Successfully copied 'input' to the shared directory.
2023-12-11 22:12:15 (17468): Create VM. (boinc_0f696516c0da1505, slot#8)
2023-12-11 22:12:16 (17468): Setting Memory Size for VM. (630MB)
2023-12-11 22:12:16 (17468): Setting CPU Count for VM. (1)
2023-12-11 22:12:17 (17468): Setting Chipset Options for VM.
2023-12-11 22:12:17 (17468): Setting Graphics Controller Options for VM.
2023-12-11 22:12:17 (17468): Setting Boot Options for VM.
2023-12-11 22:12:18 (17468): Setting Network Configuration for NAT.
2023-12-11 22:12:18 (17468): Enabling VM Network Access.
2023-12-11 22:12:18 (17468): Disabling USB Support for VM.
2023-12-11 22:12:19 (17468): Disabling COM Port Support for VM.
2023-12-11 22:12:19 (17468): Disabling LPT Port Support for VM.
2023-12-11 22:12:19 (17468): Disabling Audio Support for VM.
2023-12-11 22:12:20 (17468): Disabling Clipboard Support for VM.
2023-12-11 22:12:20 (17468): Disabling Drag and Drop Support for VM.
2023-12-11 22:12:21 (17468): Adding storage controller(s) to VM.
2023-12-11 22:12:21 (17468): Adding virtual disk drive to VM. (vm_image.vdi)
2023-12-11 22:12:22 (17468): Adding VirtualBox Guest Additions to VM.
2023-12-11 22:12:22 (17468): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-12-11 22:12:22 (17468): forwarding host port 60935 to guest port 80
2023-12-11 22:12:23 (17468): Enabling remote desktop for VM.
2023-12-11 22:12:23 (17468): Required extension pack not installed, remote desktop not enabled.
2023-12-11 22:12:23 (17468): Enabling shared directory for VM.
2023-12-11 22:12:24 (17468): Starting VM using VBoxManage interface. (boinc_0f696516c0da1505, slot#8)
2023-12-11 22:12:31 (17468): Successfully started VM. (PID = '2572')
2023-12-11 22:12:31 (17468): Reporting VM Process ID to BOINC.
2023-12-11 22:12:31 (17468): Guest Log: BIOS: VirtualBox 6.1.28
2023-12-11 22:12:31 (17468): Guest Log: CPUID EDX: 0x178bfbff
2023-12-11 22:12:31 (17468): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-12-11 22:12:31 (17468): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-12-11 22:12:31 (17468): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-11 22:12:31 (17468): Detected: Web Application Enabled (http://localhost:60935)
2023-12-11 22:12:31 (17468): Preference change detected
2023-12-11 22:12:31 (17468): Setting CPU throttle for VM. (100%)
2023-12-11 22:12:32 (17468): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-11 22:12:33 (17468): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-12-11 22:12:33 (17468): Guest Log: BIOS: Booting from Hard Disk...
2023-12-11 22:12:35 (17468): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-12-11 22:12:35 (17468): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-12-11 22:13:02 (17468): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-12-11 22:13:02 (17468): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-12-11 22:13:07 (17468): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-12-11 22:13:07 (17468): Guest Log: 00:00:00.000191 main     Log opened 2023-12-12T06:13:07.872773000Z
2023-12-11 22:13:07 (17468): Guest Log: 00:00:00.000400 main     OS Product: Linux
2023-12-11 22:13:07 (17468): Guest Log: 00:00:00.000478 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-12-11 22:13:07 (17468): Guest Log: 00:00:00.000581 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-12-11 22:13:07 (17468): Guest Log: 00:00:00.000644 main     Executable: /usr/sbin/VBoxService
2023-12-11 22:13:07 (17468): Guest Log: 00:00:00.000646 main     Process ID: 3219
2023-12-11 22:13:07 (17468): Guest Log: 00:00:00.000647 main     Package type: LINUX_64BITS_GENERIC
2023-12-11 22:13:07 (17468): Guest Log: 00:00:00.005631 main     5.2.6 r120293 started. Verbose level = 0
2023-12-11 22:13:49 (17468): Guest Log: 22:13:49 PST -08:00 2023-12-11: cranky: [INFO] Detected Theory App
2023-12-11 22:13:49 (17468): Guest Log: 22:13:49 PST -08:00 2023-12-11: cranky: [INFO] Checking CVMFS.
2023-12-11 22:13:49 (17468): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-12-11 22:13:50 (17468): 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-11 22:13:50 (17468): Guest Log: 2.5.2.0 4111 0 28200 27886 3 1 269956 4096000 0 65024 0 0 n/a 5 2 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-12-11 22:13:52 (17468): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-12-11 22:13:53 (17468): 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-11 22:13:53 (17468): Guest Log: 2.5.2.0 4085 0 25484 22943 3 2 269956 4096000 0 65024 0 2 -100 7840 3163 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-12-11 22:13:54 (17468): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-12-11 22:13:55 (17468): 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-11 22:13:55 (17468): Guest Log: 2.5.2.0 4057 0 27216 268 3 1 269956 4096000 0 65024 0 0 n/a 4 2 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-12-11 22:13:56 (17468): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-12-11 22:13:57 (17468): 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-11 22:13:57 (17468): Guest Log: 2.5.2.0 4140 0 38440 17365 3 1 269956 4096000 0 65024 0 0 n/a 4815 349 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-12-11 22:13:57 (17468): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Checking runc.
2023-12-11 22:13:57 (17468): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Creating the filesystem.
2023-12-11 22:13:57 (17468): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-12-11 22:13:57 (17468): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Updating config.json.
2023-12-11 22:13:57 (17468): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Running Container 'runc'.
2023-12-11 22:13:59 (17468): Guest Log: job: htmld=/shared/html/job
2023-12-11 22:13:59 (17468): Guest Log: job: unpack exitcode=0
2023-12-11 22:13:59 (17468): Guest Log: 22:14:00 PST -08:00 2023-12-11: cranky: [INFO] ===> [runRivet] Tue Dec 12 06:14:00 UTC 2023 [boinc pp jets 7000 40 - pythia8 8.230 default-DL 100000 1012]
2023-12-11 22:53:43 (17468): VM state change detected. (old = 'running', new = 'paused')
2023-12-11 22:53:53 (17468): VM state change detected. (old = 'paused', new = 'running')
2023-12-11 22:54:02 (17468): VM state change detected. (old = 'running', new = 'paused')
2023-12-11 22:54:12 (17468): VM state change detected. (old = 'paused', new = 'running')
2023-12-11 23:12:43 (17468): Stopping VM.
2023-12-11 23:12:46 (17468): Successfully stopped VM.
2023-12-11 23:28:36 (7456): Detected: vboxwrapper 26206
2023-12-11 23:28:36 (7456): Detected: BOINC client v7.16.11
2023-12-11 23:28:37 (7456): Detected: VirtualBox VboxManage Interface (Version: 6.1.28)
2023-12-11 23:28:37 (7456): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-11 23:28:38 (7456): Guest Log: BIOS: VirtualBox 6.1.28
2023-12-11 23:28:38 (7456): Guest Log: CPUID EDX: 0x178bfbff
2023-12-11 23:28:38 (7456): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-12-11 23:28:38 (7456): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-12-11 23:28:38 (7456): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-12-11 23:28:38 (7456): Guest Log: BIOS: Booting from Hard Disk...
2023-12-11 23:28:38 (7456): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-12-11 23:28:38 (7456): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-12-11 23:28:38 (7456): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-12-11 23:28:38 (7456): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-12-11 23:28:38 (7456): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-12-11 23:28:38 (7456): Guest Log: 00:00:00.000191 main     Log opened 2023-12-12T06:13:07.872773000Z
2023-12-11 23:28:38 (7456): Guest Log: 00:00:00.000400 main     OS Product: Linux
2023-12-11 23:28:38 (7456): Guest Log: 00:00:00.000478 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-12-11 23:28:38 (7456): Guest Log: 00:00:00.000581 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-12-11 23:28:38 (7456): Guest Log: 00:00:00.000644 main     Executable: /usr/sbin/VBoxService
2023-12-11 23:28:38 (7456): Guest Log: 00:00:00.000646 main     Process ID: 3219
2023-12-11 23:28:38 (7456): Guest Log: 00:00:00.000647 main     Package type: LINUX_64BITS_GENERIC
2023-12-11 23:28:38 (7456): Guest Log: 00:00:00.005631 main     5.2.6 r120293 started. Verbose level = 0
2023-12-11 23:28:38 (7456): Guest Log: 22:13:49 PST -08:00 2023-12-11: cranky: [INFO] Detected Theory App
2023-12-11 23:28:38 (7456): Guest Log: 22:13:49 PST -08:00 2023-12-11: cranky: [INFO] Checking CVMFS.
2023-12-11 23:28:38 (7456): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-12-11 23:28:38 (7456): 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-11 23:28:38 (7456): Guest Log: 2.5.2.0 4111 0 28200 27886 3 1 269956 4096000 0 65024 0 0 n/a 5 2 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-12-11 23:28:38 (7456): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-12-11 23:28:38 (7456): 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-11 23:28:38 (7456): Guest Log: 2.5.2.0 4085 0 25484 22943 3 2 269956 4096000 0 65024 0 2 -100 7840 3163 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-12-11 23:28:38 (7456): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-12-11 23:28:38 (7456): 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-11 23:28:38 (7456): Guest Log: 2.5.2.0 4057 0 27216 268 3 1 269956 4096000 0 65024 0 0 n/a 4 2 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-12-11 23:28:38 (7456): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-12-11 23:28:38 (7456): 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-11 23:28:38 (7456): Guest Log: 2.5.2.0 4140 0 38440 17365 3 1 269956 4096000 0 65024 0 0 n/a 4815 349 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-12-11 23:28:38 (7456): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Checking runc.
2023-12-11 23:28:38 (7456): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Creating the filesystem.
2023-12-11 23:28:38 (7456): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-12-11 23:28:38 (7456): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Updating config.json.
2023-12-11 23:28:38 (7456): Guest Log: 22:13:58 PST -08:00 2023-12-11: cranky: [INFO] Running Container 'runc'.
2023-12-11 23:28:38 (7456): Guest Log: job: htmld=/shared/html/job
2023-12-11 23:28:38 (7456): Guest Log: job: unpack exitcode=0
2023-12-11 23:28:38 (7456): Guest Log: 22:14:00 PST -08:00 2023-12-11: cranky: [INFO] ===> [runRivet] Tue Dec 12 06:14:00 UTC 2023 [boinc pp jets 7000 40 - pythia8 8.230 default-DL 100000 1012]
2023-12-11 23:28:38 (7456): Starting VM using VBoxManage interface. (boinc_0f696516c0da1505, slot#8)
2023-12-11 23:28:47 (7456): Successfully started VM. (PID = '13524')
2023-12-11 23:28:47 (7456): Reporting VM Process ID to BOINC.
2023-12-11 23:28:47 (7456): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-11 23:28:47 (7456): Detected: Web Application Enabled (http://localhost:60935)
2023-12-11 23:28:47 (7456): Preference change detected
2023-12-11 23:28:47 (7456): Setting CPU throttle for VM. (100%)
2023-12-11 23:28:47 (7456): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-12 00:11:10 (7456): Status Report: Job Duration: '864000.000000'
2023-12-12 00:11:10 (7456): Status Report: Elapsed Time: '6000.002695'
2023-12-12 00:11:10 (7456): Status Report: CPU Time: '5882.500000'
2023-12-12 00:20:22 (7456): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 00:20:32 (7456): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 00:20:42 (7456): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 00:20:52 (7456): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 00:21:02 (7456): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 00:21:13 (7456): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 00:21:22 (7456): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 00:21:32 (7456): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 00:21:42 (7456): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 00:21:52 (7456): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 00:29:20 (7456): Stopping VM.
2023-12-12 00:29:23 (7456): Successfully stopped VM.
2023-12-12 01:22:54 (12012): Detected: vboxwrapper 26206
2023-12-12 01:22:54 (12012): Detected: BOINC client v7.16.11
2023-12-12 01:22:55 (12012): Detected: VirtualBox VboxManage Interface (Version: 6.1.28)
2023-12-12 01:22:55 (12012): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-12 01:22:56 (12012): Starting VM using VBoxManage interface. (boinc_0f696516c0da1505, slot#8)
2023-12-12 01:23:05 (12012): Successfully started VM. (PID = '6496')
2023-12-12 01:23:05 (12012): Reporting VM Process ID to BOINC.
2023-12-12 01:23:05 (12012): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-12 01:23:05 (12012): Detected: Web Application Enabled (http://localhost:60935)
2023-12-12 01:23:05 (12012): Status Report: Job Duration: '864000.000000'
2023-12-12 01:23:05 (12012): Status Report: Elapsed Time: '7000.152002'
2023-12-12 01:23:05 (12012): Status Report: CPU Time: '6904.750000'
2023-12-12 01:23:05 (12012): Preference change detected
2023-12-12 01:23:05 (12012): Setting CPU throttle for VM. (100%)
2023-12-12 01:23:06 (12012): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-12 01:23:08 (12012): Guest Log: 01:59:03.518340 timesync vgsvcTimeSyncWorker: Radical host time change: 3 234 243 000 000ns (HostNow=1 702 372 988 314 000 000 ns HostLast=1 702 369 754 071 000 000 ns)
2023-12-12 01:23:19 (12012): Guest Log: 01:59:13.542436 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 284 206 083 000ns (GuestNow=1 702 372 998 383 718 000 ns GuestLast=1 702 369 714 177 635 000 ns fSetTimeLastLoop=true )
2023-12-12 02:15:02 (12012): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 02:15:14 (12012): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 02:15:22 (12012): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 02:15:32 (12012): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 02:15:43 (12012): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 02:15:52 (12012): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 02:16:02 (12012): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 02:16:12 (12012): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 02:16:22 (12012): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 02:16:32 (12012): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 02:23:42 (12012): Stopping VM.
2023-12-12 02:23:45 (12012): Successfully stopped VM.
2023-12-12 02:35:18 (12432): Detected: vboxwrapper 26206
2023-12-12 02:35:18 (12432): Detected: BOINC client v7.16.11
2023-12-12 02:35:19 (12432): Detected: VirtualBox VboxManage Interface (Version: 6.1.28)
2023-12-12 02:35:19 (12432): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-12 02:35:20 (12432): Guest Log: 01:59:03.518340 timesync vgsvcTimeSyncWorker: Radical host time change: 3 234 243 000 000ns (HostNow=1 702 372 988 314 000 000 ns HostLast=1 702 369 754 071 000 000 ns)
2023-12-12 02:35:20 (12432): Guest Log: 01:59:13.542436 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 284 206 083 000ns (GuestNow=1 702 372 998 383 718 000 ns GuestLast=1 702 369 714 177 635 000 ns fSetTimeLastLoop=true )
2023-12-12 02:35:20 (12432): Starting VM using VBoxManage interface. (boinc_0f696516c0da1505, slot#8)
2023-12-12 02:35:29 (12432): Successfully started VM. (PID = '7956')
2023-12-12 02:35:29 (12432): Reporting VM Process ID to BOINC.
2023-12-12 02:35:29 (12432): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-12 02:35:29 (12432): Detected: Web Application Enabled (http://localhost:60935)
2023-12-12 02:35:30 (12432): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 02:35:40 (12432): Status Report: Job Duration: '864000.000000'
2023-12-12 02:35:40 (12432): Status Report: Elapsed Time: '10485.701320'
2023-12-12 02:35:40 (12432): Status Report: CPU Time: '10433.625000'
2023-12-12 02:35:40 (12432): Preference change detected
2023-12-12 02:35:40 (12432): Setting CPU throttle for VM. (100%)
2023-12-12 02:35:40 (12432): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-12 02:35:40 (12432): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 02:46:23 (12432): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 02:46:32 (12432): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 03:09:20 (12432): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 03:09:31 (12432): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 03:31:58 (12432): VM state change detected. (old = 'running', new = 'paused')
2023-12-12 21:58:13 (12432): VM state change detected. (old = 'paused', new = 'running')
2023-12-12 21:58:18 (12432): Guest Log: 03:54:57.106646 timesync vgsvcTimeSyncWorker: Radical host time change: 66 380 075 000 000ns (HostNow=1 702 447 095 943 000 000 ns HostLast=1 702 380 715 868 000 000 ns)
2023-12-12 21:58:18 (12432): VM state change detected. (old = 'running', new = 'paused')
2023-12-13 21:17:56 (12432): Guest Log: 03:55:07.108108 timesync vgsvcTimeSyncWorker: Radical host time change: 83 976 952 000 000ns (HostNow=1 702 531 072 895 000 000 ns HostLast=1 702 447 095 943 000 000 ns)
2023-12-13 21:17:56 (12432): Guest Log: 03:55:07.108266 timesync vgsvcTimeSyncWorker: Radical guest time change: 66 397 486 855 000ns (GuestNow=1 702 447 105 944 432 000 ns GuestLast=1 702 380 708 457 577 000 ns fSetTimeLastLoop=true )
2023-12-13 21:17:56 (12432): VM state change detected. (old = 'paused', new = 'running')
2023-12-13 21:18:02 (12432): VM state change detected. (old = 'running', new = 'paused')
2023-12-15 21:00:05 (15716): Detected: vboxwrapper 26206
2023-12-15 21:00:05 (15716): Detected: BOINC client v7.16.11
2023-12-15 21:00:06 (15716): Detected: VirtualBox VboxManage Interface (Version: 6.1.28)
2023-12-15 21:00:06 (15716): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-15 21:00:07 (15716): Guest Log: 03:54:57.106646 timesync vgsvcTimeSyncWorker: Radical host time change: 66 380 075 000 000ns (HostNow=1 702 447 095 943 000 000 ns HostLast=1 702 380 715 868 000 000 ns)
2023-12-15 21:00:07 (15716): Guest Log: 03:55:07.108108 timesync vgsvcTimeSyncWorker: Radical host time change: 83 976 952 000 000ns (HostNow=1 702 531 072 895 000 000 ns HostLast=1 702 447 095 943 000 000 ns)
2023-12-15 21:00:07 (15716): Guest Log: 03:55:07.108266 timesync vgsvcTimeSyncWorker: Radical guest time change: 66 397 486 855 000ns (GuestNow=1 702 447 105 944 432 000 ns GuestLast=1 702 380 708 457 577 000 ns fSetTimeLastLoop=true )
2023-12-15 21:00:07 (15716): Starting VM using VBoxManage interface. (boinc_0f696516c0da1505, slot#8)
2023-12-15 21:00:12 (15716): Successfully started VM. (PID = '10596')
2023-12-15 21:00:12 (15716): Reporting VM Process ID to BOINC.
2023-12-15 21:00:12 (15716): Guest Log: BIOS: VirtualBox 6.1.28
2023-12-15 21:00:12 (15716): Guest Log: CPUID EDX: 0x178bfbff
2023-12-15 21:00:12 (15716): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-12-15 21:00:12 (15716): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-12-15 21:00:12 (15716): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-15 21:00:12 (15716): Detected: Web Application Enabled (http://localhost:60935)
2023-12-15 21:00:12 (15716): Status Report: Job Duration: '864000.000000'
2023-12-15 21:00:12 (15716): Status Report: Elapsed Time: '13729.710134'
2023-12-15 21:00:12 (15716): Status Report: CPU Time: '13749.187500'
2023-12-15 21:00:12 (15716): Preference change detected
2023-12-15 21:00:12 (15716): Setting CPU throttle for VM. (100%)
2023-12-15 21:00:12 (15716): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-15 21:00:14 (15716): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-12-15 21:00:14 (15716): Guest Log: BIOS: Booting from Hard Disk...
2023-12-15 21:00:16 (15716): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-12-15 21:00:16 (15716): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-12-15 21:00:41 (15716): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-12-15 21:00:41 (15716): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-12-15 21:00:45 (15716): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-12-15 21:00:45 (15716): Guest Log: 00:00:00.000198 main     Log opened 2023-12-16T05:00:45.516960000Z
2023-12-15 21:00:45 (15716): Guest Log: 00:00:00.000325 main     OS Product: Linux
2023-12-15 21:00:45 (15716): Guest Log: 00:00:00.000394 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-12-15 21:00:45 (15716): Guest Log: 00:00:00.000441 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-12-15 21:00:45 (15716): Guest Log: 00:00:00.000506 main     Executable: /usr/sbin/VBoxService
2023-12-15 21:00:45 (15716): Guest Log: 00:00:00.000508 main     Process ID: 3216
2023-12-15 21:00:45 (15716): Guest Log: 00:00:00.000509 main     Package type: LINUX_64BITS_GENERIC
2023-12-15 21:00:45 (15716): Guest Log: 00:00:00.004805 main     5.2.6 r120293 started. Verbose level = 0
2023-12-15 21:01:14 (15716): Guest Log: 21:01:14 PST -08:00 2023-12-15: cranky: [INFO] Detected Theory App
2023-12-15 21:01:14 (15716): Guest Log: 21:01:14 PST -08:00 2023-12-15: cranky: [INFO] Checking CVMFS.
2023-12-15 21:01:15 (15716): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-12-15 21:01:17 (15716): 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-15 21:01:17 (15716): Guest Log: 2.5.2.0 4126 0 25160 27915 3 1 1072894 4096000 0 65024 0 0 n/a 5 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1
2023-12-15 21:01:18 (15716): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-12-15 21:01:19 (15716): 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-15 21:01:19 (15716): Guest Log: 2.5.2.0 4060 0 27724 22975 3 2 1072894 4096000 0 65024 0 2 0 5702 2836 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-12-15 21:01:20 (15716): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-12-15 21:01:21 (15716): 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-15 21:01:21 (15716): Guest Log: 2.5.2.0 4105 0 27204 268 3 1 1072894 4096000 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-12-15 21:01:22 (15716): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-12-15 21:01:23 (15716): 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-15 21:01:23 (15716): Guest Log: 2.5.2.0 4083 0 37612 17405 3 1 1072894 4096000 0 65024 0 0 n/a 4829 2705 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-12-15 21:01:23 (15716): Guest Log: 21:01:23 PST -08:00 2023-12-15: cranky: [INFO] Checking runc.
2023-12-15 21:01:23 (15716): Guest Log: 21:01:23 PST -08:00 2023-12-15: cranky: [INFO] Creating the filesystem.
2023-12-15 21:01:23 (15716): Guest Log: 21:01:23 PST -08:00 2023-12-15: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-12-15 21:01:23 (15716): Guest Log: 21:01:23 PST -08:00 2023-12-15: cranky: [INFO] Updating config.json.
2023-12-15 21:01:23 (15716): Guest Log: 21:01:23 PST -08:00 2023-12-15: cranky: [INFO] Running Container 'runc'.
2023-12-15 21:01:24 (15716): Guest Log: job: htmld=/shared/html/job
2023-12-15 21:01:24 (15716): Guest Log: job: unpack exitcode=0
2023-12-15 21:01:26 (15716): Guest Log: 21:01:25 PST -08:00 2023-12-15: cranky: [INFO] ===> [runRivet] Sat Dec 16 05:01:24 UTC 2023 [boinc pp jets 7000 40 - pythia8 8.230 default-DL 100000 1012]
2023-12-15 22:17:23 (15716): VM state change detected. (old = 'running', new = 'paused')
2023-12-15 22:17:34 (15716): VM state change detected. (old = 'paused', new = 'running')
2023-12-15 22:41:57 (15716): Status Report: Job Duration: '864000.000000'
2023-12-15 22:41:57 (15716): Status Report: Elapsed Time: '19729.710134'
2023-12-15 22:41:57 (15716): Status Report: CPU Time: '19769.015625'
2023-12-16 00:23:35 (15716): Status Report: Job Duration: '864000.000000'
2023-12-16 00:23:35 (15716): Status Report: Elapsed Time: '25729.710134'
2023-12-16 00:23:35 (15716): Status Report: CPU Time: '25830.468750'
2023-12-16 02:04:53 (15716): Status Report: Job Duration: '864000.000000'
2023-12-16 02:04:53 (15716): Status Report: Elapsed Time: '31729.710134'
2023-12-16 02:04:53 (15716): Status Report: CPU Time: '31873.031250'
2023-12-16 02:32:03 (15716): Guest Log: job: run exitcode=0
2023-12-16 02:32:03 (15716): Guest Log: job: diskusage=7060
2023-12-16 02:32:03 (15716): Guest Log: job: logsize=108 k
2023-12-16 02:32:03 (15716): Guest Log: job: times=
2023-12-16 02:32:03 (15716): Guest Log: 0m0.011s 0m0.015s
2023-12-16 02:32:03 (15716): Guest Log: 324m56.805s 2m18.157s
2023-12-16 02:32:03 (15716): Guest Log: job: cpuusage=19635
2023-12-16 02:32:03 (15716): Guest Log: 02:32:00 PST -08:00 2023-12-16: cranky: [INFO] Container 'runc' finished with status code 0.
2023-12-16 02:32:03 (15716): Guest Log: 02:32:00 PST -08:00 2023-12-16: cranky: [INFO] Preparing output.
2023-12-16 02:32:05 (15716): Guest Log: [INFO] Job Finished
2023-12-16 02:32:05 (15716): Guest Log: [INFO] Shutting Down.
2023-12-16 02:32:05 (15716): VM Completion File Detected.
2023-12-16 02:32:05 (15716): VM Completion Message: Job Finished
.
2023-12-16 02:32:05 (15716): Powering off VM.
2023-12-16 02:32:06 (15716): Successfully stopped VM.
2023-12-16 02:32:06 (15716): Deregistering VM. (boinc_0f696516c0da1505, slot#8)
2023-12-16 02:32:06 (15716): Removing network bandwidth throttle group from VM.
2023-12-16 02:32:06 (15716): Removing VM from VirtualBox.
02:32:12 (15716): called boinc_finish(0)

</stderr_txt>
]]>
LHC@home

Stderr output
