Task 3119444

Name	CMS_4189752_1664961934.356884_0
Workunit	2215020
Created	5 Oct 2022, 9:25:35 UTC
Sent	7 Oct 2022, 8:57:46 UTC
Report deadline	14 Oct 2022, 8:57:46 UTC
Received	11 Oct 2022, 10:09:23 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4441
Run time	15 hours 21 min 24 sec
CPU time	9 hours 7 min 32 sec
Validate state	Valid
Credit	523.39
Device peak FLOPS	3.98 GFLOPS
Application version	CMS Simulation v60.66 (vbox64_mt_mcore_cms) windows_x86_64
Peak working set size	79.91 MB
Peak swap size	107.40 MB
Peak disk usage	1.54 GB
Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
unction 03
2022-10-07 10:58:08 (15332): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-07 10:58:50 (15332): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-07 10:58:50 (15332): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-07 10:58:55 (15332): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-07 10:58:55 (15332): Guest Log: 00:00:00.000206 main     Log opened 2022-10-07T08:58:56.089466000Z
2022-10-07 10:58:55 (15332): Guest Log: 00:00:00.000427 main     OS Product: Linux
2022-10-07 10:58:55 (15332): Guest Log: 00:00:00.000708 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-07 10:58:55 (15332): Guest Log: 00:00:00.000788 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-07 10:58:55 (15332): Guest Log: 00:00:00.000884 main     Executable: /usr/sbin/VBoxService
2022-10-07 10:58:55 (15332): Guest Log: 00:00:00.000886 main     Process ID: 2177
2022-10-07 10:58:55 (15332): Guest Log: 00:00:00.000888 main     Package type: LINUX_64BITS_GENERIC
2022-10-07 10:58:55 (15332): Guest Log: 00:00:00.006551 main     5.2.6 r120293 started. Verbose level = 0
2022-10-07 10:59:48 (15332): Guest Log: [INFO] Mounting the shared directory
2022-10-07 10:59:48 (15332): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-07 10:59:48 (15332): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-07 10:59:49 (15332): Guest Log: [INFO] Testing connection to cern.ch
2022-10-07 10:59:49 (15332): Guest Log: [INFO] Testing connection to VCCS
2022-10-07 10:59:50 (15332): Guest Log: [INFO] Testing connection to HTCondor
2022-10-07 10:59:50 (15332): Guest Log: [INFO] Testing connection to WMAgent
2022-10-07 10:59:51 (15332): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-07 10:59:51 (15332): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-07 10:59:51 (15332): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-07 10:59:52 (15332): Guest Log: [INFO] Testing connection to Frontier
2022-10-07 10:59:53 (15332): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-10-07 10:59:53 (15332): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-10-07 10:59:56 (15332): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-07 11:00:37 (15332): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-07 11:01:05 (15332): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-07 11:01:06 (15332): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-07 11:01:07 (15332): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-07 11:01:09 (15332): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-07 11:01:12 (15332): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-07 11:01:12 (15332): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-07 11:01:12 (15332): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-07 11:01:13 (15332): Guest Log: [INFO] Reading volunteer information
2022-10-07 11:01:17 (15332): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-07 11:01:19 (15332): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-07 11:01:21 (15332): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-07 11:01:22 (15332): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-07 11:01:23 (15332): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-07 13:30:55 (15332): Guest Log: 01:38:35.389271 timesync vgsvcTimeSyncWorker: Radical host time change: 3 217 157 000 000ns (HostNow=1 665 142 253 388 000 000 ns HostLast=1 665 139 036 231 000 000 ns)
2022-10-07 13:31:03 (15332): VM state change detected. (old = 'running', new = 'paused')
2022-10-07 13:31:13 (15332): VM state change detected. (old = 'paused', new = 'running')
2022-10-07 13:31:14 (15332): Guest Log: 01:38:45.697202 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 212 504 857 000ns (GuestNow=1 665 142 263 815 730 000 ns GuestLast=1 665 139 051 310 873 000 ns fSetTimeLastLoop=true )
2022-10-07 13:31:44 (15332): Status Report: Job Duration: '64800.000000'
2022-10-07 13:31:44 (15332): Status Report: Elapsed Time: '6000.000000'
2022-10-07 13:31:44 (15332): Status Report: CPU Time: '3579.000000'
2022-10-07 14:13:06 (15332): VM state change detected. (old = 'running', new = 'paused')
2022-10-07 14:13:16 (15332): VM state change detected. (old = 'paused', new = 'running')
2022-10-07 15:35:35 (15332): Status Report: Job Duration: '64800.000000'
2022-10-07 15:35:35 (15332): Status Report: Elapsed Time: '12000.776320'
2022-10-07 15:35:35 (15332): Status Report: CPU Time: '7190.906250'
2022-10-07 17:15:41 (15332): Status Report: Job Duration: '64800.000000'
2022-10-07 17:15:41 (15332): Status Report: Elapsed Time: '18000.776320'
2022-10-07 17:15:41 (15332): Status Report: CPU Time: '10800.687500'
2022-10-09 23:39:40 (11708): Detected: vboxwrapper 26205
2022-10-09 23:39:40 (11708): Detected: BOINC client v7.16.11
2022-10-09 23:39:41 (11708): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-09 23:39:41 (11708): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-09 23:39:42 (11708): Create VM. (boinc_3a912fd0df08a495, slot#3)
2022-10-09 23:39:42 (11708): Setting Memory Size for VM. (1896MB)
2022-10-09 23:39:42 (11708): Setting CPU Count for VM. (1)
2022-10-09 23:39:43 (11708): Setting Chipset Options for VM.
2022-10-09 23:39:43 (11708): Setting Graphics Controller Options for VM.
2022-10-09 23:39:43 (11708): Setting Boot Options for VM.
2022-10-09 23:39:43 (11708): Setting Network Configuration for NAT.
2022-10-09 23:39:44 (11708): Enabling VM Network Access.
2022-10-09 23:39:44 (11708): Disabling USB Support for VM.
2022-10-09 23:39:44 (11708): Disabling COM Port Support for VM.
2022-10-09 23:39:44 (11708): Disabling LPT Port Support for VM.
2022-10-09 23:39:45 (11708): Disabling Audio Support for VM.
2022-10-09 23:39:45 (11708): Disabling Clipboard Support for VM.
2022-10-09 23:39:45 (11708): Disabling Drag and Drop Support for VM.
2022-10-09 23:39:45 (11708): Adding storage controller(s) to VM.
2022-10-09 23:39:46 (11708): Adding virtual disk drive to VM. (CMS_2022_09_07.vdi)
2022-10-09 23:39:46 (11708): Adding VirtualBox Guest Additions to VM.
2022-10-09 23:39:46 (11708): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2022-10-09 23:39:47 (11708): forwarding host port 56205 to guest port 80
2022-10-09 23:39:47 (11708): Enabling remote desktop for VM.
2022-10-09 23:39:48 (11708): Enabling shared directory for VM.
2022-10-09 23:39:48 (11708): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-09 23:39:48 (11708): Guest Log: CPUID EDX: 0x178bfbff
2022-10-09 23:39:48 (11708): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-09 23:39:48 (11708): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-09 23:39:48 (11708): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-09 23:39:48 (11708): Guest Log: BIOS: Booting from Hard Disk...
2022-10-09 23:39:48 (11708): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-09 23:39:48 (11708): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-09 23:39:48 (11708): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-09 23:39:48 (11708): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-09 23:39:48 (11708): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-09 23:39:48 (11708): Guest Log: 00:00:00.000206 main     Log opened 2022-10-07T08:58:56.089466000Z
2022-10-09 23:39:48 (11708): Guest Log: 00:00:00.000427 main     OS Product: Linux
2022-10-09 23:39:48 (11708): Guest Log: 00:00:00.000708 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-09 23:39:48 (11708): Guest Log: 00:00:00.000788 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-09 23:39:48 (11708): Guest Log: 00:00:00.000884 main     Executable: /usr/sbin/VBoxService
2022-10-09 23:39:48 (11708): Guest Log: 00:00:00.000886 main     Process ID: 2177
2022-10-09 23:39:48 (11708): Guest Log: 00:00:00.000888 main     Package type: LINUX_64BITS_GENERIC
2022-10-09 23:39:48 (11708): Guest Log: 00:00:00.006551 main     5.2.6 r120293 started. Verbose level = 0
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Mounting the shared directory
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Testing connection to cern.ch
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Testing connection to VCCS
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Testing connection to HTCondor
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Testing connection to WMAgent
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Testing connection to Frontier
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-09 23:39:48 (11708): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Reading volunteer information
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-09 23:39:48 (11708): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-09 23:39:48 (11708): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-09 23:39:48 (11708): Guest Log: 01:38:35.389271 timesync vgsvcTimeSyncWorker: Radical host time change: 3 217 157 000 000ns (HostNow=1 665 142 253 388 000 000 ns HostLast=1 665 139 036 231 000 000 ns)
2022-10-09 23:39:48 (11708): Guest Log: 01:38:45.697202 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 212 504 857 000ns (GuestNow=1 665 142 263 815 730 000 ns GuestLast=1 665 139 051 310 873 000 ns fSetTimeLastLoop=true )
2022-10-09 23:39:48 (11708): Starting VM using VBoxManage interface. (boinc_3a912fd0df08a495, slot#3)
2022-10-09 23:39:56 (11708): Successfully started VM. (PID = '14296')
2022-10-09 23:39:56 (11708): Reporting VM Process ID to BOINC.
2022-10-09 23:39:56 (11708): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-09 23:39:56 (11708): Guest Log: CPUID EDX: 0x178bfbff
2022-10-09 23:39:56 (11708): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-09 23:39:56 (11708): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-09 23:39:56 (11708): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-09 23:39:56 (11708): Detected: Web Application Enabled (http://localhost:56205)
2022-10-09 23:39:56 (11708): Detected: Remote Desktop Enabled (localhost:49761)
2022-10-09 23:39:57 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:40:21 (11708): Status Report: Job Duration: '64800.000000'
2022-10-09 23:40:21 (11708): Status Report: Elapsed Time: '19497.776320'
2022-10-09 23:40:21 (11708): Status Report: CPU Time: '11702.843750'
2022-10-09 23:40:21 (11708): Preference change detected
2022-10-09 23:40:21 (11708): Setting CPU throttle for VM. (50%)
2022-10-09 23:40:21 (11708): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-09 23:40:22 (11708): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-09 23:40:22 (11708): Guest Log: BIOS: Booting from Hard Disk...
2022-10-09 23:40:22 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:40:25 (11708): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-09 23:40:25 (11708): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-09 23:41:02 (11708): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-09 23:41:02 (11708): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-09 23:41:06 (11708): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-09 23:41:06 (11708): Guest Log: 00:00:00.000241 main     Log opened 2022-10-09T21:41:06.828653000Z
2022-10-09 23:41:06 (11708): Guest Log: 00:00:00.000564 main     OS Product: Linux
2022-10-09 23:41:06 (11708): Guest Log: 00:00:00.000701 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-09 23:41:06 (11708): Guest Log: 00:00:00.000790 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-09 23:41:06 (11708): Guest Log: 00:00:00.000903 main     Executable: /usr/sbin/VBoxService
2022-10-09 23:41:06 (11708): Guest Log: 00:00:00.000905 main     Process ID: 2171
2022-10-09 23:41:06 (11708): Guest Log: 00:00:00.000908 main     Package type: LINUX_64BITS_GENERIC
2022-10-09 23:41:06 (11708): Guest Log: 00:00:00.004965 main     5.2.6 r120293 started. Verbose level = 0
2022-10-09 23:41:53 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:42:08 (11708): Guest Log: [INFO] Mounting the shared directory
2022-10-09 23:42:08 (11708): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-09 23:42:08 (11708): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-09 23:42:08 (11708): Guest Log: [INFO] Testing connection to cern.ch
2022-10-09 23:42:08 (11708): Guest Log: [INFO] Testing connection to VCCS
2022-10-09 23:42:08 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:42:10 (11708): Guest Log: [INFO] Testing connection to HTCondor
2022-10-09 23:42:10 (11708): Guest Log: [INFO] Testing connection to WMAgent
2022-10-09 23:42:10 (11708): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-09 23:42:11 (11708): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-09 23:42:11 (11708): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-09 23:42:11 (11708): Guest Log: [INFO] Testing connection to Frontier
2022-10-09 23:42:12 (11708): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-09 23:42:12 (11708): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-09 23:42:12 (11708): Guest Log: [INFO] This makes the application less efficient
2022-10-09 23:42:12 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:43:02 (11708): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-09 23:43:02 (11708): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-09 23:43:02 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:43:03 (11708): Guest Log: [INFO] Advice can be found in the project forum
2022-10-09 23:43:05 (11708): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-09 23:43:32 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:43:42 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:44:01 (11708): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-09 23:44:36 (11708): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-09 23:44:37 (11708): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-09 23:44:38 (11708): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-09 23:44:42 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:44:52 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:44:53 (11708): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-09 23:44:57 (11708): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-09 23:44:57 (11708): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-09 23:44:57 (11708): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-09 23:44:58 (11708): Guest Log: [INFO] Reading volunteer information
2022-10-09 23:45:04 (11708): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-09 23:45:06 (11708): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-09 23:45:08 (11708): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-09 23:45:10 (11708): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-09 23:45:12 (11708): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-09 23:45:12 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:45:22 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:45:42 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:45:52 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:48:02 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:48:12 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:49:22 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:49:32 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:52:53 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:53:03 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:58:14 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:58:24 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:01:44 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:01:54 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:13:24 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:13:34 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:16:15 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:16:25 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:19:36 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:19:55 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:23:56 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:24:06 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:26:58 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:27:07 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:30:37 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:30:47 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:32:07 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:32:17 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:32:37 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:32:47 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:36:37 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:36:47 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:45:59 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:46:09 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:46:59 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:47:09 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:47:18 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:47:29 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:47:59 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:48:09 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:51:40 (11708): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:51:50 (11708): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 01:10:12 (6692): Detected: vboxwrapper 26205
2022-10-10 01:10:12 (6692): Detected: BOINC client v7.16.11
2022-10-10 01:10:14 (6692): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-10 01:10:14 (6692): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-10 01:10:15 (6692): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 01:10:15 (6692): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 01:10:15 (6692): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 01:10:15 (6692): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 01:10:15 (6692): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 01:10:15 (6692): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 01:10:15 (6692): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 01:10:15 (6692): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 01:10:15 (6692): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 01:10:15 (6692): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 01:10:15 (6692): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-10 01:10:15 (6692): Guest Log: 00:00:00.000241 main     Log opened 2022-10-09T21:41:06.828653000Z
2022-10-10 01:10:15 (6692): Guest Log: 00:00:00.000564 main     OS Product: Linux
2022-10-10 01:10:15 (6692): Guest Log: 00:00:00.000701 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 01:10:15 (6692): Guest Log: 00:00:00.000790 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 01:10:15 (6692): Guest Log: 00:00:00.000903 main     Executable: /usr/sbin/VBoxService
2022-10-10 01:10:15 (6692): Guest Log: 00:00:00.000905 main     Process ID: 2171
2022-10-10 01:10:15 (6692): Guest Log: 00:00:00.000908 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 01:10:15 (6692): Guest Log: 00:00:00.004965 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Mounting the shared directory
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 01:10:15 (6692): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 01:10:15 (6692): Guest Log: [INFO] This makes the application less efficient
2022-10-10 01:10:15 (6692): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 01:10:15 (6692): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Reading volunteer information
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 01:10:15 (6692): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 01:10:15 (6692): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 01:10:15 (6692): Starting VM using VBoxManage interface. (boinc_3a912fd0df08a495, slot#3)
2022-10-10 01:10:21 (6692): Successfully started VM. (PID = '12656')
2022-10-10 01:10:21 (6692): Reporting VM Process ID to BOINC.
2022-10-10 01:10:21 (6692): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 01:10:21 (6692): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 01:10:21 (6692): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 01:10:21 (6692): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 01:10:21 (6692): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-10 01:10:21 (6692): Detected: Web Application Enabled (http://localhost:56205)
2022-10-10 01:10:21 (6692): Detected: Remote Desktop Enabled (localhost:49761)
2022-10-10 01:10:21 (6692): Status Report: Job Duration: '64800.000000'
2022-10-10 01:10:21 (6692): Status Report: Elapsed Time: '23553.122746'
2022-10-10 01:10:21 (6692): Status Report: CPU Time: '14108.328125'
2022-10-10 01:10:21 (6692): Preference change detected
2022-10-10 01:10:21 (6692): Setting CPU throttle for VM. (50%)
2022-10-10 01:10:21 (6692): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-10 01:10:23 (6692): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 01:10:23 (6692): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 01:10:24 (6692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 01:10:34 (6692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 01:10:36 (6692): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 01:10:36 (6692): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 01:10:44 (6692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 01:11:14 (6692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 01:11:57 (6692): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 01:11:57 (6692): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 01:11:59 (6692): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-10 01:11:59 (6692): Guest Log: 00:00:00.000202 main     Log opened 2022-10-09T23:12:00.544708000Z
2022-10-10 01:11:59 (6692): Guest Log: 00:00:00.000419 main     OS Product: Linux
2022-10-10 01:11:59 (6692): Guest Log: 00:00:00.000497 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 01:11:59 (6692): Guest Log: 00:00:00.000553 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 01:11:59 (6692): Guest Log: 00:00:00.000642 main     Executable: /usr/sbin/VBoxService
2022-10-10 01:11:59 (6692): Guest Log: 00:00:00.000644 main     Process ID: 2162
2022-10-10 01:11:59 (6692): Guest Log: 00:00:00.000646 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 01:11:59 (6692): Guest Log: 00:00:00.006794 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 01:12:31 (6692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 01:13:04 (6692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 01:13:22 (6692): Guest Log: [INFO] Mounting the shared directory
2022-10-10 01:13:23 (6692): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 01:13:23 (6692): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 01:13:24 (6692): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 01:13:24 (6692): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 01:13:25 (6692): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 01:13:25 (6692): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 01:13:26 (6692): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 01:13:26 (6692): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 01:13:26 (6692): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 01:13:27 (6692): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 01:13:28 (6692): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 01:13:28 (6692): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 01:13:29 (6692): Guest Log: [INFO] This makes the application less efficient
2022-10-10 01:13:29 (6692): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 01:13:30 (6692): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 01:13:30 (6692): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 01:13:30 (6692): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 01:14:06 (6692): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 01:14:39 (6692): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 01:14:41 (6692): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 01:14:42 (6692): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 01:14:45 (6692): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 01:14:47 (6692): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 01:14:48 (6692): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 01:14:48 (6692): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 01:14:49 (6692): Guest Log: [INFO] Reading volunteer information
2022-10-10 01:14:51 (6692): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 01:14:53 (6692): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 01:14:55 (6692): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 01:14:56 (6692): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 01:14:57 (6692): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 08:37:59 (12740): Detected: vboxwrapper 26205
2022-10-10 08:37:59 (12740): Detected: BOINC client v7.16.11
2022-10-10 08:38:02 (12740): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-10 08:38:03 (12740): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-10 08:38:03 (12740): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 08:38:03 (12740): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 08:38:03 (12740): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 08:38:03 (12740): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 08:38:03 (12740): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 08:38:03 (12740): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 08:38:03 (12740): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 08:38:03 (12740): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 08:38:03 (12740): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 08:38:03 (12740): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 08:38:03 (12740): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-10 08:38:03 (12740): Guest Log: 00:00:00.000202 main     Log opened 2022-10-09T23:12:00.544708000Z
2022-10-10 08:38:03 (12740): Guest Log: 00:00:00.000419 main     OS Product: Linux
2022-10-10 08:38:03 (12740): Guest Log: 00:00:00.000497 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 08:38:03 (12740): Guest Log: 00:00:00.000553 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 08:38:03 (12740): Guest Log: 00:00:00.000642 main     Executable: /usr/sbin/VBoxService
2022-10-10 08:38:03 (12740): Guest Log: 00:00:00.000644 main     Process ID: 2162
2022-10-10 08:38:03 (12740): Guest Log: 00:00:00.000646 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 08:38:03 (12740): Guest Log: 00:00:00.006794 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Mounting the shared directory
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 08:38:03 (12740): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 08:38:03 (12740): Guest Log: [INFO] This makes the application less efficient
2022-10-10 08:38:03 (12740): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 08:38:03 (12740): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Reading volunteer information
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 08:38:03 (12740): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 08:38:03 (12740): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 08:38:03 (12740): Starting VM using VBoxManage interface. (boinc_3a912fd0df08a495, slot#3)
2022-10-10 08:38:15 (12740): Successfully started VM. (PID = '13928')
2022-10-10 08:38:15 (12740): Reporting VM Process ID to BOINC.
2022-10-10 08:38:16 (12740): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 08:38:16 (12740): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 08:38:16 (12740): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 08:38:16 (12740): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 08:38:16 (12740): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 08:38:16 (12740): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 08:38:16 (12740): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-10 08:38:16 (12740): Detected: Web Application Enabled (http://localhost:56205)
2022-10-10 08:38:16 (12740): Detected: Remote Desktop Enabled (localhost:49761)
2022-10-10 08:38:16 (12740): Status Report: Job Duration: '64800.000000'
2022-10-10 08:38:16 (12740): Status Report: Elapsed Time: '24803.122746'
2022-10-10 08:38:16 (12740): Status Report: CPU Time: '14822.359375'
2022-10-10 08:38:16 (12740): Preference change detected
2022-10-10 08:38:16 (12740): Setting CPU throttle for VM. (50%)
2022-10-10 08:38:16 (12740): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-10 08:38:19 (12740): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 08:38:19 (12740): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 08:38:22 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:38:51 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:39:27 (12740): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 08:39:27 (12740): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 08:39:29 (12740): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-10 08:39:29 (12740): Guest Log: 00:00:00.000096 main     Log opened 2022-10-10T06:39:30.008321000Z
2022-10-10 08:39:29 (12740): Guest Log: 00:00:00.000207 main     OS Product: Linux
2022-10-10 08:39:29 (12740): Guest Log: 00:00:00.000240 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 08:39:29 (12740): Guest Log: 00:00:00.000279 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 08:39:29 (12740): Guest Log: 00:00:00.000326 main     Executable: /usr/sbin/VBoxService
2022-10-10 08:39:29 (12740): Guest Log: 00:00:00.000327 main     Process ID: 2168
2022-10-10 08:39:29 (12740): Guest Log: 00:00:00.000328 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 08:39:29 (12740): Guest Log: 00:00:00.006232 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 08:39:43 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:40:21 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:40:40 (12740): Guest Log: [INFO] Mounting the shared directory
2022-10-10 08:40:40 (12740): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 08:40:40 (12740): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 08:40:40 (12740): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 08:40:41 (12740): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 08:40:41 (12740): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 08:40:41 (12740): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 08:40:42 (12740): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 08:40:42 (12740): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 08:40:42 (12740): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 08:40:43 (12740): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 08:40:43 (12740): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 08:40:43 (12740): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 08:40:44 (12740): Guest Log: [INFO] This makes the application less efficient
2022-10-10 08:40:44 (12740): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 08:40:44 (12740): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 08:40:44 (12740): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 08:40:44 (12740): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 08:41:06 (12740): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 08:41:24 (12740): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 08:41:24 (12740): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 08:41:25 (12740): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 08:41:26 (12740): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 08:41:27 (12740): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 08:41:27 (12740): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 08:41:27 (12740): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 08:41:28 (12740): Guest Log: [INFO] Reading volunteer information
2022-10-10 08:41:29 (12740): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 08:41:30 (12740): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 08:41:31 (12740): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 08:41:32 (12740): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 08:41:33 (12740): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 08:43:21 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:43:31 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:43:51 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:44:01 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:46:22 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:46:32 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:48:12 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:48:22 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:53:52 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:54:02 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:56:42 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:56:52 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 09:00:32 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 09:00:42 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 09:02:03 (12740): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 09:02:13 (12740): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 10:48:23 (10944): Detected: vboxwrapper 26205
2022-10-10 10:48:23 (10944): Detected: BOINC client v7.16.11
2022-10-10 10:48:24 (10944): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-10 10:48:24 (10944): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-10 10:48:24 (10944): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 10:48:24 (10944): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 10:48:24 (10944): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 10:48:24 (10944): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 10:48:24 (10944): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 10:48:24 (10944): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 10:48:24 (10944): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 10:48:24 (10944): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 10:48:24 (10944): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 10:48:24 (10944): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 10:48:24 (10944): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-10 10:48:24 (10944): Guest Log: 00:00:00.000096 main     Log opened 2022-10-10T06:39:30.008321000Z
2022-10-10 10:48:24 (10944): Guest Log: 00:00:00.000207 main     OS Product: Linux
2022-10-10 10:48:24 (10944): Guest Log: 00:00:00.000240 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 10:48:24 (10944): Guest Log: 00:00:00.000279 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 10:48:24 (10944): Guest Log: 00:00:00.000326 main     Executable: /usr/sbin/VBoxService
2022-10-10 10:48:24 (10944): Guest Log: 00:00:00.000327 main     Process ID: 2168
2022-10-10 10:48:24 (10944): Guest Log: 00:00:00.000328 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 10:48:24 (10944): Guest Log: 00:00:00.006232 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Mounting the shared directory
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 10:48:24 (10944): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 10:48:24 (10944): Guest Log: [INFO] This makes the application less efficient
2022-10-10 10:48:24 (10944): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 10:48:24 (10944): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Reading volunteer information
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 10:48:24 (10944): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 10:48:24 (10944): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 10:48:24 (10944): Starting VM using VBoxManage interface. (boinc_3a912fd0df08a495, slot#3)
2022-10-10 10:48:30 (10944): Successfully started VM. (PID = '11960')
2022-10-10 10:48:30 (10944): Reporting VM Process ID to BOINC.
2022-10-10 10:48:30 (10944): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 10:48:30 (10944): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 10:48:30 (10944): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 10:48:30 (10944): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 10:48:30 (10944): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-10 10:48:30 (10944): Detected: Web Application Enabled (http://localhost:56205)
2022-10-10 10:48:30 (10944): Detected: Remote Desktop Enabled (localhost:49761)
2022-10-10 10:48:30 (10944): Status Report: Job Duration: '64800.000000'
2022-10-10 10:48:30 (10944): Status Report: Elapsed Time: '26471.122746'
2022-10-10 10:48:30 (10944): Status Report: CPU Time: '15785.734375'
2022-10-10 10:48:30 (10944): Preference change detected
2022-10-10 10:48:30 (10944): Setting CPU throttle for VM. (50%)
2022-10-10 10:48:31 (10944): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-10 10:48:32 (10944): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 10:48:32 (10944): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 10:48:35 (10944): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 10:48:35 (10944): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 10:48:44 (10944): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 10:48:54 (10944): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 10:49:17 (10944): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 10:49:17 (10944): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 10:49:19 (10944): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-10 10:49:19 (10944): Guest Log: 00:00:00.000174 main     Log opened 2022-10-10T08:49:19.881233000Z
2022-10-10 10:49:19 (10944): Guest Log: 00:00:00.000339 main     OS Product: Linux
2022-10-10 10:49:19 (10944): Guest Log: 00:00:00.000375 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 10:49:19 (10944): Guest Log: 00:00:00.000413 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 10:49:19 (10944): Guest Log: 00:00:00.000440 main     Executable: /usr/sbin/VBoxService
2022-10-10 10:49:19 (10944): Guest Log: 00:00:00.000441 main     Process ID: 2169
2022-10-10 10:49:19 (10944): Guest Log: 00:00:00.000442 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 10:49:19 (10944): Guest Log: 00:00:00.001825 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 10:49:41 (10944): Guest Log: [INFO] Mounting the shared directory
2022-10-10 10:49:41 (10944): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 10:49:41 (10944): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 10:49:41 (10944): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 10:49:42 (10944): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 10:49:42 (10944): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 10:49:42 (10944): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 10:49:42 (10944): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 10:49:42 (10944): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 10:49:42 (10944): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 10:49:43 (10944): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 10:49:43 (10944): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-10-10 10:49:43 (10944): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-10-10 10:49:43 (10944): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 10:50:00 (10944): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 10:50:11 (10944): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 10:50:12 (10944): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 10:50:13 (10944): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 10:50:13 (10944): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 10:50:14 (10944): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 10:50:14 (10944): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 10:50:14 (10944): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 10:50:15 (10944): Guest Log: [INFO] Reading volunteer information
2022-10-10 10:50:17 (10944): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 10:50:17 (10944): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 10:50:19 (10944): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 10:50:19 (10944): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 10:50:20 (10944): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 10:50:34 (10944): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 10:50:44 (10944): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 12:05:49 (10944): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 12:05:59 (10944): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 12:29:13 (10944): Status Report: Job Duration: '64800.000000'
2022-10-10 12:29:13 (10944): Status Report: Elapsed Time: '32471.900282'
2022-10-10 12:29:13 (10944): Status Report: CPU Time: '19339.515625'
2022-10-10 14:09:20 (10944): Status Report: Job Duration: '64800.000000'
2022-10-10 14:09:20 (10944): Status Report: Elapsed Time: '38471.900282'
2022-10-10 14:09:20 (10944): Status Report: CPU Time: '22947.468750'
2022-10-10 15:49:27 (10944): Status Report: Job Duration: '64800.000000'
2022-10-10 15:49:27 (10944): Status Report: Elapsed Time: '44471.900282'
2022-10-10 15:49:27 (10944): Status Report: CPU Time: '26504.984375'
2022-10-10 17:29:34 (10944): Status Report: Job Duration: '64800.000000'
2022-10-10 17:29:34 (10944): Status Report: Elapsed Time: '50471.900282'
2022-10-10 17:29:34 (10944): Status Report: CPU Time: '30113.234375'
2022-10-10 18:18:27 (10944): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 18:18:37 (10944): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 18:42:49 (10944): Stopping VM.
2022-10-10 18:43:08 (10944): Successfully stopped VM.
2022-10-11 12:03:24 (11452): Detected: vboxwrapper 26205
2022-10-11 12:03:24 (11452): Detected: BOINC client v7.16.11
2022-10-11 12:03:25 (11452): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-11 12:03:25 (11452): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-11 12:03:26 (11452): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-11 12:03:26 (11452): Guest Log: CPUID EDX: 0x178bfbff
2022-10-11 12:03:26 (11452): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-11 12:03:26 (11452): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-11 12:03:26 (11452): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-11 12:03:26 (11452): Guest Log: BIOS: Booting from Hard Disk...
2022-10-11 12:03:26 (11452): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-11 12:03:26 (11452): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-11 12:03:26 (11452): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-11 12:03:26 (11452): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-11 12:03:26 (11452): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-11 12:03:26 (11452): Guest Log: 00:00:00.000174 main     Log opened 2022-10-10T08:49:19.881233000Z
2022-10-11 12:03:26 (11452): Guest Log: 00:00:00.000339 main     OS Product: Linux
2022-10-11 12:03:26 (11452): Guest Log: 00:00:00.000375 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-11 12:03:26 (11452): Guest Log: 00:00:00.000413 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-11 12:03:26 (11452): Guest Log: 00:00:00.000440 main     Executable: /usr/sbin/VBoxService
2022-10-11 12:03:26 (11452): Guest Log: 00:00:00.000441 main     Process ID: 2169
2022-10-11 12:03:26 (11452): Guest Log: 00:00:00.000442 main     Package type: LINUX_64BITS_GENERIC
2022-10-11 12:03:26 (11452): Guest Log: 00:00:00.001825 main     5.2.6 r120293 started. Verbose level = 0
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Mounting the shared directory
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Testing connection to cern.ch
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Testing connection to VCCS
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Testing connection to HTCondor
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Testing connection to WMAgent
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Testing connection to Frontier
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-11 12:03:26 (11452): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Reading volunteer information
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-11 12:03:26 (11452): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-11 12:03:26 (11452): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-11 12:03:26 (11452): Starting VM using VBoxManage interface. (boinc_3a912fd0df08a495, slot#3)
2022-10-11 12:03:45 (11452): Successfully started VM. (PID = '12028')
2022-10-11 12:03:45 (11452): Reporting VM Process ID to BOINC.
2022-10-11 12:03:45 (11452): Guest Log: 07:53:14.745149 timesync vgsvcTimeSyncWorker: Radical host time change: 62 464 871 000 000ns (HostNow=1 665 482 624 909 000 000 ns HostLast=1 665 420 160 038 000 000 ns)
2022-10-11 12:03:45 (11452): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-11 12:03:45 (11452): Detected: Web Application Enabled (http://localhost:56205)
2022-10-11 12:03:45 (11452): Detected: Remote Desktop Enabled (localhost:49761)
2022-10-11 12:03:46 (11452): VM state change detected. (old = 'running', new = 'paused')
2022-10-11 12:03:54 (11452): Status Report: Job Duration: '64800.000000'
2022-10-11 12:03:54 (11452): Status Report: Elapsed Time: '54850.900282'
2022-10-11 12:03:54 (11452): Status Report: CPU Time: '32761.718750'
2022-10-11 12:03:54 (11452): Preference change detected
2022-10-11 12:03:54 (11452): Setting CPU throttle for VM. (50%)
2022-10-11 12:03:54 (11452): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-11 12:03:55 (11452): VM state change detected. (old = 'paused', new = 'running')
2022-10-11 12:04:04 (11452): Guest Log: 07:53:24.752960 timesync vgsvcTimeSyncWorker: Radical guest time change: 62 480 818 676 000ns (GuestNow=1 665 482 635 133 021 000 ns GuestLast=1 665 420 154 314 345 000 ns fSetTimeLastLoop=true )
2022-10-11 12:05:37 (11452): VM state change detected. (old = 'running', new = 'paused')
2022-10-11 12:06:05 (11452): VM state change detected. (old = 'paused', new = 'running')
2022-10-11 12:08:26 (11452): VM state change detected. (old = 'running', new = 'paused')
2022-10-11 12:08:36 (11452): VM state change detected. (old = 'paused', new = 'running')
2022-10-11 12:09:09 (11452): Guest Log: [INFO] glidein exited with return value 0.
2022-10-11 12:09:09 (11452): Guest Log: [INFO] Shutting Down.
2022-10-11 12:09:09 (11452): VM Completion File Detected.
2022-10-11 12:09:09 (11452): VM Completion Message: glidein exited with return value 0.
.
2022-10-11 12:09:09 (11452): Powering off VM.
2022-10-11 12:09:10 (11452): Successfully stopped VM.
2022-10-11 12:09:10 (11452): Deregistering VM. (boinc_3a912fd0df08a495, slot#3)
2022-10-11 12:09:10 (11452): Removing network bandwidth throttle group from VM.
2022-10-11 12:09:10 (11452): Removing VM from VirtualBox.
12:09:15 (11452): called boinc_finish(0)

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

Stderr output
