Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2021-07-16 11:22:56 (5508): Detected: vboxwrapper 26197
2021-07-16 11:22:56 (5508): Detected: BOINC client v7.7
2021-07-16 11:22:56 (5508): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-07-16 11:22:56 (5508): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-07-16 11:22:56 (5508): Successfully copied 'init_data.xml' to the shared directory.
2021-07-16 11:22:56 (5508): Successfully copied 'input' to the shared directory.
2021-07-16 11:22:57 (5508): Create VM. (boinc_40766c9ad5071850, slot#9)
2021-07-16 11:22:58 (5508): Setting Memory Size for VM. (630MB)
2021-07-16 11:22:58 (5508): Setting CPU Count for VM. (1)
2021-07-16 11:22:59 (5508): Setting Chipset Options for VM.
2021-07-16 11:22:59 (5508): Setting Boot Options for VM.
2021-07-16 11:22:59 (5508): Setting Network Configuration for NAT.
2021-07-16 11:22:59 (5508): Enabling VM Network Access.
2021-07-16 11:23:00 (5508): Disabling USB Support for VM.
2021-07-16 11:23:00 (5508): Disabling COM Port Support for VM.
2021-07-16 11:23:00 (5508): Disabling LPT Port Support for VM.
2021-07-16 11:23:00 (5508): Disabling Audio Support for VM.
2021-07-16 11:23:01 (5508): Disabling Clipboard Support for VM.
2021-07-16 11:23:01 (5508): Disabling Drag and Drop Support for VM.
2021-07-16 11:23:01 (5508): Adding storage controller(s) to VM.
2021-07-16 11:23:01 (5508): Adding virtual disk drive to VM. (vm_image.vdi)
2021-07-16 11:23:02 (5508): Adding VirtualBox Guest Additions to VM.
2021-07-16 11:23:02 (5508): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-07-16 11:23:02 (5508): forwarding host port 50739 to guest port 80
2021-07-16 11:23:03 (5508): Enabling remote desktop for VM.
2021-07-16 11:23:03 (5508): Enabling shared directory for VM.
2021-07-16 11:23:03 (5508): Starting VM using VBoxManage interface. (boinc_40766c9ad5071850, slot#9)
2021-07-16 11:23:08 (5508): Successfully started VM. (PID = '376')
2021-07-16 11:23:08 (5508): Reporting VM Process ID to BOINC.
2021-07-16 11:23:08 (5508): Guest Log: BIOS: VirtualBox 6.1.12

2021-07-16 11:23:08 (5508): Guest Log: CPUID EDX: 0x178bfbff

2021-07-16 11:23:08 (5508): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-07-16 11:23:08 (5508): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-07-16 11:23:08 (5508): Detected: Web Application Enabled (http://localhost:50739)
2021-07-16 11:23:08 (5508): Detected: Remote Desktop Enabled (localhost:50740)
2021-07-16 11:23:08 (5508): Preference change detected
2021-07-16 11:23:08 (5508): Setting CPU throttle for VM. (100%)
2021-07-16 11:23:08 (5508): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-07-16 11:23:10 (5508): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-07-16 11:23:10 (5508): Guest Log: BIOS: Booting from Hard Disk...

2021-07-16 11:23:12 (5508): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-07-16 11:23:12 (5508): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-07-16 11:23:35 (5508): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-07-16 11:23:35 (5508): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-07-16 11:23:40 (5508): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2021-07-16 11:23:40 (5508): Guest Log: 00:00:00.000285 main     Log opened 2021-07-16T02:23:39.668787000Z

2021-07-16 11:23:40 (5508): Guest Log: 00:00:00.000795 main     OS Product: Linux

2021-07-16 11:23:40 (5508): Guest Log: 00:00:00.000934 main     OS Release: 4.14.76-13.cernvm.x86_64

2021-07-16 11:23:40 (5508): Guest Log: 00:00:00.000979 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2021-07-16 11:23:40 (5508): Guest Log: 00:00:00.001019 main     Executable: /usr/sbin/VBoxService

2021-07-16 11:23:40 (5508): Guest Log: 00:00:00.001020 main     Process ID: 3194

2021-07-16 11:23:40 (5508): Guest Log: 00:00:00.001021 main     Package type: LINUX_64BITS_GENERIC

2021-07-16 11:23:40 (5508): Guest Log: 00:00:00.003450 main     5.2.6 r120293 started. Verbose level = 0

2021-07-16 11:24:14 (5508): Guest Log: 11:24:14 JST +09:00 2021-07-16: cranky: [INFO] Detected Theory App

2021-07-16 11:24:14 (5508): Guest Log: 11:24:14 JST +09:00 2021-07-16: cranky: [INFO] Checking CVMFS.

2021-07-16 11:24:14 (5508): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2021-07-16 11:24:15 (5508): 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

2021-07-16 11:24:15 (5508): Guest Log: 2.5.2.0 4039 0 27220 20608 3 1 266058 4096000 0 65024 0 0 n/a 5 1 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2021-07-16 11:24:16 (5508): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2021-07-16 11:24:17 (5508): 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

2021-07-16 11:24:17 (5508): Guest Log: 2.5.2.0 4062 0 27556 15725 3 2 266058 4096000 0 65024 0 2 -100 6414 740 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2021-07-16 11:24:17 (5508): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2021-07-16 11:24:17 (5508): 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

2021-07-16 11:24:17 (5508): Guest Log: 2.5.2.0 4083 0 28312 267 3 1 266058 4096000 0 65024 0 0 n/a 4 1 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1

2021-07-16 11:24:18 (5508): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2021-07-16 11:24:19 (5508): 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

2021-07-16 11:24:19 (5508): Guest Log: 2.5.2.0 4107 0 34560 9748 3 1 266058 4096000 0 65024 0 0 n/a 5139 388 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2021-07-16 11:24:19 (5508): Guest Log: 11:24:18 JST +09:00 2021-07-16: cranky: [INFO] Checking runc.

2021-07-16 11:24:19 (5508): Guest Log: 11:24:18 JST +09:00 2021-07-16: cranky: [INFO] Creating the filesystem.

2021-07-16 11:24:19 (5508): Guest Log: 11:24:18 JST +09:00 2021-07-16: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2021-07-16 11:24:19 (5508): Guest Log: 11:24:19 JST +09:00 2021-07-16: cranky: [INFO] Updating config.json.

2021-07-16 11:24:19 (5508): Guest Log: 11:24:19 JST +09:00 2021-07-16: cranky: [INFO] Running Container 'runc'.

2021-07-16 11:24:21 (5508): Guest Log: job: htmld=/shared/html/job

2021-07-16 11:24:21 (5508): Guest Log: job: unpack exitcode=0

2021-07-16 11:24:23 (5508): Guest Log: 11:24:23 JST +09:00 2021-07-16: cranky: [INFO] ===> [runRivet] Fri Jul 16 02:24:21 UTC 2021 [boinc pp z1j 7000 100 - pythia8 8.301 dire-default 78000 194]

2021-07-16 13:03:17 (5508): Status Report: Job Duration: '864000.000000'
2021-07-16 13:03:17 (5508): Status Report: Elapsed Time: '6000.000000'
2021-07-16 13:03:17 (5508): Status Report: CPU Time: '4675.062500'
2021-07-16 14:43:37 (5508): Status Report: Job Duration: '864000.000000'
2021-07-16 14:43:37 (5508): Status Report: Elapsed Time: '12000.000000'
2021-07-16 14:43:37 (5508): Status Report: CPU Time: '10694.656250'
2021-07-16 15:00:01 (5508): Stopping VM.
2021-07-16 21:00:00 (11656): Detected: vboxwrapper 26197
2021-07-16 21:00:01 (11656): Detected: BOINC client v7.7
2021-07-16 21:00:02 (11656): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-07-16 21:00:02 (11656): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-07-16 21:00:03 (11656): Starting VM using VBoxManage interface. (boinc_40766c9ad5071850, slot#9)
2021-07-16 21:00:13 (11656): Successfully started VM. (PID = '5932')
2021-07-16 21:00:13 (11656): Reporting VM Process ID to BOINC.
2021-07-16 21:00:13 (11656): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-07-16 21:00:13 (11656): Detected: Web Application Enabled (http://localhost:50739)
2021-07-16 21:00:13 (11656): Detected: Remote Desktop Enabled (localhost:50740)
2021-07-16 21:00:13 (11656): Status Report: Job Duration: '864000.000000'
2021-07-16 21:00:13 (11656): Status Report: Elapsed Time: '12976.000000'
2021-07-16 21:00:13 (11656): Status Report: CPU Time: '11672.281250'
2021-07-16 21:00:13 (11656): Preference change detected
2021-07-16 21:00:13 (11656): Setting CPU throttle for VM. (100%)
2021-07-16 21:00:14 (11656): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-07-16 21:00:19 (11656): Guest Log: 03:36:23.113507 timesync vgsvcTimeSyncWorker: Radical host time change: 21 621 882 000 000ns (HostNow=1 626 436 763 632 000 000 ns HostLast=1 626 415 141 750 000 000 ns)

2021-07-16 21:00:29 (11656): Guest Log: 03:36:33.146218 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 570 996 929 000ns (GuestNow=1 626 436 773 721 803 000 ns GuestLast=1 626 415 202 724 874 000 ns fSetTimeLastLoop=true )

2021-07-16 22:40:49 (11656): Status Report: Job Duration: '864000.000000'
2021-07-16 22:40:49 (11656): Status Report: Elapsed Time: '18976.000000'
2021-07-16 22:40:49 (11656): Status Report: CPU Time: '17714.281250'
2021-07-17 00:21:33 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 00:21:33 (11656): Status Report: Elapsed Time: '24976.000000'
2021-07-17 00:21:33 (11656): Status Report: CPU Time: '23758.359375'
2021-07-17 02:02:14 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 02:02:14 (11656): Status Report: Elapsed Time: '30976.000000'
2021-07-17 02:02:14 (11656): Status Report: CPU Time: '29799.046875'
2021-07-17 03:42:53 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 03:42:53 (11656): Status Report: Elapsed Time: '36976.000000'
2021-07-17 03:42:53 (11656): Status Report: CPU Time: '35836.906250'
2021-07-17 05:23:40 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 05:23:40 (11656): Status Report: Elapsed Time: '42976.000000'
2021-07-17 05:23:40 (11656): Status Report: CPU Time: '41884.421875'
2021-07-17 07:04:19 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 07:04:19 (11656): Status Report: Elapsed Time: '48976.000000'
2021-07-17 07:04:19 (11656): Status Report: CPU Time: '47923.203125'
2021-07-17 08:44:59 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 08:44:59 (11656): Status Report: Elapsed Time: '54976.000000'
2021-07-17 08:44:59 (11656): Status Report: CPU Time: '53962.687500'
2021-07-17 10:25:45 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 10:25:45 (11656): Status Report: Elapsed Time: '60976.000000'
2021-07-17 10:25:45 (11656): Status Report: CPU Time: '60010.234375'
2021-07-17 12:06:13 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 12:06:13 (11656): Status Report: Elapsed Time: '66976.000000'
2021-07-17 12:06:13 (11656): Status Report: CPU Time: '66033.390625'
2021-07-17 13:46:44 (11656): Status Report: Job Duration: '864000.000000'
2021-07-17 13:46:44 (11656): Status Report: Elapsed Time: '72976.000000'
2021-07-17 13:46:44 (11656): Status Report: CPU Time: '72064.546875'
2021-07-17 15:00:00 (11656): Stopping VM.
2021-07-17 21:00:00 (3116): Detected: vboxwrapper 26197
2021-07-17 21:00:00 (3116): Detected: BOINC client v7.7
2021-07-17 21:00:01 (3116): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-07-17 21:00:02 (3116): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-07-17 21:00:02 (3116): Starting VM using VBoxManage interface. (boinc_40766c9ad5071850, slot#9)
2021-07-17 21:00:21 (3116): Successfully started VM. (PID = '10428')
2021-07-17 21:00:21 (3116): Reporting VM Process ID to BOINC.
2021-07-17 21:00:21 (3116): Guest Log: 21:36:19.631480 timesync vgsvcTimeSyncWorker: Radical host time change: 21 626 807 000 000ns (HostNow=1 626 523 209 814 000 000 ns HostLast=1 626 501 583 007 000 000 ns)

2021-07-17 21:00:21 (3116): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-07-17 21:00:21 (3116): Detected: Web Application Enabled (http://localhost:50739)
2021-07-17 21:00:21 (3116): Detected: Remote Desktop Enabled (localhost:50740)
2021-07-17 21:00:21 (3116): Status Report: Job Duration: '864000.000000'
2021-07-17 21:00:21 (3116): Status Report: Elapsed Time: '77353.000000'
2021-07-17 21:00:21 (3116): Status Report: CPU Time: '76453.171875'
2021-07-17 21:00:21 (3116): Preference change detected
2021-07-17 21:00:21 (3116): Setting CPU throttle for VM. (100%)
2021-07-17 21:00:21 (3116): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-07-17 21:00:31 (3116): Guest Log: 21:36:29.639972 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 659 747 702 000ns (GuestNow=1 626 523 219 888 623 000 ns GuestLast=1 626 501 560 140 921 000 ns fSetTimeLastLoop=true )

2021-07-17 22:40:28 (3116): Status Report: Job Duration: '864000.000000'
2021-07-17 22:40:28 (3116): Status Report: Elapsed Time: '83353.000000'
2021-07-17 22:40:28 (3116): Status Report: CPU Time: '82477.593750'
2021-07-18 00:20:36 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 00:20:36 (3116): Status Report: Elapsed Time: '89353.000000'
2021-07-18 00:20:36 (3116): Status Report: CPU Time: '88482.906250'
2021-07-18 02:00:43 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 02:00:43 (3116): Status Report: Elapsed Time: '95353.000000'
2021-07-18 02:00:43 (3116): Status Report: CPU Time: '94490.015625'
2021-07-18 03:40:51 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 03:40:51 (3116): Status Report: Elapsed Time: '101353.000000'
2021-07-18 03:40:51 (3116): Status Report: CPU Time: '100496.671875'
2021-07-18 05:20:59 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 05:20:59 (3116): Status Report: Elapsed Time: '107353.000000'
2021-07-18 05:20:59 (3116): Status Report: CPU Time: '106505.187500'
2021-07-18 07:01:07 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 07:01:07 (3116): Status Report: Elapsed Time: '113353.000000'
2021-07-18 07:01:07 (3116): Status Report: CPU Time: '112512.812500'
2021-07-18 08:41:15 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 08:41:15 (3116): Status Report: Elapsed Time: '119353.000000'
2021-07-18 08:41:15 (3116): Status Report: CPU Time: '118520.250000'
2021-07-18 10:21:22 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 10:21:22 (3116): Status Report: Elapsed Time: '125353.000000'
2021-07-18 10:21:22 (3116): Status Report: CPU Time: '124527.500000'
2021-07-18 12:01:29 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 12:01:29 (3116): Status Report: Elapsed Time: '131353.000000'
2021-07-18 12:01:29 (3116): Status Report: CPU Time: '130534.750000'
2021-07-18 13:41:36 (3116): Status Report: Job Duration: '864000.000000'
2021-07-18 13:41:36 (3116): Status Report: Elapsed Time: '137353.000000'
2021-07-18 13:41:36 (3116): Status Report: CPU Time: '136539.234375'
2021-07-18 15:00:01 (3116): Stopping VM.
2021-07-19 00:00:01 (3208): Detected: vboxwrapper 26197
2021-07-19 00:00:01 (3208): Detected: BOINC client v7.7
2021-07-19 00:00:02 (3208): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-07-19 00:00:02 (3208): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-07-19 00:00:03 (3208): Starting VM using VBoxManage interface. (boinc_40766c9ad5071850, slot#9)
2021-07-19 00:00:17 (3208): Successfully started VM. (PID = '10568')
2021-07-19 00:00:17 (3208): Reporting VM Process ID to BOINC.
2021-07-19 00:00:17 (3208): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-07-19 00:00:17 (3208): Detected: Web Application Enabled (http://localhost:50739)
2021-07-19 00:00:17 (3208): Detected: Remote Desktop Enabled (localhost:50740)
2021-07-19 00:00:17 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 00:00:17 (3208): Status Report: Elapsed Time: '142051.000000'
2021-07-19 00:00:17 (3208): Status Report: CPU Time: '141235.734375'
2021-07-19 00:00:17 (3208): Preference change detected
2021-07-19 00:00:17 (3208): Setting CPU throttle for VM. (100%)
2021-07-19 00:00:17 (3208): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-07-19 00:00:18 (3208): Guest Log: 39:35:46.455280 timesync vgsvcTimeSyncWorker: Radical host time change: 32 422 769 000 000ns (HostNow=1 626 620 374 416 000 000 ns HostLast=1 626 587 951 647 000 000 ns)

2021-07-19 00:00:28 (3208): Guest Log: 39:35:56.456241 timesync vgsvcTimeSyncWorker: Radical guest time change: 32 407 782 991 000ns (GuestNow=1 626 620 384 451 944 000 ns GuestLast=1 626 587 976 668 953 000 ns fSetTimeLastLoop=true )

2021-07-19 01:40:23 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 01:40:23 (3208): Status Report: Elapsed Time: '148051.000000'
2021-07-19 01:40:23 (3208): Status Report: CPU Time: '147253.031250'
2021-07-19 03:20:31 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 03:20:31 (3208): Status Report: Elapsed Time: '154051.000000'
2021-07-19 03:20:31 (3208): Status Report: CPU Time: '153257.546875'
2021-07-19 05:00:38 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 05:00:38 (3208): Status Report: Elapsed Time: '160051.000000'
2021-07-19 05:00:38 (3208): Status Report: CPU Time: '159264.562500'
2021-07-19 06:40:47 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 06:40:47 (3208): Status Report: Elapsed Time: '166051.000000'
2021-07-19 06:40:47 (3208): Status Report: CPU Time: '165271.546875'
2021-07-19 08:20:54 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 08:20:54 (3208): Status Report: Elapsed Time: '172051.000000'
2021-07-19 08:20:54 (3208): Status Report: CPU Time: '171279.734375'
2021-07-19 10:01:02 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 10:01:02 (3208): Status Report: Elapsed Time: '178051.000000'
2021-07-19 10:01:02 (3208): Status Report: CPU Time: '177286.609375'
2021-07-19 11:41:09 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 11:41:09 (3208): Status Report: Elapsed Time: '184051.000000'
2021-07-19 11:41:09 (3208): Status Report: CPU Time: '183293.281250'
2021-07-19 13:21:17 (3208): Status Report: Job Duration: '864000.000000'
2021-07-19 13:21:17 (3208): Status Report: Elapsed Time: '190051.000000'
2021-07-19 13:21:17 (3208): Status Report: CPU Time: '189301.437500'
2021-07-19 15:00:01 (3208): Stopping VM.
2021-07-20 00:00:01 (2660): Detected: vboxwrapper 26197
2021-07-20 00:00:01 (2660): Detected: BOINC client v7.7
2021-07-20 00:00:02 (2660): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-07-20 00:00:02 (2660): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-07-20 00:00:02 (2660): Starting VM using VBoxManage interface. (boinc_40766c9ad5071850, slot#9)
2021-07-20 00:00:09 (2660): Successfully started VM. (PID = '10664')
2021-07-20 00:00:09 (2660): Reporting VM Process ID to BOINC.
2021-07-20 00:00:09 (2660): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-07-20 00:00:09 (2660): Detected: Web Application Enabled (http://localhost:50739)
2021-07-20 00:00:09 (2660): Detected: Remote Desktop Enabled (localhost:50740)
2021-07-20 00:00:09 (2660): Status Report: Job Duration: '864000.000000'
2021-07-20 00:00:09 (2660): Status Report: Elapsed Time: '195968.000000'
2021-07-20 00:00:09 (2660): Status Report: CPU Time: '195219.078125'
2021-07-20 00:00:09 (2660): Preference change detected
2021-07-20 00:00:09 (2660): Setting CPU throttle for VM. (100%)
2021-07-20 00:00:10 (2660): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-07-20 00:00:14 (2660): Guest Log: 54:35:40.574018 timesync vgsvcTimeSyncWorker: Radical host time change: 32 415 589 000 000ns (HostNow=1 626 706 780 610 000 000 ns HostLast=1 626 674 365 021 000 000 ns)

2021-07-20 00:00:24 (2660): Guest Log: 54:35:50.576080 timesync vgsvcTimeSyncWorker: Radical guest time change: 32 422 042 354 000ns (GuestNow=1 626 706 790 612 071 000 ns GuestLast=1 626 674 368 569 717 000 ns fSetTimeLastLoop=true )

2021-07-20 01:40:16 (2660): Status Report: Job Duration: '864000.000000'
2021-07-20 01:40:16 (2660): Status Report: Elapsed Time: '201968.000000'
2021-07-20 01:40:16 (2660): Status Report: CPU Time: '201229.375000'
2021-07-20 03:20:23 (2660): Status Report: Job Duration: '864000.000000'
2021-07-20 03:20:23 (2660): Status Report: Elapsed Time: '207968.000000'
2021-07-20 03:20:23 (2660): Status Report: CPU Time: '207234.453125'
2021-07-20 05:00:30 (2660): Status Report: Job Duration: '864000.000000'
2021-07-20 05:00:30 (2660): Status Report: Elapsed Time: '213968.000000'
2021-07-20 05:00:30 (2660): Status Report: CPU Time: '213241.265625'
2021-07-20 06:40:37 (2660): Status Report: Job Duration: '864000.000000'
2021-07-20 06:40:37 (2660): Status Report: Elapsed Time: '219968.000000'
2021-07-20 06:40:37 (2660): Status Report: CPU Time: '219248.265625'
2021-07-20 08:20:44 (2660): Status Report: Job Duration: '864000.000000'
2021-07-20 08:20:44 (2660): Status Report: Elapsed Time: '225968.000000'
2021-07-20 08:20:44 (2660): Status Report: CPU Time: '225254.750000'
2021-07-20 08:50:28 (2660): Guest Log: job: run exitcode=0

2021-07-20 08:50:28 (2660): Guest Log: job: diskusage=3108

2021-07-20 08:50:28 (2660): Guest Log: job: logsize=76 k

2021-07-20 08:50:28 (2660): Guest Log: job: times=

2021-07-20 08:50:28 (2660): Guest Log: 0m0.037s 0m0.016s

2021-07-20 08:50:28 (2660): Guest Log: 3754m9.141s 8m20.076s

2021-07-20 08:50:28 (2660): Guest Log: job: cpuusage=225749

2021-07-20 08:50:29 (2660): Guest Log: 08:49:55 JST +09:00 2021-07-20: cranky: [INFO] Container 'runc' finished with status code 0.

2021-07-20 08:50:29 (2660): Guest Log: 08:49:55 JST +09:00 2021-07-20: cranky: [INFO] Preparing output.

2021-07-20 08:50:31 (2660): Guest Log: [INFO] Job Finished

2021-07-20 08:50:31 (2660): Guest Log: [INFO] Shutting Down.

2021-07-20 08:50:31 (2660): VM Completion File Detected.
2021-07-20 08:50:31 (2660): VM Completion Message: Job Finished
.
2021-07-20 08:50:31 (2660): Powering off VM.
2021-07-20 08:55:31 (2660): VM did not power off when requested.
2021-07-20 08:55:31 (2660): VM was successfully terminated.
2021-07-20 08:55:31 (2660): Deregistering VM. (boinc_40766c9ad5071850, slot#9)
2021-07-20 08:55:31 (2660): Removing network bandwidth throttle group from VM.
2021-07-20 08:55:32 (2660): Removing VM from VirtualBox.
08:55:37 (2660): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN