Task 2927222

Name	Theory_2390-1142961-48_0
Workunit	2035293
Created	27 Sep 2020, 5:20:14 UTC
Sent	28 Sep 2020, 13:29:09 UTC
Report deadline	8 Oct 2020, 13:29:09 UTC
Received	30 Sep 2020, 5:20:25 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4196
Run time	1 days 4 hours 5 min 29 sec
CPU time	15 hours 23 min 5 sec
Validate state	Valid
Credit	1,279.15
Device peak FLOPS	5.46 GFLOPS
Application version	Theory Simulation v5.21 (vbox64_theory) windows_x86_64
Peak working set size	58.45 MB
Peak swap size	53.46 MB
Peak disk usage	2.11 GB
Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2020-09-29 01:22:13 (8248): Detected: vboxwrapper 26197
2020-09-29 01:22:13 (8248): Detected: BOINC client v7.7
2020-09-29 01:22:14 (8248): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 01:22:14 (8248): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 01:22:14 (8248): Successfully copied 'init_data.xml' to the shared directory.
2020-09-29 01:22:14 (8248): Successfully copied 'input' to the shared directory.
2020-09-29 01:22:15 (8248): Create VM. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 01:22:16 (8248): Setting Memory Size for VM. (630MB)
2020-09-29 01:22:16 (8248): Setting CPU Count for VM. (1)
2020-09-29 01:22:17 (8248): Setting Chipset Options for VM.
2020-09-29 01:22:17 (8248): Setting Boot Options for VM.
2020-09-29 01:22:17 (8248): Setting Network Configuration for NAT.
2020-09-29 01:22:17 (8248): Enabling VM Network Access.
2020-09-29 01:22:18 (8248): Disabling USB Support for VM.
2020-09-29 01:22:18 (8248): Disabling COM Port Support for VM.
2020-09-29 01:22:18 (8248): Disabling LPT Port Support for VM.
2020-09-29 01:22:19 (8248): Disabling Audio Support for VM.
2020-09-29 01:22:19 (8248): Disabling Clipboard Support for VM.
2020-09-29 01:22:19 (8248): Disabling Drag and Drop Support for VM.
2020-09-29 01:22:19 (8248): Adding storage controller(s) to VM.
2020-09-29 01:22:20 (8248): Adding virtual disk drive to VM. (vm_image.vdi)
2020-09-29 01:22:20 (8248): Adding VirtualBox Guest Additions to VM.
2020-09-29 01:22:20 (8248): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-09-29 01:22:20 (8248): forwarding host port 57532 to guest port 80
2020-09-29 01:22:21 (8248): Enabling remote desktop for VM.
2020-09-29 01:22:21 (8248): Required extension pack not installed, remote desktop not enabled.
2020-09-29 01:22:21 (8248): Enabling shared directory for VM.
2020-09-29 01:22:21 (8248): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 01:22:27 (8248): Successfully started VM. (PID = '1492')
2020-09-29 01:22:27 (8248): Reporting VM Process ID to BOINC.
2020-09-29 01:22:27 (8248): Guest Log: BIOS: VirtualBox 6.1.12

2020-09-29 01:22:27 (8248): Guest Log: CPUID EDX: 0x178bfbff

