Task 3050267

Name	CMS_1596642_1641196683.703229_0
Workunit	2152666
Created	3 Jan 2022, 7:58:06 UTC
Sent	5 Jan 2022, 22:01:21 UTC
Report deadline	12 Jan 2022, 22:01:21 UTC
Received	7 Jan 2022, 7:51:56 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4039
Run time	11 hours 54 min 21 sec
CPU time	11 hours 42 min 35 sec
Validate state	Valid
Credit	623.24
Device peak FLOPS	3.72 GFLOPS
Application version	CMS Simulation v60.55 (vbox64_mt_mcore_cms) windows_x86_64
Peak working set size	66.56 MB
Peak swap size	86.19 MB
Peak disk usage	4.12 GB
Stderr output

<core_client_version>7.16.20</core_client_version>
<![CDATA[
<stderr_txt>
2022-01-05 16:08:04 (13212): Detected: vboxwrapper 26202
2022-01-05 16:08:04 (13212): Detected: BOINC client v7.16.20
2022-01-05 16:08:04 (13212): Detected: VirtualBox VboxManage Interface (Version: 6.1.16)
2022-01-05 16:08:04 (13212): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-01-05 16:08:04 (13212): Successfully copied 'init_data.xml' to the shared directory.
2022-01-05 16:08:07 (13212): Create VM. (boinc_41c977de772a3748, slot#7)
2022-01-05 16:08:07 (13212): Setting Memory Size for VM. (1896MB)
2022-01-05 16:08:08 (13212): Setting CPU Count for VM. (1)
2022-01-05 16:08:08 (13212): Setting Chipset Options for VM.
2022-01-05 16:08:08 (13212): Setting Boot Options for VM.
2022-01-05 16:08:08 (13212): Setting Network Configuration for NAT.
2022-01-05 16:08:09 (13212): Enabling VM Network Access.
2022-01-05 16:08:09 (13212): Disabling USB Support for VM.
2022-01-05 16:08:09 (13212): Disabling COM Port Support for VM.
2022-01-05 16:08:09 (13212): Disabling LPT Port Support for VM.
2022-01-05 16:08:10 (13212): Disabling Audio Support for VM.
2022-01-05 16:08:10 (13212): Disabling Clipboard Support for VM.
2022-01-05 16:08:10 (13212): Disabling Drag and Drop Support for VM.
2022-01-05 16:08:10 (13212): Adding storage controller(s) to VM.
2022-01-05 16:08:11 (13212): Adding virtual disk drive to VM. (vm_image.vdi)
2022-01-05 16:08:11 (13212): Adding VirtualBox Guest Additions to VM.
2022-01-05 16:08:12 (13212): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2022-01-05 16:08:12 (13212): forwarding host port 60067 to guest port 80
2022-01-05 16:08:12 (13212): Enabling remote desktop for VM.
2022-01-05 16:08:13 (13212): Enabling shared directory for VM.
2022-01-05 16:08:13 (13212): Starting VM using VBoxManage interface. (boinc_41c977de772a3748, slot#7)
2022-01-05 16:08:19 (13212): Successfully started VM. (PID = '6404')
2022-01-05 16:08:19 (13212): Reporting VM Process ID to BOINC.
2022-01-05 16:08:19 (13212): Guest Log: BIOS: VirtualBox 6.1.16
2022-01-05 16:08:19 (13212): Guest Log: CPUID EDX: 0x178bfbff
2022-01-05 16:08:19 (13212): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-01-05 16:08:19 (13212): VM state change detected. (old = 'poweredoff', new = 'running')
2022-01-05 16:08:19 (13212): Detected: Web Application Enabled (http://localhost:60067)
2022-01-05 16:08:19 (13212): Detected: Remote Desktop Enabled (localhost:60069)
2022-01-05 16:08:19 (13212): Preference change detected
2022-01-05 16:08:19 (13212): Setting CPU throttle for VM. (100%)
2022-01-05 16:08:20 (13212): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-01-05 16:08:21 (13212): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-01-05 16:08:21 (13212): Guest Log: BIOS: Booting from Hard Disk...
2022-01-05 16:08:24 (13212): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-01-05 16:08:24 (13212): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-01-05 16:09:00 (13212): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-01-05 16:09:00 (13212): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-01-05 16:09:02 (13212): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-01-05 16:09:02 (13212): Guest Log: 00:00:00.000177 main     Log opened 2022-01-05T22:09:10.624203000Z
2022-01-05 16:09:02 (13212): Guest Log: 00:00:00.000311 main     OS Product: Linux
2022-01-05 16:09:02 (13212): Guest Log: 00:00:00.000366 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-01-05 16:09:02 (13212): Guest Log: 00:00:00.000417 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-01-05 16:09:02 (13212): Guest Log: 00:00:00.000487 main     Executable: /usr/sbin/VBoxService
2022-01-05 16:09:02 (13212): Guest Log: 00:00:00.000489 main     Process ID: 2155
2022-01-05 16:09:02 (13212): Guest Log: 00:00:00.000491 main     Package type: LINUX_64BITS_GENERIC
2022-01-05 16:09:02 (13212): Guest Log: 00:00:00.003975 main     5.2.6 r120293 started. Verbose level = 0
2022-01-05 16:09:23 (13212): Guest Log: [INFO] Mounting the shared directory
2022-01-05 16:09:23 (13212): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-01-05 16:09:23 (13212): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-01-05 16:09:23 (13212): Guest Log: [INFO] Testing connection to cern.ch
2022-01-05 16:09:24 (13212): Guest Log: [INFO] Testing connection to VCCS
2022-01-05 16:09:24 (13212): Guest Log: [INFO] Testing connection to HTCondor
2022-01-05 16:09:25 (13212): Guest Log: [INFO] Testing connection to WMAgent
2022-01-05 16:09:25 (13212): Guest Log: [INFO] Testing connection to EOSCMS
2022-01-05 16:09:25 (13212): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-01-05 16:09:26 (13212): Guest Log: [INFO] Testing connection to Frontier
2022-01-05 16:09:27 (13212): Guest Log: [INFO] Could not find a local HTTP proxy
2022-01-05 16:09:27 (13212): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-01-05 16:09:27 (13212): Guest Log: [INFO] This makes the application less efficient
2022-01-05 16:09:27 (13212): Guest Log: [INFO] It also puts higher load on the project servers
2022-01-05 16:09:27 (13212): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-01-05 16:09:27 (13212): Guest Log: [INFO] Advice can be found in the project forum
2022-01-05 16:09:27 (13212): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-01-05 16:09:44 (13212): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2022-01-05 16:09:45 (13212): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-01-05 16:09:57 (13212): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-01-05 16:09:57 (13212): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-01-05 16:09:58 (13212): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-01-05 16:09:59 (13212): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-01-05 16:10:00 (13212): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-01-05 16:10:00 (13212): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io DIRECT
2022-01-05 16:10:00 (13212): Guest Log: [INFO] Reading volunteer information
2022-01-05 16:10:06 (13212): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-01-05 16:10:07 (13212): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-01-05 16:10:08 (13212): Guest Log: [INFO] CMS application starting. Check log files.
2022-01-05 17:48:24 (13212): Status Report: Job Duration: '64800.000000'
2022-01-05 17:48:24 (13212): Status Report: Elapsed Time: '6000.000000'
2022-01-05 17:48:24 (13212): Status Report: CPU Time: '5875.187500'
2022-01-05 18:49:34 (13212): VM state change detected. (old = 'running', new = 'paused')
2022-01-05 19:08:59 (13212): VM state change detected. (old = 'paused', new = 'running')
2022-01-05 19:47:54 (13212): Status Report: Job Duration: '64800.000000'
2022-01-05 19:47:54 (13212): Status Report: Elapsed Time: '12000.000000'
2022-01-05 19:47:54 (13212): Status Report: CPU Time: '11844.843750'
2022-01-05 20:09:27 (13212): VM state change detected. (old = 'running', new = 'paused')
2022-01-05 20:39:07 (13212): VM state change detected. (old = 'paused', new = 'running')
2022-01-05 20:39:17 (13212): Guest Log: 03:41:07.012193 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 949 167 664 000ns (GuestNow=1 641 436 756 765 621 000 ns GuestLast=1 641 433 807 597 957 000 ns fSetTimeLastLoop=true )
2022-01-05 20:42:29 (13212): VM state change detected. (old = 'running', new = 'paused')
2022-01-06 08:01:28 (6572): Detected: vboxwrapper 26202
2022-01-06 08:01:28 (6572): Detected: BOINC client v7.16.20
2022-01-06 08:01:28 (6572): Detected: VirtualBox VboxManage Interface (Version: 6.1.16)
2022-01-06 08:01:28 (6572): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-01-06 08:01:29 (6572): Guest Log: BIOS: VirtualBox 6.1.16
2022-01-06 08:01:29 (6572): Guest Log: CPUID EDX: 0x178bfbff
2022-01-06 08:01:29 (6572): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-01-06 08:01:29 (6572): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-01-06 08:01:29 (6572): Guest Log: BIOS: Booting from Hard Disk...
2022-01-06 08:01:29 (6572): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-01-06 08:01:29 (6572): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-01-06 08:01:29 (6572): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-01-06 08:01:29 (6572): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-01-06 08:01:29 (6572): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-01-06 08:01:29 (6572): Guest Log: 00:00:00.000177 main     Log opened 2022-01-05T22:09:10.624203000Z
2022-01-06 08:01:29 (6572): Guest Log: 00:00:00.000311 main     OS Product: Linux
2022-01-06 08:01:29 (6572): Guest Log: 00:00:00.000366 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-01-06 08:01:29 (6572): Guest Log: 00:00:00.000417 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-01-06 08:01:29 (6572): Guest Log: 00:00:00.000487 main     Executable: /usr/sbin/VBoxService
2022-01-06 08:01:29 (6572): Guest Log: 00:00:00.000489 main     Process ID: 2155
2022-01-06 08:01:29 (6572): Guest Log: 00:00:00.000491 main     Package type: LINUX_64BITS_GENERIC
2022-01-06 08:01:29 (6572): Guest Log: 00:00:00.003975 main     5.2.6 r120293 started. Verbose level = 0
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Mounting the shared directory
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Testing connection to cern.ch
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Testing connection to VCCS
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Testing connection to HTCondor
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Testing connection to WMAgent
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Testing connection to EOSCMS
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Testing connection to Frontier
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Could not find a local HTTP proxy
2022-01-06 08:01:29 (6572): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-01-06 08:01:29 (6572): Guest Log: [INFO] This makes the application less efficient
2022-01-06 08:01:29 (6572): Guest Log: [INFO] It also puts higher load on the project servers
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Advice can be found in the project forum
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-01-06 08:01:29 (6572): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io DIRECT
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Reading volunteer information
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-01-06 08:01:29 (6572): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-01-06 08:01:29 (6572): Guest Log: [INFO] CMS application starting. Check log files.
2022-01-06 08:01:29 (6572): Guest Log: 03:41:07.012193 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 949 167 664 000ns (GuestNow=1 641 436 756 765 621 000 ns GuestLast=1 641 433 807 597 957 000 ns fSetTimeLastLoop=true )
2022-01-06 08:01:29 (6572): Starting VM using VBoxManage interface. (boinc_41c977de772a3748, slot#7)
2022-01-06 08:01:35 (6572): Successfully started VM. (PID = '7136')
2022-01-06 08:01:35 (6572): Reporting VM Process ID to BOINC.
2022-01-06 08:01:35 (6572): Guest Log: BIOS: VirtualBox 6.1.16
2022-01-06 08:01:35 (6572): Guest Log: CPUID EDX: 0x178bfbff
2022-01-06 08:01:35 (6572): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-01-06 08:01:35 (6572): VM state change detected. (old = 'poweredoff', new = 'running')
2022-01-06 08:01:35 (6572): Detected: Web Application Enabled (http://localhost:60067)
2022-01-06 08:01:35 (6572): Detected: Remote Desktop Enabled (localhost:60069)
2022-01-06 08:01:35 (6572): Status Report: Job Duration: '64800.000000'
2022-01-06 08:01:35 (6572): Status Report: Elapsed Time: '13471.000000'
2022-01-06 08:01:35 (6572): Status Report: CPU Time: '13316.312500'
2022-01-06 08:01:35 (6572): Preference change detected
2022-01-06 08:01:35 (6572): Setting CPU throttle for VM. (100%)
2022-01-06 08:01:35 (6572): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-01-06 08:01:37 (6572): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-01-06 08:01:37 (6572): Guest Log: BIOS: Booting from Hard Disk...
2022-01-06 08:01:40 (6572): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-01-06 08:01:40 (6572): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-01-06 08:02:14 (6572): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-01-06 08:02:14 (6572): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-01-06 08:02:17 (6572): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-01-06 08:02:17 (6572): Guest Log: 00:00:00.000159 main     Log opened 2022-01-06T14:02:20.344295000Z
2022-01-06 08:02:17 (6572): Guest Log: 00:00:00.000477 main     OS Product: Linux
2022-01-06 08:02:17 (6572): Guest Log: 00:00:00.000541 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-01-06 08:02:17 (6572): Guest Log: 00:00:00.000658 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-01-06 08:02:17 (6572): Guest Log: 00:00:00.000702 main     Executable: /usr/sbin/VBoxService
2022-01-06 08:02:17 (6572): Guest Log: 00:00:00.000703 main     Process ID: 2161
2022-01-06 08:02:17 (6572): Guest Log: 00:00:00.000705 main     Package type: LINUX_64BITS_GENERIC
2022-01-06 08:02:17 (6572): Guest Log: 00:00:00.008035 main     5.2.6 r120293 started. Verbose level = 0
2022-01-06 08:02:39 (6572): Guest Log: [INFO] Mounting the shared directory
2022-01-06 08:02:39 (6572): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-01-06 08:02:39 (6572): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-01-06 08:02:39 (6572): Guest Log: [INFO] Testing connection to cern.ch
2022-01-06 08:02:40 (6572): Guest Log: [INFO] Testing connection to VCCS
2022-01-06 08:02:40 (6572): Guest Log: [INFO] Testing connection to HTCondor
2022-01-06 08:02:40 (6572): Guest Log: [INFO] Testing connection to WMAgent
2022-01-06 08:02:41 (6572): Guest Log: [INFO] Testing connection to EOSCMS
2022-01-06 08:02:41 (6572): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-01-06 08:02:42 (6572): Guest Log: [INFO] Testing connection to Frontier
2022-01-06 08:02:43 (6572): Guest Log: [INFO] Could not find a local HTTP proxy
2022-01-06 08:02:43 (6572): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-01-06 08:02:43 (6572): Guest Log: [INFO] This makes the application less efficient
2022-01-06 08:02:43 (6572): Guest Log: [INFO] It also puts higher load on the project servers
2022-01-06 08:02:43 (6572): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-01-06 08:02:43 (6572): Guest Log: [INFO] Advice can be found in the project forum
2022-01-06 08:02:43 (6572): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-01-06 08:03:07 (6572): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2022-01-06 08:03:07 (6572): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-01-06 08:03:19 (6572): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-01-06 08:03:19 (6572): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-01-06 08:03:20 (6572): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-01-06 08:03:21 (6572): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-01-06 08:03:22 (6572): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-01-06 08:03:22 (6572): Guest Log: [INFO] 2.7.2.0 http://s1bnl-cvmfs.openhtc.io DIRECT
2022-01-06 08:03:22 (6572): Guest Log: [INFO] Reading volunteer information
2022-01-06 08:03:24 (6572): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-01-06 08:03:26 (6572): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-01-06 08:03:27 (6572): Guest Log: [INFO] CMS application starting. Check log files.
2022-01-06 09:02:21 (6572): VM state change detected. (old = 'running', new = 'paused')
2022-01-06 10:57:48 (6572): VM state change detected. (old = 'paused', new = 'running')
2022-01-06 10:57:57 (6572): Guest Log: 01:00:11.695083 timesync vgsvcTimeSyncWorker: Radical host time change: 6 937 647 000 000ns (HostNow=1 641 488 277 737 000 000 ns HostLast=1 641 481 340 090 000 000 ns)
2022-01-06 10:58:07 (6572): Guest Log: 01:00:21.702832 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 935 721 393 000ns (GuestNow=1 641 488 287 752 298 000 ns GuestLast=1 641 481 352 030 905 000 ns fSetTimeLastLoop=true )
2022-01-06 11:37:08 (6572): Status Report: Job Duration: '64800.000000'
2022-01-06 11:37:08 (6572): Status Report: Elapsed Time: '19471.000000'
2022-01-06 11:37:08 (6572): Status Report: CPU Time: '19029.328125'
2022-01-06 11:58:07 (6572): VM state change detected. (old = 'running', new = 'paused')
2022-01-06 12:50:09 (6572): VM state change detected. (old = 'paused', new = 'running')
2022-01-06 12:50:11 (6572): Guest Log: 02:00:23.580996 timesync vgsvcTimeSyncWorker: Radical host time change: 3 131 962 000 000ns (HostNow=1 641 495 011 581 000 000 ns HostLast=1 641 491 879 619 000 000 ns)
2022-01-06 12:50:21 (6572): Guest Log: 02:00:33.585049 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 131 966 142 000ns (GuestNow=1 641 495 021 590 803 000 ns GuestLast=1 641 491 889 624 661 000 ns fSetTimeLastLoop=true )
2022-01-06 13:50:38 (6572): VM state change detected. (old = 'running', new = 'paused')
2022-01-06 15:20:34 (6572): VM state change detected. (old = 'paused', new = 'running')
2022-01-06 15:20:39 (6572): Guest Log: 03:00:55.549206 timesync vgsvcTimeSyncWorker: Radical host time change: 5 405 562 000 000ns (HostNow=1 641 504 039 113 000 000 ns HostLast=1 641 498 633 551 000 000 ns)
2022-01-06 15:20:49 (6572): Guest Log: 03:01:05.553849 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 405 562 739 000ns (GuestNow=1 641 504 049 117 669 000 ns GuestLast=1 641 498 643 554 930 000 ns fSetTimeLastLoop=true )
2022-01-06 15:39:11 (6572): Status Report: Job Duration: '64800.000000'
2022-01-06 15:39:11 (6572): Status Report: Elapsed Time: '25471.000000'
2022-01-06 15:39:11 (6572): Status Report: CPU Time: '25018.000000'
2022-01-06 16:21:21 (6572): VM state change detected. (old = 'running', new = 'paused')
2022-01-06 17:22:11 (6572): Guest Log: 04:01:37.469082 timesync vgsvcTimeSyncWorker: Radical host time change: 3 659 454 000 000ns (HostNow=1 641 511 330 330 000 000 ns HostLast=1 641 507 670 876 000 000 ns)
2022-01-06 17:22:11 (6572): VM state change detected. (old = 'paused', new = 'running')
2022-01-06 17:22:21 (6572): Guest Log: 04:01:47.476774 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 659 304 801 000ns (GuestNow=1 641 511 340 337 706 000 ns GuestLast=1 641 507 681 032 905 000 ns fSetTimeLastLoop=true )
2022-01-06 18:20:06 (6572): Status Report: Job Duration: '64800.000000'
2022-01-06 18:20:06 (6572): Status Report: Elapsed Time: '31471.000000'
2022-01-06 18:20:06 (6572): Status Report: CPU Time: '30956.406250'
2022-01-06 18:22:42 (6572): VM state change detected. (old = 'running', new = 'paused')
2022-01-06 19:02:35 (6572): Guest Log: 05:02:09.377102 timesync vgsvcTimeSyncWorker: Radical host time change: 2 402 032 000 000ns (HostNow=1 641 517 354 265 000 000 ns HostLast=1 641 514 952 233 000 000 ns)
2022-01-06 19:02:35 (6572): VM state change detected. (old = 'paused', new = 'running')
2022-01-06 19:02:45 (6572): Guest Log: 05:02:19.387268 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 402 037 182 000ns (GuestNow=1 641 517 364 275 183 000 ns GuestLast=1 641 514 962 238 001 000 ns fSetTimeLastLoop=true )
2022-01-06 20:03:21 (6572): VM state change detected. (old = 'running', new = 'paused')
2022-01-06 21:33:50 (6572): VM state change detected. (old = 'paused', new = 'running')
2022-01-06 21:33:55 (6572): Guest Log: 06:03:01.279447 timesync vgsvcTimeSyncWorker: Radical host time change: 5 438 616 000 000ns (HostNow=1 641 526 434 772 000 000 ns HostLast=1 641 520 996 156 000 000 ns)
2022-01-06 21:34:05 (6572): Guest Log: 06:03:11.284293 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 438 609 595 000ns (GuestNow=1 641 526 444 776 896 000 ns GuestLast=1 641 521 006 167 301 000 ns fSetTimeLastLoop=true )
2022-01-06 22:10:41 (6572): Status Report: Job Duration: '64800.000000'
2022-01-06 22:10:41 (6572): Status Report: Elapsed Time: '37471.000000'
2022-01-06 22:10:41 (6572): Status Report: CPU Time: '36962.625000'
2022-01-06 22:34:45 (6572): VM state change detected. (old = 'running', new = 'paused')
2022-01-06 23:29:13 (6572): VM state change detected. (old = 'paused', new = 'running')
2022-01-06 23:29:14 (6572): Guest Log: 07:03:53.250660 timesync vgsvcTimeSyncWorker: Radical host time change: 3 277 639 000 000ns (HostNow=1 641 533 354 374 000 000 ns HostLast=1 641 530 076 735 000 000 ns)
2022-01-06 23:29:24 (6572): Guest Log: 07:04:03.253644 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 277 633 760 000ns (GuestNow=1 641 533 364 376 995 000 ns GuestLast=1 641 530 086 743 235 000 ns fSetTimeLastLoop=true )
2022-01-07 00:29:41 (6572): VM state change detected. (old = 'running', new = 'paused')
2022-01-07 01:46:15 (6572): VM state change detected. (old = 'paused', new = 'running')
2022-01-07 01:46:20 (6572): Guest Log: 08:04:25.191563 timesync vgsvcTimeSyncWorker: Radical host time change: 4 604 268 000 000ns (HostNow=1 641 541 580 579 000 000 ns HostLast=1 641 536 976 311 000 000 ns)
2022-01-07 01:46:30 (6572): Guest Log: 08:04:35.194545 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 604 267 138 000ns (GuestNow=1 641 541 590 581 999 000 ns GuestLast=1 641 536 986 314 861 000 ns fSetTimeLastLoop=true )
2022-01-07 01:51:41 (6572): Guest Log: [INFO] glidein exited with return value 0.
2022-01-07 01:51:41 (6572): Guest Log: [INFO] Shutting Down.
2022-01-07 01:51:41 (6572): VM Completion File Detected.
2022-01-07 01:51:41 (6572): VM Completion Message: glidein exited with return value 0.
.
2022-01-07 01:51:41 (6572): Powering off VM.
2022-01-07 01:51:42 (6572): Successfully stopped VM.
2022-01-07 01:51:42 (6572): Deregistering VM. (boinc_41c977de772a3748, slot#7)
2022-01-07 01:51:43 (6572): Removing network bandwidth throttle group from VM.
2022-01-07 01:51:43 (6572): Removing VM from VirtualBox.
01:51:48 (6572): called boinc_finish(0)

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

Stderr output
