Stderr output

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

2021-05-02 12:49:22 (9000): Guest Log: CPUID EDX: 0x178bfbff

2021-05-02 12:49:22 (9000): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-05-02 12:49:22 (9000): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-02 12:49:22 (9000): Detected: Web Application Enabled (http://localhost:6835)
2021-05-02 12:49:22 (9000): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-02 12:49:22 (9000): Preference change detected
2021-05-02 12:49:22 (9000): Setting CPU throttle for VM. (99%)
2021-05-02 12:49:22 (9000): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-02 12:49:24 (9000): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-05-02 12:49:24 (9000): Guest Log: BIOS: Booting from Hard Disk...

2021-05-02 12:49:26 (9000): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-05-02 12:49:26 (9000): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-05-02 12:49:55 (9000): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-05-02 12:49:55 (9000): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-05-02 12:49:58 (9000): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2021-05-02 12:49:58 (9000): Guest Log: 00:00:00.000105 main     Log opened 2021-05-02T07:49:58.743591000Z

2021-05-02 12:49:58 (9000): Guest Log: 00:00:00.000979 main     OS Product: Linux

2021-05-02 12:49:58 (9000): Guest Log: 00:00:00.001180 main     OS Release: 4.14.76-13.cernvm.x86_64

2021-05-02 12:49:58 (9000): Guest Log: 00:00:00.001222 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2021-05-02 12:49:58 (9000): Guest Log: 00:00:00.001256 main     Executable: /usr/sbin/VBoxService

2021-05-02 12:49:58 (9000): Guest Log: 00:00:00.001257 main     Process ID: 3203

2021-05-02 12:49:58 (9000): Guest Log: 00:00:00.001258 main     Package type: LINUX_64BITS_GENERIC

2021-05-02 12:49:58 (9000): Guest Log: 00:00:00.003600 main     5.2.6 r120293 started. Verbose level = 0

2021-05-02 12:50:32 (9000): Guest Log: 10:50:32 MSK +03:00 2021-05-02: cranky: [INFO] Detected Theory App

2021-05-02 12:50:32 (9000): Guest Log: 10:50:32 MSK +03:00 2021-05-02: cranky: [INFO] Checking CVMFS.

2021-05-02 12:50:33 (9000): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2021-05-02 12:50:34 (9000): 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-05-02 12:50:34 (9000): Guest Log: 2.5.2.0 4092 0 28240 20062 3 1 265693 4096000 0 65024 0 0 n/a 5 1 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2021-05-02 12:50:35 (9000): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2021-05-02 12:50:36 (9000): 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-05-02 12:50:36 (9000): Guest Log: 2.5.2.0 4061 0 27504 15079 3 2 265693 4096000 0 65024 0 2 -100 6413 2047 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2021-05-02 12:50:36 (9000): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2021-05-02 12:50:37 (9000): 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-05-02 12:50:37 (9000): Guest Log: 2.5.2.0 4045 0 27204 264 3 1 265693 4096000 0 65024 0 0 n/a 4 3 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2021-05-02 12:50:38 (9000): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2021-05-02 12:50:39 (9000): 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-05-02 12:50:39 (9000): Guest Log: 2.5.2.0 4121 0 31216 9228 3 1 265693 4096000 0 65024 0 0 n/a 4990 437 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1

2021-05-02 12:50:39 (9000): Guest Log: 10:50:39 MSK +03:00 2021-05-02: cranky: [INFO] Checking runc.

2021-05-02 12:50:39 (9000): Guest Log: 10:50:39 MSK +03:00 2021-05-02: cranky: [INFO] Creating the filesystem.

2021-05-02 12:50:39 (9000): Guest Log: 10:50:39 MSK +03:00 2021-05-02: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2021-05-02 12:50:40 (9000): Guest Log: 10:50:40 MSK +03:00 2021-05-02: cranky: [INFO] Updating config.json.

2021-05-02 12:50:40 (9000): Guest Log: 10:50:40 MSK +03:00 2021-05-02: cranky: [INFO] Running Container 'runc'.

2021-05-02 12:50:42 (9000): Guest Log: job: htmld=/shared/html/job

2021-05-02 12:50:42 (9000): Guest Log: job: unpack exitcode=0

2021-05-02 12:50:44 (9000): Guest Log: 10:50:44 MSK +03:00 2021-05-02: cranky: [INFO] ===> [runRivet] Sun May  2 07:50:42 UTC 2021 [boinc pp jets 7000 80,-,1760 - pythia8 8.240 tune-4cx 100000 182]

2021-05-02 13:08:14 (9000): Stopping VM.
2021-05-04 00:35:48 (13380): Detected: vboxwrapper 26197
2021-05-04 00:35:48 (13380): Detected: BOINC client v7.7
2021-05-04 00:35:49 (13380): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 00:35:49 (13380): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 00:35:50 (13380): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 00:36:01 (13380): Successfully started VM. (PID = '8924')
2021-05-04 00:36:01 (13380): Reporting VM Process ID to BOINC.
2021-05-04 00:36:01 (13380): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 00:36:01 (13380): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 00:36:01 (13380): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 00:36:01 (13380): Preference change detected
2021-05-04 00:36:01 (13380): Setting CPU throttle for VM. (99%)
2021-05-04 00:36:01 (13380): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 00:36:04 (13380): Guest Log: 00:18:20.067089 timesync vgsvcTimeSyncWorker: Radical host time change: 127 675 614 000 000ns (HostNow=1 620 070 564 272 000 000 ns HostLast=1 619 942 888 658 000 000 ns)

2021-05-04 00:36:14 (13380): Guest Log: 00:18:30.074329 timesync vgsvcTimeSyncWorker: Radical guest time change: 127 675 487 397 000ns (GuestNow=1 620 070 574 286 344 000 ns GuestLast=1 619 942 898 798 947 000 ns fSetTimeLastLoop=true )

2021-05-04 01:09:22 (13380): Stopping VM.
2021-05-04 02:30:05 (11192): Detected: vboxwrapper 26197
2021-05-04 02:30:05 (11192): Detected: BOINC client v7.7
2021-05-04 02:30:07 (11192): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 02:30:07 (11192): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 02:30:07 (11192): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 02:30:16 (11192): Successfully started VM. (PID = '2948')
2021-05-04 02:30:16 (11192): Reporting VM Process ID to BOINC.
2021-05-04 02:30:16 (11192): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 02:30:16 (11192): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 02:30:16 (11192): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 02:30:16 (11192): Preference change detected
2021-05-04 02:30:16 (11192): Setting CPU throttle for VM. (99%)
2021-05-04 02:30:16 (11192): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 02:30:17 (11192): Guest Log: 00:51:40.105437 timesync vgsvcTimeSyncWorker: Radical host time change: 4 862 607 000 000ns (HostNow=1 620 077 416 928 000 000 ns HostLast=1 620 072 554 321 000 000 ns)

2021-05-04 02:30:27 (11192): Guest Log: 00:51:50.105779 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 862 611 040 000ns (GuestNow=1 620 077 426 928 403 000 ns GuestLast=1 620 072 564 317 363 000 ns fSetTimeLastLoop=true )

2021-05-04 03:03:39 (11192): Stopping VM.
2021-05-04 07:05:42 (8236): Detected: vboxwrapper 26197
2021-05-04 07:05:42 (8236): Detected: BOINC client v7.7
2021-05-04 07:05:43 (8236): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 07:05:44 (8236): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 07:05:44 (8236): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 07:05:53 (8236): Successfully started VM. (PID = '7144')
2021-05-04 07:05:53 (8236): Reporting VM Process ID to BOINC.
2021-05-04 07:05:53 (8236): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 07:05:53 (8236): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 07:05:53 (8236): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 07:05:53 (8236): Preference change detected
2021-05-04 07:05:53 (8236): Setting CPU throttle for VM. (99%)
2021-05-04 07:05:53 (8236): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 07:06:00 (8236): Guest Log: 01:25:10.820895 timesync vgsvcTimeSyncWorker: Radical host time change: 14 542 585 000 000ns (HostNow=1 620 093 960 224 000 000 ns HostLast=1 620 079 417 639 000 000 ns)

2021-05-04 07:06:10 (8236): Guest Log: 01:25:20.829872 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 542 589 513 000ns (GuestNow=1 620 093 970 233 002 000 ns GuestLast=1 620 079 427 643 489 000 ns fSetTimeLastLoop=true )

2021-05-04 07:20:21 (8236): Status Report: Job Duration: '864000.000000'
2021-05-04 07:20:21 (8236): Status Report: Elapsed Time: '6000.000000'
2021-05-04 07:20:21 (8236): Status Report: CPU Time: '2819.578125'
2021-05-04 07:39:15 (8236): Stopping VM.
2021-05-04 09:53:58 (7396): Detected: vboxwrapper 26197
2021-05-04 09:53:58 (7396): Detected: BOINC client v7.7
2021-05-04 09:53:59 (7396): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 09:53:59 (7396): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 09:54:00 (7396): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 09:54:09 (7396): Successfully started VM. (PID = '6740')
2021-05-04 09:54:09 (7396): Reporting VM Process ID to BOINC.
2021-05-04 09:54:09 (7396): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 09:54:09 (7396): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 09:54:09 (7396): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 09:54:09 (7396): Status Report: Job Duration: '864000.000000'
2021-05-04 09:54:09 (7396): Status Report: Elapsed Time: '7133.000000'
2021-05-04 09:54:09 (7396): Status Report: CPU Time: '3958.781250'
2021-05-04 09:54:09 (7396): Preference change detected
2021-05-04 09:54:09 (7396): Setting CPU throttle for VM. (99%)
2021-05-04 09:54:09 (7396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 09:54:13 (7396): Guest Log: 01:58:31.502894 timesync vgsvcTimeSyncWorker: Radical host time change: 8 102 087 000 000ns (HostNow=1 620 104 052 989 000 000 ns HostLast=1 620 095 950 902 000 000 ns)

2021-05-04 09:54:23 (7396): Guest Log: 01:58:41.511210 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 102 091 389 000ns (GuestNow=1 620 104 062 997 359 000 ns GuestLast=1 620 095 960 905 970 000 ns fSetTimeLastLoop=true )

2021-05-04 10:27:31 (7396): Stopping VM.
2021-05-04 11:30:08 (1816): Detected: vboxwrapper 26197
2021-05-04 11:30:08 (1816): Detected: BOINC client v7.7
2021-05-04 11:30:09 (1816): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 11:30:09 (1816): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 11:30:09 (1816): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 11:30:18 (1816): Successfully started VM. (PID = '552')
2021-05-04 11:30:18 (1816): Reporting VM Process ID to BOINC.
2021-05-04 11:30:18 (1816): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 11:30:18 (1816): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 11:30:18 (1816): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 11:30:18 (1816): Status Report: Job Duration: '864000.000000'
2021-05-04 11:30:18 (1816): Status Report: Elapsed Time: '9134.000000'
2021-05-04 11:30:18 (1816): Status Report: CPU Time: '5957.390625'
2021-05-04 11:30:18 (1816): Preference change detected
2021-05-04 11:30:18 (1816): Setting CPU throttle for VM. (99%)
2021-05-04 11:30:18 (1816): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 11:30:20 (1816): Guest Log: 02:31:52.328006 timesync vgsvcTimeSyncWorker: Radical host time change: 3 775 917 000 000ns (HostNow=1 620 109 819 731 000 000 ns HostLast=1 620 106 043 814 000 000 ns)

2021-05-04 11:30:29 (1816): Guest Log: 02:32:02.329000 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 775 917 872 000ns (GuestNow=1 620 109 829 732 005 000 ns GuestLast=1 620 106 053 814 133 000 ns fSetTimeLastLoop=true )

2021-05-04 12:03:43 (1816): Stopping VM.
2021-05-04 12:41:03 (3240): Detected: vboxwrapper 26197
2021-05-04 12:41:03 (3240): Detected: BOINC client v7.7
2021-05-04 12:41:04 (3240): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 12:41:04 (3240): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 12:41:05 (3240): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 12:41:14 (3240): Successfully started VM. (PID = '16372')
2021-05-04 12:41:14 (3240): Reporting VM Process ID to BOINC.
2021-05-04 12:41:14 (3240): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 12:41:14 (3240): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 12:41:14 (3240): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 12:41:14 (3240): Status Report: Job Duration: '864000.000000'
2021-05-04 12:41:14 (3240): Status Report: Elapsed Time: '11137.000000'
2021-05-04 12:41:14 (3240): Status Report: CPU Time: '7933.265625'
2021-05-04 12:41:14 (3240): Preference change detected
2021-05-04 12:41:14 (3240): Setting CPU throttle for VM. (99%)
2021-05-04 12:41:14 (3240): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 12:41:20 (3240): Guest Log: 03:05:22.955143 timesync vgsvcTimeSyncWorker: Radical host time change: 2 259 264 000 000ns (HostNow=1 620 114 079 619 000 000 ns HostLast=1 620 111 820 355 000 000 ns)

2021-05-04 12:41:30 (3240): Guest Log: 03:05:32.956074 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 259 261 810 000ns (GuestNow=1 620 114 089 619 937 000 ns GuestLast=1 620 111 830 358 127 000 ns fSetTimeLastLoop=true )

2021-05-04 13:14:37 (3240): Stopping VM.
2021-05-04 14:26:56 (9784): Detected: vboxwrapper 26197
2021-05-04 14:26:56 (9784): Detected: BOINC client v7.7
2021-05-04 14:26:57 (9784): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 14:26:57 (9784): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 14:26:58 (9784): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 14:27:06 (9784): Successfully started VM. (PID = '15148')
2021-05-04 14:27:06 (9784): Reporting VM Process ID to BOINC.
2021-05-04 14:27:06 (9784): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 14:27:06 (9784): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 14:27:06 (9784): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 14:27:06 (9784): Status Report: Job Duration: '864000.000000'
2021-05-04 14:27:06 (9784): Status Report: Elapsed Time: '13138.000000'
2021-05-04 14:27:06 (9784): Status Report: CPU Time: '9908.015625'
2021-05-04 14:27:06 (9784): Preference change detected
2021-05-04 14:27:06 (9784): Setting CPU throttle for VM. (99%)
2021-05-04 14:27:07 (9784): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 14:27:09 (9784): Guest Log: 03:38:43.637140 timesync vgsvcTimeSyncWorker: Radical host time change: 4 358 600 000 000ns (HostNow=1 620 120 428 893 000 000 ns HostLast=1 620 116 070 293 000 000 ns)

2021-05-04 14:27:19 (9784): Guest Log: 03:38:53.638173 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 358 593 057 000ns (GuestNow=1 620 120 438 894 042 000 ns GuestLast=1 620 116 080 300 985 000 ns fSetTimeLastLoop=true )

2021-05-04 15:00:30 (9784): Stopping VM.
2021-05-04 16:13:31 (1444): Detected: vboxwrapper 26197
2021-05-04 16:13:31 (1444): Detected: BOINC client v7.7
2021-05-04 16:13:32 (1444): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 16:13:32 (1444): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 16:13:33 (1444): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 16:13:41 (1444): Successfully started VM. (PID = '13940')
2021-05-04 16:13:41 (1444): Reporting VM Process ID to BOINC.
2021-05-04 16:13:41 (1444): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 16:13:41 (1444): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 16:13:41 (1444): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 16:13:41 (1444): Status Report: Job Duration: '864000.000000'
2021-05-04 16:13:41 (1444): Status Report: Elapsed Time: '15140.000000'
2021-05-04 16:13:41 (1444): Status Report: CPU Time: '11914.656250'
2021-05-04 16:13:41 (1444): Preference change detected
2021-05-04 16:13:41 (1444): Setting CPU throttle for VM. (99%)
2021-05-04 16:13:42 (1444): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 16:13:50 (1444): Guest Log: 04:12:14.380136 timesync vgsvcTimeSyncWorker: Radical host time change: 4 400 307 000 000ns (HostNow=1 620 126 829 940 000 000 ns HostLast=1 620 122 429 633 000 000 ns)

2021-05-04 16:14:00 (1444): Guest Log: 04:12:24.381055 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 400 305 010 000ns (GuestNow=1 620 126 839 940 951 000 ns GuestLast=1 620 122 439 635 941 000 ns fSetTimeLastLoop=true )

2021-05-04 16:47:07 (1444): Stopping VM.
2021-05-04 18:49:20 (4992): Detected: vboxwrapper 26197
2021-05-04 18:49:20 (4992): Detected: BOINC client v7.7
2021-05-04 18:49:21 (4992): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 18:49:21 (4992): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 18:49:21 (4992): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 18:49:30 (4992): Successfully started VM. (PID = '6600')
2021-05-04 18:49:30 (4992): Reporting VM Process ID to BOINC.
2021-05-04 18:49:30 (4992): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 18:49:30 (4992): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 18:49:30 (4992): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 18:49:30 (4992): Status Report: Job Duration: '864000.000000'
2021-05-04 18:49:30 (4992): Status Report: Elapsed Time: '17143.000000'
2021-05-04 18:49:30 (4992): Status Report: CPU Time: '13895.421875'
2021-05-04 18:49:30 (4992): Preference change detected
2021-05-04 18:49:30 (4992): Setting CPU throttle for VM. (99%)
2021-05-04 18:49:30 (4992): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 18:49:33 (4992): Guest Log: 04:45:35.063724 timesync vgsvcTimeSyncWorker: Radical host time change: 7 352 138 000 000ns (HostNow=1 620 136 172 741 000 000 ns HostLast=1 620 128 820 603 000 000 ns)

2021-05-04 18:49:43 (4992): Guest Log: 04:45:45.065738 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 352 119 427 000ns (GuestNow=1 620 136 182 743 027 000 ns GuestLast=1 620 128 830 623 600 000 ns fSetTimeLastLoop=true )

2021-05-04 19:22:53 (4992): Stopping VM.
2021-05-04 19:58:59 (12812): Detected: vboxwrapper 26197
2021-05-04 19:58:59 (12812): Detected: BOINC client v7.7
2021-05-04 19:59:00 (12812): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 19:59:01 (12812): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 19:59:01 (12812): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 19:59:10 (12812): Successfully started VM. (PID = '14868')
2021-05-04 19:59:10 (12812): Reporting VM Process ID to BOINC.
2021-05-04 19:59:10 (12812): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 19:59:10 (12812): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 19:59:10 (12812): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 19:59:10 (12812): Status Report: Job Duration: '864000.000000'
2021-05-04 19:59:10 (12812): Status Report: Elapsed Time: '19144.000000'
2021-05-04 19:59:10 (12812): Status Report: CPU Time: '15900.671875'
2021-05-04 19:59:10 (12812): Preference change detected
2021-05-04 19:59:10 (12812): Setting CPU throttle for VM. (99%)
2021-05-04 19:59:10 (12812): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 19:59:19 (12812): Guest Log: 05:19:05.900939 timesync vgsvcTimeSyncWorker: Radical host time change: 2 185 620 000 000ns (HostNow=1 620 140 359 196 000 000 ns HostLast=1 620 138 173 576 000 000 ns)

2021-05-04 19:59:29 (12812): Guest Log: 05:19:15.902612 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 185 619 484 000ns (GuestNow=1 620 140 369 197 689 000 ns GuestLast=1 620 138 183 578 205 000 ns fSetTimeLastLoop=true )

2021-05-04 20:32:32 (12812): Stopping VM.
2021-05-04 21:40:23 (15036): Detected: vboxwrapper 26197
2021-05-04 21:40:23 (15036): Detected: BOINC client v7.7
2021-05-04 21:40:24 (15036): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 21:40:25 (15036): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 21:40:25 (15036): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 21:40:34 (15036): Successfully started VM. (PID = '10204')
2021-05-04 21:40:34 (15036): Reporting VM Process ID to BOINC.
2021-05-04 21:40:34 (15036): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 21:40:34 (15036): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 21:40:34 (15036): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 21:40:34 (15036): Status Report: Job Duration: '864000.000000'
2021-05-04 21:40:34 (15036): Status Report: Elapsed Time: '21145.000000'
2021-05-04 21:40:34 (15036): Status Report: CPU Time: '17904.281250'
2021-05-04 21:40:34 (15036): Preference change detected
2021-05-04 21:40:34 (15036): Setting CPU throttle for VM. (99%)
2021-05-04 21:40:34 (15036): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 21:40:41 (15036): Guest Log: 05:52:26.674854 timesync vgsvcTimeSyncWorker: Radical host time change: 4 090 254 000 000ns (HostNow=1 620 146 440 215 000 000 ns HostLast=1 620 142 349 961 000 000 ns)

2021-05-04 21:40:50 (15036): Guest Log: 05:52:36.676831 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 090 247 139 000ns (GuestNow=1 620 146 450 217 019 000 ns GuestLast=1 620 142 359 969 880 000 ns fSetTimeLastLoop=true )

2021-05-04 22:13:57 (15036): Stopping VM.
2021-05-04 22:51:24 (14284): Detected: vboxwrapper 26197
2021-05-04 22:51:24 (14284): Detected: BOINC client v7.7
2021-05-04 22:51:26 (14284): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-04 22:51:26 (14284): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-04 22:51:27 (14284): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-04 22:51:36 (14284): Successfully started VM. (PID = '15848')
2021-05-04 22:51:36 (14284): Reporting VM Process ID to BOINC.
2021-05-04 22:51:36 (14284): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-04 22:51:36 (14284): Detected: Web Application Enabled (http://localhost:6835)
2021-05-04 22:51:36 (14284): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-04 22:51:36 (14284): Status Report: Job Duration: '864000.000000'
2021-05-04 22:51:36 (14284): Status Report: Elapsed Time: '23147.000000'
2021-05-04 22:51:36 (14284): Status Report: CPU Time: '19910.218750'
2021-05-04 22:51:36 (14284): Preference change detected
2021-05-04 22:51:36 (14284): Setting CPU throttle for VM. (99%)
2021-05-04 22:51:36 (14284): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-04 22:51:39 (14284): Guest Log: 06:25:47.464838 timesync vgsvcTimeSyncWorker: Radical host time change: 2 267 609 000 000ns (HostNow=1 620 150 698 597 000 000 ns HostLast=1 620 148 430 988 000 000 ns)

2021-05-04 22:51:49 (14284): Guest Log: 06:25:57.470665 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 267 597 885 000ns (GuestNow=1 620 150 708 602 862 000 ns GuestLast=1 620 148 441 004 977 000 ns fSetTimeLastLoop=true )

2021-05-04 23:24:58 (14284): Stopping VM.
2021-05-05 16:21:41 (9172): Detected: vboxwrapper 26197
2021-05-05 16:21:41 (9172): Detected: BOINC client v7.7
2021-05-05 16:21:42 (9172): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-05 16:21:42 (9172): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-05 16:21:42 (9172): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-05 16:21:51 (9172): Successfully started VM. (PID = '6444')
2021-05-05 16:21:51 (9172): Reporting VM Process ID to BOINC.
2021-05-05 16:21:51 (9172): Guest Log: 06:59:08.094967 timesync vgsvcTimeSyncWorker: Radical host time change: 61 022 040 000 000ns (HostNow=1 620 213 711 267 000 000 ns HostLast=1 620 152 689 227 000 000 ns)

2021-05-05 16:21:51 (9172): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-05 16:21:51 (9172): Detected: Web Application Enabled (http://localhost:6835)
2021-05-05 16:21:51 (9172): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-05 16:21:51 (9172): Status Report: Job Duration: '864000.000000'
2021-05-05 16:21:51 (9172): Status Report: Elapsed Time: '25147.000000'
2021-05-05 16:21:51 (9172): Status Report: CPU Time: '21916.140625'
2021-05-05 16:21:51 (9172): Preference change detected
2021-05-05 16:21:51 (9172): Setting CPU throttle for VM. (99%)
2021-05-05 16:21:52 (9172): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-05 16:22:01 (9172): Guest Log: 06:59:18.104733 timesync vgsvcTimeSyncWorker: Radical guest time change: 61 022 049 612 000ns (GuestNow=1 620 213 721 276 745 000 ns GuestLast=1 620 152 699 227 133 000 ns fSetTimeLastLoop=true )

2021-05-05 16:30:03 (9172): Stopping VM.
2021-05-05 18:41:10 (3320): Detected: vboxwrapper 26197
2021-05-05 18:41:10 (3320): Detected: BOINC client v7.7
2021-05-05 18:41:11 (3320): Detected: VirtualBox VboxManage Interface (Version: 6.1.18)
2021-05-05 18:41:11 (3320): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-05-05 18:41:11 (3320): Starting VM using VBoxManage interface. (boinc_ce0ad2414be53a88, slot#3)
2021-05-05 18:41:20 (3320): Successfully started VM. (PID = '10212')
2021-05-05 18:41:20 (3320): Reporting VM Process ID to BOINC.
2021-05-05 18:41:20 (3320): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-05-05 18:41:20 (3320): Detected: Web Application Enabled (http://localhost:6835)
2021-05-05 18:41:20 (3320): Detected: Remote Desktop Enabled (localhost:6837)
2021-05-05 18:41:20 (3320): Status Report: Job Duration: '864000.000000'
2021-05-05 18:41:20 (3320): Status Report: Elapsed Time: '25638.000000'
2021-05-05 18:41:20 (3320): Status Report: CPU Time: '22413.375000'
2021-05-05 18:41:20 (3320): Preference change detected
2021-05-05 18:41:20 (3320): Setting CPU throttle for VM. (99%)
2021-05-05 18:41:20 (3320): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 400 seconds) or (Vbox_job.xml: 600 seconds))
2021-05-05 18:41:28 (3320): Guest Log: 07:07:28.295069 timesync vgsvcTimeSyncWorker: Radical host time change: 7 885 757 000 000ns (HostNow=1 620 222 087 222 000 000 ns HostLast=1 620 214 201 465 000 000 ns)

2021-05-05 18:41:38 (3320): Guest Log: 07:07:38.296218 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 885 756 096 000ns (GuestNow=1 620 222 097 223 175 000 ns GuestLast=1 620 214 211 467 079 000 ns fSetTimeLastLoop=true )

2021-05-05 20:21:24 (3320): Status Report: Job Duration: '864000.000000'
2021-05-05 20:21:24 (3320): Status Report: Elapsed Time: '31638.000000'
2021-05-05 20:21:24 (3320): Status Report: CPU Time: '28420.468750'
2021-05-05 22:01:29 (3320): Status Report: Job Duration: '864000.000000'
2021-05-05 22:01:29 (3320): Status Report: Elapsed Time: '37638.000000'
2021-05-05 22:01:29 (3320): Status Report: CPU Time: '34421.750000'
2021-05-05 22:48:25 (3320): Guest Log: job: run exitcode=0

2021-05-05 22:48:25 (3320): Guest Log: job: diskusage=2116

2021-05-05 22:48:25 (3320): Guest Log: job: logsize=76 k

2021-05-05 22:48:25 (3320): Guest Log: job: times=

2021-05-05 22:48:25 (3320): Guest Log: 0m0.014s 0m0.020s

2021-05-05 22:48:25 (3320): Guest Log: 610m12.939s 3m18.358s

2021-05-05 22:48:25 (3320): Guest Log: job: cpuusage=36811

2021-05-05 22:48:25 (3320): Guest Log: 20:48:24 MSK +03:00 2021-05-05: cranky: [INFO] Container 'runc' finished with status code 0.

2021-05-05 22:48:25 (3320): Guest Log: 20:48:24 MSK +03:00 2021-05-05: cranky: [INFO] Preparing output.

2021-05-05 22:48:27 (3320): Guest Log: [INFO] Job Finished

2021-05-05 22:48:27 (3320): Guest Log: [INFO] Shutting Down.

2021-05-05 22:48:27 (3320): VM Completion File Detected.
2021-05-05 22:48:27 (3320): VM Completion Message: Job Finished
.
2021-05-05 22:48:27 (3320): Powering off VM.
2021-05-05 22:53:28 (3320): VM did not power off when requested.
2021-05-05 22:53:28 (3320): VM was successfully terminated.
2021-05-05 22:53:28 (3320): Deregistering VM. (boinc_ce0ad2414be53a88, slot#3)
2021-05-05 22:53:29 (3320): Removing network bandwidth throttle group from VM.
2021-05-05 22:53:29 (3320): Removing VM from VirtualBox.
22:53:35 (3320): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN