Stderr output

<core_client_version>7.16.5</core_client_version>
<![CDATA[
<stderr_txt>
2020-05-26 15:47:40 (16080): Detected: vboxwrapper 26197
2020-05-26 15:47:40 (16080): Detected: BOINC client v7.7
2020-05-26 15:47:40 (16080): Detected: VirtualBox VboxManage Interface (Version: 6.0.20)
2020-05-26 15:47:40 (16080): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-26 15:47:40 (16080): Successfully copied 'init_data.xml' to the shared directory.
2020-05-26 15:47:40 (16080): Successfully copied 'input' to the shared directory.
2020-05-26 15:47:42 (16080): Create VM. (boinc_a4c397a8cd9cd833, slot#3)
2020-05-26 15:47:43 (16080): Setting Memory Size for VM. (630MB)
2020-05-26 15:47:43 (16080): Setting CPU Count for VM. (1)
2020-05-26 15:47:43 (16080): Setting Chipset Options for VM.
2020-05-26 15:47:43 (16080): Setting Boot Options for VM.
2020-05-26 15:47:44 (16080): Setting Network Configuration for NAT.
2020-05-26 15:47:44 (16080): Enabling VM Network Access.
2020-05-26 15:47:44 (16080): Disabling USB Support for VM.
2020-05-26 15:47:44 (16080): Disabling COM Port Support for VM.
2020-05-26 15:47:45 (16080): Disabling LPT Port Support for VM.
2020-05-26 15:47:45 (16080): Disabling Audio Support for VM.
2020-05-26 15:47:45 (16080): Disabling Clipboard Support for VM.
2020-05-26 15:47:45 (16080): Disabling Drag and Drop Support for VM.
2020-05-26 15:47:46 (16080): Adding storage controller(s) to VM.
2020-05-26 15:47:46 (16080): Adding virtual disk drive to VM. (vm_image.vdi)
2020-05-26 15:47:46 (16080): Adding VirtualBox Guest Additions to VM.
2020-05-26 15:47:47 (16080): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-05-26 15:47:47 (16080): forwarding host port 54488 to guest port 80
2020-05-26 15:47:47 (16080): Enabling remote desktop for VM.
2020-05-26 15:47:48 (16080): Enabling shared directory for VM.
2020-05-26 15:47:48 (16080): Starting VM using VBoxManage interface. (boinc_a4c397a8cd9cd833, slot#3)
2020-05-26 15:47:52 (16080): Successfully started VM. (PID = '6968')
2020-05-26 15:47:52 (16080): Reporting VM Process ID to BOINC.
2020-05-26 15:47:52 (16080): Guest Log: BIOS: VirtualBox 6.0.20

2020-05-26 15:47:52 (16080): Guest Log: CPUID EDX: 0x178bfbff

2020-05-26 15:47:52 (16080): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-05-26 15:47:52 (16080): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-05-26 15:47:52 (16080): Detected: Web Application Enabled (http://localhost:54488)
2020-05-26 15:47:52 (16080): Detected: Remote Desktop Enabled (localhost:54489)
2020-05-26 15:47:52 (16080): Preference change detected
2020-05-26 15:47:52 (16080): Setting CPU throttle for VM. (100%)
2020-05-26 15:47:52 (16080): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-26 15:47:54 (16080): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-05-26 15:47:54 (16080): Guest Log: BIOS: Booting from Hard Disk...

2020-05-26 15:47:56 (16080): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-05-26 15:47:56 (16080): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-05-26 15:48:17 (16080): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-05-26 15:48:17 (16080): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-05-26 15:48:20 (16080): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-05-26 15:48:20 (16080): Guest Log: 00:00:00.000125 main     Log opened 2020-05-26T13:48:22.958129000Z

2020-05-26 15:48:20 (16080): Guest Log: 00:00:00.000214 main     OS Product: Linux

2020-05-26 15:48:20 (16080): Guest Log: 00:00:00.000266 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-05-26 15:48:20 (16080): Guest Log: 00:00:00.000300 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-05-26 15:48:20 (16080): Guest Log: 00:00:00.000348 main     Executable: /usr/sbin/VBoxService

2020-05-26 15:48:20 (16080): Guest Log: 00:00:00.000349 main     Process ID: 3191

2020-05-26 15:48:20 (16080): Guest Log: 00:00:00.000351 main     Package type: LINUX_64BITS_GENERIC

2020-05-26 15:48:20 (16080): Guest Log: 00:00:00.003778 main     5.2.6 r120293 started. Verbose level = 0

2020-05-26 15:49:07 (16080): Guest Log: 15:49:09 CEST +02:00 2020-05-26: cranky: [INFO] Detected Theory App

2020-05-26 15:49:07 (16080): Guest Log: 15:49:09 CEST +02:00 2020-05-26: cranky: [INFO] Checking CVMFS.

2020-05-26 15:49:08 (16080): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-05-26 15:49:08 (16080): 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-05-26 15:49:08 (16080): Guest Log: 2.5.2.0 4027 0 28376 18089 3 1 263483 4096000 0 65024 0 0 n/a 5 7 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-05-26 15:49:09 (16080): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-05-26 15:49:10 (16080): 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-05-26 15:49:10 (16080): Guest Log: 2.5.2.0 4106 0 27508 12327 3 2 263483 4096000 0 65024 0 2 -100 6411 281 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-05-26 15:49:11 (16080): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-05-26 15:49:12 (16080): 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-05-26 15:49:12 (16080): Guest Log: 2.5.2.0 4049 0 27232 249 3 1 263483 4096000 0 65024 0 0 n/a 4 4 http://s1fnal-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-05-26 15:49:13 (16080): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-05-26 15:49:13 (16080): 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-05-26 15:49:13 (16080): Guest Log: 2.5.2.0 4080 0 29640 6668 3 1 263483 4096000 0 65024 0 0 n/a 4071 245 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-05-26 15:49:13 (16080): Guest Log: 15:49:16 CEST +02:00 2020-05-26: cranky: [INFO] Checking runc.

2020-05-26 15:49:14 (16080): Guest Log: 15:49:16 CEST +02:00 2020-05-26: cranky: [INFO] Creating the filesystem.

2020-05-26 15:49:14 (16080): Guest Log: 15:49:16 CEST +02:00 2020-05-26: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-05-26 15:49:14 (16080): Guest Log: 15:49:16 CEST +02:00 2020-05-26: cranky: [INFO] Updating config.json.

2020-05-26 15:49:14 (16080): Guest Log: 15:49:16 CEST +02:00 2020-05-26: cranky: [INFO] Running Container 'runc'.

2020-05-26 15:49:14 (16080): Guest Log: job: htmld=/shared/html/job

2020-05-26 15:49:14 (16080): Guest Log: job: unpack exitcode=0

2020-05-26 15:49:16 (16080): Guest Log: 15:49:19 CEST +02:00 2020-05-26: cranky: [INFO] ===> [runRivet] Tue May 26 13:49:17 UTC 2020 [boinc pp zinclusive 7000 -,-,50,130 - pythia8 8.235 tune-AU2ct10 100000 12]

2020-05-26 16:23:55 (16080): Stopping VM.
2020-05-27 08:16:46 (12380): Detected: vboxwrapper 26197
2020-05-27 08:16:46 (12380): Detected: BOINC client v7.7
2020-05-27 08:16:47 (12380): Detected: VirtualBox VboxManage Interface (Version: 6.0.20)
2020-05-27 08:16:47 (12380): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-27 08:16:48 (12380): Starting VM using VBoxManage interface. (boinc_a4c397a8cd9cd833, slot#3)
2020-05-27 08:16:55 (12380): Successfully started VM. (PID = '7220')
2020-05-27 08:16:55 (12380): Reporting VM Process ID to BOINC.
2020-05-27 08:16:55 (12380): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-05-27 08:16:55 (12380): Detected: Web Application Enabled (http://localhost:54488)
2020-05-27 08:16:55 (12380): Detected: Remote Desktop Enabled (localhost:54489)
2020-05-27 08:16:55 (12380): Preference change detected
2020-05-27 08:16:55 (12380): Setting CPU throttle for VM. (100%)
2020-05-27 08:16:55 (12380): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-27 08:17:00 (12380): Guest Log: 00:35:40.614503 timesync vgsvcTimeSyncWorker: Radical host time change: 57 188 394 000 000ns (HostNow=1 590 560 219 573 000 000 ns HostLast=1 590 503 031 179 000 000 ns)

2020-05-27 08:17:10 (12380): Guest Log: 00:35:50.619086 timesync vgsvcTimeSyncWorker: Radical guest time change: 57 186 054 199 000ns (GuestNow=1 590 560 229 601 929 000 ns GuestLast=1 590 503 043 547 730 000 ns fSetTimeLastLoop=true )

2020-05-27 09:21:03 (12380): Status Report: Job Duration: '864000.000000'
2020-05-27 09:21:03 (12380): Status Report: Elapsed Time: '6000.997553'
2020-05-27 09:21:03 (12380): Status Report: CPU Time: '5290.187500'
2020-05-27 11:01:09 (12380): Status Report: Job Duration: '864000.000000'
2020-05-27 11:01:09 (12380): Status Report: Elapsed Time: '12000.997553'
2020-05-27 11:01:09 (12380): Status Report: CPU Time: '11277.703125'
2020-05-27 12:41:17 (12380): Status Report: Job Duration: '864000.000000'
2020-05-27 12:41:17 (12380): Status Report: Elapsed Time: '18000.997553'
2020-05-27 12:41:17 (12380): Status Report: CPU Time: '17258.375000'
2020-05-27 12:52:34 (12380): Stopping VM.
2020-05-27 18:48:39 (9296): Detected: vboxwrapper 26197
2020-05-27 18:48:39 (9296): Detected: BOINC client v7.7
2020-05-27 18:48:40 (9296): Detected: VirtualBox VboxManage Interface (Version: 6.0.20)
2020-05-27 18:48:40 (9296): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-27 18:48:41 (9296): Starting VM using VBoxManage interface. (boinc_a4c397a8cd9cd833, slot#3)
2020-05-27 18:48:47 (9296): Successfully started VM. (PID = '15956')
2020-05-27 18:48:47 (9296): Reporting VM Process ID to BOINC.
2020-05-27 18:48:47 (9296): Guest Log: 05:11:16.723856 timesync vgsvcTimeSyncWorker: Radical host time change: 21 381 389 000 000ns (HostNow=1 590 598 127 095 000 000 ns HostLast=1 590 576 745 706 000 000 ns)

2020-05-27 18:48:47 (9296): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-05-27 18:48:47 (9296): Detected: Web Application Enabled (http://localhost:54488)
2020-05-27 18:48:47 (9296): Detected: Remote Desktop Enabled (localhost:54489)
2020-05-27 18:48:47 (9296): Status Report: Job Duration: '864000.000000'
2020-05-27 18:48:47 (9296): Status Report: Elapsed Time: '18677.997553'
2020-05-27 18:48:47 (9296): Status Report: CPU Time: '17927.671875'
2020-05-27 18:48:47 (9296): Preference change detected
2020-05-27 18:48:47 (9296): Setting CPU throttle for VM. (100%)
2020-05-27 18:48:47 (9296): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-27 18:48:57 (9296): Guest Log: 05:11:26.736523 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 381 400 619 000ns (GuestNow=1 590 598 137 107 678 000 ns GuestLast=1 590 576 755 707 059 000 ns fSetTimeLastLoop=true )

2020-05-27 20:28:54 (9296): Status Report: Job Duration: '864000.000000'
2020-05-27 20:28:54 (9296): Status Report: Elapsed Time: '24677.997553'
2020-05-27 20:28:54 (9296): Status Report: CPU Time: '23926.156250'
2020-05-27 20:41:51 (9296): Stopping VM.
2020-05-27 20:41:54 (9296): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_a4c397a8cd9cd833" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...
2020-05-27 20:41:54 (9296): VM did not stop when requested.
2020-05-27 20:41:54 (9296): VM was successfully terminated.
2020-05-28 08:02:37 (9996): Detected: vboxwrapper 26197
2020-05-28 08:02:37 (9996): Detected: BOINC client v7.7
2020-05-28 08:04:10 (9996): Detected: VirtualBox VboxManage Interface (Version: 6.0.20)
2020-05-28 08:04:10 (9996): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-28 08:04:10 (9996): Starting VM using VBoxManage interface. (boinc_a4c397a8cd9cd833, slot#3)
2020-05-28 08:04:16 (9996): Successfully started VM. (PID = '9716')
2020-05-28 08:04:16 (9996): Reporting VM Process ID to BOINC.
2020-05-28 08:04:16 (9996): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-05-28 08:04:16 (9996): Detected: Web Application Enabled (http://localhost:54488)
2020-05-28 08:04:16 (9996): Detected: Remote Desktop Enabled (localhost:54489)
2020-05-28 08:04:16 (9996): Status Report: Job Duration: '864000.000000'
2020-05-28 08:04:16 (9996): Status Report: Elapsed Time: '25453.997553'
2020-05-28 08:04:16 (9996): Status Report: CPU Time: '24693.375000'
2020-05-28 08:04:16 (9996): Preference change detected
2020-05-28 08:04:16 (9996): Setting CPU throttle for VM. (100%)
2020-05-28 08:04:16 (9996): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-28 08:04:24 (9996): Guest Log: 07:04:29.221990 timesync vgsvcTimeSyncWorker: Radical host time change: 40 954 114 000 000ns (HostNow=1 590 645 863 675 000 000 ns HostLast=1 590 604 909 561 000 000 ns)

2020-05-28 08:04:34 (9996): Guest Log: 07:04:39.222583 timesync vgsvcTimeSyncWorker: Radical guest time change: 40 954 127 560 000ns (GuestNow=1 590 645 873 698 139 000 ns GuestLast=1 590 604 919 570 579 000 ns fSetTimeLastLoop=true )

2020-05-28 09:44:25 (9996): Status Report: Job Duration: '864000.000000'
2020-05-28 09:44:25 (9996): Status Report: Elapsed Time: '31453.997553'
2020-05-28 09:44:25 (9996): Status Report: CPU Time: '30608.062500'
2020-05-28 11:24:33 (9996): Status Report: Job Duration: '864000.000000'
2020-05-28 11:24:33 (9996): Status Report: Elapsed Time: '37453.997553'
2020-05-28 11:24:33 (9996): Status Report: CPU Time: '36521.093750'
2020-05-28 13:04:41 (9996): Status Report: Job Duration: '864000.000000'
2020-05-28 13:04:41 (9996): Status Report: Elapsed Time: '43453.997553'
2020-05-28 13:04:41 (9996): Status Report: CPU Time: '42451.656250'
2020-05-28 14:44:50 (9996): Status Report: Job Duration: '864000.000000'
2020-05-28 14:44:50 (9996): Status Report: Elapsed Time: '49453.997553'
2020-05-28 14:44:50 (9996): Status Report: CPU Time: '48399.187500'
2020-05-28 15:54:35 (9996): Stopping VM.
2020-05-28 15:54:35 (9996): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_a4c397a8cd9cd833" savestate
Output:

2020-05-28 15:54:35 (9996): VM did not stop when requested.
2020-05-28 15:54:35 (9996): VM was successfully terminated.
2020-05-29 08:09:56 (4776): Detected: vboxwrapper 26197
2020-05-29 08:09:56 (4776): Detected: BOINC client v7.7
2020-05-29 08:09:59 (4776): Detected: VirtualBox VboxManage Interface (Version: 6.0.20)
2020-05-29 08:09:59 (4776): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-29 08:09:59 (4776): Starting VM using VBoxManage interface. (boinc_a4c397a8cd9cd833, slot#3)
2020-05-29 08:10:04 (4776): Successfully started VM. (PID = '14208')
2020-05-29 08:10:04 (4776): Reporting VM Process ID to BOINC.
2020-05-29 08:10:04 (4776): Guest Log: BIOS: VirtualBox 6.0.20

2020-05-29 08:10:04 (4776): Guest Log: CPUID EDX: 0x178bfbff

2020-05-29 08:10:04 (4776): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-05-29 08:10:04 (4776): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-05-29 08:10:04 (4776): Detected: Web Application Enabled (http://localhost:54488)
2020-05-29 08:10:04 (4776): Detected: Remote Desktop Enabled (localhost:54489)
2020-05-29 08:10:04 (4776): Status Report: Job Duration: '864000.000000'
2020-05-29 08:10:04 (4776): Status Report: Elapsed Time: '53632.997553'
2020-05-29 08:10:04 (4776): Status Report: CPU Time: '52489.593750'
2020-05-29 08:10:04 (4776): Preference change detected
2020-05-29 08:10:04 (4776): Setting CPU throttle for VM. (100%)
2020-05-29 08:10:05 (4776): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-29 08:10:06 (4776): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-05-29 08:10:06 (4776): Guest Log: BIOS: Booting from Hard Disk...

2020-05-29 08:10:08 (4776): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-05-29 08:10:08 (4776): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-05-29 08:10:32 (4776): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-05-29 08:10:32 (4776): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-05-29 08:10:36 (4776): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-05-29 08:10:36 (4776): Guest Log: 00:00:00.000246 main     Log opened 2020-05-29T06:10:42.759610000Z

2020-05-29 08:10:36 (4776): Guest Log: 00:00:00.000804 main     OS Product: Linux

2020-05-29 08:10:36 (4776): Guest Log: 00:00:00.000867 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-05-29 08:10:36 (4776): Guest Log: 00:00:00.000926 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-05-29 08:10:36 (4776): Guest Log: 00:00:00.000986 main     Executable: /usr/sbin/VBoxService

2020-05-29 08:10:36 (4776): Guest Log: 00:00:00.000987 main     Process ID: 3193

2020-05-29 08:10:36 (4776): Guest Log: 00:00:00.000989 main     Package type: LINUX_64BITS_GENERIC

2020-05-29 08:10:36 (4776): Guest Log: 00:00:00.004842 main     5.2.6 r120293 started. Verbose level = 0

2020-05-29 08:11:27 (4776): Guest Log: 08:11:33 CEST +02:00 2020-05-29: cranky: [INFO] Detected Theory App

2020-05-29 08:11:27 (4776): Guest Log: 08:11:33 CEST +02:00 2020-05-29: cranky: [INFO] Checking CVMFS.

2020-05-29 08:11:28 (4776): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-05-29 08:11:28 (4776): 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-05-29 08:11:28 (4776): Guest Log: 2.5.2.0 4028 0 28536 18129 3 1 1633326 4096000 0 65024 0 0 n/a 5 1 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-05-29 08:11:30 (4776): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-05-29 08:11:30 (4776): 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-05-29 08:11:30 (4776): Guest Log: 2.5.2.0 4112 0 25596 12347 3 2 1633326 4096000 0 65024 0 2 0 4274 212 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-05-29 08:11:32 (4776): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-05-29 08:11:32 (4776): 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-05-29 08:11:32 (4776): Guest Log: 2.5.2.0 4058 0 27496 249 3 1 1633326 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-05-29 08:11:33 (4776): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-05-29 08:11:34 (4776): 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-05-29 08:11:34 (4776): Guest Log: 2.5.2.0 4086 0 29644 6689 3 1 1633326 4096000 0 65024 0 0 n/a 4077 212 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-05-29 08:11:34 (4776): Guest Log: 08:11:40 CEST +02:00 2020-05-29: cranky: [INFO] Checking runc.

2020-05-29 08:11:34 (4776): Guest Log: 08:11:40 CEST +02:00 2020-05-29: cranky: [INFO] Creating the filesystem.

2020-05-29 08:11:34 (4776): Guest Log: 08:11:41 CEST +02:00 2020-05-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-05-29 08:11:34 (4776): Guest Log: 08:11:41 CEST +02:00 2020-05-29: cranky: [INFO] Updating config.json.

2020-05-29 08:11:34 (4776): Guest Log: 08:11:41 CEST +02:00 2020-05-29: cranky: [INFO] Running Container 'runc'.

2020-05-29 08:11:35 (4776): Guest Log: job: htmld=/shared/html/job

2020-05-29 08:11:35 (4776): Guest Log: job: unpack exitcode=0

2020-05-29 08:11:37 (4776): Guest Log: 08:11:43 CEST +02:00 2020-05-29: cranky: [INFO] ===> [runRivet] Fri May 29 06:11:41 UTC 2020 [boinc pp zinclusive 7000 -,-,50,130 - pythia8 8.235 tune-AU2ct10 100000 12]

2020-05-29 09:50:11 (4776): Status Report: Job Duration: '864000.000000'
2020-05-29 09:50:11 (4776): Status Report: Elapsed Time: '59632.997553'
2020-05-29 09:50:11 (4776): Status Report: CPU Time: '58314.390625'
2020-05-29 11:30:19 (4776): Status Report: Job Duration: '864000.000000'
2020-05-29 11:30:19 (4776): Status Report: Elapsed Time: '65633.997553'
2020-05-29 11:30:19 (4776): Status Report: CPU Time: '64241.484375'
2020-05-29 13:10:27 (4776): Status Report: Job Duration: '864000.000000'
2020-05-29 13:10:27 (4776): Status Report: Elapsed Time: '71633.997553'
2020-05-29 13:10:27 (4776): Status Report: CPU Time: '70189.140625'
2020-05-29 14:50:36 (4776): Status Report: Job Duration: '864000.000000'
2020-05-29 14:50:36 (4776): Status Report: Elapsed Time: '77633.997553'
2020-05-29 14:50:36 (4776): Status Report: CPU Time: '76070.375000'
2020-05-29 16:30:44 (4776): Status Report: Job Duration: '864000.000000'
2020-05-29 16:30:44 (4776): Status Report: Elapsed Time: '83633.997553'
2020-05-29 16:30:44 (4776): Status Report: CPU Time: '81908.281250'
2020-05-29 16:40:26 (4776): Stopping VM.
2020-05-30 08:42:13 (13040): Detected: vboxwrapper 26197
2020-05-30 08:42:13 (13040): Detected: BOINC client v7.7
2020-05-30 08:42:14 (13040): Detected: VirtualBox VboxManage Interface (Version: 6.0.20)
2020-05-30 08:42:14 (13040): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-30 08:42:15 (13040): Starting VM using VBoxManage interface. (boinc_a4c397a8cd9cd833, slot#3)
2020-05-30 08:42:22 (13040): Successfully started VM. (PID = '9892')
2020-05-30 08:42:22 (13040): Reporting VM Process ID to BOINC.
2020-05-30 08:42:22 (13040): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-05-30 08:42:22 (13040): Detected: Web Application Enabled (http://localhost:54488)
2020-05-30 08:42:22 (13040): Detected: Remote Desktop Enabled (localhost:54489)
2020-05-30 08:42:22 (13040): Status Report: Job Duration: '864000.000000'
2020-05-30 08:42:22 (13040): Status Report: Elapsed Time: '84214.997553'
2020-05-30 08:42:22 (13040): Status Report: CPU Time: '82472.609375'
2020-05-30 08:42:22 (13040): Preference change detected
2020-05-30 08:42:22 (13040): Setting CPU throttle for VM. (100%)
2020-05-30 08:42:23 (13040): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-30 08:42:27 (13040): Guest Log: 08:29:49.682068 timesync vgsvcTimeSyncWorker: Radical host time change: 57 725 366 000 000ns (HostNow=1 590 820 947 708 000 000 ns HostLast=1 590 763 222 342 000 000 ns)

2020-05-30 08:42:37 (13040): Guest Log: 08:29:59.697677 timesync vgsvcTimeSyncWorker: Radical guest time change: 57 725 417 963 000ns (GuestNow=1 590 820 957 758 335 000 ns GuestLast=1 590 763 232 340 372 000 ns fSetTimeLastLoop=true )

2020-05-30 10:06:09 (13040): VM state change detected. (old = 'Running', new = 'Paused')
2020-05-30 21:47:02 (13040): Stopping VM.
2020-05-31 19:58:58 (13684): Detected: vboxwrapper 26197
2020-05-31 19:58:58 (13684): Detected: BOINC client v7.7
2020-05-31 19:58:59 (13684): Detected: VirtualBox VboxManage Interface (Version: 6.0.20)
2020-05-31 19:58:59 (13684): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-31 19:59:00 (13684): Starting VM using VBoxManage interface. (boinc_a4c397a8cd9cd833, slot#3)
2020-05-31 19:59:06 (13684): Successfully started VM. (PID = '3728')
2020-05-31 19:59:06 (13684): Reporting VM Process ID to BOINC.
2020-05-31 19:59:06 (13684): Guest Log: 09:53:31.305685 timesync vgsvcTimeSyncWorker: Radical host time change: 121 986 616 000 000ns (HostNow=1 590 947 946 046 000 000 ns HostLast=1 590 825 959 430 000 000 ns)

2020-05-31 19:59:06 (13684): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-05-31 19:59:06 (13684): Detected: Web Application Enabled (http://localhost:54488)
2020-05-31 19:59:06 (13684): Detected: Remote Desktop Enabled (localhost:54489)
2020-05-31 19:59:06 (13684): Status Report: Job Duration: '864000.000000'
2020-05-31 19:59:06 (13684): Status Report: Elapsed Time: '89228.997553'
2020-05-31 19:59:06 (13684): Status Report: CPU Time: '87316.468750'
2020-05-31 19:59:06 (13684): Preference change detected
2020-05-31 19:59:06 (13684): Setting CPU throttle for VM. (100%)
2020-05-31 19:59:06 (13684): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-31 19:59:16 (13684): Guest Log: 09:53:41.306169 timesync vgsvcTimeSyncWorker: Radical guest time change: 121 986 680 187 000ns (GuestNow=1 590 947 956 046 495 000 ns GuestLast=1 590 825 969 366 308 000 ns fSetTimeLastLoop=true )

2020-05-31 21:39:13 (13684): Status Report: Job Duration: '864000.000000'
2020-05-31 21:39:13 (13684): Status Report: Elapsed Time: '95228.997553'
2020-05-31 21:39:13 (13684): Status Report: CPU Time: '93236.609375'
2020-05-31 21:49:50 (13684): Stopping VM.
2020-06-01 08:46:36 (13044): Detected: vboxwrapper 26197
2020-06-01 08:46:36 (13044): Detected: BOINC client v7.7
2020-06-01 08:46:37 (13044): Detected: VirtualBox VboxManage Interface (Version: 6.0.20)
2020-06-01 08:46:37 (13044): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-06-01 08:46:38 (13044): Starting VM using VBoxManage interface. (boinc_a4c397a8cd9cd833, slot#3)
2020-06-01 08:46:44 (13044): Successfully started VM. (PID = '13528')
2020-06-01 08:46:44 (13044): Reporting VM Process ID to BOINC.
2020-06-01 08:46:44 (13044): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-06-01 08:46:44 (13044): Detected: Web Application Enabled (http://localhost:54488)
2020-06-01 08:46:44 (13044): Detected: Remote Desktop Enabled (localhost:54489)
2020-06-01 08:46:44 (13044): Status Report: Job Duration: '864000.000000'
2020-06-01 08:46:44 (13044): Status Report: Elapsed Time: '95865.997553'
2020-06-01 08:46:44 (13044): Status Report: CPU Time: '93844.906250'
2020-06-01 08:46:44 (13044): Preference change detected
2020-06-01 08:46:44 (13044): Setting CPU throttle for VM. (100%)
2020-06-01 08:46:45 (13044): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2020-06-01 08:46:51 (13044): Guest Log: 11:44:23.496767 timesync vgsvcTimeSyncWorker: Radical host time change: 39 422 990 000 000ns (HostNow=1 590 994 011 218 000 000 ns HostLast=1 590 954 588 228 000 000 ns)

2020-06-01 08:47:01 (13044): Guest Log: 11:44:33.505983 timesync vgsvcTimeSyncWorker: Radical guest time change: 39 422 990 193 000ns (GuestNow=1 590 994 021 227 246 000 ns GuestLast=1 590 954 598 237 053 000 ns fSetTimeLastLoop=true )

2020-06-01 10:26:53 (13044): Status Report: Job Duration: '864000.000000'
2020-06-01 10:26:53 (13044): Status Report: Elapsed Time: '101865.997553'
2020-06-01 10:26:53 (13044): Status Report: CPU Time: '99694.250000'
2020-06-01 12:07:02 (13044): Status Report: Job Duration: '864000.000000'
2020-06-01 12:07:02 (13044): Status Report: Elapsed Time: '107865.997553'
2020-06-01 12:07:02 (13044): Status Report: CPU Time: '105542.234375'
2020-06-01 13:25:53 (13044): Guest Log: job: run exitcode=0

2020-06-01 13:25:53 (13044): Guest Log: job: diskusage=2160

2020-06-01 13:25:53 (13044): Guest Log: job: logsize=72 k

2020-06-01 13:25:53 (13044): Guest Log: job: times=

2020-06-01 13:25:53 (13044): Guest Log: 0m0.009s 0m0.020s

2020-06-01 13:25:53 (13044): Guest Log: 970m50.802s 4m4.654s

2020-06-01 13:25:53 (13044): Guest Log: job: cpuusage=58495

2020-06-01 13:25:53 (13044): Guest Log: 13:25:52 CEST +02:00 2020-06-01: cranky: [INFO] Container 'runc' finished with status code 0.

2020-06-01 13:25:53 (13044): Guest Log: 13:25:52 CEST +02:00 2020-06-01: cranky: [INFO] Preparing output.

2020-06-01 13:26:00 (13044): Guest Log: [INFO] Job Finished

2020-06-01 13:26:00 (13044): Guest Log: [INFO] Shutting Down.

2020-06-01 13:26:00 (13044): VM Completion File Detected.
2020-06-01 13:26:00 (13044): VM Completion Message: Job Finished
.
2020-06-01 13:26:00 (13044): Powering off VM.
2020-06-01 13:31:01 (13044): VM did not power off when requested.
2020-06-01 13:31:01 (13044): VM was successfully terminated.
2020-06-01 13:31:01 (13044): Deregistering VM. (boinc_a4c397a8cd9cd833, slot#3)
2020-06-01 13:31:01 (13044): Removing network bandwidth throttle group from VM.
2020-06-01 13:31:01 (13044): Removing VM from VirtualBox.
13:31:06 (13044): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN