Task 2911025

Name	Theory_2390-1135315-16_1
Workunit	2020277
Created	14 Jun 2020, 7:47:04 UTC
Sent	15 Jun 2020, 3:31:03 UTC
Report deadline	25 Jun 2020, 3:31:03 UTC
Received	21 Jun 2020, 6:54:25 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4093
Run time	3 hours 46 min 29 sec
CPU time	3 hours 6 min 3 sec
Validate state	Valid
Credit	96.85
Device peak FLOPS	3.08 GFLOPS
Application version	Theory Simulation v5.21 (vbox64_theory) windows_x86_64
Peak working set size	72.39 MB
Peak swap size	77.31 MB
Peak disk usage	1.99 GB
Stderr output

<core_client_version>7.16.7</core_client_version>
<![CDATA[
<stderr_txt>
2020-06-15 14:03:37 (16276): Detected: vboxwrapper 26197
2020-06-15 14:03:37 (16276): Detected: BOINC client v7.7
2020-06-15 14:03:38 (16276): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-06-15 14:03:38 (16276): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-06-15 14:03:38 (16276): Successfully copied 'init_data.xml' to the shared directory.
2020-06-15 14:03:38 (16276): Successfully copied 'input' to the shared directory.
2020-06-15 14:03:39 (16276): Create VM. (boinc_f9290e91f7c6693a, slot#36)
2020-06-15 14:03:41 (16276): Setting Memory Size for VM. (630MB)
2020-06-15 14:03:42 (16276): Setting CPU Count for VM. (1)
2020-06-15 14:03:42 (16276): Setting Chipset Options for VM.
2020-06-15 14:03:43 (16276): Setting Boot Options for VM.
2020-06-15 14:03:44 (16276): Setting Network Configuration for NAT.
2020-06-15 14:03:44 (16276): Enabling VM Network Access.
2020-06-15 14:03:44 (16276): Disabling USB Support for VM.
2020-06-15 14:03:45 (16276): Disabling COM Port Support for VM.
2020-06-15 14:03:45 (16276): Disabling LPT Port Support for VM.
2020-06-15 14:03:46 (16276): Disabling Audio Support for VM.
2020-06-15 14:03:47 (16276): Disabling Clipboard Support for VM.
2020-06-15 14:03:47 (16276): Disabling Drag and Drop Support for VM.
2020-06-15 14:03:47 (16276): Adding storage controller(s) to VM.
2020-06-15 14:03:48 (16276): Adding virtual disk drive to VM. (vm_image.vdi)
2020-06-15 14:03:48 (16276): Adding VirtualBox Guest Additions to VM.
2020-06-15 14:03:48 (16276): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-06-15 14:03:49 (16276): forwarding host port 63690 to guest port 80
2020-06-15 14:03:49 (16276): Enabling remote desktop for VM.
2020-06-15 14:03:50 (16276): Required extension pack not installed, remote desktop not enabled.
2020-06-15 14:03:50 (16276): Enabling shared directory for VM.
2020-06-15 14:03:51 (16276): Starting VM using VBoxManage interface. (boinc_f9290e91f7c6693a, slot#36)
2020-06-15 14:03:57 (16276): Successfully started VM. (PID = '12168')
2020-06-15 14:03:57 (16276): Reporting VM Process ID to BOINC.
2020-06-15 14:03:57 (16276): Guest Log: BIOS: VirtualBox 6.0.14

2020-06-15 14:03:57 (16276): Guest Log: CPUID EDX: 0x178bfbff

2020-06-15 14:03:57 (16276): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-06-15 14:03:57 (16276): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-06-15 14:03:57 (16276): Detected: Web Application Enabled (http://localhost:63690)
2020-06-15 14:03:57 (16276): Preference change detected
2020-06-15 14:03:58 (16276): Setting CPU throttle for VM. (85%)
2020-06-15 14:04:00 (16276): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-06-15 14:04:00 (16276): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-06-15 14:04:00 (16276): Guest Log: BIOS: Booting from Hard Disk...

2020-06-15 14:04:01 (16276): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-06-15 14:04:01 (16276): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-06-15 14:04:42 (16276): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-06-15 14:04:42 (16276): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-06-15 14:04:48 (16276): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-06-15 14:04:48 (16276): Guest Log: 00:00:00.000221 main     Log opened 2020-06-15T04:04:49.615306000Z

2020-06-15 14:04:48 (16276): Guest Log: 00:00:00.000425 main     OS Product: Linux

2020-06-15 14:04:48 (16276): Guest Log: 00:00:00.000518 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-06-15 14:04:48 (16276): Guest Log: 00:00:00.000608 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-06-15 14:04:48 (16276): Guest Log: 00:00:00.000700 main     Executable: /usr/sbin/VBoxService

2020-06-15 14:04:48 (16276): Guest Log: 00:00:00.000702 main     Process ID: 3190

2020-06-15 14:04:48 (16276): Guest Log: 00:00:00.000703 main     Package type: LINUX_64BITS_GENERIC

2020-06-15 14:04:48 (16276): Guest Log: 00:00:00.005526 main     5.2.6 r120293 started. Verbose level = 0

2020-06-15 14:05:56 (16276): Guest Log: 06:05:57 CEST +02:00 2020-06-15: cranky: [INFO] Detected Theory App

2020-06-15 14:05:56 (16276): Guest Log: 06:05:57 CEST +02:00 2020-06-15: cranky: [INFO] Checking CVMFS.

2020-06-15 14:05:59 (16276): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-06-15 14:06:04 (16276): 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-06-15 14:06:04 (16276): Guest Log: 2.5.2.0 4066 0 26192 18228 3 1 263616 4096000 0 65024 0 0 n/a 5 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1

2020-06-15 14:06:07 (16276): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-06-15 14:06:09 (16276): 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-06-15 14:06:09 (16276): Guest Log: 2.5.2.0 4122 0 27552 12483 3 2 263616 4096000 0 65024 0 2 -100 6410 174 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1

2020-06-15 14:06:12 (16276): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-06-15 14:06:17 (16276): 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-06-15 14:06:17 (16276): Guest Log: 2.5.2.0 4044 1 25192 252 3 1 263616 4096000 0 65024 0 0 n/a 4 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-06-15 14:06:20 (16276): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-06-15 14:06:23 (16276): 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-06-15 14:06:23 (16276): Guest Log: 2.5.2.0 4096 1 31840 6798 3 1 263616 4096000 0 65024 0 0 n/a 4128 208 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1

2020-06-15 14:06:23 (16276): Guest Log: 06:06:23 CEST +02:00 2020-06-15: cranky: [INFO] Checking runc.

2020-06-15 14:06:23 (16276): Guest Log: 06:06:23 CEST +02:00 2020-06-15: cranky: [INFO] Creating the filesystem.

2020-06-15 14:06:23 (16276): Guest Log: 06:06:23 CEST +02:00 2020-06-15: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-06-15 14:06:23 (16276): Guest Log: 06:06:24 CEST +02:00 2020-06-15: cranky: [INFO] Updating config.json.

2020-06-15 14:06:23 (16276): Guest Log: 06:06:24 CEST +02:00 2020-06-15: cranky: [INFO] Running Container 'runc'.

2020-06-15 14:06:24 (16276): Guest Log: job: htmld=/shared/html/job

2020-06-15 14:06:24 (16276): Guest Log: job: unpack exitcode=0

2020-06-15 14:06:25 (16276): Guest Log: 06:06:26 CEST +02:00 2020-06-15: cranky: [INFO] ===> [runRivet] Mon Jun 15 04:06:24 UTC 2020 [boinc pp jets 8000 800 - pythia8 8.209 default 100000 16]

2020-06-15 14:08:49 (16276): Stopping VM.
2020-06-15 14:09:35 (16276): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_f9290e91f7c6693a" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...
2020-06-15 14:09:35 (16276): VM did not stop when requested.
2020-06-15 14:09:35 (16276): VM was successfully terminated.
2020-06-21 13:12:20 (9172): Detected: vboxwrapper 26197
2020-06-21 13:12:20 (9172): Detected: BOINC client v7.7
2020-06-21 13:12:20 (9172): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-06-21 13:12:21 (9172): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-06-21 13:12:21 (9172): Starting VM using VBoxManage interface. (boinc_f9290e91f7c6693a, slot#36)
2020-06-21 13:12:27 (9172): Successfully started VM. (PID = '22300')
2020-06-21 13:12:27 (9172): Reporting VM Process ID to BOINC.
2020-06-21 13:12:27 (9172): Guest Log: BIOS: VirtualBox 6.0.14

2020-06-21 13:12:27 (9172): Guest Log: CPUID EDX: 0x178bfbff

2020-06-21 13:12:27 (9172): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-06-21 13:12:27 (9172): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-06-21 13:12:27 (9172): Detected: Web Application Enabled (http://localhost:63690)
2020-06-21 13:12:27 (9172): Preference change detected
2020-06-21 13:12:27 (9172): Setting CPU throttle for VM. (85%)
2020-06-21 13:12:27 (9172): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-06-21 13:12:29 (9172): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-06-21 13:12:29 (9172): Guest Log: BIOS: Booting from Hard Disk...

2020-06-21 13:12:32 (9172): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-06-21 13:12:32 (9172): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-06-21 13:13:24 (9172): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-06-21 13:13:24 (9172): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-06-21 13:13:30 (9172): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-06-21 13:13:30 (9172): Guest Log: 00:00:00.000271 main     Log opened 2020-06-21T03:13:31.241003000Z

2020-06-21 13:13:30 (9172): Guest Log: 00:00:00.000422 main     OS Product: Linux

2020-06-21 13:13:30 (9172): Guest Log: 00:00:00.000487 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-06-21 13:13:30 (9172): Guest Log: 00:00:00.000549 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-06-21 13:13:30 (9172): Guest Log: 00:00:00.000609 main     Executable: /usr/sbin/VBoxService

2020-06-21 13:13:30 (9172): Guest Log: 00:00:00.000611 main     Process ID: 3180

2020-06-21 13:13:30 (9172): Guest Log: 00:00:00.000612 main     Package type: LINUX_64BITS_GENERIC

2020-06-21 13:13:30 (9172): Guest Log: 00:00:00.067852 main     5.2.6 r120293 started. Verbose level = 0

2020-06-21 13:14:26 (9172): Guest Log: 05:14:27 CEST +02:00 2020-06-21: cranky: [INFO] Detected Theory App

2020-06-21 13:14:26 (9172): Guest Log: 05:14:27 CEST +02:00 2020-06-21: cranky: [INFO] Checking CVMFS.

2020-06-21 13:14:29 (9172): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-06-21 13:14:30 (9172): 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-06-21 13:14:30 (9172): Guest Log: 2.5.2.0 4051 0 26184 18306 3 1 294015 4096001 0 65024 0 0 n/a 5 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1

2020-06-21 13:14:32 (9172): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-06-21 13:14:33 (9172): 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-06-21 13:14:33 (9172): Guest Log: 2.5.2.0 4097 0 27412 12529 3 2 294015 4096001 0 65024 0 2 0 4273 304 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1

2020-06-21 13:14:36 (9172): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-06-21 13:14:40 (9172): 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-06-21 13:14:40 (9172): Guest Log: 2.5.2.0 4072 0 27232 255 3 1 294015 4096001 0 65024 0 0 n/a 4 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-06-21 13:14:42 (9172): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-06-21 13:14:46 (9172): 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-06-21 13:14:46 (9172): Guest Log: 2.5.2.0 4117 0 32292 6843 3 1 294015 4096001 0 65024 0 0 n/a 4151 278 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-06-21 13:14:46 (9172): Guest Log: 05:14:47 CEST +02:00 2020-06-21: cranky: [INFO] Checking runc.

2020-06-21 13:14:46 (9172): Guest Log: 05:14:47 CEST +02:00 2020-06-21: cranky: [INFO] Creating the filesystem.

2020-06-21 13:14:46 (9172): Guest Log: 05:14:47 CEST +02:00 2020-06-21: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-06-21 13:14:46 (9172): Guest Log: 05:14:47 CEST +02:00 2020-06-21: cranky: [INFO] Updating config.json.

2020-06-21 13:14:46 (9172): Guest Log: 05:14:47 CEST +02:00 2020-06-21: cranky: [INFO] Running Container 'runc'.

2020-06-21 13:14:47 (9172): Guest Log: job: htmld=/shared/html/job

2020-06-21 13:14:47 (9172): Guest Log: job: unpack exitcode=0

2020-06-21 13:14:48 (9172): Guest Log: 05:14:49 CEST +02:00 2020-06-21: cranky: [INFO] ===> [runRivet] Sun Jun 21 03:14:48 UTC 2020 [boinc pp jets 8000 800 - pythia8 8.209 default 100000 16]

2020-06-21 14:48:36 (9172): Status Report: Job Duration: '864000.000000'
2020-06-21 14:48:36 (9172): Status Report: Elapsed Time: '6000.000830'
2020-06-21 14:48:36 (9172): Status Report: CPU Time: '4713.937500'
2020-06-21 16:29:34 (9172): Status Report: Job Duration: '864000.000000'
2020-06-21 16:29:34 (9172): Status Report: Elapsed Time: '12000.180134'
2020-06-21 16:29:34 (9172): Status Report: CPU Time: '10115.234375'
2020-06-21 16:49:00 (9172): Guest Log: job: run exitcode=0

2020-06-21 16:49:00 (9172): Guest Log: job: diskusage=2304

2020-06-21 16:49:00 (9172): Guest Log: job: logsize=64 k

2020-06-21 16:49:00 (9172): Guest Log: job: times=

2020-06-21 16:49:00 (9172): Guest Log: 0m0.012s 0m0.026s

2020-06-21 16:49:00 (9172): Guest Log: 201m1.198s 2m6.777s

2020-06-21 16:49:00 (9172): Guest Log: job: cpuusage=12188

2020-06-21 16:49:00 (9172): Guest Log: 08:49:00 CEST +02:00 2020-06-21: cranky: [INFO] Container 'runc' finished with status code 0.

2020-06-21 16:49:00 (9172): Guest Log: 08:49:00 CEST +02:00 2020-06-21: cranky: [INFO] Preparing output.

2020-06-21 16:49:00 (9172): Guest Log: [INFO] Job Finished

2020-06-21 16:49:00 (9172): Guest Log: [INFO] Shutting Down.

2020-06-21 16:49:00 (9172): VM Completion File Detected.
2020-06-21 16:49:00 (9172): VM Completion Message: Job Finished
.
2020-06-21 16:49:00 (9172): Powering off VM.
2020-06-21 16:54:02 (9172): VM did not power off when requested.
2020-06-21 16:54:02 (9172): VM was successfully terminated.
2020-06-21 16:54:02 (9172): Deregistering VM. (boinc_f9290e91f7c6693a, slot#36)
2020-06-21 16:54:02 (9172): Removing network bandwidth throttle group from VM.
2020-06-21 16:54:02 (9172): Removing VM from VirtualBox.
16:54:08 (9172): called boinc_finish(0)

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

Stderr output
