Task 3223124

Name	Theory_2390-1101703-494_1
Workunit	2313439
Created	27 Jun 2023, 18:30:20 UTC
Sent	1 Jul 2023, 16:54:55 UTC
Report deadline	11 Jul 2023, 16:54:55 UTC
Received	4 Jul 2023, 16:11:00 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4480
Run time	1 days 18 hours 5 min 44 sec
CPU time	1 hours 56 min 16 sec
Validate state	Valid
Credit	2,299.01
Device peak FLOPS	6.55 GFLOPS
Application version	Theory Simulation v5.50 (vbox64_theory) windows_x86_64
Peak working set size	84.90 MB
Peak swap size	100.20 MB
Peak disk usage	1.33 GB
Stderr output

<core_client_version>7.20.2</core_client_version>
<![CDATA[
<stderr_txt>
2023-07-01 18:55:38 (11300): Detected: vboxwrapper 26206
2023-07-01 18:55:38 (11300): Detected: BOINC client v7.20.2
2023-07-01 18:55:38 (11300): Detected: VirtualBox VboxManage Interface (Version: 6.1.40)
2023-07-01 18:55:39 (11300): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-07-01 18:55:39 (11300): Successfully copied 'init_data.xml' to the shared directory.
2023-07-01 18:55:39 (11300): Successfully copied 'input' to the shared directory.
2023-07-01 18:55:39 (11300): Create VM. (boinc_1e9781bbffdec372, slot#16)
2023-07-01 18:55:40 (11300): Setting Memory Size for VM. (630MB)
2023-07-01 18:55:40 (11300): Setting CPU Count for VM. (1)
2023-07-01 18:55:40 (11300): Setting Chipset Options for VM.
2023-07-01 18:55:40 (11300): Setting Graphics Controller Options for VM.
2023-07-01 18:55:41 (11300): Setting Boot Options for VM.
2023-07-01 18:55:41 (11300): Setting Network Configuration for NAT.
2023-07-01 18:55:41 (11300): Enabling VM Network Access.
2023-07-01 18:55:41 (11300): Disabling USB Support for VM.
2023-07-01 18:55:42 (11300): Disabling COM Port Support for VM.
2023-07-01 18:55:42 (11300): Disabling LPT Port Support for VM.
2023-07-01 18:55:42 (11300): Disabling Audio Support for VM.
2023-07-01 18:55:42 (11300): Disabling Clipboard Support for VM.
2023-07-01 18:55:43 (11300): Disabling Drag and Drop Support for VM.
2023-07-01 18:55:43 (11300): Adding storage controller(s) to VM.
2023-07-01 18:55:43 (11300): Adding virtual disk drive to VM. (Theory_2022_07_28.vdi)
2023-07-01 18:55:46 (11300): Adding VirtualBox Guest Additions to VM.
2023-07-01 18:55:46 (11300): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-07-01 18:55:47 (11300): forwarding host port 51181 to guest port 80
2023-07-01 18:55:47 (11300): Enabling remote desktop for VM.
2023-07-01 18:55:47 (11300): Enabling shared directory for VM.
2023-07-01 18:55:48 (11300): Starting VM using VBoxManage interface. (boinc_1e9781bbffdec372, slot#16)
2023-07-01 18:55:52 (11300): Successfully started VM. (PID = '12388')
2023-07-01 18:55:52 (11300): Reporting VM Process ID to BOINC.
2023-07-01 18:55:52 (11300): Guest Log: BIOS: VirtualBox 6.1.40
2023-07-01 18:55:52 (11300): Guest Log: CPUID EDX: 0x178bfbff
2023-07-01 18:55:52 (11300): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-07-01 18:55:52 (11300): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-07-01 18:55:52 (11300): VM state change detected. (old = 'poweredoff', new = 'running')
2023-07-01 18:55:52 (11300): Detected: Web Application Enabled (http://localhost:51181)
2023-07-01 18:55:52 (11300): Detected: Remote Desktop Enabled (localhost:51182)
2023-07-01 18:55:52 (11300): Preference change detected
2023-07-01 18:55:52 (11300): Setting CPU throttle for VM. (100%)
2023-07-01 18:55:52 (11300): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2023-07-01 18:55:54 (11300): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-07-01 18:55:54 (11300): Guest Log: BIOS: Booting from Hard Disk...
2023-07-01 18:55:56 (11300): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-07-01 18:55:56 (11300): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-07-01 18:56:12 (11300): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-07-01 18:56:12 (11300): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-07-01 18:56:14 (11300): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-07-01 18:56:14 (11300): Guest Log: 00:00:00.000045 main     Log opened 2023-07-01T16:56:13.904108000Z
2023-07-01 18:56:14 (11300): Guest Log: 00:00:00.000119 main     OS Product: Linux
2023-07-01 18:56:14 (11300): Guest Log: 00:00:00.000149 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-07-01 18:56:14 (11300): Guest Log: 00:00:00.000175 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-07-01 18:56:14 (11300): Guest Log: 00:00:00.000198 main     Executable: /usr/sbin/VBoxService
2023-07-01 18:56:14 (11300): Guest Log: 00:00:00.000198 main     Process ID: 3213
2023-07-01 18:56:14 (11300): Guest Log: 00:00:00.000199 main     Package type: LINUX_64BITS_GENERIC
2023-07-01 18:56:14 (11300): Guest Log: 00:00:00.001529 main     5.2.6 r120293 started. Verbose level = 0
2023-07-01 18:56:33 (11300): Guest Log: 18:56:32 CEST +02:00 2023-07-01: cranky: [INFO] Detected Theory App
2023-07-01 18:56:33 (11300): Guest Log: 18:56:32 CEST +02:00 2023-07-01: cranky: [INFO] Checking CVMFS.
2023-07-01 18:56:33 (11300): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-07-01 18:56:34 (11300): 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-07-01 18:56:34 (11300): Guest Log: 2.5.2.0 4047 0 28392 26343 3 1 268389 4096000 0 65024 0 0 n/a 5 7 http://s1fnal-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-07-01 18:56:34 (11300): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-07-01 18:56:34 (11300): 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-07-01 18:56:34 (11300): Guest Log: 2.5.2.0 4117 0 25492 21617 3 2 268389 4096000 0 65024 0 2 -100 7813 4542 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-07-01 18:56:34 (11300): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-07-01 18:56:34 (11300): 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-07-01 18:56:34 (11300): Guest Log: 2.5.2.0 4090 0 25172 268 3 1 268389 4096000 0 65024 0 0 n/a 4 6 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-07-01 18:56:35 (11300): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-07-01 18:56:35 (11300): 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-07-01 18:56:35 (11300): Guest Log: 2.5.2.0 4068 0 35564 15793 3 1 268389 4096000 0 65024 0 0 n/a 4182 8841 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-07-01 18:56:35 (11300): Guest Log: 18:56:34 CEST +02:00 2023-07-01: cranky: [INFO] Checking runc.
2023-07-01 18:56:35 (11300): Guest Log: 18:56:34 CEST +02:00 2023-07-01: cranky: [INFO] Creating the filesystem.
2023-07-01 18:56:35 (11300): Guest Log: 18:56:34 CEST +02:00 2023-07-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-07-01 18:56:35 (11300): Guest Log: 18:56:34 CEST +02:00 2023-07-01: cranky: [INFO] Updating config.json.
2023-07-01 18:56:35 (11300): Guest Log: 18:56:35 CEST +02:00 2023-07-01: cranky: [INFO] Running Container 'runc'.
2023-07-01 18:56:36 (11300): Guest Log: job: htmld=/shared/html/job
2023-07-01 18:56:36 (11300): Guest Log: job: unpack exitcode=0
2023-07-01 18:56:37 (11300): Guest Log: 18:56:37 CEST +02:00 2023-07-01: cranky: [INFO] ===> [runRivet] Sat Jul  1 16:56:35 UTC 2023 [boinc ppbar zinclusive 1960 -,-,50,120 - sherpa 2.1.0 default 18000 494]
2023-07-01 20:35:57 (11300): Status Report: Job Duration: '864000.000000'
2023-07-01 20:35:57 (11300): Status Report: Elapsed Time: '6000.000000'
2023-07-01 20:35:57 (11300): Status Report: CPU Time: '3711.062500'
2023-07-01 22:16:01 (11300): Status Report: Job Duration: '864000.000000'
2023-07-01 22:16:01 (11300): Status Report: Elapsed Time: '12000.000000'
2023-07-01 22:16:01 (11300): Status Report: CPU Time: '3713.343750'
2023-07-01 23:56:06 (11300): Status Report: Job Duration: '864000.000000'
2023-07-01 23:56:06 (11300): Status Report: Elapsed Time: '18000.000000'
2023-07-01 23:56:06 (11300): Status Report: CPU Time: '3715.968750'
2023-07-02 01:36:10 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 01:36:10 (11300): Status Report: Elapsed Time: '24000.000000'
2023-07-02 01:36:10 (11300): Status Report: CPU Time: '3719.609375'
2023-07-02 03:16:15 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 03:16:15 (11300): Status Report: Elapsed Time: '30000.000000'
2023-07-02 03:16:15 (11300): Status Report: CPU Time: '3722.765625'
2023-07-02 04:56:19 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 04:56:19 (11300): Status Report: Elapsed Time: '36000.000000'
2023-07-02 04:56:19 (11300): Status Report: CPU Time: '3726.140625'
2023-07-02 06:36:24 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 06:36:24 (11300): Status Report: Elapsed Time: '42000.000000'
2023-07-02 06:36:24 (11300): Status Report: CPU Time: '3729.453125'
2023-07-02 08:16:28 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 08:16:28 (11300): Status Report: Elapsed Time: '48000.000000'
2023-07-02 08:16:28 (11300): Status Report: CPU Time: '3732.656250'
2023-07-02 09:56:32 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 09:56:32 (11300): Status Report: Elapsed Time: '54000.000000'
2023-07-02 09:56:32 (11300): Status Report: CPU Time: '3736.031250'
2023-07-02 11:36:37 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 11:36:37 (11300): Status Report: Elapsed Time: '60000.000000'
2023-07-02 11:36:37 (11300): Status Report: CPU Time: '3739.500000'
2023-07-02 13:16:41 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 13:16:41 (11300): Status Report: Elapsed Time: '66000.000000'
2023-07-02 13:16:41 (11300): Status Report: CPU Time: '3742.875000'
2023-07-02 14:56:46 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 14:56:46 (11300): Status Report: Elapsed Time: '72000.000000'
2023-07-02 14:56:46 (11300): Status Report: CPU Time: '3746.687500'
2023-07-02 16:36:51 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 16:36:51 (11300): Status Report: Elapsed Time: '78000.000000'
2023-07-02 16:36:51 (11300): Status Report: CPU Time: '3750.359375'
2023-07-02 18:16:56 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 18:16:56 (11300): Status Report: Elapsed Time: '84000.000000'
2023-07-02 18:16:56 (11300): Status Report: CPU Time: '3754.093750'
2023-07-02 19:57:01 (11300): Status Report: Job Duration: '864000.000000'
2023-07-02 19:57:01 (11300): Status Report: Elapsed Time: '90000.000000'
2023-07-02 19:57:01 (11300): Status Report: CPU Time: '3762.000000'
2023-07-02 20:54:24 (11300): Stopping VM.
2023-07-02 20:54:25 (11300): Successfully stopped VM.
2023-07-03 07:34:57 (10468): Detected: vboxwrapper 26206
2023-07-03 07:34:57 (10468): Detected: BOINC client v7.20.2
2023-07-03 07:34:58 (10468): Detected: VirtualBox VboxManage Interface (Version: 6.1.40)
2023-07-03 07:34:58 (10468): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-07-03 07:34:59 (10468): Guest Log: BIOS: VirtualBox 6.1.40
2023-07-03 07:34:59 (10468): Guest Log: CPUID EDX: 0x178bfbff
2023-07-03 07:34:59 (10468): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-07-03 07:34:59 (10468): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-07-03 07:34:59 (10468): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-07-03 07:34:59 (10468): Guest Log: BIOS: Booting from Hard Disk...
2023-07-03 07:34:59 (10468): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-07-03 07:34:59 (10468): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-07-03 07:34:59 (10468): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-07-03 07:34:59 (10468): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-07-03 07:34:59 (10468): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-07-03 07:34:59 (10468): Guest Log: 00:00:00.000045 main     Log opened 2023-07-01T16:56:13.904108000Z
2023-07-03 07:34:59 (10468): Guest Log: 00:00:00.000119 main     OS Product: Linux
2023-07-03 07:34:59 (10468): Guest Log: 00:00:00.000149 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-07-03 07:34:59 (10468): Guest Log: 00:00:00.000175 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-07-03 07:34:59 (10468): Guest Log: 00:00:00.000198 main     Executable: /usr/sbin/VBoxService
2023-07-03 07:34:59 (10468): Guest Log: 00:00:00.000198 main     Process ID: 3213
2023-07-03 07:34:59 (10468): Guest Log: 00:00:00.000199 main     Package type: LINUX_64BITS_GENERIC
2023-07-03 07:34:59 (10468): Guest Log: 00:00:00.001529 main     5.2.6 r120293 started. Verbose level = 0
2023-07-03 07:34:59 (10468): Guest Log: 18:56:32 CEST +02:00 2023-07-01: cranky: [INFO] Detected Theory App
2023-07-03 07:34:59 (10468): Guest Log: 18:56:32 CEST +02:00 2023-07-01: cranky: [INFO] Checking CVMFS.
2023-07-03 07:34:59 (10468): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-07-03 07:34:59 (10468): 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-07-03 07:34:59 (10468): Guest Log: 2.5.2.0 4047 0 28392 26343 3 1 268389 4096000 0 65024 0 0 n/a 5 7 http://s1fnal-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-07-03 07:34:59 (10468): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-07-03 07:34:59 (10468): 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-07-03 07:34:59 (10468): Guest Log: 2.5.2.0 4117 0 25492 21617 3 2 268389 4096000 0 65024 0 2 -100 7813 4542 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-07-03 07:34:59 (10468): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-07-03 07:34:59 (10468): 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-07-03 07:34:59 (10468): Guest Log: 2.5.2.0 4090 0 25172 268 3 1 268389 4096000 0 65024 0 0 n/a 4 6 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-07-03 07:34:59 (10468): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-07-03 07:34:59 (10468): 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-07-03 07:34:59 (10468): Guest Log: 2.5.2.0 4068 0 35564 15793 3 1 268389 4096000 0 65024 0 0 n/a 4182 8841 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-07-03 07:34:59 (10468): Guest Log: 18:56:34 CEST +02:00 2023-07-01: cranky: [INFO] Checking runc.
2023-07-03 07:34:59 (10468): Guest Log: 18:56:34 CEST +02:00 2023-07-01: cranky: [INFO] Creating the filesystem.
2023-07-03 07:34:59 (10468): Guest Log: 18:56:34 CEST +02:00 2023-07-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-07-03 07:34:59 (10468): Guest Log: 18:56:34 CEST +02:00 2023-07-01: cranky: [INFO] Updating config.json.
2023-07-03 07:34:59 (10468): Guest Log: 18:56:35 CEST +02:00 2023-07-01: cranky: [INFO] Running Container 'runc'.
2023-07-03 07:34:59 (10468): Guest Log: job: htmld=/shared/html/job
2023-07-03 07:34:59 (10468): Guest Log: job: unpack exitcode=0
2023-07-03 07:34:59 (10468): Guest Log: 18:56:37 CEST +02:00 2023-07-01: cranky: [INFO] ===> [runRivet] Sat Jul  1 16:56:35 UTC 2023 [boinc ppbar zinclusive 1960 -,-,50,120 - sherpa 2.1.0 default 18000 494]
2023-07-03 07:34:59 (10468): Starting VM using VBoxManage interface. (boinc_1e9781bbffdec372, slot#16)
2023-07-03 07:35:04 (10468): Successfully started VM. (PID = '20808')
2023-07-03 07:35:04 (10468): Reporting VM Process ID to BOINC.
2023-07-03 07:35:04 (10468): Guest Log: 25:58:10.828019 timesync vgsvcTimeSyncWorker: Radical host time change: 38 449 294 000 000ns (HostNow=1 688 362 503 835 000 000 ns HostLast=1 688 324 054 541 000 000 ns)
2023-07-03 07:35:04 (10468): VM state change detected. (old = 'poweredoff', new = 'running')
2023-07-03 07:35:04 (10468): Detected: Web Application Enabled (http://localhost:51181)
2023-07-03 07:35:04 (10468): Detected: Remote Desktop Enabled (localhost:51182)
2023-07-03 07:35:04 (10468): Status Report: Job Duration: '864000.000000'
2023-07-03 07:35:04 (10468): Status Report: Elapsed Time: '93440.000000'
2023-07-03 07:35:04 (10468): Status Report: CPU Time: '3764.234375'
2023-07-03 07:35:04 (10468): Preference change detected
2023-07-03 07:35:04 (10468): Setting CPU throttle for VM. (100%)
2023-07-03 07:35:04 (10468): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2023-07-03 07:35:14 (10468): Guest Log: 25:58:20.830505 timesync vgsvcTimeSyncWorker: Radical guest time change: 38 449 118 065 000ns (GuestNow=1 688 362 513 843 792 000 ns GuestLast=1 688 324 064 725 727 000 ns fSetTimeLastLoop=true )
2023-07-03 09:15:09 (10468): Status Report: Job Duration: '864000.000000'
2023-07-03 09:15:09 (10468): Status Report: Elapsed Time: '99440.038586'
2023-07-03 09:15:09 (10468): Status Report: CPU Time: '3769.921875'
2023-07-03 10:55:13 (10468): Status Report: Job Duration: '864000.000000'
2023-07-03 10:55:13 (10468): Status Report: Elapsed Time: '105440.038586'
2023-07-03 10:55:13 (10468): Status Report: CPU Time: '3776.078125'
2023-07-03 12:35:18 (10468): Status Report: Job Duration: '864000.000000'
2023-07-03 12:35:18 (10468): Status Report: Elapsed Time: '111440.038586'
2023-07-03 12:35:18 (10468): Status Report: CPU Time: '3780.343750'
2023-07-03 14:15:22 (10468): Status Report: Job Duration: '864000.000000'
2023-07-03 14:15:22 (10468): Status Report: Elapsed Time: '117440.038586'
2023-07-03 14:15:22 (10468): Status Report: CPU Time: '3784.484375'
2023-07-03 15:55:27 (10468): Status Report: Job Duration: '864000.000000'
2023-07-03 15:55:27 (10468): Status Report: Elapsed Time: '123440.038586'
2023-07-03 15:55:27 (10468): Status Report: CPU Time: '3788.906250'
2023-07-03 17:35:32 (10468): Status Report: Job Duration: '864000.000000'
2023-07-03 17:35:32 (10468): Status Report: Elapsed Time: '129440.038586'
2023-07-03 17:35:32 (10468): Status Report: CPU Time: '3793.359375'
2023-07-03 19:15:37 (10468): Status Report: Job Duration: '864000.000000'
2023-07-03 19:15:37 (10468): Status Report: Elapsed Time: '135440.038586'
2023-07-03 19:15:37 (10468): Status Report: CPU Time: '3799.078125'
2023-07-03 20:08:28 (10468): Stopping VM.
2023-07-03 20:08:29 (10468): Successfully stopped VM.
2023-07-04 08:46:06 (4304): Detected: vboxwrapper 26206
2023-07-04 08:46:06 (4304): Detected: BOINC client v7.20.2
2023-07-04 08:46:06 (4304): Detected: VirtualBox VboxManage Interface (Version: 6.1.40)
2023-07-04 08:46:07 (4304): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-07-04 08:46:08 (4304): Guest Log: 25:58:10.828019 timesync vgsvcTimeSyncWorker: Radical host time change: 38 449 294 000 000ns (HostNow=1 688 362 503 835 000 000 ns HostLast=1 688 324 054 541 000 000 ns)
2023-07-04 08:46:08 (4304): Guest Log: 25:58:20.830505 timesync vgsvcTimeSyncWorker: Radical guest time change: 38 449 118 065 000ns (GuestNow=1 688 362 513 843 792 000 ns GuestLast=1 688 324 064 725 727 000 ns fSetTimeLastLoop=true )
2023-07-04 08:46:08 (4304): Starting VM using VBoxManage interface. (boinc_1e9781bbffdec372, slot#16)
2023-07-04 08:46:12 (4304): Successfully started VM. (PID = '16204')
2023-07-04 08:46:12 (4304): Reporting VM Process ID to BOINC.
2023-07-04 08:46:12 (4304): VM state change detected. (old = 'poweredoff', new = 'running')
2023-07-04 08:46:12 (4304): Detected: Web Application Enabled (http://localhost:51181)
2023-07-04 08:46:12 (4304): Detected: Remote Desktop Enabled (localhost:51182)
2023-07-04 08:46:12 (4304): Status Report: Job Duration: '864000.000000'
2023-07-04 08:46:12 (4304): Status Report: Elapsed Time: '138608.038586'
2023-07-04 08:46:12 (4304): Status Report: CPU Time: '3801.765625'
2023-07-04 08:46:12 (4304): Preference change detected
2023-07-04 08:46:12 (4304): Setting CPU throttle for VM. (100%)
2023-07-04 08:46:13 (4304): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2023-07-04 08:46:21 (4304): Guest Log: 38:31:44.484518 timesync vgsvcTimeSyncWorker: Radical host time change: 45 473 664 000 000ns (HostNow=1 688 453 181 138 000 000 ns HostLast=1 688 407 707 474 000 000 ns)
2023-07-04 08:46:31 (4304): Guest Log: 38:31:54.486438 timesync vgsvcTimeSyncWorker: Radical guest time change: 45 473 642 138 000ns (GuestNow=1 688 453 191 139 926 000 ns GuestLast=1 688 407 717 497 788 000 ns fSetTimeLastLoop=true )
2023-07-04 10:26:16 (4304): Status Report: Job Duration: '864000.000000'
2023-07-04 10:26:16 (4304): Status Report: Elapsed Time: '144608.038586'
2023-07-04 10:26:16 (4304): Status Report: CPU Time: '3807.781250'
2023-07-04 11:40:32 (4304): Stopping VM.
2023-07-04 11:40:33 (4304): Successfully stopped VM.
2023-07-04 17:12:21 (9844): Detected: vboxwrapper 26206
2023-07-04 17:12:21 (9844): Detected: BOINC client v7.20.2
2023-07-04 17:12:22 (9844): Detected: VirtualBox VboxManage Interface (Version: 6.1.40)
2023-07-04 17:12:22 (9844): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-07-04 17:12:23 (9844): Guest Log: 38:31:44.484518 timesync vgsvcTimeSyncWorker: Radical host time change: 45 473 664 000 000ns (HostNow=1 688 453 181 138 000 000 ns HostLast=1 688 407 707 474 000 000 ns)
2023-07-04 17:12:23 (9844): Guest Log: 38:31:54.486438 timesync vgsvcTimeSyncWorker: Radical guest time change: 45 473 642 138 000ns (GuestNow=1 688 453 191 139 926 000 ns GuestLast=1 688 407 717 497 788 000 ns fSetTimeLastLoop=true )
2023-07-04 17:12:23 (9844): Starting VM using VBoxManage interface. (boinc_1e9781bbffdec372, slot#16)
2023-07-04 17:12:28 (9844): Successfully started VM. (PID = '4008')
2023-07-04 17:12:28 (9844): Reporting VM Process ID to BOINC.
2023-07-04 17:12:28 (9844): Guest Log: 41:25:55.485415 timesync vgsvcTimeSyncWorker: Radical host time change: 19 925 570 000 000ns (HostNow=1 688 483 547 622 000 000 ns HostLast=1 688 463 622 052 000 000 ns)
2023-07-04 17:12:28 (9844): VM state change detected. (old = 'poweredoff', new = 'running')
2023-07-04 17:12:28 (9844): Detected: Web Application Enabled (http://localhost:51181)
2023-07-04 17:12:28 (9844): Detected: Remote Desktop Enabled (localhost:51182)
2023-07-04 17:12:28 (9844): Status Report: Job Duration: '864000.000000'
2023-07-04 17:12:28 (9844): Status Report: Elapsed Time: '149060.038586'
2023-07-04 17:12:28 (9844): Status Report: CPU Time: '3810.703125'
2023-07-04 17:12:28 (9844): Preference change detected
2023-07-04 17:12:28 (9844): Setting CPU throttle for VM. (100%)
2023-07-04 17:12:28 (9844): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2023-07-04 17:12:37 (9844): Guest Log: 41:26:05.486099 timesync vgsvcTimeSyncWorker: Radical guest time change: 19 925 483 874 000ns (GuestNow=1 688 483 557 622 722 000 ns GuestLast=1 688 463 632 138 848 000 ns fSetTimeLastLoop=true )
2023-07-04 17:17:01 (15108): Detected: vboxwrapper 26206
2023-07-04 17:17:01 (15108): Detected: BOINC client v7.20.2
2023-07-04 17:17:01 (15108): Detected: VirtualBox VboxManage Interface (Version: 6.1.40)
2023-07-04 17:17:02 (15108): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-07-04 17:17:03 (15108): Guest Log: 41:25:55.485415 timesync vgsvcTimeSyncWorker: Radical host time change: 19 925 570 000 000ns (HostNow=1 688 483 547 622 000 000 ns HostLast=1 688 463 622 052 000 000 ns)
2023-07-04 17:17:03 (15108): Guest Log: 41:26:05.486099 timesync vgsvcTimeSyncWorker: Radical guest time change: 19 925 483 874 000ns (GuestNow=1 688 483 557 622 722 000 ns GuestLast=1 688 463 632 138 848 000 ns fSetTimeLastLoop=true )
2023-07-04 17:17:03 (15108): Starting VM using VBoxManage interface. (boinc_1e9781bbffdec372, slot#16)
2023-07-04 17:17:06 (15108): Successfully started VM. (PID = '16300')
2023-07-04 17:17:06 (15108): Reporting VM Process ID to BOINC.
2023-07-04 17:17:06 (15108): Guest Log: BIOS: VirtualBox 6.1.40
2023-07-04 17:17:06 (15108): Guest Log: CPUID EDX: 0x178bfbff
2023-07-04 17:17:06 (15108): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-07-04 17:17:06 (15108): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-07-04 17:17:06 (15108): VM state change detected. (old = 'poweredoff', new = 'running')
2023-07-04 17:17:06 (15108): Detected: Web Application Enabled (http://localhost:51181)
2023-07-04 17:17:06 (15108): Detected: Remote Desktop Enabled (localhost:51182)
2023-07-04 17:17:06 (15108): Status Report: Job Duration: '864000.000000'
2023-07-04 17:17:06 (15108): Status Report: Elapsed Time: '149060.038586'
2023-07-04 17:17:06 (15108): Status Report: CPU Time: '3810.703125'
2023-07-04 17:17:06 (15108): Preference change detected
2023-07-04 17:17:06 (15108): Setting CPU throttle for VM. (100%)
2023-07-04 17:17:07 (15108): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2023-07-04 17:17:08 (15108): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-07-04 17:17:08 (15108): Guest Log: BIOS: Booting from Hard Disk...
2023-07-04 17:17:10 (15108): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-07-04 17:17:10 (15108): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-07-04 17:17:25 (15108): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-07-04 17:17:25 (15108): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-07-04 17:17:27 (15108): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-07-04 17:17:27 (15108): Guest Log: 00:00:00.000317 main     Log opened 2023-07-04T15:17:27.063871000Z
2023-07-04 17:17:27 (15108): Guest Log: 00:00:00.000398 main     OS Product: Linux
2023-07-04 17:17:27 (15108): Guest Log: 00:00:00.000424 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-07-04 17:17:27 (15108): Guest Log: 00:00:00.000445 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-07-04 17:17:27 (15108): Guest Log: 00:00:00.000465 main     Executable: /usr/sbin/VBoxService
2023-07-04 17:17:27 (15108): Guest Log: 00:00:00.000465 main     Process ID: 3210
2023-07-04 17:17:27 (15108): Guest Log: 00:00:00.000466 main     Package type: LINUX_64BITS_GENERIC
2023-07-04 17:17:27 (15108): Guest Log: 00:00:00.002521 main     5.2.6 r120293 started. Verbose level = 0
2023-07-04 17:17:47 (15108): Guest Log: 17:17:46 CEST +02:00 2023-07-04: cranky: [INFO] Detected Theory App
2023-07-04 17:17:47 (15108): Guest Log: 17:17:46 CEST +02:00 2023-07-04: cranky: [INFO] Checking CVMFS.
2023-07-04 17:17:47 (15108): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-07-04 17:17:47 (15108): 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-07-04 17:17:47 (15108): Guest Log: 2.5.2.0 4065 0 25148 26364 3 1 1004781 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-07-04 17:17:47 (15108): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-07-04 17:17:48 (15108): 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-07-04 17:17:48 (15108): Guest Log: 2.5.2.0 4043 0 27716 21641 3 2 1004781 4096001 0 65024 0 2 0 5675 10892 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-07-04 17:17:48 (15108): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-07-04 17:17:48 (15108): 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-07-04 17:17:48 (15108): Guest Log: 2.5.2.0 4086 0 28400 268 3 1 1004781 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-07-04 17:17:48 (15108): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-07-04 17:17:49 (15108): 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-07-04 17:17:49 (15108): Guest Log: 2.5.2.0 4113 0 35612 15810 3 1 1004781 4096001 0 65024 0 0 n/a 4186 2619 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-07-04 17:17:49 (15108): Guest Log: 17:17:48 CEST +02:00 2023-07-04: cranky: [INFO] Checking runc.
2023-07-04 17:17:49 (15108): Guest Log: 17:17:48 CEST +02:00 2023-07-04: cranky: [INFO] Creating the filesystem.
2023-07-04 17:17:49 (15108): Guest Log: 17:17:48 CEST +02:00 2023-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-07-04 17:17:49 (15108): Guest Log: 17:17:48 CEST +02:00 2023-07-04: cranky: [INFO] Updating config.json.
2023-07-04 17:17:49 (15108): Guest Log: 17:17:48 CEST +02:00 2023-07-04: cranky: [INFO] Running Container 'runc'.
2023-07-04 17:17:49 (15108): Guest Log: job: htmld=/shared/html/job
2023-07-04 17:17:49 (15108): Guest Log: job: unpack exitcode=0
2023-07-04 17:17:51 (15108): Guest Log: 17:17:50 CEST +02:00 2023-07-04: cranky: [INFO] ===> [runRivet] Tue Jul  4 15:17:48 UTC 2023 [boinc ppbar zinclusive 1960 -,-,50,120 - sherpa 2.1.0 default 18000 494]
2023-07-04 18:10:32 (15108): Guest Log: job: run exitcode=1
2023-07-04 18:10:32 (15108): Guest Log: job: diskusage=4752
2023-07-04 18:10:32 (15108): Guest Log: job: logsize=48 k
2023-07-04 18:10:32 (15108): Guest Log: job: times=
2023-07-04 18:10:32 (15108): Guest Log: 0m0.009s 0m0.000s
2023-07-04 18:10:32 (15108): Guest Log: 51m50.938s 0m27.419s
2023-07-04 18:10:32 (15108): Guest Log: job: cpuusage=3138
2023-07-04 18:10:32 (15108): Guest Log: 18:10:30 CEST +02:00 2023-07-04: cranky: [INFO] Container 'runc' finished with status code 1.
2023-07-04 18:10:32 (15108): Guest Log: 18:10:30 CEST +02:00 2023-07-04: cranky: [INFO] Preparing output.
2023-07-04 18:10:33 (15108): Guest Log: [INFO] Job Finished
2023-07-04 18:10:33 (15108): Guest Log: [INFO] Shutting Down.
2023-07-04 18:10:33 (15108): VM Completion File Detected.
2023-07-04 18:10:33 (15108): VM Completion Message: Job Finished
.
2023-07-04 18:10:33 (15108): Powering off VM.
2023-07-04 18:10:34 (15108): Successfully stopped VM.
2023-07-04 18:10:34 (15108): Deregistering VM. (boinc_1e9781bbffdec372, slot#16)
2023-07-04 18:10:34 (15108): Removing network bandwidth throttle group from VM.
2023-07-04 18:10:34 (15108): Removing VM from VirtualBox.
18:10:39 (15108): called boinc_finish(0)

</stderr_txt>
]]>
Development for LHC@home

Stderr output
