Task 2785338

Name	Theory_2279-803782-68_0
Workunit	1903993
Created	10 Jun 2019, 18:00:08 UTC
Sent	11 Jun 2019, 8:47:01 UTC
Report deadline	21 Jun 2019, 8:47:01 UTC
Received	11 Jun 2019, 20:48:53 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	3809
Run time	7 hours 40 min 3 sec
CPU time	7 hours 38 min 10 sec
Validate state	Valid
Credit	291.82
Device peak FLOPS	4.57 GFLOPS
Application version	Theory Simulation v4.16 (vbox64_mt_mcore) windows_x86_64
Peak working set size	70.27 MB
Peak swap size	79.37 MB
Peak disk usage	1.57 GB
Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-06-11 12:41:15 (1760): Detected: vboxwrapper 26197
2019-06-11 12:41:15 (1760): Detected: BOINC client v7.7
2019-06-11 12:41:15 (1760): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-06-11 12:41:15 (1760): Successfully copied 'init_data.xml' to the shared directory.
2019-06-11 12:41:15 (1760): Successfully copied 'cranky' to the shared directory.
2019-06-11 12:41:15 (1760): Successfully copied 'input' to the shared directory.
2019-06-11 12:41:16 (1760): Create VM. (boinc_f48a12e7b0b5a582, slot#0)
2019-06-11 12:41:17 (1760): Setting Memory Size for VM. (730MB)
2019-06-11 12:41:18 (1760): Setting CPU Count for VM. (1)
2019-06-11 12:41:18 (1760): Setting Chipset Options for VM.
2019-06-11 12:41:19 (1760): Setting Boot Options for VM.
2019-06-11 12:41:20 (1760): Setting Network Configuration for NAT.
2019-06-11 12:41:21 (1760): Enabling VM Network Access.
2019-06-11 12:41:21 (1760): Disabling USB Support for VM.
2019-06-11 12:41:22 (1760): Disabling COM Port Support for VM.
2019-06-11 12:41:22 (1760): Disabling LPT Port Support for VM.
2019-06-11 12:41:22 (1760): Disabling Audio Support for VM.
2019-06-11 12:41:25 (1760): Disabling Clipboard Support for VM.
2019-06-11 12:41:25 (1760): Disabling Drag and Drop Support for VM.
2019-06-11 12:41:26 (1760): Adding storage controller(s) to VM.
2019-06-11 12:41:26 (1760): Adding virtual disk drive to VM. (vm_image.vdi)
2019-06-11 12:41:26 (1760): Adding VirtualBox Guest Additions to VM.
2019-06-11 12:41:26 (1760): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-06-11 12:41:27 (1760): forwarding host port 59981 to guest port 80
2019-06-11 12:41:27 (1760): Enabling remote desktop for VM.
2019-06-11 12:41:28 (1760): Enabling shared directory for VM.
2019-06-11 12:41:29 (1760): Starting VM using VBoxManage interface. (boinc_f48a12e7b0b5a582, slot#0)
2019-06-11 12:41:33 (1760): Successfully started VM. (PID = '2152')
2019-06-11 12:41:33 (1760): Reporting VM Process ID to BOINC.
2019-06-11 12:41:33 (1760): Guest Log: BIOS: VirtualBox 5.2.8

2019-06-11 12:41:33 (1760): Guest Log: CPUID EDX: 0x078bfbff

2019-06-11 12:41:33 (1760): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-06-11 12:41:33 (1760): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-06-11 12:41:33 (1760): Detected: Web Application Enabled (http://localhost:59981)
2019-06-11 12:41:33 (1760): Detected: Remote Desktop Enabled (localhost:59982)
2019-06-11 12:41:33 (1760): Preference change detected
2019-06-11 12:41:33 (1760): Setting CPU throttle for VM. (100%)
2019-06-11 12:41:33 (1760): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds))
2019-06-11 12:41:35 (1760): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-06-11 12:41:35 (1760): Guest Log: BIOS: Booting from Hard Disk...

2019-06-11 12:41:37 (1760): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-06-11 12:41:37 (1760): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-06-11 12:41:54 (1760): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-06-11 12:41:54 (1760): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-06-11 12:41:56 (1760): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-06-11 12:41:56 (1760): Guest Log: 00:00:00.000098 main     Log opened 2019-06-11T10:40:47.180257000Z

2019-06-11 12:41:56 (1760): Guest Log: 00:00:00.000218 main     OS Product: Linux

2019-06-11 12:41:56 (1760): Guest Log: 00:00:00.000258 main     OS Release: 4.14.76-13.cernvm.x86_64

2019-06-11 12:41:56 (1760): Guest Log: 00:00:00.000290 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2019-06-11 12:41:56 (1760): Guest Log: 00:00:00.000353 main     Executable: /usr/sbin/VBoxService

2019-06-11 12:41:56 (1760): Guest Log: 00:00:00.000354 main     Process ID: 3197

2019-06-11 12:41:56 (1760): Guest Log: 00:00:00.000354 main     Package type: LINUX_64BITS_GENERIC

2019-06-11 12:41:56 (1760): Guest Log: 00:00:00.005652 main     5.2.6 r120293 started. Verbose level = 0

2019-06-11 12:42:06 (1760): Guest Log: 00:00:10.014270 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 679 252 751 000ns (GuestNow=1 560 253 326 446 062 000 ns GuestLast=1 560 249 647 193 311 000 ns fSetTimeLastLoop=true )

2019-06-11 12:42:07 (1760): Guest Log: 11:42:07 2019-06-11: cranky: [INFO] Detected Theory App

2019-06-11 12:42:07 (1760): Guest Log: 11:42:07 2019-06-11: cranky: [INFO] Checking CVMFS.

2019-06-11 12:42:12 (1760): Guest Log: 11:42:12 2019-06-11: cranky: [INFO] Checking runc.

2019-06-11 12:42:12 (1760): Guest Log: 11:42:12 2019-06-11: cranky: [INFO] Creating the filesystem.

2019-06-11 12:42:12 (1760): Guest Log: 11:42:12 2019-06-11: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2019-06-11 12:42:12 (1760): Guest Log: 11:42:12 2019-06-11: cranky: [INFO] Updating config.json.

2019-06-11 12:42:13 (1760): Guest Log: 11:42:12 2019-06-11: cranky: [INFO] Running Container 'runc'.

2019-06-11 14:13:53 (1760): Stopping VM.
2019-06-11 14:13:53 (1760): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_f48a12e7b0b5a582" savestate
Output:

2019-06-11 14:13:53 (1760): VM did not stop when requested.
2019-06-11 14:13:53 (1760): VM was successfully terminated.
2019-06-11 14:33:55 (1648): Detected: vboxwrapper 26197
2019-06-11 14:33:55 (1648): Detected: BOINC client v7.7
2019-06-11 14:33:55 (1648): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-06-11 14:33:56 (1648): Starting VM using VBoxManage interface. (boinc_f48a12e7b0b5a582, slot#0)
2019-06-11 14:34:00 (1648): Successfully started VM. (PID = '4880')
2019-06-11 14:34:00 (1648): Reporting VM Process ID to BOINC.
2019-06-11 14:34:00 (1648): Guest Log: BIOS: VirtualBox 5.2.8

2019-06-11 14:34:00 (1648): Guest Log: CPUID EDX: 0x078bfbff

2019-06-11 14:34:00 (1648): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-06-11 14:34:00 (1648): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-06-11 14:34:00 (1648): Detected: Web Application Enabled (http://localhost:59981)
2019-06-11 14:34:00 (1648): Detected: Remote Desktop Enabled (localhost:59982)
2019-06-11 14:34:00 (1648): Preference change detected
2019-06-11 14:34:00 (1648): Setting CPU throttle for VM. (100%)
2019-06-11 14:34:00 (1648): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds))
2019-06-11 14:34:02 (1648): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-06-11 14:34:02 (1648): Guest Log: BIOS: Booting from Hard Disk...

2019-06-11 14:34:04 (1648): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-06-11 14:34:04 (1648): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-06-11 14:34:20 (1648): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-06-11 14:34:20 (1648): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-06-11 14:34:23 (1648): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-06-11 14:34:23 (1648): Guest Log: 00:00:00.000087 main     Log opened 2019-06-11T12:33:12.293562000Z

2019-06-11 14:34:23 (1648): Guest Log: 00:00:00.000189 main     OS Product: Linux

2019-06-11 14:34:23 (1648): Guest Log: 00:00:00.000232 main     OS Release: 4.14.76-13.cernvm.x86_64

2019-06-11 14:34:23 (1648): Guest Log: 00:00:00.000271 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2019-06-11 14:34:23 (1648): Guest Log: 00:00:00.000309 main     Executable: /usr/sbin/VBoxService

2019-06-11 14:34:23 (1648): Guest Log: 00:00:00.000310 main     Process ID: 3194

2019-06-11 14:34:23 (1648): Guest Log: 00:00:00.000310 main     Package type: LINUX_64BITS_GENERIC

2019-06-11 14:34:23 (1648): Guest Log: 00:00:00.006712 main     5.2.6 r120293 started. Verbose level = 0

2019-06-11 14:34:32 (1648): Guest Log: 13:34:31 2019-06-11: cranky: [INFO] Detected Theory App

2019-06-11 14:34:32 (1648): Guest Log: 13:34:31 2019-06-11: cranky: [INFO] Checking CVMFS.

2019-06-11 14:34:33 (1648): Guest Log: 00:00:10.016497 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 680 209 096 000ns (GuestNow=1 560 260 072 517 004 000 ns GuestLast=1 560 256 392 307 908 000 ns fSetTimeLastLoop=true )

2019-06-11 14:34:36 (1648): Guest Log: 13:34:35 2019-06-11: cranky: [INFO] Checking runc.

2019-06-11 14:34:36 (1648): Guest Log: 13:34:35 2019-06-11: cranky: [INFO] Creating the filesystem.

2019-06-11 14:34:36 (1648): Guest Log: 13:34:35 2019-06-11: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2019-06-11 14:34:36 (1648): Guest Log: 13:34:35 2019-06-11: cranky: [INFO] Updating config.json.

2019-06-11 14:34:36 (1648): Guest Log: 13:34:36 2019-06-11: cranky: [INFO] Running Container 'runc'.

2019-06-11 14:43:12 (1648): Status Report: Job Duration: '64800.000000'
2019-06-11 14:43:12 (1648): Status Report: Elapsed Time: '6000.000000'
2019-06-11 14:43:12 (1648): Status Report: CPU Time: '5965.656250'
2019-06-11 16:14:57 (1648): Stopping VM.
2019-06-11 16:18:59 (2788): Detected: vboxwrapper 26197
2019-06-11 16:18:59 (2788): Detected: BOINC client v7.7
2019-06-11 16:18:59 (2788): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-06-11 16:19:00 (2788): Starting VM using VBoxManage interface. (boinc_f48a12e7b0b5a582, slot#0)
2019-06-11 16:19:08 (2788): Successfully started VM. (PID = '6852')
2019-06-11 16:19:08 (2788): Reporting VM Process ID to BOINC.
2019-06-11 16:19:08 (2788): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-06-11 16:19:08 (2788): Detected: Web Application Enabled (http://localhost:59981)
2019-06-11 16:19:08 (2788): Detected: Remote Desktop Enabled (localhost:59982)
2019-06-11 16:19:08 (2788): Status Report: Job Duration: '64800.000000'
2019-06-11 16:19:08 (2788): Status Report: Elapsed Time: '11432.000000'
2019-06-11 16:19:08 (2788): Status Report: CPU Time: '11461.156250'
2019-06-11 16:19:08 (2788): Preference change detected
2019-06-11 16:19:08 (2788): Setting CPU throttle for VM. (100%)
2019-06-11 16:19:08 (2788): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds))
2019-06-11 16:20:32 (2788): Stopping VM.
2019-06-11 16:20:32 (2788): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_f48a12e7b0b5a582" savestate
Output:

2019-06-11 16:20:32 (2788): VM did not stop when requested.
2019-06-11 16:20:32 (2788): VM was successfully terminated.
2019-06-11 18:15:59 (1368): Detected: vboxwrapper 26197
2019-06-11 18:15:59 (1368): Detected: BOINC client v7.7
2019-06-11 18:16:00 (1368): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-06-11 18:16:00 (1368): Starting VM using VBoxManage interface. (boinc_f48a12e7b0b5a582, slot#0)
2019-06-11 18:16:04 (1368): Successfully started VM. (PID = '7940')
2019-06-11 18:16:04 (1368): Reporting VM Process ID to BOINC.
2019-06-11 18:16:04 (1368): Guest Log: BIOS: VirtualBox 5.2.8

2019-06-11 18:16:04 (1368): Guest Log: CPUID EDX: 0x078bfbff

2019-06-11 18:16:04 (1368): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-06-11 18:16:04 (1368): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-06-11 18:16:04 (1368): Detected: Web Application Enabled (http://localhost:59981)
2019-06-11 18:16:04 (1368): Detected: Remote Desktop Enabled (localhost:59982)
2019-06-11 18:16:04 (1368): Status Report: Job Duration: '64800.000000'
2019-06-11 18:16:04 (1368): Status Report: Elapsed Time: '11513.000000'
2019-06-11 18:16:04 (1368): Status Report: CPU Time: '11547.156250'
2019-06-11 18:16:04 (1368): Preference change detected
2019-06-11 18:16:04 (1368): Setting CPU throttle for VM. (100%)
2019-06-11 18:16:04 (1368): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds))
2019-06-11 18:16:06 (1368): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-06-11 18:16:06 (1368): Guest Log: BIOS: Booting from Hard Disk...

2019-06-11 18:16:08 (1368): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-06-11 18:16:08 (1368): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-06-11 18:16:30 (1368): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-06-11 18:16:30 (1368): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-06-11 18:16:32 (1368): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-06-11 18:16:32 (1368): Guest Log: 00:00:00.000089 main     Log opened 2019-06-11T17:16:37.479346000Z

2019-06-11 18:16:32 (1368): Guest Log: 00:00:00.000206 main     OS Product: Linux

2019-06-11 18:16:32 (1368): Guest Log: 00:00:00.000243 main     OS Release: 4.14.76-13.cernvm.x86_64

2019-06-11 18:16:32 (1368): Guest Log: 00:00:00.000286 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2019-06-11 18:16:32 (1368): Guest Log: 00:00:00.000316 main     Executable: /usr/sbin/VBoxService

2019-06-11 18:16:32 (1368): Guest Log: 00:00:00.000317 main     Process ID: 3191

2019-06-11 18:16:32 (1368): Guest Log: 00:00:00.000317 main     Package type: LINUX_64BITS_GENERIC

2019-06-11 18:16:32 (1368): Guest Log: 00:00:00.006215 main     5.2.6 r120293 started. Verbose level = 0

2019-06-11 18:16:43 (1368): Guest Log: 17:16:48 2019-06-11: cranky: [INFO] Detected Theory App

2019-06-11 18:16:43 (1368): Guest Log: 17:16:48 2019-06-11: cranky: [INFO] Checking CVMFS.

2019-06-11 18:16:48 (1368): Guest Log: 17:16:53 2019-06-11: cranky: [INFO] Checking runc.

2019-06-11 18:16:48 (1368): Guest Log: 17:16:53 2019-06-11: cranky: [INFO] Creating the filesystem.

2019-06-11 18:16:48 (1368): Guest Log: 17:16:53 2019-06-11: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2019-06-11 18:16:48 (1368): Guest Log: 17:16:53 2019-06-11: cranky: [INFO] Updating config.json.

2019-06-11 18:16:48 (1368): Guest Log: 17:16:53 2019-06-11: cranky: [INFO] Running Container 'runc'.

2019-06-11 19:58:49 (1368): Status Report: Job Duration: '64800.000000'
2019-06-11 19:58:49 (1368): Status Report: Elapsed Time: '17513.585501'
2019-06-11 19:58:49 (1368): Status Report: CPU Time: '17631.703125'
2019-06-11 21:40:53 (1368): Status Report: Job Duration: '64800.000000'
2019-06-11 21:40:53 (1368): Status Report: Elapsed Time: '23513.585501'
2019-06-11 21:40:53 (1368): Status Report: CPU Time: '23704.656250'
2019-06-11 22:44:43 (1368): Guest Log: ===> [runRivet] Tue Jun 11 17:16:53 UTC 2019 [boinc pp z1j 7000 150 - pythia8 8.235 tune-AU2 96000 68]

2019-06-11 22:44:43 (1368): Guest Log: 21:44:42 2019-06-11: cranky: [INFO] Preparing output.

2019-06-11 22:44:43 (1368): VM Completion File Detected.
2019-06-11 22:44:43 (1368): Powering off VM.
2019-06-11 22:49:43 (1368): VM did not power off when requested.
2019-06-11 22:49:43 (1368): VM was successfully terminated.
2019-06-11 22:49:43 (1368): Deregistering VM. (boinc_f48a12e7b0b5a582, slot#0)
2019-06-11 22:49:43 (1368): Removing network bandwidth throttle group from VM.
2019-06-11 22:49:44 (1368): Removing VM from VirtualBox.
22:49:49 (1368): called boinc_finish(0)

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

Stderr output
