Task 3119405

Name	CMS_4180626_1664951132.469795_0
Workunit	2214982
Created	5 Oct 2022, 6:25:37 UTC
Sent	7 Oct 2022, 8:56:38 UTC
Report deadline	14 Oct 2022, 8:56:38 UTC
Received	11 Oct 2022, 10:04:30 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4441
Run time	15 hours 17 min 53 sec
CPU time	9 hours 6 min 47 sec
Validate state	Valid
Credit	521.49
Device peak FLOPS	3.98 GFLOPS
Application version	CMS Simulation v60.66 (vbox64_mt_mcore_cms) windows_x86_64
Peak working set size	84.42 MB
Peak swap size	108.64 MB
Peak disk usage	1.34 GB
Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2022-10-07 10:56:46 (6796): Disabling Clipboard Support for VM.
2022-10-07 10:56:46 (6796): Disabling Drag and Drop Support for VM.
2022-10-07 10:56:47 (6796): Adding storage controller(s) to VM.
2022-10-07 10:56:47 (6796): Adding virtual disk drive to VM. (CMS_2022_09_07.vdi)
2022-10-07 10:56:48 (6796): Adding VirtualBox Guest Additions to VM.
2022-10-07 10:56:48 (6796): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2022-10-07 10:56:49 (6796): forwarding host port 56187 to guest port 80
2022-10-07 10:56:49 (6796): Enabling remote desktop for VM.
2022-10-07 10:56:49 (6796): Enabling shared directory for VM.
2022-10-07 10:56:50 (6796): Starting VM using VBoxManage interface. (boinc_33172a236756abc4, slot#2)
2022-10-07 10:56:56 (6796): Successfully started VM. (PID = '13036')
2022-10-07 10:56:56 (6796): Reporting VM Process ID to BOINC.
2022-10-07 10:56:56 (6796): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-07 10:56:56 (6796): Guest Log: CPUID EDX: 0x178bfbff
2022-10-07 10:56:56 (6796): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-07 10:56:56 (6796): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-07 10:56:56 (6796): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-07 10:56:56 (6796): Detected: Web Application Enabled (http://localhost:56187)
2022-10-07 10:56:56 (6796): Detected: Remote Desktop Enabled (localhost:56188)
2022-10-07 10:56:56 (6796): Preference change detected
2022-10-07 10:56:56 (6796): Setting CPU throttle for VM. (50%)
2022-10-07 10:56:56 (6796): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-07 10:56:58 (6796): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-07 10:56:58 (6796): Guest Log: BIOS: Booting from Hard Disk...
2022-10-07 10:57:01 (6796): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-07 10:57:01 (6796): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-07 10:57:41 (6796): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-07 10:57:41 (6796): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-07 10:57:46 (6796): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-07 10:57:46 (6796): Guest Log: 00:00:00.000331 main     Log opened 2022-10-07T08:57:47.449384000Z
2022-10-07 10:57:46 (6796): Guest Log: 00:00:00.000570 main     OS Product: Linux
2022-10-07 10:57:46 (6796): Guest Log: 00:00:00.000725 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-07 10:57:46 (6796): Guest Log: 00:00:00.000862 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-07 10:57:46 (6796): Guest Log: 00:00:00.001222 main     Executable: /usr/sbin/VBoxService
2022-10-07 10:57:46 (6796): Guest Log: 00:00:00.001225 main     Process ID: 2171
2022-10-07 10:57:46 (6796): Guest Log: 00:00:00.001228 main     Package type: LINUX_64BITS_GENERIC
2022-10-07 10:57:46 (6796): Guest Log: 00:00:00.005567 main     5.2.6 r120293 started. Verbose level = 0
2022-10-07 10:58:36 (6796): Guest Log: [INFO] Mounting the shared directory
2022-10-07 10:58:36 (6796): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-07 10:58:37 (6796): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-07 10:58:37 (6796): Guest Log: [INFO] Testing connection to cern.ch
2022-10-07 10:58:38 (6796): Guest Log: [INFO] Testing connection to VCCS
2022-10-07 10:58:38 (6796): Guest Log: [INFO] Testing connection to HTCondor
2022-10-07 10:58:39 (6796): Guest Log: [INFO] Testing connection to WMAgent
2022-10-07 10:58:39 (6796): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-07 10:58:40 (6796): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-07 10:58:40 (6796): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-07 10:58:40 (6796): Guest Log: [INFO] Testing connection to Frontier
2022-10-07 10:58:42 (6796): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-10-07 10:58:42 (6796): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-10-07 10:58:46 (6796): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-07 10:59:24 (6796): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-07 11:00:00 (6796): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-07 11:00:02 (6796): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-07 11:00:02 (6796): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-07 11:00:03 (6796): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-07 11:00:06 (6796): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-07 11:00:06 (6796): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-07 11:00:06 (6796): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-07 11:00:07 (6796): Guest Log: [INFO] Reading volunteer information
2022-10-07 11:00:12 (6796): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-07 11:00:14 (6796): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-07 11:00:16 (6796): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-07 11:00:17 (6796): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-07 11:00:18 (6796): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-07 12:37:01 (6796): Status Report: Job Duration: '64800.000000'
2022-10-07 12:37:01 (6796): Status Report: Elapsed Time: '6000.000000'
2022-10-07 12:37:01 (6796): Status Report: CPU Time: '3596.515625'
2022-10-07 13:30:55 (6796): Guest Log: 01:39:43.996071 timesync vgsvcTimeSyncWorker: Radical host time change: 3 215 491 000 000ns (HostNow=1 665 142 253 393 000 000 ns HostLast=1 665 139 037 902 000 000 ns)
2022-10-07 13:31:02 (6796): VM state change detected. (old = 'running', new = 'paused')
2022-10-07 13:31:12 (6796): VM state change detected. (old = 'paused', new = 'running')
2022-10-07 13:31:14 (6796): Guest Log: 01:39:54.355953 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 212 652 625 000ns (GuestNow=1 665 142 263 894 560 000 ns GuestLast=1 665 139 051 241 935 000 ns fSetTimeLastLoop=true )
2022-10-07 14:13:06 (6796): VM state change detected. (old = 'running', new = 'paused')
2022-10-07 14:13:16 (6796): VM state change detected. (old = 'paused', new = 'running')
2022-10-07 15:34:30 (6796): Status Report: Job Duration: '64800.000000'
2022-10-07 15:34:30 (6796): Status Report: Elapsed Time: '12000.722637'
2022-10-07 15:34:30 (6796): Status Report: CPU Time: '7208.421875'
2022-10-07 17:14:36 (6796): Status Report: Job Duration: '64800.000000'
2022-10-07 17:14:36 (6796): Status Report: Elapsed Time: '18000.722637'
2022-10-07 17:14:36 (6796): Status Report: CPU Time: '10831.984375'
2022-10-09 23:39:40 (11692): Detected: vboxwrapper 26205
2022-10-09 23:39:40 (11692): Detected: BOINC client v7.16.11
2022-10-09 23:39:41 (11692): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-09 23:39:41 (11692): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-09 23:39:42 (11692): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-09 23:39:42 (11692): Guest Log: CPUID EDX: 0x178bfbff
2022-10-09 23:39:42 (11692): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-09 23:39:42 (11692): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-09 23:39:42 (11692): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-09 23:39:42 (11692): Guest Log: BIOS: Booting from Hard Disk...
2022-10-09 23:39:42 (11692): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-09 23:39:42 (11692): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-09 23:39:42 (11692): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-09 23:39:42 (11692): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-09 23:39:42 (11692): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-09 23:39:42 (11692): Guest Log: 00:00:00.000331 main     Log opened 2022-10-07T08:57:47.449384000Z
2022-10-09 23:39:42 (11692): Guest Log: 00:00:00.000570 main     OS Product: Linux
2022-10-09 23:39:42 (11692): Guest Log: 00:00:00.000725 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-09 23:39:42 (11692): Guest Log: 00:00:00.000862 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-09 23:39:42 (11692): Guest Log: 00:00:00.001222 main     Executable: /usr/sbin/VBoxService
2022-10-09 23:39:42 (11692): Guest Log: 00:00:00.001225 main     Process ID: 2171
2022-10-09 23:39:42 (11692): Guest Log: 00:00:00.001228 main     Package type: LINUX_64BITS_GENERIC
2022-10-09 23:39:42 (11692): Guest Log: 00:00:00.005567 main     5.2.6 r120293 started. Verbose level = 0
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Mounting the shared directory
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Testing connection to cern.ch
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Testing connection to VCCS
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Testing connection to HTCondor
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Testing connection to WMAgent
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Testing connection to Frontier
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-09 23:39:42 (11692): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Reading volunteer information
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-09 23:39:42 (11692): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-09 23:39:42 (11692): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-09 23:39:42 (11692): Guest Log: 01:39:43.996071 timesync vgsvcTimeSyncWorker: Radical host time change: 3 215 491 000 000ns (HostNow=1 665 142 253 393 000 000 ns HostLast=1 665 139 037 902 000 000 ns)
2022-10-09 23:39:42 (11692): Guest Log: 01:39:54.355953 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 212 652 625 000ns (GuestNow=1 665 142 263 894 560 000 ns GuestLast=1 665 139 051 241 935 000 ns fSetTimeLastLoop=true )
2022-10-09 23:39:42 (11692): Starting VM using VBoxManage interface. (boinc_33172a236756abc4, slot#2)
2022-10-09 23:39:47 (11692): Successfully started VM. (PID = '11916')
2022-10-09 23:39:47 (11692): Reporting VM Process ID to BOINC.
2022-10-09 23:39:47 (11692): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-09 23:39:47 (11692): Guest Log: CPUID EDX: 0x178bfbff
2022-10-09 23:39:47 (11692): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-09 23:39:47 (11692): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-09 23:39:47 (11692): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-09 23:39:47 (11692): Detected: Web Application Enabled (http://localhost:56187)
2022-10-09 23:39:47 (11692): Detected: Remote Desktop Enabled (localhost:56188)
2022-10-09 23:39:47 (11692): Status Report: Job Duration: '64800.000000'
2022-10-09 23:39:47 (11692): Status Report: Elapsed Time: '19555.722637'
2022-10-09 23:39:47 (11692): Status Report: CPU Time: '11764.718750'
2022-10-09 23:39:47 (11692): Preference change detected
2022-10-09 23:39:47 (11692): Setting CPU throttle for VM. (50%)
2022-10-09 23:39:47 (11692): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-09 23:39:49 (11692): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-09 23:39:49 (11692): Guest Log: BIOS: Booting from Hard Disk...
2022-10-09 23:39:51 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:40:22 (11692): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-09 23:40:22 (11692): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-09 23:40:22 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:41:00 (11692): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-09 23:41:01 (11692): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-09 23:41:04 (11692): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-09 23:41:04 (11692): Guest Log: 00:00:00.000864 main     Log opened 2022-10-09T21:41:04.919752000Z
2022-10-09 23:41:04 (11692): Guest Log: 00:00:00.003502 main     OS Product: Linux
2022-10-09 23:41:04 (11692): Guest Log: 00:00:00.003693 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-09 23:41:04 (11692): Guest Log: 00:00:00.003822 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-09 23:41:04 (11692): Guest Log: 00:00:00.003940 main     Executable: /usr/sbin/VBoxService
2022-10-09 23:41:04 (11692): Guest Log: 00:00:00.003944 main     Process ID: 2169
2022-10-09 23:41:04 (11692): Guest Log: 00:00:00.003947 main     Package type: LINUX_64BITS_GENERIC
2022-10-09 23:41:04 (11692): Guest Log: 00:00:00.011985 main     5.2.6 r120293 started. Verbose level = 0
2022-10-09 23:41:53 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:42:05 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:42:08 (11692): Guest Log: [INFO] Mounting the shared directory
2022-10-09 23:42:08 (11692): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-09 23:42:08 (11692): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-09 23:42:08 (11692): Guest Log: [INFO] Testing connection to cern.ch
2022-10-09 23:42:08 (11692): Guest Log: [INFO] Testing connection to VCCS
2022-10-09 23:42:08 (11692): Guest Log: [INFO] Testing connection to HTCondor
2022-10-09 23:42:10 (11692): Guest Log: [INFO] Testing connection to WMAgent
2022-10-09 23:42:10 (11692): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-09 23:42:10 (11692): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-09 23:42:11 (11692): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-09 23:42:11 (11692): Guest Log: [INFO] Testing connection to Frontier
2022-10-09 23:42:13 (11692): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-09 23:42:13 (11692): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-09 23:42:13 (11692): Guest Log: [INFO] This makes the application less efficient
2022-10-09 23:42:13 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:43:02 (11692): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-09 23:43:02 (11692): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-09 23:43:02 (11692): Guest Log: [INFO] Advice can be found in the project forum
2022-10-09 23:43:02 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:43:03 (11692): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-09 23:43:32 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:43:42 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:43:58 (11692): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-09 23:44:32 (11692): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-09 23:44:34 (11692): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-09 23:44:35 (11692): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-09 23:44:35 (11692): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-09 23:44:38 (11692): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-09 23:44:38 (11692): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-09 23:44:38 (11692): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-09 23:44:39 (11692): Guest Log: [INFO] Reading volunteer information
2022-10-09 23:44:41 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:44:52 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:44:55 (11692): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-09 23:44:57 (11692): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-09 23:45:01 (11692): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-09 23:45:02 (11692): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-09 23:45:04 (11692): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-09 23:45:12 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:45:22 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:45:41 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:45:51 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:48:03 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:48:13 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:49:23 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:49:33 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:52:53 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:53:03 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-09 23:58:13 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-09 23:58:23 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:01:43 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:01:53 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:13:25 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:13:35 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:16:15 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:16:25 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:19:36 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:19:55 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:23:56 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:24:06 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:26:58 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:27:07 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:30:37 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:30:47 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:32:07 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:32:17 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:32:37 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:32:47 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:36:37 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:36:47 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:45:59 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:46:09 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:46:59 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:47:09 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:47:18 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:47:29 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:47:59 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:48:09 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 00:51:40 (11692): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 00:51:50 (11692): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 01:10:12 (10888): Detected: vboxwrapper 26205
2022-10-10 01:10:12 (10888): Detected: BOINC client v7.16.11
2022-10-10 01:10:14 (10888): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-10 01:10:14 (10888): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-10 01:10:15 (10888): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 01:10:15 (10888): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 01:10:15 (10888): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 01:10:15 (10888): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 01:10:15 (10888): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 01:10:15 (10888): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 01:10:15 (10888): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 01:10:15 (10888): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 01:10:15 (10888): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 01:10:15 (10888): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 01:10:15 (10888): 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 (10888): Guest Log: 00:00:00.000864 main     Log opened 2022-10-09T21:41:04.919752000Z
2022-10-10 01:10:15 (10888): Guest Log: 00:00:00.003502 main     OS Product: Linux
2022-10-10 01:10:15 (10888): Guest Log: 00:00:00.003693 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 01:10:15 (10888): Guest Log: 00:00:00.003822 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 01:10:15 (10888): Guest Log: 00:00:00.003940 main     Executable: /usr/sbin/VBoxService
2022-10-10 01:10:15 (10888): Guest Log: 00:00:00.003944 main     Process ID: 2169
2022-10-10 01:10:15 (10888): Guest Log: 00:00:00.003947 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 01:10:15 (10888): Guest Log: 00:00:00.011985 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Mounting the shared directory
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 01:10:15 (10888): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 01:10:15 (10888): Guest Log: [INFO] This makes the application less efficient
2022-10-10 01:10:15 (10888): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 01:10:15 (10888): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Reading volunteer information
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 01:10:15 (10888): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 01:10:15 (10888): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 01:10:15 (10888): Starting VM using VBoxManage interface. (boinc_33172a236756abc4, slot#2)
2022-10-10 01:10:21 (10888): Successfully started VM. (PID = '12552')
2022-10-10 01:10:21 (10888): Reporting VM Process ID to BOINC.
2022-10-10 01:10:21 (10888): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 01:10:21 (10888): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 01:10:21 (10888): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 01:10:21 (10888): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 01:10:21 (10888): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-10 01:10:21 (10888): Detected: Web Application Enabled (http://localhost:56187)
2022-10-10 01:10:21 (10888): Detected: Remote Desktop Enabled (localhost:56188)
2022-10-10 01:10:21 (10888): Status Report: Job Duration: '64800.000000'
2022-10-10 01:10:21 (10888): Status Report: Elapsed Time: '23611.404825'
2022-10-10 01:10:21 (10888): Status Report: CPU Time: '14161.078125'
2022-10-10 01:10:21 (10888): Preference change detected
2022-10-10 01:10:21 (10888): Setting CPU throttle for VM. (50%)
2022-10-10 01:10:21 (10888): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-10 01:10:23 (10888): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 01:10:23 (10888): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 01:10:24 (10888): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 01:10:34 (10888): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 01:10:36 (10888): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 01:10:36 (10888): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 01:10:44 (10888): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 01:11:14 (10888): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 01:11:56 (10888): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 01:11:56 (10888): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 01:12:00 (10888): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-10 01:12:00 (10888): Guest Log: 00:00:00.000226 main     Log opened 2022-10-09T23:12:00.965336000Z
2022-10-10 01:12:00 (10888): Guest Log: 00:00:00.000499 main     OS Product: Linux
2022-10-10 01:12:00 (10888): Guest Log: 00:00:00.000589 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 01:12:00 (10888): Guest Log: 00:00:00.000671 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 01:12:00 (10888): Guest Log: 00:00:00.000753 main     Executable: /usr/sbin/VBoxService
2022-10-10 01:12:00 (10888): Guest Log: 00:00:00.000755 main     Process ID: 2171
2022-10-10 01:12:00 (10888): Guest Log: 00:00:00.000757 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 01:12:00 (10888): Guest Log: 00:00:00.006495 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 01:12:31 (10888): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 01:13:04 (10888): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 01:13:20 (10888): Guest Log: [INFO] Mounting the shared directory
2022-10-10 01:13:21 (10888): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 01:13:21 (10888): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 01:13:22 (10888): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 01:13:22 (10888): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 01:13:23 (10888): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 01:13:23 (10888): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 01:13:24 (10888): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 01:13:24 (10888): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 01:13:25 (10888): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 01:13:25 (10888): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 01:13:27 (10888): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 01:13:27 (10888): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 01:13:27 (10888): Guest Log: [INFO] This makes the application less efficient
2022-10-10 01:13:28 (10888): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 01:13:28 (10888): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 01:13:28 (10888): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 01:13:29 (10888): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 01:14:07 (10888): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 01:14:38 (10888): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 01:14:40 (10888): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 01:14:41 (10888): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 01:14:42 (10888): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 01:14:45 (10888): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 01:14:45 (10888): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 01:14:45 (10888): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 01:14:46 (10888): Guest Log: [INFO] Reading volunteer information
2022-10-10 01:14:49 (10888): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 01:14:50 (10888): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 01:14:52 (10888): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 01:14:53 (10888): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 01:14:54 (10888): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 08:37:59 (12728): Detected: vboxwrapper 26205
2022-10-10 08:37:59 (12728): Detected: BOINC client v7.16.11
2022-10-10 08:38:02 (12728): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-10 08:38:02 (12728): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-10 08:38:03 (12728): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 08:38:03 (12728): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 08:38:03 (12728): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 08:38:03 (12728): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 08:38:03 (12728): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 08:38:03 (12728): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 08:38:03 (12728): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 08:38:03 (12728): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 08:38:03 (12728): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 08:38:03 (12728): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 08:38:03 (12728): 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 (12728): Guest Log: 00:00:00.000226 main     Log opened 2022-10-09T23:12:00.965336000Z
2022-10-10 08:38:03 (12728): Guest Log: 00:00:00.000499 main     OS Product: Linux
2022-10-10 08:38:03 (12728): Guest Log: 00:00:00.000589 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 08:38:03 (12728): Guest Log: 00:00:00.000671 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 08:38:03 (12728): Guest Log: 00:00:00.000753 main     Executable: /usr/sbin/VBoxService
2022-10-10 08:38:03 (12728): Guest Log: 00:00:00.000755 main     Process ID: 2171
2022-10-10 08:38:03 (12728): Guest Log: 00:00:00.000757 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 08:38:03 (12728): Guest Log: 00:00:00.006495 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Mounting the shared directory
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 08:38:03 (12728): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 08:38:03 (12728): Guest Log: [INFO] This makes the application less efficient
2022-10-10 08:38:03 (12728): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 08:38:03 (12728): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Reading volunteer information
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 08:38:03 (12728): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 08:38:03 (12728): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 08:38:03 (12728): Starting VM using VBoxManage interface. (boinc_33172a236756abc4, slot#2)
2022-10-10 08:38:15 (12728): Successfully started VM. (PID = '13940')
2022-10-10 08:38:15 (12728): Reporting VM Process ID to BOINC.
2022-10-10 08:38:16 (12728): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 08:38:16 (12728): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 08:38:16 (12728): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 08:38:16 (12728): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 08:38:16 (12728): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 08:38:16 (12728): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 08:38:16 (12728): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-10 08:38:16 (12728): Detected: Web Application Enabled (http://localhost:56187)
2022-10-10 08:38:16 (12728): Detected: Remote Desktop Enabled (localhost:56188)
2022-10-10 08:38:16 (12728): Status Report: Job Duration: '64800.000000'
2022-10-10 08:38:16 (12728): Status Report: Elapsed Time: '24862.404825'
2022-10-10 08:38:16 (12728): Status Report: CPU Time: '14882.546875'
2022-10-10 08:38:16 (12728): Preference change detected
2022-10-10 08:38:16 (12728): Setting CPU throttle for VM. (50%)
2022-10-10 08:38:16 (12728): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-10 08:38:19 (12728): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 08:38:19 (12728): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 08:38:22 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:38:51 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:39:27 (12728): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 08:39:27 (12728): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 08:39:29 (12728): 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 (12728): Guest Log: 00:00:00.000108 main     Log opened 2022-10-10T06:39:29.551512000Z
2022-10-10 08:39:29 (12728): Guest Log: 00:00:00.000228 main     OS Product: Linux
2022-10-10 08:39:29 (12728): Guest Log: 00:00:00.000268 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 08:39:29 (12728): Guest Log: 00:00:00.000302 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 08:39:29 (12728): Guest Log: 00:00:00.000333 main     Executable: /usr/sbin/VBoxService
2022-10-10 08:39:29 (12728): Guest Log: 00:00:00.000334 main     Process ID: 2161
2022-10-10 08:39:29 (12728): Guest Log: 00:00:00.000335 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 08:39:29 (12728): Guest Log: 00:00:00.008916 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 08:39:43 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:40:21 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:40:40 (12728): Guest Log: [INFO] Mounting the shared directory
2022-10-10 08:40:40 (12728): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 08:40:40 (12728): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 08:40:40 (12728): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 08:40:41 (12728): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 08:40:41 (12728): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 08:40:41 (12728): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 08:40:42 (12728): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 08:40:42 (12728): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 08:40:42 (12728): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 08:40:43 (12728): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 08:40:43 (12728): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 08:40:43 (12728): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 08:40:44 (12728): Guest Log: [INFO] This makes the application less efficient
2022-10-10 08:40:44 (12728): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 08:40:44 (12728): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 08:40:44 (12728): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 08:40:44 (12728): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 08:41:08 (12728): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 08:41:22 (12728): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 08:41:25 (12728): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 08:41:25 (12728): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 08:41:26 (12728): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 08:41:27 (12728): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 08:41:27 (12728): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 08:41:27 (12728): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 08:41:28 (12728): Guest Log: [INFO] Reading volunteer information
2022-10-10 08:41:29 (12728): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 08:41:30 (12728): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 08:41:31 (12728): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 08:41:32 (12728): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 08:41:33 (12728): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 08:43:21 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:43:31 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:43:51 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:44:01 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:46:22 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:46:32 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:48:12 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:48:22 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:53:52 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:54:02 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 08:56:42 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 08:56:52 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 09:00:32 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 09:00:42 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 09:02:03 (12728): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 09:02:13 (12728): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 10:48:23 (10952): Detected: vboxwrapper 26205
2022-10-10 10:48:23 (10952): Detected: BOINC client v7.16.11
2022-10-10 10:48:24 (10952): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-10 10:48:24 (10952): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-10 10:48:24 (10952): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 10:48:24 (10952): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 10:48:24 (10952): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 10:48:24 (10952): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 10:48:24 (10952): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 10:48:24 (10952): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 10:48:24 (10952): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 10:48:24 (10952): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 10:48:24 (10952): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 10:48:24 (10952): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 10:48:24 (10952): 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 (10952): Guest Log: 00:00:00.000108 main     Log opened 2022-10-10T06:39:29.551512000Z
2022-10-10 10:48:24 (10952): Guest Log: 00:00:00.000228 main     OS Product: Linux
2022-10-10 10:48:24 (10952): Guest Log: 00:00:00.000268 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 10:48:24 (10952): Guest Log: 00:00:00.000302 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 10:48:24 (10952): Guest Log: 00:00:00.000333 main     Executable: /usr/sbin/VBoxService
2022-10-10 10:48:24 (10952): Guest Log: 00:00:00.000334 main     Process ID: 2161
2022-10-10 10:48:24 (10952): Guest Log: 00:00:00.000335 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 10:48:24 (10952): Guest Log: 00:00:00.008916 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Mounting the shared directory
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Could not find a local HTTP proxy
2022-10-10 10:48:24 (10952): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-10-10 10:48:24 (10952): Guest Log: [INFO] This makes the application less efficient
2022-10-10 10:48:24 (10952): Guest Log: [INFO] It also puts higher load on the project servers
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Advice can be found in the project forum
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 10:48:24 (10952): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Reading volunteer information
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 10:48:24 (10952): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 10:48:24 (10952): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 10:48:24 (10952): Starting VM using VBoxManage interface. (boinc_33172a236756abc4, slot#2)
2022-10-10 10:48:30 (10952): Successfully started VM. (PID = '11940')
2022-10-10 10:48:30 (10952): Reporting VM Process ID to BOINC.
2022-10-10 10:48:30 (10952): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-10 10:48:30 (10952): Guest Log: CPUID EDX: 0x178bfbff
2022-10-10 10:48:30 (10952): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-10 10:48:30 (10952): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-10 10:48:30 (10952): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-10 10:48:30 (10952): Detected: Web Application Enabled (http://localhost:56187)
2022-10-10 10:48:30 (10952): Detected: Remote Desktop Enabled (localhost:56188)
2022-10-10 10:48:30 (10952): Status Report: Job Duration: '64800.000000'
2022-10-10 10:48:30 (10952): Status Report: Elapsed Time: '26530.404825'
2022-10-10 10:48:30 (10952): Status Report: CPU Time: '15828.687500'
2022-10-10 10:48:30 (10952): Preference change detected
2022-10-10 10:48:30 (10952): Setting CPU throttle for VM. (50%)
2022-10-10 10:48:31 (10952): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-10 10:48:32 (10952): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-10 10:48:32 (10952): Guest Log: BIOS: Booting from Hard Disk...
2022-10-10 10:48:35 (10952): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-10 10:48:35 (10952): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-10 10:48:45 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 10:48:55 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 10:49:16 (10952): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-10 10:49:16 (10952): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-10 10:49:18 (10952): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-10-10 10:49:18 (10952): Guest Log: 00:00:00.000121 main     Log opened 2022-10-10T08:49:19.219671000Z
2022-10-10 10:49:18 (10952): Guest Log: 00:00:00.000216 main     OS Product: Linux
2022-10-10 10:49:18 (10952): Guest Log: 00:00:00.000260 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-10 10:49:18 (10952): Guest Log: 00:00:00.000299 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-10 10:49:18 (10952): Guest Log: 00:00:00.000337 main     Executable: /usr/sbin/VBoxService
2022-10-10 10:49:18 (10952): Guest Log: 00:00:00.000338 main     Process ID: 2166
2022-10-10 10:49:18 (10952): Guest Log: 00:00:00.000339 main     Package type: LINUX_64BITS_GENERIC
2022-10-10 10:49:18 (10952): Guest Log: 00:00:00.003118 main     5.2.6 r120293 started. Verbose level = 0
2022-10-10 10:49:40 (10952): Guest Log: [INFO] Mounting the shared directory
2022-10-10 10:49:40 (10952): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-10 10:49:40 (10952): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-10 10:49:40 (10952): Guest Log: [INFO] Testing connection to cern.ch
2022-10-10 10:49:40 (10952): Guest Log: [INFO] Testing connection to VCCS
2022-10-10 10:49:40 (10952): Guest Log: [INFO] Testing connection to HTCondor
2022-10-10 10:49:40 (10952): Guest Log: [INFO] Testing connection to WMAgent
2022-10-10 10:49:41 (10952): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-10 10:49:41 (10952): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-10 10:49:41 (10952): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-10 10:49:41 (10952): Guest Log: [INFO] Testing connection to Frontier
2022-10-10 10:49:42 (10952): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-10-10 10:49:42 (10952): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-10-10 10:49:42 (10952): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-10 10:49:59 (10952): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-10 10:50:12 (10952): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-10 10:50:13 (10952): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-10 10:50:13 (10952): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-10 10:50:14 (10952): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-10 10:50:15 (10952): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-10 10:50:15 (10952): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-10 10:50:16 (10952): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-10 10:50:16 (10952): Guest Log: [INFO] Reading volunteer information
2022-10-10 10:50:17 (10952): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-10 10:50:18 (10952): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-10 10:50:19 (10952): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-10 10:50:19 (10952): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-10 10:50:20 (10952): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-10 10:50:34 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 10:50:44 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 12:05:49 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 12:05:59 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 12:29:13 (10952): Status Report: Job Duration: '64800.000000'
2022-10-10 12:29:13 (10952): Status Report: Elapsed Time: '32531.182361'
2022-10-10 12:29:13 (10952): Status Report: CPU Time: '19387.609375'
2022-10-10 14:09:20 (10952): Status Report: Job Duration: '64800.000000'
2022-10-10 14:09:20 (10952): Status Report: Elapsed Time: '38531.182361'
2022-10-10 14:09:20 (10952): Status Report: CPU Time: '22995.718750'
2022-10-10 15:49:27 (10952): Status Report: Job Duration: '64800.000000'
2022-10-10 15:49:27 (10952): Status Report: Elapsed Time: '44531.182361'
2022-10-10 15:49:27 (10952): Status Report: CPU Time: '26550.468750'
2022-10-10 17:29:34 (10952): Status Report: Job Duration: '64800.000000'
2022-10-10 17:29:34 (10952): Status Report: Elapsed Time: '50531.182361'
2022-10-10 17:29:34 (10952): Status Report: CPU Time: '30158.953125'
2022-10-10 18:18:27 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-10-10 18:18:37 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-10-10 18:42:49 (10952): Stopping VM.
2022-10-10 18:43:08 (10952): Successfully stopped VM.
2022-10-11 12:03:24 (11444): Detected: vboxwrapper 26205
2022-10-11 12:03:24 (11444): Detected: BOINC client v7.16.11
2022-10-11 12:03:25 (11444): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-10-11 12:03:25 (11444): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-10-11 12:03:26 (11444): Guest Log: BIOS: VirtualBox 6.1.12
2022-10-11 12:03:26 (11444): Guest Log: CPUID EDX: 0x178bfbff
2022-10-11 12:03:26 (11444): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-10-11 12:03:26 (11444): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-10-11 12:03:26 (11444): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-10-11 12:03:26 (11444): Guest Log: BIOS: Booting from Hard Disk...
2022-10-11 12:03:26 (11444): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-10-11 12:03:26 (11444): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-10-11 12:03:26 (11444): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-10-11 12:03:26 (11444): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-10-11 12:03:26 (11444): 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 (11444): Guest Log: 00:00:00.000121 main     Log opened 2022-10-10T08:49:19.219671000Z
2022-10-11 12:03:26 (11444): Guest Log: 00:00:00.000216 main     OS Product: Linux
2022-10-11 12:03:26 (11444): Guest Log: 00:00:00.000260 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-10-11 12:03:26 (11444): Guest Log: 00:00:00.000299 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-10-11 12:03:26 (11444): Guest Log: 00:00:00.000337 main     Executable: /usr/sbin/VBoxService
2022-10-11 12:03:26 (11444): Guest Log: 00:00:00.000338 main     Process ID: 2166
2022-10-11 12:03:26 (11444): Guest Log: 00:00:00.000339 main     Package type: LINUX_64BITS_GENERIC
2022-10-11 12:03:26 (11444): Guest Log: 00:00:00.003118 main     5.2.6 r120293 started. Verbose level = 0
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Mounting the shared directory
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Testing connection to cern.ch
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Testing connection to VCCS
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Testing connection to HTCondor
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Testing connection to WMAgent
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Testing connection to EOSCMS
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Testing connection to CMS-Factory
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Testing connection to Frontier
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-10-11 12:03:26 (11444): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Environment HTTP proxy: not set
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Reading volunteer information
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-10-11 12:03:26 (11444): Guest Log: [INFO] CMS application starting. Check log files.
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-10-11 12:03:26 (11444): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-10-11 12:03:26 (11444): Starting VM using VBoxManage interface. (boinc_33172a236756abc4, slot#2)
2022-10-11 12:03:45 (11444): Successfully started VM. (PID = '12116')
2022-10-11 12:03:45 (11444): Reporting VM Process ID to BOINC.
2022-10-11 12:03:45 (11444): Guest Log: 07:53:14.778280 timesync vgsvcTimeSyncWorker: Radical host time change: 62 464 824 000 000ns (HostNow=1 665 482 624 396 000 000 ns HostLast=1 665 420 159 572 000 000 ns)
2022-10-11 12:03:45 (11444): VM state change detected. (old = 'poweredoff', new = 'running')
2022-10-11 12:03:45 (11444): Detected: Web Application Enabled (http://localhost:56187)
2022-10-11 12:03:45 (11444): Detected: Remote Desktop Enabled (localhost:56188)
2022-10-11 12:03:46 (11444): VM state change detected. (old = 'running', new = 'paused')
2022-10-11 12:03:54 (11444): Status Report: Job Duration: '64800.000000'
2022-10-11 12:03:54 (11444): Status Report: Elapsed Time: '54910.182361'
2022-10-11 12:03:54 (11444): Status Report: CPU Time: '32807.125000'
2022-10-11 12:03:54 (11444): Preference change detected
2022-10-11 12:03:54 (11444): Setting CPU throttle for VM. (50%)
2022-10-11 12:03:54 (11444): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-10-11 12:03:55 (11444): VM state change detected. (old = 'paused', new = 'running')
2022-10-11 12:03:58 (11444): Guest Log: [INFO] glidein exited with return value 0.
2022-10-11 12:03:58 (11444): Guest Log: [INFO] Shutting Down.
2022-10-11 12:03:58 (11444): VM Completion File Detected.
2022-10-11 12:03:58 (11444): VM Completion Message: glidein exited with return value 0.
.
2022-10-11 12:03:58 (11444): Powering off VM.
2022-10-11 12:03:59 (11444): Successfully stopped VM.
2022-10-11 12:03:59 (11444): Deregistering VM. (boinc_33172a236756abc4, slot#2)
2022-10-11 12:03:59 (11444): Removing network bandwidth throttle group from VM.
2022-10-11 12:03:59 (11444): Removing VM from VirtualBox.
12:04:04 (11444): called boinc_finish(0)

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

Stderr output