2020-09-29 01:22:27 (8248): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-29 01:22:27 (8248): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 01:22:27 (8248): Detected: Web Application Enabled (http://localhost:57532)
2020-09-29 01:22:27 (8248): Preference change detected
2020-09-29 01:22:27 (8248): Setting CPU throttle for VM. (100%)
2020-09-29 01:22:27 (8248): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 01:22:29 (8248): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-29 01:22:29 (8248): Guest Log: BIOS: Booting from Hard Disk...

2020-09-29 01:22:31 (8248): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-29 01:22:31 (8248): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-29 01:22:54 (8248): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-29 01:22:54 (8248): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-29 01:22:58 (8248): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-29 01:22:58 (8248): Guest Log: 00:00:00.000201 main     Log opened 2020-09-28T23:23:01.046835000Z

2020-09-29 01:22:58 (8248): Guest Log: 00:00:00.000342 main     OS Product: Linux

2020-09-29 01:22:58 (8248): Guest Log: 00:00:00.000398 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-29 01:22:58 (8248): Guest Log: 00:00:00.000472 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-29 01:22:58 (8248): Guest Log: 00:00:00.000526 main     Executable: /usr/sbin/VBoxService

2020-09-29 01:22:58 (8248): Guest Log: 00:00:00.000528 main     Process ID: 3200

2020-09-29 01:22:58 (8248): Guest Log: 00:00:00.000529 main     Package type: LINUX_64BITS_GENERIC

2020-09-29 01:22:58 (8248): Guest Log: 00:00:00.004014 main     5.2.6 r120293 started. Verbose level = 0

2020-09-29 01:23:28 (8248): Guest Log: 01:23:30 CEST +02:00 2020-09-29: cranky: [INFO] Detected Theory App

2020-09-29 01:23:28 (8248): Guest Log: 01:23:30 CEST +02:00 2020-09-29: cranky: [INFO] Checking CVMFS.

2020-09-29 01:23:29 (8248): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-29 01:23:29 (8248): 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

2020-09-29 01:23:29 (8248): Guest Log: 2.5.2.0 4108 0 25156 19010 3 1 264257 4096000 0 65024 0 0 n/a 5 13 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-09-29 01:23:30 (8248): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-29 01:23:31 (8248): 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

2020-09-29 01:23:31 (8248): Guest Log: 2.5.2.0 4058 0 25488 13325 3 2 264257 4096000 0 65024 0 2 -100 6412 5255 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-09-29 01:23:32 (8248): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-29 01:23:33 (8248): 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

2020-09-29 01:23:33 (8248): Guest Log: 2.5.2.0 4033 0 27232 259 3 1 264257 4096000 0 65024 0 0 n/a 4 2 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-29 01:23:34 (8248): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-29 01:23:35 (8248): 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

2020-09-29 01:23:35 (8248): Guest Log: 2.5.2.0 4080 0 30156 7570 3 1 264257 4096000 0 65024 0 0 n/a 4383 7354 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-09-29 01:23:35 (8248): Guest Log: 01:23:37 CEST +02:00 2020-09-29: cranky: [INFO] Checking runc.

2020-09-29 01:23:35 (8248): Guest Log: 01:23:37 CEST +02:00 2020-09-29: cranky: [INFO] Creating the filesystem.

2020-09-29 01:23:35 (8248): Guest Log: 01:23:37 CEST +02:00 2020-09-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-29 01:23:35 (8248): Guest Log: 01:23:37 CEST +02:00 2020-09-29: cranky: [INFO] Updating config.json.

2020-09-29 01:23:35 (8248): Guest Log: 01:23:37 CEST +02:00 2020-09-29: cranky: [INFO] Running Container 'runc'.

2020-09-29 01:23:37 (8248): Guest Log: job: htmld=/shared/html/job

2020-09-29 01:23:37 (8248): Guest Log: job: unpack exitcode=0

2020-09-29 01:23:39 (8248): Guest Log: 01:23:42 CEST +02:00 2020-09-29: cranky: [INFO] ===> [runRivet] Mon Sep 28 23:23:40 UTC 2020 [boinc pp ttbar 7000 - - pythia8 8.301 tune-1 100000 48]

2020-09-29 03:02:32 (8248): Status Report: Job Duration: '864000.000000'
2020-09-29 03:02:32 (8248): Status Report: Elapsed Time: '6000.000000'
2020-09-29 03:02:32 (8248): Status Report: CPU Time: '5756.328125'
2020-09-29 04:42:39 (8248): Status Report: Job Duration: '864000.000000'
2020-09-29 04:42:39 (8248): Status Report: Elapsed Time: '12000.000000'
2020-09-29 04:42:39 (8248): Status Report: CPU Time: '11476.375000'
2020-09-29 06:22:45 (8248): Status Report: Job Duration: '864000.000000'
2020-09-29 06:22:45 (8248): Status Report: Elapsed Time: '18000.000000'
2020-09-29 06:22:45 (8248): Status Report: CPU Time: '17222.031250'
2020-09-29 08:02:51 (8248): Status Report: Job Duration: '864000.000000'
2020-09-29 08:02:51 (8248): Status Report: Elapsed Time: '24000.000000'
2020-09-29 08:02:51 (8248): Status Report: CPU Time: '22941.250000'
2020-09-29 09:42:57 (8248): Status Report: Job Duration: '864000.000000'
2020-09-29 09:42:57 (8248): Status Report: Elapsed Time: '30000.000000'
2020-09-29 09:42:57 (8248): Status Report: CPU Time: '28657.671875'
2020-09-29 11:23:03 (8248): Status Report: Job Duration: '864000.000000'
2020-09-29 11:23:03 (8248): Status Report: Elapsed Time: '36000.000000'
2020-09-29 11:23:03 (8248): Status Report: CPU Time: '34433.046875'
2020-09-29 13:03:09 (8248): Status Report: Job Duration: '864000.000000'
2020-09-29 13:03:09 (8248): Status Report: Elapsed Time: '42000.000000'
2020-09-29 13:03:09 (8248): Status Report: CPU Time: '40031.687500'
2020-09-29 13:42:25 (8248): Stopping VM.
2020-09-29 13:42:26 (8248): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_d13263b081e6c33b" savestate
Output:

2020-09-29 13:42:26 (8248): VM did not stop when requested.
2020-09-29 13:42:26 (8248): VM was successfully terminated.
2020-09-29 14:07:52 (9856): Detected: vboxwrapper 26197
2020-09-29 14:07:52 (9856): Detected: BOINC client v7.7
2020-09-29 14:07:56 (9856): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 14:07:58 (9856): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 14:07:59 (9856): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 14:08:06 (9856): Successfully started VM. (PID = '14148')
2020-09-29 14:08:06 (9856): Reporting VM Process ID to BOINC.
2020-09-29 14:08:06 (9856): Guest Log: BIOS: VirtualBox 6.1.12

2020-09-29 14:08:06 (9856): Guest Log: CPUID EDX: 0x178bfbff

2020-09-29 14:08:06 (9856): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-29 14:08:06 (9856): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 14:08:06 (9856): Detected: Web Application Enabled (http://localhost:57532)
2020-09-29 14:08:06 (9856): Status Report: Job Duration: '864000.000000'
2020-09-29 14:08:06 (9856): Status Report: Elapsed Time: '44353.000000'
2020-09-29 14:08:06 (9856): Status Report: CPU Time: '42226.406250'
2020-09-29 14:08:06 (9856): Preference change detected
2020-09-29 14:08:06 (9856): Setting CPU throttle for VM. (100%)
2020-09-29 14:08:06 (9856): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 14:08:08 (9856): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-29 14:08:08 (9856): Guest Log: BIOS: Booting from Hard Disk...

2020-09-29 14:08:10 (9856): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-29 14:08:10 (9856): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-29 14:08:34 (9856): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-29 14:08:34 (9856): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-29 14:08:38 (9856): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-29 14:08:38 (9856): Guest Log: 00:00:00.000159 main     Log opened 2020-09-29T12:08:42.117745000Z

2020-09-29 14:08:38 (9856): Guest Log: 00:00:00.000358 main     OS Product: Linux

2020-09-29 14:08:38 (9856): Guest Log: 00:00:00.000450 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-29 14:08:38 (9856): Guest Log: 00:00:00.000539 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-29 14:08:38 (9856): Guest Log: 00:00:00.000594 main     Executable: /usr/sbin/VBoxService

2020-09-29 14:08:38 (9856): Guest Log: 00:00:00.000596 main     Process ID: 3198

2020-09-29 14:08:38 (9856): Guest Log: 00:00:00.000598 main     Package type: LINUX_64BITS_GENERIC

2020-09-29 14:08:38 (9856): Guest Log: 00:00:00.004684 main     5.2.6 r120293 started. Verbose level = 0

2020-09-29 14:09:04 (9856): Guest Log: 14:09:07 CEST +02:00 2020-09-29: cranky: [INFO] Detected Theory App

2020-09-29 14:09:04 (9856): Guest Log: 14:09:07 CEST +02:00 2020-09-29: cranky: [INFO] Checking CVMFS.

2020-09-29 14:09:05 (9856): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-29 14:09:06 (9856): 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

2020-09-29 14:09:06 (9856): Guest Log: 2.5.2.0 4074 0 25144 19013 3 1 1313270 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-09-29 14:09:07 (9856): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-29 14:09:07 (9856): 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

2020-09-29 14:09:07 (9856): Guest Log: 2.5.2.0 4053 0 25472 13329 3 2 1313270 4096001 0 65024 0 2 0 4274 6427 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-09-29 14:09:09 (9856): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-29 14:09:10 (9856): 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

2020-09-29 14:09:10 (9856): Guest Log: 2.5.2.0 4031 0 27216 259 3 1 1313270 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-29 14:09:11 (9856): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-29 14:09:12 (9856): 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

2020-09-29 14:09:12 (9856): Guest Log: 2.5.2.0 4097 0 30144 7572 3 1 1313270 4096001 0 65024 0 0 n/a 4383 5828 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-09-29 14:09:12 (9856): Guest Log: 14:09:16 CEST +02:00 2020-09-29: cranky: [INFO] Checking runc.

2020-09-29 14:09:12 (9856): Guest Log: 14:09:16 CEST +02:00 2020-09-29: cranky: [INFO] Creating the filesystem.

2020-09-29 14:09:12 (9856): Guest Log: 14:09:16 CEST +02:00 2020-09-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-29 14:09:12 (9856): Guest Log: 14:09:16 CEST +02:00 2020-09-29: cranky: [INFO] Updating config.json.

2020-09-29 14:09:12 (9856): Guest Log: 14:09:16 CEST +02:00 2020-09-29: cranky: [INFO] Running Container 'runc'.

2020-09-29 14:09:13 (9856): Guest Log: job: htmld=/shared/html/job

2020-09-29 14:09:13 (9856): Guest Log: job: unpack exitcode=0

2020-09-29 14:09:15 (9856): Guest Log: 14:09:18 CEST +02:00 2020-09-29: cranky: [INFO] ===> [runRivet] Tue Sep 29 12:09:16 UTC 2020 [boinc pp ttbar 7000 - - pythia8 8.301 tune-1 100000 48]

2020-09-29 14:12:07 (9856): Stopping VM.
2020-09-29 14:12:08 (9856): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_d13263b081e6c33b" savestate
Output:

2020-09-29 14:12:08 (9856): VM did not stop when requested.
2020-09-29 14:12:08 (9856): VM was successfully terminated.
2020-09-29 14:14:16 (12096): Detected: vboxwrapper 26197
2020-09-29 14:14:16 (12096): Detected: BOINC client v7.7
2020-09-29 14:14:18 (12096): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 14:14:19 (12096): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 14:14:19 (12096): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 14:14:25 (12096): Successfully started VM. (PID = '14096')
2020-09-29 14:14:25 (12096): Reporting VM Process ID to BOINC.
2020-09-29 14:14:25 (12096): Guest Log: BIOS: VirtualBox 6.1.12

2020-09-29 14:14:25 (12096): Guest Log: CPUID EDX: 0x178bfbff

2020-09-29 14:14:25 (12096): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-29 14:14:25 (12096): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 14:14:25 (12096): Detected: Web Application Enabled (http://localhost:57532)
2020-09-29 14:14:25 (12096): Status Report: Job Duration: '864000.000000'
2020-09-29 14:14:25 (12096): Status Report: Elapsed Time: '44593.000000'
2020-09-29 14:14:25 (12096): Status Report: CPU Time: '42435.531250'
2020-09-29 14:14:25 (12096): Preference change detected
2020-09-29 14:14:25 (12096): Setting CPU throttle for VM. (100%)
2020-09-29 14:14:26 (12096): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 14:14:27 (12096): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-29 14:14:27 (12096): Guest Log: BIOS: Booting from Hard Disk...

2020-09-29 14:14:30 (12096): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-29 14:14:30 (12096): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-29 14:14:51 (12096): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-29 14:14:51 (12096): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-29 14:14:55 (12096): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-29 14:14:55 (12096): Guest Log: 00:00:00.005629 main     Log opened 2020-09-29T12:15:00.226440000Z

2020-09-29 14:14:55 (12096): Guest Log: 00:00:00.018663 main     OS Product: Linux

2020-09-29 14:14:55 (12096): Guest Log: 00:00:00.019184 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-29 14:14:55 (12096): Guest Log: 00:00:00.019647 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-29 14:14:55 (12096): Guest Log: 00:00:00.020852 main     Executable: /usr/sbin/VBoxService

2020-09-29 14:14:55 (12096): Guest Log: 00:00:00.020854 main     Process ID: 3197

2020-09-29 14:14:55 (12096): Guest Log: 00:00:00.020856 main     Package type: LINUX_64BITS_GENERIC

2020-09-29 14:14:55 (12096): Guest Log: 00:00:00.028229 main     5.2.6 r120293 started. Verbose level = 0

2020-09-29 14:15:24 (12096): Guest Log: 14:15:28 CEST +02:00 2020-09-29: cranky: [INFO] Detected Theory App

2020-09-29 14:15:24 (12096): Guest Log: 14:15:28 CEST +02:00 2020-09-29: cranky: [INFO] Checking CVMFS.

2020-09-29 14:15:25 (12096): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-29 14:15:25 (12096): 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

2020-09-29 14:15:25 (12096): Guest Log: 2.5.2.0 4054 0 25116 19013 3 1 1313288 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-09-29 14:15:26 (12096): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-29 14:15:27 (12096): 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

2020-09-29 14:15:27 (12096): Guest Log: 2.5.2.0 4076 0 27652 13329 3 2 1313288 4096001 0 65024 0 2 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-09-29 14:15:28 (12096): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-29 14:15:29 (12096): 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

2020-09-29 14:15:29 (12096): Guest Log: 2.5.2.0 4102 0 27976 259 3 1 1313288 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-29 14:15:30 (12096): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-29 14:15:31 (12096): 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

2020-09-29 14:15:31 (12096): Guest Log: 2.5.2.0 4033 0 29388 7572 3 1 1313288 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-09-29 14:15:31 (12096): Guest Log: 14:15:35 CEST +02:00 2020-09-29: cranky: [INFO] Checking runc.

2020-09-29 14:15:31 (12096): Guest Log: 14:15:35 CEST +02:00 2020-09-29: cranky: [INFO] Creating the filesystem.

2020-09-29 14:15:31 (12096): Guest Log: 14:15:35 CEST +02:00 2020-09-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-29 14:15:31 (12096): Guest Log: 14:15:36 CEST +02:00 2020-09-29: cranky: [INFO] Updating config.json.

2020-09-29 14:15:31 (12096): Guest Log: 14:15:36 CEST +02:00 2020-09-29: cranky: [INFO] Running Container 'runc'.

2020-09-29 14:15:31 (12096): Guest Log: job: htmld=/shared/html/job

2020-09-29 14:15:31 (12096): Guest Log: job: unpack exitcode=0

2020-09-29 14:15:33 (12096): Guest Log: 14:15:38 CEST +02:00 2020-09-29: cranky: [INFO] ===> [runRivet] Tue Sep 29 12:15:36 UTC 2020 [boinc pp ttbar 7000 - - pythia8 8.301 tune-1 100000 48]

2020-09-29 14:21:19 (12720): Detected: vboxwrapper 26197
2020-09-29 14:21:19 (12720): Detected: BOINC client v7.7
2020-09-29 14:21:20 (12720): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 14:21:21 (12720): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 14:21:22 (12720): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 14:21:28 (12720): Successfully started VM. (PID = '1660')
2020-09-29 14:21:28 (12720): Reporting VM Process ID to BOINC.
2020-09-29 14:21:28 (12720): Guest Log: BIOS: VirtualBox 6.1.12

2020-09-29 14:21:28 (12720): Guest Log: CPUID EDX: 0x178bfbff

2020-09-29 14:21:28 (12720): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-29 14:21:28 (12720): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 14:21:28 (12720): Detected: Web Application Enabled (http://localhost:57532)
2020-09-29 14:21:28 (12720): Status Report: Job Duration: '864000.000000'
2020-09-29 14:21:28 (12720): Status Report: Elapsed Time: '44593.000000'
2020-09-29 14:21:28 (12720): Status Report: CPU Time: '42435.531250'
2020-09-29 14:21:28 (12720): Preference change detected
2020-09-29 14:21:28 (12720): Setting CPU throttle for VM. (100%)
2020-09-29 14:21:28 (12720): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 14:21:30 (12720): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-29 14:21:30 (12720): Guest Log: BIOS: Booting from Hard Disk...

2020-09-29 14:21:32 (12720): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-29 14:21:32 (12720): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-29 14:22:56 (11984): Detected: vboxwrapper 26197
2020-09-29 14:22:56 (11984): Detected: BOINC client v7.7
2020-09-29 14:22:58 (11984): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 14:22:59 (11984): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 14:23:00 (11984): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 14:23:06 (11984): Successfully started VM. (PID = '13396')
2020-09-29 14:23:06 (11984): Reporting VM Process ID to BOINC.
2020-09-29 14:23:06 (11984): Guest Log: BIOS: VirtualBox 6.1.12

2020-09-29 14:23:06 (11984): Guest Log: CPUID EDX: 0x178bfbff

2020-09-29 14:23:06 (11984): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-29 14:23:06 (11984): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 14:23:06 (11984): Preference change detected
2020-09-29 14:23:06 (11984): Setting CPU throttle for VM. (100%)
2020-09-29 14:23:06 (11984): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 14:23:08 (11984): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-29 14:24:29 (11984): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-29 14:24:29 (11984): Guest Log: BIOS: Booting from Hard Disk...

2020-09-29 14:24:29 (11984): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-29 14:24:32 (11984): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-29 14:24:32 (11984): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-29 14:24:53 (11984): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-29 14:24:53 (11984): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-29 14:24:58 (11984): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-29 14:24:58 (11984): Guest Log: 00:00:00.000152 main     Log opened 2020-09-29T12:25:01.945840000Z

2020-09-29 14:24:58 (11984): Guest Log: 00:00:00.000322 main     OS Product: Linux

2020-09-29 14:24:58 (11984): Guest Log: 00:00:00.000393 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-29 14:24:58 (11984): Guest Log: 00:00:00.000453 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-29 14:24:58 (11984): Guest Log: 00:00:00.000509 main     Executable: /usr/sbin/VBoxService

2020-09-29 14:24:58 (11984): Guest Log: 00:00:00.000511 main     Process ID: 3200

2020-09-29 14:24:58 (11984): Guest Log: 00:00:00.000513 main     Package type: LINUX_64BITS_GENERIC

2020-09-29 14:24:58 (11984): Guest Log: 00:00:00.004074 main     5.2.6 r120293 started. Verbose level = 0

2020-09-29 14:25:24 (11984): Guest Log: 14:25:28 CEST +02:00 2020-09-29: cranky: [INFO] Detected Theory App

2020-09-29 14:25:24 (11984): Guest Log: 14:25:28 CEST +02:00 2020-09-29: cranky: [INFO] Checking CVMFS.

2020-09-29 14:25:25 (11984): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-29 14:25:26 (11984): 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

2020-09-29 14:25:26 (11984): Guest Log: 2.5.2.0 4029 0 26148 19013 3 1 1313288 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-09-29 14:25:27 (11984): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-29 14:25:27 (11984): 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

2020-09-29 14:25:27 (11984): Guest Log: 2.5.2.0 4101 0 27504 13329 3 2 1313288 4096001 0 65024 0 2 100 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-09-29 14:25:28 (11984): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-29 14:25:29 (11984): 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

2020-09-29 14:25:29 (11984): Guest Log: 2.5.2.0 4051 0 25188 259 3 1 1313288 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-29 14:25:30 (11984): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-29 14:25:31 (11984): 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

2020-09-29 14:25:31 (11984): Guest Log: 2.5.2.0 4076 0 30624 7572 3 1 1313288 4096001 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-09-29 14:25:31 (11984): Guest Log: 14:25:35 CEST +02:00 2020-09-29: cranky: [INFO] Checking runc.

2020-09-29 14:25:31 (11984): Guest Log: 14:25:35 CEST +02:00 2020-09-29: cranky: [INFO] Creating the filesystem.

2020-09-29 14:25:31 (11984): Guest Log: 14:25:35 CEST +02:00 2020-09-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-29 14:25:31 (11984): Guest Log: 14:25:35 CEST +02:00 2020-09-29: cranky: [INFO] Updating config.json.

2020-09-29 14:25:31 (11984): Guest Log: 14:25:35 CEST +02:00 2020-09-29: cranky: [INFO] Running Container 'runc'.

2020-09-29 14:25:32 (11984): Guest Log: job: htmld=/shared/html/job

2020-09-29 14:25:32 (11984): Guest Log: job: unpack exitcode=0

2020-09-29 14:25:33 (11984): Guest Log: 14:25:37 CEST +02:00 2020-09-29: cranky: [INFO] ===> [runRivet] Tue Sep 29 12:25:36 UTC 2020 [boinc pp ttbar 7000 - - pythia8 8.301 tune-1 100000 48]

2020-09-29 14:41:11 (11984): Stopping VM.
2020-09-29 14:46:44 (11740): Detected: vboxwrapper 26197
2020-09-29 14:46:44 (11740): Detected: BOINC client v7.7
2020-09-29 14:46:46 (11740): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 14:46:46 (11740): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 14:46:46 (11740): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 14:46:56 (11740): Successfully started VM. (PID = '12500')
2020-09-29 14:46:56 (11740): Reporting VM Process ID to BOINC.
2020-09-29 14:46:56 (11740): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 14:46:56 (11740): Preference change detected
2020-09-29 14:46:56 (11740): Setting CPU throttle for VM. (100%)
2020-09-29 14:46:56 (11740): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 14:56:21 (12688): Detected: vboxwrapper 26197
2020-09-29 14:56:21 (12688): Detected: BOINC client v7.7
2020-09-29 14:56:22 (12688): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 14:56:22 (12688): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 14:56:23 (12688): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 14:56:28 (12688): Successfully started VM. (PID = '13784')
2020-09-29 14:56:28 (12688): Reporting VM Process ID to BOINC.
2020-09-29 14:56:28 (12688): Guest Log: BIOS: VirtualBox 6.1.12

2020-09-29 14:56:28 (12688): Guest Log: CPUID EDX: 0x178bfbff

2020-09-29 14:56:28 (12688): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-29 14:56:28 (12688): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 14:56:28 (12688): Preference change detected
2020-09-29 14:56:28 (12688): Setting CPU throttle for VM. (100%)
2020-09-29 14:56:29 (12688): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 14:56:30 (12688): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-29 14:56:30 (12688): Guest Log: BIOS: Booting from Hard Disk...

2020-09-29 14:56:32 (12688): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-29 14:56:32 (12688): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-29 14:56:55 (12688): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-29 14:56:55 (12688): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-29 14:56:59 (12688): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-29 14:56:59 (12688): Guest Log: 00:00:00.000146 main     Log opened 2020-09-29T12:57:04.686499000Z

2020-09-29 14:56:59 (12688): Guest Log: 00:00:00.000272 main     OS Product: Linux

2020-09-29 14:56:59 (12688): Guest Log: 00:00:00.000317 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-29 14:56:59 (12688): Guest Log: 00:00:00.000394 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-29 14:56:59 (12688): Guest Log: 00:00:00.000437 main     Executable: /usr/sbin/VBoxService

2020-09-29 14:56:59 (12688): Guest Log: 00:00:00.000439 main     Process ID: 3204

2020-09-29 14:56:59 (12688): Guest Log: 00:00:00.000441 main     Package type: LINUX_64BITS_GENERIC

2020-09-29 14:56:59 (12688): Guest Log: 00:00:00.004239 main     5.2.6 r120293 started. Verbose level = 0

2020-09-29 14:57:29 (12688): Guest Log: 14:57:33 CEST +02:00 2020-09-29: cranky: [INFO] Detected Theory App

2020-09-29 14:57:29 (12688): Guest Log: 14:57:33 CEST +02:00 2020-09-29: cranky: [INFO] Checking CVMFS.

2020-09-29 14:57:30 (12688): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-29 14:57:31 (12688): 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

2020-09-29 14:57:31 (12688): Guest Log: 2.5.2.0 4086 0 26232 19013 3 1 1322941 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1

2020-09-29 14:57:32 (12688): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-29 14:57:32 (12688): 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

2020-09-29 14:57:32 (12688): Guest Log: 2.5.2.0 4034 0 27492 13329 3 2 1322941 4096001 0 65024 0 2 100 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-09-29 14:57:33 (12688): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-29 14:57:34 (12688): 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

2020-09-29 14:57:34 (12688): Guest Log: 2.5.2.0 4108 0 25140 259 3 1 1322941 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-29 14:57:35 (12688): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-29 14:57:36 (12688): 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

2020-09-29 14:57:36 (12688): Guest Log: 2.5.2.0 4060 0 30128 7573 3 1 1322941 4096001 0 65024 0 0 n/a 4384 5225 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-09-29 14:57:36 (12688): Guest Log: 14:57:40 CEST +02:00 2020-09-29: cranky: [INFO] Checking runc.

2020-09-29 14:57:36 (12688): Guest Log: 14:57:40 CEST +02:00 2020-09-29: cranky: [INFO] Creating the filesystem.

2020-09-29 14:57:36 (12688): Guest Log: 14:57:40 CEST +02:00 2020-09-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-29 14:57:36 (12688): Guest Log: 14:57:41 CEST +02:00 2020-09-29: cranky: [INFO] Updating config.json.

2020-09-29 14:57:37 (12688): Guest Log: 14:57:41 CEST +02:00 2020-09-29: cranky: [INFO] Running Container 'runc'.

2020-09-29 14:57:37 (12688): Guest Log: job: htmld=/shared/html/job

2020-09-29 14:57:37 (12688): Guest Log: job: unpack exitcode=0

2020-09-29 14:57:39 (12688): Guest Log: 14:57:43 CEST +02:00 2020-09-29: cranky: [INFO] ===> [runRivet] Tue Sep 29 12:57:41 UTC 2020 [boinc pp ttbar 7000 - - pythia8 8.301 tune-1 100000 48]

2020-09-29 15:04:59 (12952): Detected: vboxwrapper 26197
2020-09-29 15:04:59 (12952): Detected: BOINC client v7.7
2020-09-29 15:05:01 (12952): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 15:05:01 (12952): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 15:05:01 (12952): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 15:05:07 (12952): Successfully started VM. (PID = '14224')
2020-09-29 15:05:07 (12952): Reporting VM Process ID to BOINC.
2020-09-29 15:05:07 (12952): Guest Log: BIOS: VirtualBox 6.1.12

2020-09-29 15:05:07 (12952): Guest Log: CPUID EDX: 0x178bfbff

2020-09-29 15:05:07 (12952): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-29 15:05:07 (12952): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 15:05:07 (12952): Preference change detected
2020-09-29 15:05:07 (12952): Setting CPU throttle for VM. (100%)
2020-09-29 15:05:07 (12952): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 15:05:09 (12952): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-29 15:05:09 (12952): Guest Log: BIOS: Booting from Hard Disk...

2020-09-29 15:05:11 (12952): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-29 15:05:11 (12952): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-29 15:05:35 (12952): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-29 15:05:35 (12952): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-29 15:05:39 (12952): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-29 15:05:39 (12952): Guest Log: 00:00:00.000145 main     Log opened 2020-09-29T13:05:43.331522000Z

2020-09-29 15:05:39 (12952): Guest Log: 00:00:00.000277 main     OS Product: Linux

2020-09-29 15:05:39 (12952): Guest Log: 00:00:00.000325 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-29 15:05:39 (12952): Guest Log: 00:00:00.000389 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-29 15:05:39 (12952): Guest Log: 00:00:00.000433 main     Executable: /usr/sbin/VBoxService

2020-09-29 15:05:39 (12952): Guest Log: 00:00:00.000435 main     Process ID: 3197

2020-09-29 15:05:39 (12952): Guest Log: 00:00:00.000436 main     Package type: LINUX_64BITS_GENERIC

2020-09-29 15:05:39 (12952): Guest Log: 00:00:00.004310 main     5.2.6 r120293 started. Verbose level = 0

2020-09-29 15:06:06 (12952): Guest Log: 15:06:10 CEST +02:00 2020-09-29: cranky: [INFO] Detected Theory App

2020-09-29 15:06:06 (12952): Guest Log: 15:06:10 CEST +02:00 2020-09-29: cranky: [INFO] Checking CVMFS.

2020-09-29 15:06:07 (12952): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-29 15:06:08 (12952): 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

2020-09-29 15:06:08 (12952): Guest Log: 2.5.2.0 4056 0 28364 19013 3 1 1331278 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-09-29 15:06:09 (12952): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-29 15:06:10 (12952): 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

2020-09-29 15:06:10 (12952): Guest Log: 2.5.2.0 4030 0 27572 13331 3 2 1331278 4096001 0 65024 0 2 0 4271 2076 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-09-29 15:06:11 (12952): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-29 15:06:11 (12952): 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

2020-09-29 15:06:11 (12952): Guest Log: 2.5.2.0 4077 0 27200 259 3 1 1331278 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-29 15:06:13 (12952): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-29 15:06:13 (12952): 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

2020-09-29 15:06:13 (12952): Guest Log: 2.5.2.0 4101 0 31008 7573 3 1 1331278 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-09-29 15:06:13 (12952): Guest Log: 15:06:18 CEST +02:00 2020-09-29: cranky: [INFO] Checking runc.

2020-09-29 15:06:13 (12952): Guest Log: 15:06:18 CEST +02:00 2020-09-29: cranky: [INFO] Creating the filesystem.

2020-09-29 15:06:13 (12952): Guest Log: 15:06:18 CEST +02:00 2020-09-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-29 15:06:14 (12952): Guest Log: 15:06:18 CEST +02:00 2020-09-29: cranky: [INFO] Updating config.json.

2020-09-29 15:06:14 (12952): Guest Log: 15:06:18 CEST +02:00 2020-09-29: cranky: [INFO] Running Container 'runc'.

2020-09-29 15:06:14 (12952): Guest Log: job: htmld=/shared/html/job

2020-09-29 15:06:14 (12952): Guest Log: job: unpack exitcode=0

2020-09-29 15:06:16 (12952): Guest Log: 15:06:20 CEST +02:00 2020-09-29: cranky: [INFO] ===> [runRivet] Tue Sep 29 13:06:19 UTC 2020 [boinc pp ttbar 7000 - - pythia8 8.301 tune-1 100000 48]

2020-09-29 15:12:07 (12952): Stopping VM.
2020-09-29 15:23:19 (14652): Detected: vboxwrapper 26197
2020-09-29 15:23:19 (14652): Detected: BOINC client v7.7
2020-09-29 15:23:20 (14652): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 15:23:20 (14652): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 15:23:21 (14652): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 15:23:30 (14652): Successfully started VM. (PID = '15956')
2020-09-29 15:23:30 (14652): Reporting VM Process ID to BOINC.
2020-09-29 15:23:30 (14652): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 15:23:30 (14652): Preference change detected
2020-09-29 15:23:30 (14652): Setting CPU throttle for VM. (100%)
2020-09-29 15:23:30 (14652): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 15:46:34 (14652): Stopping VM.
2020-09-29 15:49:47 (4676): Detected: vboxwrapper 26197
2020-09-29 15:49:47 (4676): Detected: BOINC client v7.7
2020-09-29 15:49:48 (4676): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 15:49:48 (4676): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 15:49:48 (4676): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 15:49:57 (4676): Successfully started VM. (PID = '7304')
2020-09-29 15:49:57 (4676): Reporting VM Process ID to BOINC.
2020-09-29 15:49:57 (4676): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 15:49:57 (4676): Preference change detected
2020-09-29 15:49:57 (4676): Setting CPU throttle for VM. (100%)
2020-09-29 15:49:57 (4676): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 15:53:02 (4676): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-29 15:58:37 (6540): Detected: vboxwrapper 26197
2020-09-29 15:58:37 (6540): Detected: BOINC client v7.7
2020-09-29 15:58:39 (6540): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-09-29 15:58:39 (6540): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-29 15:58:39 (6540): Starting VM using VBoxManage interface. (boinc_d13263b081e6c33b, slot#4)
2020-09-29 15:58:45 (6540): Successfully started VM. (PID = '5644')
2020-09-29 15:58:45 (6540): Reporting VM Process ID to BOINC.
2020-09-29 15:58:45 (6540): Guest Log: BIOS: VirtualBox 6.1.12

2020-09-29 15:58:45 (6540): Guest Log: CPUID EDX: 0x178bfbff

2020-09-29 15:58:45 (6540): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-29 15:58:45 (6540): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-29 15:58:45 (6540): Preference change detected
2020-09-29 15:58:45 (6540): Setting CPU throttle for VM. (100%)
2020-09-29 15:58:46 (6540): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-29 15:58:47 (6540): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-29 15:58:47 (6540): Guest Log: BIOS: Booting from Hard Disk...

2020-09-29 15:58:49 (6540): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-29 15:58:49 (6540): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-29 15:59:13 (6540): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-29 15:59:13 (6540): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-29 15:59:17 (6540): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-29 15:59:17 (6540): Guest Log: 00:00:00.000149 main     Log opened 2020-09-29T13:59:22.071900000Z

2020-09-29 15:59:17 (6540): Guest Log: 00:00:00.000329 main     OS Product: Linux

2020-09-29 15:59:18 (6540): Guest Log: 00:00:00.000386 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-29 15:59:18 (6540): Guest Log: 00:00:00.000452 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-29 15:59:18 (6540): Guest Log: 00:00:00.000507 main     Executable: /usr/sbin/VBoxService

2020-09-29 15:59:18 (6540): Guest Log: 00:00:00.000509 main     Process ID: 3196

2020-09-29 15:59:18 (6540): Guest Log: 00:00:00.000511 main     Package type: LINUX_64BITS_GENERIC

2020-09-29 15:59:18 (6540): Guest Log: 00:00:00.004509 main     5.2.6 r120293 started. Verbose level = 0

2020-09-29 15:59:49 (6540): Guest Log: 15:59:53 CEST +02:00 2020-09-29: cranky: [INFO] Detected Theory App

2020-09-29 15:59:49 (6540): Guest Log: 15:59:53 CEST +02:00 2020-09-29: cranky: [INFO] Checking CVMFS.

2020-09-29 15:59:50 (6540): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-29 15:59:51 (6540): 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

2020-09-29 15:59:51 (6540): Guest Log: 2.5.2.0 4030 0 25148 19013 3 1 1331278 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1

2020-09-29 15:59:52 (6540): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-29 15:59:53 (6540): 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

2020-09-29 15:59:53 (6540): Guest Log: 2.5.2.0 4052 0 27660 13331 3 2 1331278 4096001 0 65024 0 2 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-09-29 15:59:54 (6540): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-29 15:59:55 (6540): 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

2020-09-29 15:59:55 (6540): Guest Log: 2.5.2.0 4101 0 25140 259 3 1 1331278 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-29 15:59:56 (6540): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-29 15:59:57 (6540): 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

2020-09-29 15:59:57 (6540): Guest Log: 2.5.2.0 4072 0 30108 7573 3 1 1331278 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-09-29 15:59:57 (6540): Guest Log: 16:00:01 CEST +02:00 2020-09-29: cranky: [INFO] Checking runc.

2020-09-29 15:59:57 (6540): Guest Log: 16:00:01 CEST +02:00 2020-09-29: cranky: [INFO] Creating the filesystem.

2020-09-29 15:59:57 (6540): Guest Log: 16:00:01 CEST +02:00 2020-09-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-29 15:59:57 (6540): Guest Log: 16:00:01 CEST +02:00 2020-09-29: cranky: [INFO] Updating config.json.

2020-09-29 15:59:57 (6540): Guest Log: 16:00:01 CEST +02:00 2020-09-29: cranky: [INFO] Running Container 'runc'.

2020-09-29 15:59:58 (6540): Guest Log: job: htmld=/shared/html/job

2020-09-29 15:59:58 (6540): Guest Log: job: unpack exitcode=0

2020-09-29 15:59:59 (6540): Guest Log: 16:00:03 CEST +02:00 2020-09-29: cranky: [INFO] ===> [runRivet] Tue Sep 29 14:00:02 UTC 2020 [boinc pp ttbar 7000 - - pythia8 8.301 tune-1 100000 48]

2020-09-29 16:52:23 (6540): Status Report: Job Duration: '864000.000000'
2020-09-29 16:52:23 (6540): Status Report: Elapsed Time: '6000.012461'
2020-09-29 16:52:23 (6540): Status Report: CPU Time: '5799.453125'
2020-09-29 18:32:54 (6540): Status Report: Job Duration: '864000.000000'
2020-09-29 18:32:54 (6540): Status Report: Elapsed Time: '12000.012461'
2020-09-29 18:32:54 (6540): Status Report: CPU Time: '11711.781250'
2020-09-29 20:13:25 (6540): Status Report: Job Duration: '864000.000000'
2020-09-29 20:13:25 (6540): Status Report: Elapsed Time: '18001.012461'
2020-09-29 20:13:25 (6540): Status Report: CPU Time: '17625.578125'
2020-09-29 21:53:31 (6540): Status Report: Job Duration: '864000.000000'
2020-09-29 21:53:31 (6540): Status Report: Elapsed Time: '24001.663445'
2020-09-29 21:53:31 (6540): Status Report: CPU Time: '23485.718750'
2020-09-29 23:33:36 (6540): Status Report: Job Duration: '864000.000000'
2020-09-29 23:33:36 (6540): Status Report: Elapsed Time: '30001.663445'
2020-09-29 23:33:36 (6540): Status Report: CPU Time: '29222.015625'
2020-09-30 01:13:41 (6540): Status Report: Job Duration: '864000.000000'
2020-09-30 01:13:41 (6540): Status Report: Elapsed Time: '36001.663445'
2020-09-30 01:13:41 (6540): Status Report: CPU Time: '34860.875000'
2020-09-30 02:53:47 (6540): Status Report: Job Duration: '864000.000000'
2020-09-30 02:53:47 (6540): Status Report: Elapsed Time: '42001.663445'
2020-09-30 02:53:47 (6540): Status Report: CPU Time: '40503.671875'
2020-09-30 04:33:52 (6540): Status Report: Job Duration: '864000.000000'
2020-09-30 04:33:52 (6540): Status Report: Elapsed Time: '48001.663445'
2020-09-30 04:33:52 (6540): Status Report: CPU Time: '46203.671875'
2020-09-30 06:13:57 (6540): Status Report: Job Duration: '864000.000000'
2020-09-30 06:13:57 (6540): Status Report: Elapsed Time: '54001.663445'
2020-09-30 06:13:57 (6540): Status Report: CPU Time: '51911.046875'
2020-09-30 07:15:05 (6540): Guest Log: job: run exitcode=0

2020-09-30 07:15:05 (6540): Guest Log: job: diskusage=3276

2020-09-30 07:15:05 (6540): Guest Log: job: logsize=80 k

2020-09-30 07:15:05 (6540): Guest Log: job: times=

2020-09-30 07:15:05 (6540): Guest Log: 0m0.012s 0m0.019s

2020-09-30 07:15:05 (6540): Guest Log: 902m58.361s 4m23.900s

2020-09-30 07:15:05 (6540): Guest Log: job: cpuusage=54442

2020-09-30 07:15:05 (6540): Guest Log: 07:15:04 CEST +02:00 2020-09-30: cranky: [INFO] Container 'runc' finished with status code 0.

2020-09-30 07:15:05 (6540): Guest Log: 07:15:04 CEST +02:00 2020-09-30: cranky: [INFO] Preparing output.

2020-09-30 07:15:06 (6540): Guest Log: [INFO] Job Finished

2020-09-30 07:15:06 (6540): Guest Log: [INFO] Shutting Down.

2020-09-30 07:15:06 (6540): VM Completion File Detected.
2020-09-30 07:15:06 (6540): VM Completion Message: Job Finished
.
2020-09-30 07:15:06 (6540): Powering off VM.
2020-09-30 07:20:06 (6540): VM did not power off when requested.
2020-09-30 07:20:06 (6540): VM was successfully terminated.
2020-09-30 07:20:06 (6540): Deregistering VM. (boinc_d13263b081e6c33b, slot#4)
2020-09-30 07:20:07 (6540): Removing network bandwidth throttle group from VM.
2020-09-30 07:20:08 (6540): Removing VM from VirtualBox.
07:20:13 (6540): called boinc_finish(0)

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

Stderr output
