Name CMS_1278595_1637996972.608635_0
Workunit 2144594
Created 27 Nov 2021, 7:09:35 UTC
Sent 28 Nov 2021, 17:51:48 UTC
Report deadline 5 Dec 2021, 17:51:48 UTC
Received 2 Dec 2021, 0:05:25 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4164
Run time 17 hours 58 min 38 sec
CPU time 6 hours 40 min 54 sec
Validate state Valid
Credit 5,829.76
Device peak FLOPS 24.30 GFLOPS
Application version CMS Simulation v60.55 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 95.54 MB
Peak swap size 116.69 MB
Peak disk usage 6.78 GB

Stderr output

<core_client_version>7.16.20</core_client_version>
<![CDATA[
<stderr_txt>
2021-11-30 17:51:29 (27396): Detected: vboxwrapper 26202
2021-11-30 17:51:29 (27396): Detected: BOINC client v7.16.20
2021-11-30 17:51:30 (27396): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-11-30 17:51:30 (27396): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-11-30 17:51:30 (27396): Successfully copied 'init_data.xml' to the shared directory.
2021-11-30 17:51:31 (27396): Create VM. (boinc_85e0c2ca8d3ce270, slot#1)
2021-11-30 17:51:32 (27396): Setting Memory Size for VM. (6376MB)
2021-11-30 17:51:32 (27396): Setting CPU Count for VM. (6)
2021-11-30 17:51:32 (27396): Setting Chipset Options for VM.
2021-11-30 17:51:33 (27396): Setting Boot Options for VM.
2021-11-30 17:51:33 (27396): Setting Network Configuration for NAT.
2021-11-30 17:51:33 (27396): Enabling VM Network Access.
2021-11-30 17:51:33 (27396): Disabling USB Support for VM.
2021-11-30 17:51:34 (27396): Disabling COM Port Support for VM.
2021-11-30 17:51:34 (27396): Disabling LPT Port Support for VM.
2021-11-30 17:51:34 (27396): Disabling Audio Support for VM.
2021-11-30 17:51:34 (27396): Disabling Clipboard Support for VM.
2021-11-30 17:51:35 (27396): Disabling Drag and Drop Support for VM.
2021-11-30 17:51:35 (27396): Adding storage controller(s) to VM.
2021-11-30 17:51:35 (27396): Adding virtual disk drive to VM. (vm_image.vdi)
2021-11-30 17:51:36 (27396): Adding VirtualBox Guest Additions to VM.
2021-11-30 17:51:36 (27396): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-11-30 17:51:36 (27396): forwarding host port 62191 to guest port 80
2021-11-30 17:51:36 (27396): Enabling remote desktop for VM.
2021-11-30 17:51:37 (27396): Required extension pack not installed, remote desktop not enabled.
2021-11-30 17:51:37 (27396): Enabling shared directory for VM.
2021-11-30 17:51:37 (27396): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-11-30 17:51:41 (27396): Successfully started VM. (PID = '4548')
2021-11-30 17:51:41 (27396): Reporting VM Process ID to BOINC.
2021-11-30 17:51:41 (27396): Guest Log: BIOS: VirtualBox 6.0.14
2021-11-30 17:51:41 (27396): Guest Log: CPUID EDX: 0x178bfbff
2021-11-30 17:51:41 (27396): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2021-11-30 17:51:41 (27396): VM state change detected. (old = 'poweredoff', new = 'running')
2021-11-30 17:51:42 (27396): Detected: Web Application Enabled (http://localhost:62191)
2021-11-30 17:51:43 (27396): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 17:51:53 (27396): Preference change detected
2021-11-30 17:51:53 (27396): Setting CPU throttle for VM. (100%)
2021-11-30 17:51:53 (27396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-11-30 17:51:54 (27396): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 17:51:55 (27396): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2021-11-30 17:51:55 (27396): Guest Log: BIOS: Booting from Hard Disk...
2021-11-30 17:51:57 (27396): Guest Log: BIOS: KBD: unsupported int 16h function 03
2021-11-30 17:51:57 (27396): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2021-11-30 17:52:23 (27396): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2021-11-30 17:52:23 (27396): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2021-11-30 17:52:24 (27396): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2021-11-30 17:52:24 (27396): Guest Log: 00:00:00.000151 main     Log opened 2021-11-30T16:52:23.700019000Z
2021-11-30 17:52:24 (27396): Guest Log: 00:00:00.000293 main     OS Product: Linux
2021-11-30 17:52:24 (27396): Guest Log: 00:00:00.000329 main     OS Release: 4.14.232-19.cernvm.x86_64
2021-11-30 17:52:24 (27396): Guest Log: 00:00:00.000367 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2021-11-30 17:52:24 (27396): Guest Log: 00:00:00.000395 main     Executable: /usr/sbin/VBoxService
2021-11-30 17:52:24 (27396): Guest Log: 00:00:00.000396 main     Process ID: 2340
2021-11-30 17:52:24 (27396): Guest Log: 00:00:00.000396 main     Package type: LINUX_64BITS_GENERIC
2021-11-30 17:52:24 (27396): Guest Log: 00:00:00.004111 main     5.2.6 r120293 started. Verbose level = 0
2021-11-30 17:52:38 (27396): Guest Log: [INFO] Mounting the shared directory
2021-11-30 17:52:38 (27396): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2021-11-30 17:52:38 (27396): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2021-11-30 17:52:38 (27396): Guest Log: [INFO] Testing connection to cern.ch
2021-11-30 17:52:39 (27396): Guest Log: [INFO] Testing connection to VCCS
2021-11-30 17:52:39 (27396): Guest Log: [INFO] Testing connection to HTCondor
2021-11-30 17:52:39 (27396): Guest Log: [INFO] Testing connection to WMAgent
2021-11-30 17:52:39 (27396): Guest Log: [INFO] Testing connection to Frontier
2021-11-30 17:52:40 (27396): Guest Log: [INFO] Could not find a local HTTP proxy
2021-11-30 17:52:40 (27396): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2021-11-30 17:52:40 (27396): Guest Log: [INFO] This makes the application less efficient
2021-11-30 17:52:40 (27396): Guest Log: [INFO] It also puts higher load on the project servers
2021-11-30 17:52:40 (27396): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2021-11-30 17:52:40 (27396): Guest Log: [INFO] Advice can be found in the project forum
2021-11-30 17:52:40 (27396): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2021-11-30 17:52:46 (27396): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2021-11-30 17:52:46 (27396): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2021-11-30 17:52:48 (27396): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2021-11-30 17:52:48 (27396): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2021-11-30 17:52:49 (27396): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2021-11-30 17:52:56 (27396): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2021-11-30 17:52:58 (27396): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2021-11-30 17:52:58 (27396): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2021-11-30 17:52:58 (27396): Guest Log: [INFO] Reading volunteer information
2021-11-30 17:53:09 (27396): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2021-11-30 17:53:10 (27396): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2021-11-30 17:53:12 (27396): Guest Log: [INFO] CMS application starting. Check log files.
2021-11-30 18:11:05 (27396): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:11:45 (27396): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:12:55 (27396): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:13:05 (27396): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:13:55 (27396): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:14:05 (27396): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:14:25 (27396): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:14:35 (27396): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:14:53 (27396): Stopping VM.
2021-11-30 18:15:15 (27396): Successfully stopped VM.
2021-11-30 18:16:30 (11188): Detected: vboxwrapper 26202
2021-11-30 18:16:30 (11188): Detected: BOINC client v7.16.20
2021-11-30 18:16:31 (11188): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-11-30 18:16:31 (11188): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-11-30 18:16:32 (11188): Guest Log: BIOS: VirtualBox 6.0.14
2021-11-30 18:16:32 (11188): Guest Log: CPUID EDX: 0x178bfbff
2021-11-30 18:16:32 (11188): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2021-11-30 18:16:32 (11188): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2021-11-30 18:16:32 (11188): Guest Log: BIOS: Booting from Hard Disk...
2021-11-30 18:16:32 (11188): Guest Log: BIOS: KBD: unsupported int 16h function 03
2021-11-30 18:16:32 (11188): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2021-11-30 18:16:32 (11188): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2021-11-30 18:16:32 (11188): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2021-11-30 18:16:32 (11188): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2021-11-30 18:16:32 (11188): Guest Log: 00:00:00.000151 main     Log opened 2021-11-30T16:52:23.700019000Z
2021-11-30 18:16:32 (11188): Guest Log: 00:00:00.000293 main     OS Product: Linux
2021-11-30 18:16:32 (11188): Guest Log: 00:00:00.000329 main     OS Release: 4.14.232-19.cernvm.x86_64
2021-11-30 18:16:32 (11188): Guest Log: 00:00:00.000367 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2021-11-30 18:16:32 (11188): Guest Log: 00:00:00.000395 main     Executable: /usr/sbin/VBoxService
2021-11-30 18:16:32 (11188): Guest Log: 00:00:00.000396 main     Process ID: 2340
2021-11-30 18:16:32 (11188): Guest Log: 00:00:00.000396 main     Package type: LINUX_64BITS_GENERIC
2021-11-30 18:16:32 (11188): Guest Log: 00:00:00.004111 main     5.2.6 r120293 started. Verbose level = 0
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Mounting the shared directory
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Testing connection to cern.ch
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Testing connection to VCCS
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Testing connection to HTCondor
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Testing connection to WMAgent
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Testing connection to Frontier
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Could not find a local HTTP proxy
2021-11-30 18:16:32 (11188): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2021-11-30 18:16:32 (11188): Guest Log: [INFO] This makes the application less efficient
2021-11-30 18:16:32 (11188): Guest Log: [INFO] It also puts higher load on the project servers
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Advice can be found in the project forum
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2021-11-30 18:16:32 (11188): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Reading volunteer information
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2021-11-30 18:16:32 (11188): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2021-11-30 18:16:32 (11188): Guest Log: [INFO] CMS application starting. Check log files.
2021-11-30 18:16:32 (11188): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-11-30 18:16:48 (11188): Successfully started VM. (PID = '33492')
2021-11-30 18:16:48 (11188): Reporting VM Process ID to BOINC.
2021-11-30 18:16:48 (11188): VM state change detected. (old = 'poweredoff', new = 'running')
2021-11-30 18:16:48 (11188): Detected: Web Application Enabled (http://localhost:62191)
2021-11-30 18:16:49 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:16:56 (11188): Preference change detected
2021-11-30 18:16:56 (11188): Setting CPU throttle for VM. (100%)
2021-11-30 18:16:56 (11188): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-11-30 18:16:57 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:24:17 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:24:27 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:28:27 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:28:47 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:30:27 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:30:37 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:30:58 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:31:08 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:35:41 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:35:58 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:40:52 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:41:08 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:41:59 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:42:10 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:44:21 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:44:39 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:44:59 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:45:09 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:45:40 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:45:50 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:46:20 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:46:30 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:48:01 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:48:20 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:50:30 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:50:40 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:51:11 (11188): VM state change detected. (old = 'running', new = 'paused')
2021-11-30 18:51:51 (11188): VM state change detected. (old = 'paused', new = 'running')
2021-11-30 18:52:23 (11188): Stopping VM.
2021-11-30 18:52:47 (11188): Successfully stopped VM.
2021-11-30 18:58:44 (17064): Detected: vboxwrapper 26202
2021-11-30 18:58:44 (17064): Detected: BOINC client v7.16.20
2021-11-30 18:58:45 (17064): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-11-30 18:58:45 (17064): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-11-30 18:58:46 (17064): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-11-30 18:59:00 (17064): Successfully started VM. (PID = '25892')
2021-11-30 18:59:00 (17064): Reporting VM Process ID to BOINC.
2021-11-30 18:59:00 (17064): VM state change detected. (old = 'poweredoff', new = 'running')
2021-11-30 18:59:00 (17064): Detected: Web Application Enabled (http://localhost:62191)
2021-11-30 18:59:00 (17064): Preference change detected
2021-11-30 18:59:00 (17064): Setting CPU throttle for VM. (100%)
2021-11-30 18:59:01 (17064): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-11-30 19:45:51 (17064): Status Report: Job Duration: '64800.000000'
2021-11-30 19:45:51 (17064): Status Report: Elapsed Time: '6000.610407'
2021-11-30 19:45:51 (17064): Status Report: CPU Time: '7247.250000'
2021-11-30 20:50:02 (17064): Stopping VM.
2021-11-30 20:50:28 (17064): Successfully stopped VM.
2021-11-30 21:54:07 (39824): Detected: vboxwrapper 26202
2021-11-30 21:54:07 (39824): Detected: BOINC client v7.16.20
2021-11-30 21:54:08 (39824): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-11-30 21:54:08 (39824): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-11-30 21:54:09 (39824): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-11-30 21:54:27 (39824): Successfully started VM. (PID = '45060')
2021-11-30 21:54:27 (39824): Reporting VM Process ID to BOINC.
2021-11-30 21:54:27 (39824): VM state change detected. (old = 'poweredoff', new = 'running')
2021-11-30 21:54:27 (39824): Detected: Web Application Enabled (http://localhost:62191)
2021-11-30 21:54:27 (39824): Status Report: Job Duration: '64800.000000'
2021-11-30 21:54:27 (39824): Status Report: Elapsed Time: '9848.610407'
2021-11-30 21:54:27 (39824): Status Report: CPU Time: '11573.640625'
2021-11-30 21:54:27 (39824): Preference change detected
2021-11-30 21:54:27 (39824): Setting CPU throttle for VM. (100%)
2021-11-30 21:54:27 (39824): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-11-30 21:54:32 (39824): Guest Log: 02:44:36.972026 timesync vgsvcTimeSyncWorker: Radical host time change: 3 873 406 000 000ns (HostNow=1 638 305 671 538 000 000 ns HostLast=1 638 301 798 132 000 000 ns)
2021-11-30 21:54:42 (39824): Guest Log: 02:44:46.996897 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 873 144 291 000ns (GuestNow=1 638 305 681 563 576 000 ns GuestLast=1 638 301 808 419 285 000 ns fSetTimeLastLoop=true )
2021-11-30 22:54:41 (39824): Stopping VM.
2021-11-30 22:55:14 (39824): Successfully stopped VM.
2021-11-30 23:55:58 (35624): Detected: vboxwrapper 26202
2021-11-30 23:55:58 (35624): Detected: BOINC client v7.16.20
2021-11-30 23:55:59 (35624): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-11-30 23:56:00 (35624): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-11-30 23:56:00 (35624): Guest Log: 02:44:36.972026 timesync vgsvcTimeSyncWorker: Radical host time change: 3 873 406 000 000ns (HostNow=1 638 305 671 538 000 000 ns HostLast=1 638 301 798 132 000 000 ns)
2021-11-30 23:56:00 (35624): Guest Log: 02:44:46.996897 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 873 144 291 000ns (GuestNow=1 638 305 681 563 576 000 ns GuestLast=1 638 301 808 419 285 000 ns fSetTimeLastLoop=true )
2021-11-30 23:56:00 (35624): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-11-30 23:56:18 (35624): Successfully started VM. (PID = '27140')
2021-11-30 23:56:18 (35624): Reporting VM Process ID to BOINC.
2021-11-30 23:56:18 (35624): VM state change detected. (old = 'poweredoff', new = 'running')
2021-11-30 23:56:18 (35624): Detected: Web Application Enabled (http://localhost:62191)
2021-11-30 23:56:18 (35624): Status Report: Job Duration: '64800.000000'
2021-11-30 23:56:18 (35624): Status Report: Elapsed Time: '13459.610407'
2021-11-30 23:56:18 (35624): Status Report: CPU Time: '15892.062500'
2021-11-30 23:56:18 (35624): Preference change detected
2021-11-30 23:56:18 (35624): Setting CPU throttle for VM. (100%)
2021-11-30 23:56:18 (35624): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-11-30 23:56:23 (35624): Guest Log: 03:44:53.190664 timesync vgsvcTimeSyncWorker: Radical host time change: 3 704 919 000 000ns (HostNow=1 638 312 982 759 000 000 ns HostLast=1 638 309 277 840 000 000 ns)
2021-11-30 23:56:33 (35624): Guest Log: 03:45:03.193742 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 705 005 189 000ns (GuestNow=1 638 312 992 762 303 000 ns GuestLast=1 638 309 287 757 114 000 ns fSetTimeLastLoop=true )
2021-12-01 00:56:34 (35624): Stopping VM.
2021-12-01 00:57:10 (35624): Successfully stopped VM.
2021-12-01 01:58:09 (41400): Detected: vboxwrapper 26202
2021-12-01 01:58:09 (41400): Detected: BOINC client v7.16.20
2021-12-01 01:58:10 (41400): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 01:58:10 (41400): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 01:58:10 (41400): Guest Log: 03:44:53.190664 timesync vgsvcTimeSyncWorker: Radical host time change: 3 704 919 000 000ns (HostNow=1 638 312 982 759 000 000 ns HostLast=1 638 309 277 840 000 000 ns)
2021-12-01 01:58:10 (41400): Guest Log: 03:45:03.193742 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 705 005 189 000ns (GuestNow=1 638 312 992 762 303 000 ns GuestLast=1 638 309 287 757 114 000 ns fSetTimeLastLoop=true )
2021-12-01 01:58:10 (41400): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 01:58:29 (41400): Successfully started VM. (PID = '28624')
2021-12-01 01:58:29 (41400): Reporting VM Process ID to BOINC.
2021-12-01 01:58:29 (41400): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 01:58:29 (41400): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 01:58:30 (41400): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 01:58:37 (41400): Status Report: Job Duration: '64800.000000'
2021-12-01 01:58:37 (41400): Status Report: Elapsed Time: '17071.610407'
2021-12-01 01:58:37 (41400): Status Report: CPU Time: '20173.843750'
2021-12-01 01:58:37 (41400): Preference change detected
2021-12-01 01:58:37 (41400): Setting CPU throttle for VM. (100%)
2021-12-01 01:58:37 (41400): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 01:58:38 (41400): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 01:58:39 (41400): Guest Log: 04:45:08.787713 timesync vgsvcTimeSyncWorker: Radical host time change: 3 730 902 000 000ns (HostNow=1 638 320 319 340 000 000 ns HostLast=1 638 316 588 438 000 000 ns)
2021-12-01 01:58:49 (41400): Guest Log: 04:45:18.795868 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 730 992 525 000ns (GuestNow=1 638 320 329 348 469 000 ns GuestLast=1 638 316 598 355 944 000 ns fSetTimeLastLoop=true )
2021-12-01 03:20:45 (41400): Stopping VM.
2021-12-01 03:21:20 (41400): Successfully stopped VM.
2021-12-01 04:21:48 (31372): Detected: vboxwrapper 26202
2021-12-01 04:21:48 (31372): Detected: BOINC client v7.16.20
2021-12-01 04:21:49 (31372): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 04:21:49 (31372): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 04:21:50 (31372): Guest Log: 04:45:08.787713 timesync vgsvcTimeSyncWorker: Radical host time change: 3 730 902 000 000ns (HostNow=1 638 320 319 340 000 000 ns HostLast=1 638 316 588 438 000 000 ns)
2021-12-01 04:21:50 (31372): Guest Log: 04:45:18.795868 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 730 992 525 000ns (GuestNow=1 638 320 329 348 469 000 ns GuestLast=1 638 316 598 355 944 000 ns fSetTimeLastLoop=true )
2021-12-01 04:21:50 (31372): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 04:22:07 (31372): Successfully started VM. (PID = '11100')
2021-12-01 04:22:07 (31372): Reporting VM Process ID to BOINC.
2021-12-01 04:22:07 (31372): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 04:22:07 (31372): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 04:22:07 (31372): Status Report: Job Duration: '64800.000000'
2021-12-01 04:22:07 (31372): Status Report: Elapsed Time: '21995.610407'
2021-12-01 04:22:07 (31372): Status Report: CPU Time: '21652.234375'
2021-12-01 04:22:07 (31372): Preference change detected
2021-12-01 04:22:07 (31372): Setting CPU throttle for VM. (100%)
2021-12-01 04:22:08 (31372): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 04:22:11 (31372): Guest Log: 06:07:20.840413 timesync vgsvcTimeSyncWorker: Radical host time change: 3 690 327 000 000ns (HostNow=1 638 328 931 720 000 000 ns HostLast=1 638 325 241 393 000 000 ns)
2021-12-01 04:22:21 (31372): Guest Log: 06:07:30.852094 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 690 339 216 000ns (GuestNow=1 638 328 941 731 943 000 ns GuestLast=1 638 325 251 392 727 000 ns fSetTimeLastLoop=true )
2021-12-01 05:43:13 (31372): Stopping VM.
2021-12-01 05:43:49 (31372): Successfully stopped VM.
2021-12-01 06:44:36 (21856): Detected: vboxwrapper 26202
2021-12-01 06:44:36 (21856): Detected: BOINC client v7.16.20
2021-12-01 06:44:37 (21856): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 06:44:37 (21856): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 06:44:38 (21856): Guest Log: 06:07:20.840413 timesync vgsvcTimeSyncWorker: Radical host time change: 3 690 327 000 000ns (HostNow=1 638 328 931 720 000 000 ns HostLast=1 638 325 241 393 000 000 ns)
2021-12-01 06:44:38 (21856): Guest Log: 06:07:30.852094 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 690 339 216 000ns (GuestNow=1 638 328 941 731 943 000 ns GuestLast=1 638 325 251 392 727 000 ns fSetTimeLastLoop=true )
2021-12-01 06:44:38 (21856): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 06:44:55 (21856): Successfully started VM. (PID = '45172')
2021-12-01 06:44:55 (21856): Reporting VM Process ID to BOINC.
2021-12-01 06:44:55 (21856): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 06:44:55 (21856): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 06:44:55 (21856): Status Report: Job Duration: '64800.000000'
2021-12-01 06:44:55 (21856): Status Report: Elapsed Time: '26857.610407'
2021-12-01 06:44:55 (21856): Status Report: CPU Time: '21879.015625'
2021-12-01 06:44:55 (21856): Preference change detected
2021-12-01 06:44:55 (21856): Setting CPU throttle for VM. (100%)
2021-12-01 06:44:56 (21856): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 06:45:03 (21856): Guest Log: 07:28:32.611343 timesync vgsvcTimeSyncWorker: Radical host time change: 3 709 772 000 000ns (HostNow=1 638 337 503 244 000 000 ns HostLast=1 638 333 793 472 000 000 ns)
2021-12-01 06:45:13 (21856): Guest Log: 07:28:42.614212 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 709 757 862 000ns (GuestNow=1 638 337 513 247 946 000 ns GuestLast=1 638 333 803 490 084 000 ns fSetTimeLastLoop=true )
2021-12-01 07:39:54 (21856): Stopping VM.
2021-12-01 07:40:29 (21856): Successfully stopped VM.
2021-12-01 08:56:20 (34116): Detected: vboxwrapper 26202
2021-12-01 08:56:20 (34116): Detected: BOINC client v7.16.20
2021-12-01 08:56:21 (34116): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 08:56:21 (34116): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 08:56:22 (34116): Guest Log: 07:28:32.611343 timesync vgsvcTimeSyncWorker: Radical host time change: 3 709 772 000 000ns (HostNow=1 638 337 503 244 000 000 ns HostLast=1 638 333 793 472 000 000 ns)
2021-12-01 08:56:22 (34116): Guest Log: 07:28:42.614212 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 709 757 862 000ns (GuestNow=1 638 337 513 247 946 000 ns GuestLast=1 638 333 803 490 084 000 ns fSetTimeLastLoop=true )
2021-12-01 08:56:22 (34116): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 08:56:42 (34116): Successfully started VM. (PID = '33852')
2021-12-01 08:56:42 (34116): Reporting VM Process ID to BOINC.
2021-12-01 08:56:42 (34116): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 08:56:42 (34116): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 08:56:44 (34116): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 08:56:49 (34116): Status Report: Job Duration: '64800.000000'
2021-12-01 08:56:49 (34116): Status Report: Elapsed Time: '30153.610407'
2021-12-01 08:56:49 (34116): Status Report: CPU Time: '22039.484375'
2021-12-01 08:56:49 (34116): Preference change detected
2021-12-01 08:56:49 (34116): Setting CPU throttle for VM. (100%)
2021-12-01 08:56:49 (34116): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 08:56:50 (34116): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 08:56:56 (34116): Guest Log: 08:23:33.824072 timesync vgsvcTimeSyncWorker: Radical host time change: 4 621 475 000 000ns (HostNow=1 638 345 415 874 000 000 ns HostLast=1 638 340 794 399 000 000 ns)
2021-12-01 08:57:06 (34116): Guest Log: 08:23:43.828287 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 621 421 293 000ns (GuestNow=1 638 345 425 878 626 000 ns GuestLast=1 638 340 804 457 333 000 ns fSetTimeLastLoop=true )
2021-12-01 10:36:54 (34116): Status Report: Job Duration: '64800.000000'
2021-12-01 10:36:54 (34116): Status Report: Elapsed Time: '36153.610407'
2021-12-01 10:36:54 (34116): Status Report: CPU Time: '22403.750000'
2021-12-01 11:06:02 (34116): Stopping VM.
2021-12-01 11:06:38 (34116): Successfully stopped VM.
2021-12-01 12:07:14 (13396): Detected: vboxwrapper 26202
2021-12-01 12:07:14 (13396): Detected: BOINC client v7.16.20
2021-12-01 12:07:15 (13396): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 12:07:15 (13396): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 12:07:16 (13396): Guest Log: 08:23:33.824072 timesync vgsvcTimeSyncWorker: Radical host time change: 4 621 475 000 000ns (HostNow=1 638 345 415 874 000 000 ns HostLast=1 638 340 794 399 000 000 ns)
2021-12-01 12:07:16 (13396): Guest Log: 08:23:43.828287 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 621 421 293 000ns (GuestNow=1 638 345 425 878 626 000 ns GuestLast=1 638 340 804 457 333 000 ns fSetTimeLastLoop=true )
2021-12-01 12:07:16 (13396): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 12:07:34 (13396): Successfully started VM. (PID = '20488')
2021-12-01 12:07:34 (13396): Reporting VM Process ID to BOINC.
2021-12-01 12:07:34 (13396): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 12:07:34 (13396): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 12:07:34 (13396): Status Report: Job Duration: '64800.000000'
2021-12-01 12:07:34 (13396): Status Report: Elapsed Time: '37899.610407'
2021-12-01 12:07:34 (13396): Status Report: CPU Time: '22504.453125'
2021-12-01 12:07:34 (13396): Preference change detected
2021-12-01 12:07:34 (13396): Setting CPU throttle for VM. (100%)
2021-12-01 12:07:35 (13396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 12:07:39 (13396): Guest Log: 10:32:47.300803 timesync vgsvcTimeSyncWorker: Radical host time change: 3 700 103 000 000ns (HostNow=1 638 356 859 446 000 000 ns HostLast=1 638 353 159 343 000 000 ns)
2021-12-01 12:07:49 (13396): Guest Log: 10:32:57.305103 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 700 100 403 000ns (GuestNow=1 638 356 869 450 914 000 ns GuestLast=1 638 353 169 350 511 000 ns fSetTimeLastLoop=true )
2021-12-01 13:29:49 (13396): Stopping VM.
2021-12-01 13:30:23 (13396): Successfully stopped VM.
2021-12-01 14:31:09 (27312): Detected: vboxwrapper 26202
2021-12-01 14:31:09 (27312): Detected: BOINC client v7.16.20
2021-12-01 14:31:10 (27312): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 14:31:11 (27312): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 14:31:11 (27312): Guest Log: 10:32:47.300803 timesync vgsvcTimeSyncWorker: Radical host time change: 3 700 103 000 000ns (HostNow=1 638 356 859 446 000 000 ns HostLast=1 638 353 159 343 000 000 ns)
2021-12-01 14:31:11 (27312): Guest Log: 10:32:57.305103 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 700 100 403 000ns (GuestNow=1 638 356 869 450 914 000 ns GuestLast=1 638 353 169 350 511 000 ns fSetTimeLastLoop=true )
2021-12-01 14:31:11 (27312): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 14:31:30 (27312): Successfully started VM. (PID = '29848')
2021-12-01 14:31:30 (27312): Reporting VM Process ID to BOINC.
2021-12-01 14:31:30 (27312): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 14:31:30 (27312): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 14:31:30 (27312): Status Report: Job Duration: '64800.000000'
2021-12-01 14:31:30 (27312): Status Report: Elapsed Time: '42829.610407'
2021-12-01 14:31:30 (27312): Status Report: CPU Time: '22805.437500'
2021-12-01 14:31:30 (27312): Preference change detected
2021-12-01 14:31:30 (27312): Setting CPU throttle for VM. (100%)
2021-12-01 14:31:30 (27312): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 14:31:31 (27312): Guest Log: 11:54:59.713037 timesync vgsvcTimeSyncWorker: Radical host time change: 3 708 691 000 000ns (HostNow=1 638 365 490 550 000 000 ns HostLast=1 638 361 781 859 000 000 ns)
2021-12-01 14:31:41 (27312): Guest Log: 11:55:09.714144 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 708 693 098 000ns (GuestNow=1 638 365 500 551 506 000 ns GuestLast=1 638 361 791 858 408 000 ns fSetTimeLastLoop=true )
2021-12-01 15:52:44 (27312): Stopping VM.
2021-12-01 15:53:20 (27312): Successfully stopped VM.
2021-12-01 16:53:55 (44612): Detected: vboxwrapper 26202
2021-12-01 16:53:55 (44612): Detected: BOINC client v7.16.20
2021-12-01 16:53:56 (44612): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 16:53:56 (44612): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 16:53:57 (44612): Guest Log: 11:54:59.713037 timesync vgsvcTimeSyncWorker: Radical host time change: 3 708 691 000 000ns (HostNow=1 638 365 490 550 000 000 ns HostLast=1 638 361 781 859 000 000 ns)
2021-12-01 16:53:57 (44612): Guest Log: 11:55:09.714144 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 708 693 098 000ns (GuestNow=1 638 365 500 551 506 000 ns GuestLast=1 638 361 791 858 408 000 ns fSetTimeLastLoop=true )
2021-12-01 16:53:57 (44612): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 16:54:15 (44612): Successfully started VM. (PID = '39948')
2021-12-01 16:54:15 (44612): Reporting VM Process ID to BOINC.
2021-12-01 16:54:15 (44612): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 16:54:15 (44612): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 16:54:15 (44612): Status Report: Job Duration: '64800.000000'
2021-12-01 16:54:15 (44612): Status Report: Elapsed Time: '47698.610407'
2021-12-01 16:54:15 (44612): Status Report: CPU Time: '23106.390625'
2021-12-01 16:54:15 (44612): Preference change detected
2021-12-01 16:54:15 (44612): Setting CPU throttle for VM. (100%)
2021-12-01 16:54:16 (44612): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 16:54:22 (44612): Guest Log: 13:16:22.007026 timesync vgsvcTimeSyncWorker: Radical host time change: 3 699 544 000 000ns (HostNow=1 638 374 062 380 000 000 ns HostLast=1 638 370 362 836 000 000 ns)
2021-12-01 16:54:32 (44612): Guest Log: 13:16:32.080180 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 699 612 946 000ns (GuestNow=1 638 374 072 455 039 000 ns GuestLast=1 638 370 372 842 093 000 ns fSetTimeLastLoop=true )
2021-12-01 18:16:31 (44612): Stopping VM.
2021-12-01 18:17:07 (44612): Successfully stopped VM.
2021-12-01 19:18:13 (17668): Detected: vboxwrapper 26202
2021-12-01 19:18:13 (17668): Detected: BOINC client v7.16.20
2021-12-01 19:18:14 (17668): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 19:18:14 (17668): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 19:18:15 (17668): Guest Log: 13:16:22.007026 timesync vgsvcTimeSyncWorker: Radical host time change: 3 699 544 000 000ns (HostNow=1 638 374 062 380 000 000 ns HostLast=1 638 370 362 836 000 000 ns)
2021-12-01 19:18:15 (17668): Guest Log: 13:16:32.080180 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 699 612 946 000ns (GuestNow=1 638 374 072 455 039 000 ns GuestLast=1 638 370 372 842 093 000 ns fSetTimeLastLoop=true )
2021-12-01 19:18:15 (17668): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 19:18:34 (17668): Successfully started VM. (PID = '35428')
2021-12-01 19:18:34 (17668): Reporting VM Process ID to BOINC.
2021-12-01 19:18:34 (17668): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 19:18:34 (17668): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 19:18:36 (17668): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 19:18:44 (17668): Status Report: Job Duration: '64800.000000'
2021-12-01 19:18:44 (17668): Status Report: Elapsed Time: '52629.610407'
2021-12-01 19:18:44 (17668): Status Report: CPU Time: '23425.406250'
2021-12-01 19:18:44 (17668): Preference change detected
2021-12-01 19:18:44 (17668): Setting CPU throttle for VM. (100%)
2021-12-01 19:18:44 (17668): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 19:18:44 (17668): Guest Log: 14:38:34.126714 timesync vgsvcTimeSyncWorker: Radical host time change: 3 739 891 000 000ns (HostNow=1 638 382 724 398 000 000 ns HostLast=1 638 378 984 507 000 000 ns)
2021-12-01 19:18:44 (17668): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 19:18:54 (17668): Guest Log: 14:38:44.139216 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 739 908 882 000ns (GuestNow=1 638 382 734 410 651 000 ns GuestLast=1 638 378 994 501 769 000 ns fSetTimeLastLoop=true )
2021-12-01 20:17:28 (17668): Stopping VM.
2021-12-01 20:18:02 (17668): Successfully stopped VM.
2021-12-01 21:32:20 (40004): Detected: vboxwrapper 26202
2021-12-01 21:32:20 (40004): Detected: BOINC client v7.16.20
2021-12-01 21:32:21 (40004): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 21:32:22 (40004): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 21:32:22 (40004): Guest Log: 14:38:34.126714 timesync vgsvcTimeSyncWorker: Radical host time change: 3 739 891 000 000ns (HostNow=1 638 382 724 398 000 000 ns HostLast=1 638 378 984 507 000 000 ns)
2021-12-01 21:32:22 (40004): Guest Log: 14:38:44.139216 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 739 908 882 000ns (GuestNow=1 638 382 734 410 651 000 ns GuestLast=1 638 378 994 501 769 000 ns fSetTimeLastLoop=true )
2021-12-01 21:32:22 (40004): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 21:32:41 (40004): Successfully started VM. (PID = '20872')
2021-12-01 21:32:41 (40004): Reporting VM Process ID to BOINC.
2021-12-01 21:32:41 (40004): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 21:32:41 (40004): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 21:32:42 (40004): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 21:32:51 (40004): Status Report: Job Duration: '64800.000000'
2021-12-01 21:32:51 (40004): Status Report: Elapsed Time: '56150.610407'
2021-12-01 21:32:51 (40004): Status Report: CPU Time: '23628.125000'
2021-12-01 21:32:51 (40004): Preference change detected
2021-12-01 21:32:51 (40004): Setting CPU throttle for VM. (100%)
2021-12-01 21:32:51 (40004): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 21:32:52 (40004): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 21:32:57 (40004): Guest Log: 15:37:26.008531 timesync vgsvcTimeSyncWorker: Radical host time change: 4 530 638 000 000ns (HostNow=1 638 390 776 916 000 000 ns HostLast=1 638 386 246 278 000 000 ns)
2021-12-01 21:33:07 (40004): Guest Log: 15:37:36.018858 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 530 646 818 000ns (GuestNow=1 638 390 786 926 571 000 ns GuestLast=1 638 386 256 279 753 000 ns fSetTimeLastLoop=true )
2021-12-01 21:44:25 (40004): Stopping VM.
2021-12-01 21:45:02 (40004): Successfully stopped VM.
2021-12-01 22:45:48 (25328): Detected: vboxwrapper 26202
2021-12-01 22:45:48 (25328): Detected: BOINC client v7.16.20
2021-12-01 22:45:48 (25328): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2021-12-01 22:45:49 (25328): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-12-01 22:45:49 (25328): Guest Log: 15:37:26.008531 timesync vgsvcTimeSyncWorker: Radical host time change: 4 530 638 000 000ns (HostNow=1 638 390 776 916 000 000 ns HostLast=1 638 386 246 278 000 000 ns)
2021-12-01 22:45:49 (25328): Guest Log: 15:37:36.018858 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 530 646 818 000ns (GuestNow=1 638 390 786 926 571 000 ns GuestLast=1 638 386 256 279 753 000 ns fSetTimeLastLoop=true )
2021-12-01 22:45:49 (25328): Starting VM using VBoxManage interface. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-01 22:46:18 (25328): Successfully started VM. (PID = '36036')
2021-12-01 22:46:18 (25328): Reporting VM Process ID to BOINC.
2021-12-01 22:46:18 (25328): Guest Log: 15:48:56.640026 timesync vgsvcTimeSyncWorker: Radical host time change: 3 720 892 000 000ns (HostNow=1 638 395 178 431 000 000 ns HostLast=1 638 391 457 539 000 000 ns)
2021-12-01 22:46:18 (25328): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-01 22:46:18 (25328): Detected: Web Application Enabled (http://localhost:62191)
2021-12-01 22:46:19 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 22:46:25 (25328): Status Report: Job Duration: '64800.000000'
2021-12-01 22:46:25 (25328): Status Report: Elapsed Time: '56844.610407'
2021-12-01 22:46:25 (25328): Status Report: CPU Time: '23674.359375'
2021-12-01 22:46:25 (25328): Preference change detected
2021-12-01 22:46:25 (25328): Setting CPU throttle for VM. (100%)
2021-12-01 22:46:25 (25328): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-12-01 22:46:25 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 22:46:34 (25328): Guest Log: 15:49:06.652902 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 720 896 678 000ns (GuestNow=1 638 395 188 444 130 000 ns GuestLast=1 638 391 467 547 452 000 ns fSetTimeLastLoop=true )
2021-12-01 22:46:35 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 22:46:45 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 22:48:05 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 22:48:15 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 22:50:36 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 22:50:46 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 22:54:47 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 22:54:57 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:10:29 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:10:38 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:13:09 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:13:19 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:13:29 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:13:39 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:13:49 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:13:59 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:14:41 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:14:49 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:16:31 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:16:41 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:22:11 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:22:21 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:23:21 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:23:31 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:24:22 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:24:32 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:31:33 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:31:43 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:32:33 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:32:53 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:36:35 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:36:44 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:39:15 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:39:25 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:42:26 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:42:46 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:46:57 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:47:07 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:48:47 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:49:07 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:49:37 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:49:58 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:50:38 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:50:48 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:51:08 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:51:18 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:51:58 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:52:09 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-01 23:52:29 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-01 23:52:39 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-02 00:00:30 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-02 00:00:40 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-02 00:01:30 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-02 00:01:40 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-02 00:32:08 (25328): Status Report: Job Duration: '64800.000000'
2021-12-02 00:32:08 (25328): Status Report: Elapsed Time: '62844.697840'
2021-12-02 00:32:08 (25328): Status Report: CPU Time: '23972.750000'
2021-12-02 00:51:26 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-02 00:51:36 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-02 01:02:37 (25328): VM state change detected. (old = 'running', new = 'paused')
2021-12-02 01:02:47 (25328): VM state change detected. (old = 'paused', new = 'running')
2021-12-02 01:05:08 (25328): Powering off VM.
2021-12-02 01:05:10 (25328): Successfully stopped VM.
2021-12-02 01:05:10 (25328): Deregistering VM. (boinc_85e0c2ca8d3ce270, slot#1)
2021-12-02 01:05:10 (25328): Removing network bandwidth throttle group from VM.
2021-12-02 01:05:11 (25328): Removing VM from VirtualBox.
01:05:16 (25328): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN