Task 3115014

Name	CMS_3044851_1663660873.011133_0
Workunit	2210759
Created	20 Sep 2022, 8:01:15 UTC
Sent	21 Sep 2022, 14:40:26 UTC
Report deadline	28 Sep 2022, 14:40:26 UTC
Received	26 Sep 2022, 14:29:57 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4441
Run time	18 hours 3 min 51 sec
CPU time	5 hours 10 min 44 sec
Validate state	Valid
Credit	286.62
Device peak FLOPS	1.90 GFLOPS
Application version	CMS Simulation v60.66 (vbox64_mt_mcore_cms) windows_x86_64
Peak working set size	81.09 MB
Peak swap size	107.30 MB
Peak disk usage	1.24 GB
Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
ed', new = 'running')
2022-09-22 11:52:35 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 11:52:45 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 11:53:35 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 11:53:45 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 11:54:15 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 11:54:25 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:01:26 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:01:36 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:03:26 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:03:36 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:05:17 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:05:27 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:11:28 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:11:48 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:11:58 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:12:18 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:13:58 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:14:08 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:16:58 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:17:08 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:17:48 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:17:58 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:19:08 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:19:18 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:22:49 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:22:59 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:24:29 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:24:39 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:28:50 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:28:59 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:29:09 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:29:19 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 12:34:59 (10952): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 12:35:09 (10952): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 16:58:14 (12700): Detected: vboxwrapper 26205
2022-09-22 16:58:14 (12700): Detected: BOINC client v7.16.11
2022-09-22 16:58:15 (12700): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-09-22 16:58:15 (12700): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-09-22 16:58:16 (12700): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-22 16:58:16 (12700): Guest Log: CPUID EDX: 0x178bfbff
2022-09-22 16:58:16 (12700): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-22 16:58:16 (12700): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-22 16:58:16 (12700): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-22 16:58:16 (12700): Guest Log: BIOS: Booting from Hard Disk...
2022-09-22 16:58:16 (12700): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-22 16:58:16 (12700): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-22 16:58:16 (12700): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-22 16:58:16 (12700): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-22 16:58:16 (12700): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-22 16:58:16 (12700): Guest Log: 00:00:00.000111 main     Log opened 2022-09-22T08:59:00.251218000Z
2022-09-22 16:58:16 (12700): Guest Log: 00:00:00.000212 main     OS Product: Linux
2022-09-22 16:58:16 (12700): Guest Log: 00:00:00.000252 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-22 16:58:16 (12700): Guest Log: 00:00:00.000286 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-22 16:58:16 (12700): Guest Log: 00:00:00.000333 main     Executable: /usr/sbin/VBoxService
2022-09-22 16:58:16 (12700): Guest Log: 00:00:00.000334 main     Process ID: 2172
2022-09-22 16:58:16 (12700): Guest Log: 00:00:00.000335 main     Package type: LINUX_64BITS_GENERIC
2022-09-22 16:58:16 (12700): Guest Log: 00:00:00.003284 main     5.2.6 r120293 started. Verbose level = 0
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Mounting the shared directory
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Testing connection to cern.ch
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Testing connection to VCCS
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Testing connection to HTCondor
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Testing connection to WMAgent
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Testing connection to Frontier
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-22 16:58:16 (12700): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-22 16:58:16 (12700): Guest Log: [INFO] This makes the application less efficient
2022-09-22 16:58:16 (12700): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Advice can be found in the project forum
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-22 16:58:16 (12700): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Reading volunteer information
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-22 16:58:16 (12700): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-22 16:58:16 (12700): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-22 16:58:16 (12700): Starting VM using VBoxManage interface. (boinc_1f61dccbcb2f35cd, slot#4)
2022-09-22 16:58:20 (12700): Successfully started VM. (PID = '13408')
2022-09-22 16:58:20 (12700): Reporting VM Process ID to BOINC.
2022-09-22 16:58:20 (12700): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-22 16:58:20 (12700): Guest Log: CPUID EDX: 0x178bfbff
2022-09-22 16:58:20 (12700): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-22 16:58:20 (12700): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-22 16:58:20 (12700): VM state change detected. (old = 'poweredoff', new = 'running')
2022-09-22 16:58:20 (12700): Detected: Web Application Enabled (http://localhost:60299)
2022-09-22 16:58:20 (12700): Detected: Remote Desktop Enabled (localhost:60301)
2022-09-22 16:58:20 (12700): Status Report: Job Duration: '64800.000000'
2022-09-22 16:58:20 (12700): Status Report: Elapsed Time: '12635.365433'
2022-09-22 16:58:20 (12700): Status Report: CPU Time: '1147.562500'
2022-09-22 16:58:20 (12700): Preference change detected
2022-09-22 16:58:20 (12700): Setting CPU throttle for VM. (50%)
2022-09-22 16:58:21 (12700): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-09-22 16:58:22 (12700): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-22 16:58:22 (12700): Guest Log: BIOS: Booting from Hard Disk...
2022-09-22 16:58:25 (12700): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-22 16:58:25 (12700): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-22 16:58:35 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 16:58:45 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 16:59:09 (12700): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-22 16:59:09 (12700): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-22 16:59:11 (12700): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-22 16:59:11 (12700): Guest Log: 00:00:00.000105 main     Log opened 2022-09-22T14:59:10.926052000Z
2022-09-22 16:59:11 (12700): Guest Log: 00:00:00.000251 main     OS Product: Linux
2022-09-22 16:59:11 (12700): Guest Log: 00:00:00.000290 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-22 16:59:11 (12700): Guest Log: 00:00:00.000318 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-22 16:59:11 (12700): Guest Log: 00:00:00.000345 main     Executable: /usr/sbin/VBoxService
2022-09-22 16:59:11 (12700): Guest Log: 00:00:00.000346 main     Process ID: 2167
2022-09-22 16:59:11 (12700): Guest Log: 00:00:00.000346 main     Package type: LINUX_64BITS_GENERIC
2022-09-22 16:59:11 (12700): Guest Log: 00:00:00.002885 main     5.2.6 r120293 started. Verbose level = 0
2022-09-22 16:59:30 (12700): Guest Log: [INFO] Mounting the shared directory
2022-09-22 16:59:30 (12700): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-22 16:59:30 (12700): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-22 16:59:30 (12700): Guest Log: [INFO] Testing connection to cern.ch
2022-09-22 16:59:31 (12700): Guest Log: [INFO] Testing connection to VCCS
2022-09-22 16:59:31 (12700): Guest Log: [INFO] Testing connection to HTCondor
2022-09-22 16:59:31 (12700): Guest Log: [INFO] Testing connection to WMAgent
2022-09-22 16:59:31 (12700): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-22 16:59:32 (12700): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-22 16:59:32 (12700): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-22 16:59:32 (12700): Guest Log: [INFO] Testing connection to Frontier
2022-09-22 16:59:33 (12700): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-22 16:59:33 (12700): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-22 16:59:33 (12700): Guest Log: [INFO] This makes the application less efficient
2022-09-22 16:59:33 (12700): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-22 16:59:33 (12700): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-22 16:59:33 (12700): Guest Log: [INFO] Advice can be found in the project forum
2022-09-22 16:59:33 (12700): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-22 16:59:49 (12700): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-22 17:00:01 (12700): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-22 17:00:02 (12700): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-22 17:00:02 (12700): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-22 17:00:03 (12700): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-22 17:00:04 (12700): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-22 17:00:04 (12700): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-22 17:00:04 (12700): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-22 17:00:05 (12700): Guest Log: [INFO] Reading volunteer information
2022-09-22 17:00:06 (12700): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-22 17:00:07 (12700): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-22 17:00:09 (12700): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-22 17:00:09 (12700): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-22 17:00:10 (12700): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-22 17:00:15 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 17:00:25 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 17:16:06 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 17:16:16 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 17:21:17 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 17:21:27 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 17:23:38 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 17:23:48 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 17:27:58 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 17:28:08 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 17:38:58 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 17:39:08 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 17:46:09 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 17:46:19 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:15:31 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:15:41 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:16:31 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:16:41 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:19:22 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:19:32 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:26:42 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:26:52 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:40:23 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:40:33 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:40:49 (12700): Status Report: Job Duration: '64800.000000'
2022-09-22 18:40:49 (12700): Status Report: Elapsed Time: '18636.365433'
2022-09-22 18:40:49 (12700): Status Report: CPU Time: '1470.078125'
2022-09-22 18:42:03 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:42:13 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:53:04 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:53:14 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:56:44 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:56:54 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:59:04 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:59:14 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 18:59:34 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 18:59:44 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 19:19:36 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 19:19:46 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 19:46:19 (12700): VM state change detected. (old = 'running', new = 'paused')
2022-09-22 19:46:29 (12700): VM state change detected. (old = 'paused', new = 'running')
2022-09-22 20:22:11 (12700): Status Report: Job Duration: '64800.000000'
2022-09-22 20:22:11 (12700): Status Report: Elapsed Time: '24636.365433'
2022-09-22 20:22:11 (12700): Status Report: CPU Time: '1566.828125'
2022-09-22 22:02:16 (12700): Status Report: Job Duration: '64800.000000'
2022-09-22 22:02:17 (12700): Status Report: Elapsed Time: '30636.365433'
2022-09-22 22:02:17 (12700): Status Report: CPU Time: '1656.843750'
2022-09-23 08:41:03 (12508): Detected: vboxwrapper 26205
2022-09-23 08:41:03 (12508): Detected: BOINC client v7.16.11
2022-09-23 08:41:04 (12508): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-09-23 08:41:05 (12508): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-09-23 08:41:05 (12508): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-23 08:41:05 (12508): Guest Log: CPUID EDX: 0x178bfbff
2022-09-23 08:41:05 (12508): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-23 08:41:05 (12508): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-23 08:41:05 (12508): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-23 08:41:05 (12508): Guest Log: BIOS: Booting from Hard Disk...
2022-09-23 08:41:05 (12508): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-23 08:41:05 (12508): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-23 08:41:05 (12508): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-23 08:41:05 (12508): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-23 08:41:05 (12508): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-23 08:41:05 (12508): Guest Log: 00:00:00.000105 main     Log opened 2022-09-22T14:59:10.926052000Z
2022-09-23 08:41:05 (12508): Guest Log: 00:00:00.000251 main     OS Product: Linux
2022-09-23 08:41:05 (12508): Guest Log: 00:00:00.000290 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-23 08:41:05 (12508): Guest Log: 00:00:00.000318 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-23 08:41:05 (12508): Guest Log: 00:00:00.000345 main     Executable: /usr/sbin/VBoxService
2022-09-23 08:41:05 (12508): Guest Log: 00:00:00.000346 main     Process ID: 2167
2022-09-23 08:41:05 (12508): Guest Log: 00:00:00.000346 main     Package type: LINUX_64BITS_GENERIC
2022-09-23 08:41:05 (12508): Guest Log: 00:00:00.002885 main     5.2.6 r120293 started. Verbose level = 0
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Mounting the shared directory
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Testing connection to cern.ch
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Testing connection to VCCS
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Testing connection to HTCondor
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Testing connection to WMAgent
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Testing connection to Frontier
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-23 08:41:05 (12508): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-23 08:41:05 (12508): Guest Log: [INFO] This makes the application less efficient
2022-09-23 08:41:05 (12508): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Advice can be found in the project forum
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-23 08:41:05 (12508): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Reading volunteer information
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-23 08:41:05 (12508): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-23 08:41:05 (12508): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-23 08:41:05 (12508): Starting VM using VBoxManage interface. (boinc_1f61dccbcb2f35cd, slot#4)
2022-09-23 08:41:10 (12508): Successfully started VM. (PID = '13384')
2022-09-23 08:41:10 (12508): Reporting VM Process ID to BOINC.
2022-09-23 08:41:10 (12508): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-23 08:41:10 (12508): Guest Log: CPUID EDX: 0x178bfbff
2022-09-23 08:41:10 (12508): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-23 08:41:10 (12508): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-23 08:41:10 (12508): VM state change detected. (old = 'poweredoff', new = 'running')
2022-09-23 08:41:10 (12508): Detected: Web Application Enabled (http://localhost:60299)
2022-09-23 08:41:10 (12508): Detected: Remote Desktop Enabled (localhost:60301)
2022-09-23 08:41:10 (12508): Status Report: Job Duration: '64800.000000'
2022-09-23 08:41:10 (12508): Status Report: Elapsed Time: '36418.365433'
2022-09-23 08:41:10 (12508): Status Report: CPU Time: '1740.890625'
2022-09-23 08:41:10 (12508): Preference change detected
2022-09-23 08:41:10 (12508): Setting CPU throttle for VM. (50%)
2022-09-23 08:41:10 (12508): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-09-23 08:41:12 (12508): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-23 08:41:12 (12508): Guest Log: BIOS: Booting from Hard Disk...
2022-09-23 08:41:15 (12508): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-23 08:41:15 (12508): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-23 08:41:25 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 08:41:45 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-23 08:42:17 (12508): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-23 08:42:17 (12508): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-23 08:42:21 (12508): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-23 08:42:21 (12508): Guest Log: 00:00:00.000166 main     Log opened 2022-09-23T06:42:19.365896000Z
2022-09-23 08:42:21 (12508): Guest Log: 00:00:00.000365 main     OS Product: Linux
2022-09-23 08:42:21 (12508): Guest Log: 00:00:00.000434 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-23 08:42:21 (12508): Guest Log: 00:00:00.000491 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-23 08:42:21 (12508): Guest Log: 00:00:00.000548 main     Executable: /usr/sbin/VBoxService
2022-09-23 08:42:21 (12508): Guest Log: 00:00:00.000550 main     Process ID: 2171
2022-09-23 08:42:21 (12508): Guest Log: 00:00:00.000551 main     Package type: LINUX_64BITS_GENERIC
2022-09-23 08:42:21 (12508): Guest Log: 00:00:00.005129 main     5.2.6 r120293 started. Verbose level = 0
2022-09-23 08:42:25 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 08:42:35 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-23 08:43:14 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 08:43:34 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-23 08:43:41 (12508): Guest Log: [INFO] Mounting the shared directory
2022-09-23 08:43:41 (12508): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-23 08:43:41 (12508): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-23 08:43:41 (12508): Guest Log: [INFO] Testing connection to cern.ch
2022-09-23 08:43:42 (12508): Guest Log: [INFO] Testing connection to VCCS
2022-09-23 08:43:43 (12508): Guest Log: [INFO] Testing connection to HTCondor
2022-09-23 08:43:43 (12508): Guest Log: [INFO] Testing connection to WMAgent
2022-09-23 08:43:44 (12508): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-23 08:43:45 (12508): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-23 08:43:45 (12508): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-23 08:43:46 (12508): Guest Log: [INFO] Testing connection to Frontier
2022-09-23 08:43:47 (12508): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-23 08:43:47 (12508): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-23 08:43:47 (12508): Guest Log: [INFO] This makes the application less efficient
2022-09-23 08:43:47 (12508): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-23 08:43:48 (12508): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-23 08:43:48 (12508): Guest Log: [INFO] Advice can be found in the project forum
2022-09-23 08:43:48 (12508): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-23 08:44:27 (12508): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-23 08:45:13 (12508): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-23 08:45:15 (12508): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-23 08:45:17 (12508): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-23 08:45:19 (12508): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-23 08:45:22 (12508): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-23 08:45:22 (12508): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-23 08:45:23 (12508): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-23 08:45:24 (12508): Guest Log: [INFO] Reading volunteer information
2022-09-23 08:45:27 (12508): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-23 08:45:29 (12508): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-23 08:45:31 (12508): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-23 08:45:34 (12508): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-23 08:45:35 (12508): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-23 08:48:15 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 08:48:25 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-23 08:49:15 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 08:49:35 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-23 08:56:06 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 08:56:16 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-23 09:00:27 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 09:00:37 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-23 09:01:38 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 09:01:48 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-23 09:12:28 (12508): VM state change detected. (old = 'running', new = 'paused')
2022-09-23 09:12:38 (12508): VM state change detected. (old = 'paused', new = 'running')
2022-09-24 09:38:10 (2440): Detected: vboxwrapper 26205
2022-09-24 09:38:10 (2440): Detected: BOINC client v7.16.11
2022-09-24 09:38:11 (2440): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-09-24 09:38:11 (2440): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-09-24 09:38:12 (2440): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-24 09:38:12 (2440): Guest Log: CPUID EDX: 0x178bfbff
2022-09-24 09:38:12 (2440): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-24 09:38:12 (2440): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-24 09:38:12 (2440): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-24 09:38:12 (2440): Guest Log: BIOS: Booting from Hard Disk...
2022-09-24 09:38:12 (2440): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-24 09:38:12 (2440): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-24 09:38:12 (2440): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-24 09:38:12 (2440): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-24 09:38:12 (2440): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-24 09:38:12 (2440): Guest Log: 00:00:00.000166 main     Log opened 2022-09-23T06:42:19.365896000Z
2022-09-24 09:38:12 (2440): Guest Log: 00:00:00.000365 main     OS Product: Linux
2022-09-24 09:38:12 (2440): Guest Log: 00:00:00.000434 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-24 09:38:12 (2440): Guest Log: 00:00:00.000491 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-24 09:38:12 (2440): Guest Log: 00:00:00.000548 main     Executable: /usr/sbin/VBoxService
2022-09-24 09:38:12 (2440): Guest Log: 00:00:00.000550 main     Process ID: 2171
2022-09-24 09:38:12 (2440): Guest Log: 00:00:00.000551 main     Package type: LINUX_64BITS_GENERIC
2022-09-24 09:38:12 (2440): Guest Log: 00:00:00.005129 main     5.2.6 r120293 started. Verbose level = 0
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Mounting the shared directory
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Testing connection to cern.ch
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Testing connection to VCCS
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Testing connection to HTCondor
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Testing connection to WMAgent
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Testing connection to Frontier
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-24 09:38:12 (2440): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-24 09:38:12 (2440): Guest Log: [INFO] This makes the application less efficient
2022-09-24 09:38:12 (2440): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Advice can be found in the project forum
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-24 09:38:12 (2440): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Reading volunteer information
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-24 09:38:12 (2440): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-24 09:38:12 (2440): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-24 09:38:12 (2440): Starting VM using VBoxManage interface. (boinc_1f61dccbcb2f35cd, slot#4)
2022-09-24 09:38:19 (2440): Successfully started VM. (PID = '11668')
2022-09-24 09:38:19 (2440): Reporting VM Process ID to BOINC.
2022-09-24 09:38:19 (2440): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-24 09:38:19 (2440): Guest Log: CPUID EDX: 0x178bfbff
2022-09-24 09:38:19 (2440): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-24 09:38:19 (2440): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-24 09:38:19 (2440): VM state change detected. (old = 'poweredoff', new = 'running')
2022-09-24 09:38:19 (2440): Detected: Web Application Enabled (http://localhost:60299)
2022-09-24 09:38:19 (2440): Detected: Remote Desktop Enabled (localhost:60301)
2022-09-24 09:38:19 (2440): Status Report: Job Duration: '64800.000000'
2022-09-24 09:38:19 (2440): Status Report: Elapsed Time: '38169.365433'
2022-09-24 09:38:19 (2440): Status Report: CPU Time: '2783.843750'
2022-09-24 09:38:19 (2440): Preference change detected
2022-09-24 09:38:19 (2440): Setting CPU throttle for VM. (50%)
2022-09-24 09:38:19 (2440): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-09-24 09:38:21 (2440): VM state change detected. (old = 'running', new = 'paused')
2022-09-24 09:39:11 (2440): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-24 09:39:11 (2440): Guest Log: BIOS: Booting from Hard Disk...
2022-09-24 09:39:11 (2440): VM state change detected. (old = 'paused', new = 'running')
2022-09-24 09:39:14 (2440): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-24 09:39:14 (2440): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-24 09:41:35 (2440): VM state change detected. (old = 'running', new = 'paused')
2022-09-24 09:41:45 (2440): VM state change detected. (old = 'paused', new = 'running')
2022-09-24 09:42:05 (2440): VM state change detected. (old = 'running', new = 'paused')
2022-09-24 09:43:05 (2440): VM state change detected. (old = 'paused', new = 'running')
2022-09-24 09:43:11 (2440): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-24 09:43:11 (2440): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-24 09:43:13 (2440): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-24 09:43:13 (2440): Guest Log: 00:00:00.000145 main     Log opened 2022-09-24T07:42:12.478343000Z
2022-09-24 09:43:13 (2440): Guest Log: 00:00:00.000279 main     OS Product: Linux
2022-09-24 09:43:13 (2440): Guest Log: 00:00:00.000320 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-24 09:43:13 (2440): Guest Log: 00:00:00.000379 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-24 09:43:13 (2440): Guest Log: 00:00:00.000418 main     Executable: /usr/sbin/VBoxService
2022-09-24 09:43:13 (2440): Guest Log: 00:00:00.000419 main     Process ID: 2170
2022-09-24 09:43:13 (2440): Guest Log: 00:00:00.000420 main     Package type: LINUX_64BITS_GENERIC
2022-09-24 09:43:13 (2440): Guest Log: 00:00:00.007014 main     5.2.6 r120293 started. Verbose level = 0
2022-09-24 09:43:45 (2440): Guest Log: [INFO] Mounting the shared directory
2022-09-24 09:43:45 (2440): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-24 09:43:45 (2440): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-24 09:43:45 (2440): Guest Log: [INFO] Testing connection to cern.ch
2022-09-24 09:43:46 (2440): Guest Log: [INFO] Testing connection to VCCS
2022-09-24 09:43:46 (2440): Guest Log: [INFO] Testing connection to HTCondor
2022-09-24 09:43:46 (2440): Guest Log: [INFO] Testing connection to WMAgent
2022-09-24 09:43:47 (2440): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-24 09:43:47 (2440): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-24 09:43:47 (2440): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-24 09:43:47 (2440): Guest Log: [INFO] Testing connection to Frontier
2022-09-24 09:43:48 (2440): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-24 09:43:48 (2440): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-24 09:43:48 (2440): Guest Log: [INFO] This makes the application less efficient
2022-09-24 09:43:48 (2440): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-24 09:43:48 (2440): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-24 09:43:49 (2440): Guest Log: [INFO] Advice can be found in the project forum
2022-09-24 09:43:49 (2440): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-24 09:44:07 (2440): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-24 09:44:21 (2440): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-24 09:44:22 (2440): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-24 09:44:22 (2440): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-24 09:44:23 (2440): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-24 09:44:24 (2440): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-24 09:44:25 (2440): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-24 09:44:25 (2440): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-24 09:44:25 (2440): Guest Log: [INFO] Reading volunteer information
2022-09-24 09:44:29 (2440): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-24 09:44:29 (2440): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-24 09:44:31 (2440): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-24 09:44:31 (2440): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-24 09:44:32 (2440): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-24 09:49:46 (2440): VM state change detected. (old = 'running', new = 'paused')
2022-09-24 09:49:56 (2440): VM state change detected. (old = 'paused', new = 'running')
2022-09-24 10:02:07 (2440): VM state change detected. (old = 'running', new = 'paused')
2022-09-24 10:02:17 (2440): VM state change detected. (old = 'paused', new = 'running')
2022-09-25 23:15:01 (12224): Detected: vboxwrapper 26205
2022-09-25 23:15:01 (12224): Detected: BOINC client v7.16.11
2022-09-25 23:15:02 (12224): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-09-25 23:15:03 (12224): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-09-25 23:15:03 (12224): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-25 23:15:03 (12224): Guest Log: CPUID EDX: 0x178bfbff
2022-09-25 23:15:03 (12224): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-25 23:15:03 (12224): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-25 23:15:03 (12224): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-25 23:15:03 (12224): Guest Log: BIOS: Booting from Hard Disk...
2022-09-25 23:15:03 (12224): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-25 23:15:03 (12224): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-25 23:15:03 (12224): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-25 23:15:03 (12224): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-25 23:15:03 (12224): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-25 23:15:03 (12224): Guest Log: 00:00:00.000145 main     Log opened 2022-09-24T07:42:12.478343000Z
2022-09-25 23:15:03 (12224): Guest Log: 00:00:00.000279 main     OS Product: Linux
2022-09-25 23:15:03 (12224): Guest Log: 00:00:00.000320 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-25 23:15:03 (12224): Guest Log: 00:00:00.000379 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-25 23:15:03 (12224): Guest Log: 00:00:00.000418 main     Executable: /usr/sbin/VBoxService
2022-09-25 23:15:03 (12224): Guest Log: 00:00:00.000419 main     Process ID: 2170
2022-09-25 23:15:03 (12224): Guest Log: 00:00:00.000420 main     Package type: LINUX_64BITS_GENERIC
2022-09-25 23:15:03 (12224): Guest Log: 00:00:00.007014 main     5.2.6 r120293 started. Verbose level = 0
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Mounting the shared directory
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Testing connection to cern.ch
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Testing connection to VCCS
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Testing connection to HTCondor
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Testing connection to WMAgent
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Testing connection to Frontier
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-25 23:15:03 (12224): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-25 23:15:03 (12224): Guest Log: [INFO] This makes the application less efficient
2022-09-25 23:15:03 (12224): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Advice can be found in the project forum
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-25 23:15:03 (12224): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Reading volunteer information
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-25 23:15:03 (12224): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-25 23:15:03 (12224): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-25 23:15:03 (12224): Starting VM using VBoxManage interface. (boinc_1f61dccbcb2f35cd, slot#4)
2022-09-25 23:15:10 (12224): Successfully started VM. (PID = '12800')
2022-09-25 23:15:10 (12224): Reporting VM Process ID to BOINC.
2022-09-25 23:15:10 (12224): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-25 23:15:10 (12224): Guest Log: CPUID EDX: 0x178bfbff
2022-09-25 23:15:10 (12224): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-25 23:15:10 (12224): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-25 23:15:10 (12224): VM state change detected. (old = 'poweredoff', new = 'running')
2022-09-25 23:15:10 (12224): Detected: Web Application Enabled (http://localhost:60299)
2022-09-25 23:15:10 (12224): Detected: Remote Desktop Enabled (localhost:60301)
2022-09-25 23:15:10 (12224): Status Report: Job Duration: '64800.000000'
2022-09-25 23:15:10 (12224): Status Report: Elapsed Time: '39760.365433'
2022-09-25 23:15:10 (12224): Status Report: CPU Time: '3680.328125'
2022-09-25 23:15:10 (12224): Preference change detected
2022-09-25 23:15:10 (12224): Setting CPU throttle for VM. (50%)
2022-09-25 23:15:11 (12224): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-09-25 23:15:11 (12224): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-25 23:15:11 (12224): Guest Log: BIOS: Booting from Hard Disk...
2022-09-25 23:15:13 (12224): VM state change detected. (old = 'running', new = 'paused')
2022-09-25 23:16:02 (12224): VM state change detected. (old = 'paused', new = 'running')
2022-09-25 23:16:03 (12224): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-25 23:16:03 (12224): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-25 23:16:46 (12224): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-25 23:16:47 (12224): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-25 23:16:52 (12224): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-25 23:16:52 (12224): Guest Log: 00:00:00.000126 main     Log opened 2022-09-25T21:16:50.812319000Z
2022-09-25 23:16:52 (12224): Guest Log: 00:00:00.000256 main     OS Product: Linux
2022-09-25 23:16:52 (12224): Guest Log: 00:00:00.000308 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-25 23:16:52 (12224): Guest Log: 00:00:00.000350 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-25 23:16:52 (12224): Guest Log: 00:00:00.000390 main     Executable: /usr/sbin/VBoxService
2022-09-25 23:16:52 (12224): Guest Log: 00:00:00.000391 main     Process ID: 2168
2022-09-25 23:16:52 (12224): Guest Log: 00:00:00.000392 main     Package type: LINUX_64BITS_GENERIC
2022-09-25 23:16:52 (12224): Guest Log: 00:00:00.052574 main     5.2.6 r120293 started. Verbose level = 0
2022-09-25 23:17:14 (12224): VM state change detected. (old = 'running', new = 'paused')
2022-09-25 23:18:34 (12224): VM state change detected. (old = 'paused', new = 'running')
2022-09-25 23:18:58 (12224): Guest Log: [INFO] Mounting the shared directory
2022-09-25 23:18:58 (12224): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-25 23:18:59 (12224): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-25 23:18:59 (12224): Guest Log: [INFO] Testing connection to cern.ch
2022-09-25 23:19:00 (12224): Guest Log: [INFO] Testing connection to VCCS
2022-09-25 23:19:00 (12224): Guest Log: [INFO] Testing connection to HTCondor
2022-09-25 23:19:01 (12224): Guest Log: [INFO] Testing connection to WMAgent
2022-09-25 23:19:01 (12224): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-25 23:19:02 (12224): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-25 23:19:02 (12224): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-25 23:19:03 (12224): Guest Log: [INFO] Testing connection to Frontier
2022-09-25 23:19:05 (12224): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-25 23:19:05 (12224): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-25 23:19:05 (12224): Guest Log: [INFO] This makes the application less efficient
2022-09-25 23:19:06 (12224): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-25 23:19:06 (12224): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-25 23:19:06 (12224): Guest Log: [INFO] Advice can be found in the project forum
2022-09-25 23:19:07 (12224): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-25 23:19:49 (12224): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-25 23:20:21 (12224): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-25 23:20:22 (12224): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-25 23:20:24 (12224): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-25 23:20:25 (12224): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-25 23:20:28 (12224): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-25 23:20:28 (12224): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-25 23:20:28 (12224): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-25 23:20:29 (12224): Guest Log: [INFO] Reading volunteer information
2022-09-25 23:20:33 (12224): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-25 23:20:35 (12224): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-25 23:20:39 (12224): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-25 23:20:40 (12224): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-25 23:20:43 (12224): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-26 09:40:20 (10260): Detected: vboxwrapper 26205
2022-09-26 09:40:20 (10260): Detected: BOINC client v7.16.11
2022-09-26 09:40:21 (10260): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2022-09-26 09:40:21 (10260): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-09-26 09:40:22 (10260): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-26 09:40:22 (10260): Guest Log: CPUID EDX: 0x178bfbff
2022-09-26 09:40:22 (10260): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-26 09:40:22 (10260): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-26 09:40:22 (10260): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-26 09:40:22 (10260): Guest Log: BIOS: Booting from Hard Disk...
2022-09-26 09:40:22 (10260): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-26 09:40:22 (10260): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-26 09:40:22 (10260): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-26 09:40:22 (10260): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-26 09:40:22 (10260): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-26 09:40:22 (10260): Guest Log: 00:00:00.000126 main     Log opened 2022-09-25T21:16:50.812319000Z
2022-09-26 09:40:22 (10260): Guest Log: 00:00:00.000256 main     OS Product: Linux
2022-09-26 09:40:22 (10260): Guest Log: 00:00:00.000308 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-26 09:40:22 (10260): Guest Log: 00:00:00.000350 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-26 09:40:22 (10260): Guest Log: 00:00:00.000390 main     Executable: /usr/sbin/VBoxService
2022-09-26 09:40:22 (10260): Guest Log: 00:00:00.000391 main     Process ID: 2168
2022-09-26 09:40:22 (10260): Guest Log: 00:00:00.000392 main     Package type: LINUX_64BITS_GENERIC
2022-09-26 09:40:22 (10260): Guest Log: 00:00:00.052574 main     5.2.6 r120293 started. Verbose level = 0
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Mounting the shared directory
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Testing connection to cern.ch
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Testing connection to VCCS
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Testing connection to HTCondor
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Testing connection to WMAgent
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Testing connection to Frontier
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Could not find a local HTTP proxy
2022-09-26 09:40:22 (10260): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-09-26 09:40:22 (10260): Guest Log: [INFO] This makes the application less efficient
2022-09-26 09:40:22 (10260): Guest Log: [INFO] It also puts higher load on the project servers
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Advice can be found in the project forum
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-26 09:40:22 (10260): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Reading volunteer information
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-26 09:40:22 (10260): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-26 09:40:22 (10260): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-26 09:40:22 (10260): Starting VM using VBoxManage interface. (boinc_1f61dccbcb2f35cd, slot#4)
2022-09-26 09:40:27 (10260): Successfully started VM. (PID = '11788')
2022-09-26 09:40:27 (10260): Reporting VM Process ID to BOINC.
2022-09-26 09:40:27 (10260): Guest Log: BIOS: VirtualBox 6.1.12
2022-09-26 09:40:27 (10260): Guest Log: CPUID EDX: 0x178bfbff
2022-09-26 09:40:27 (10260): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-09-26 09:40:27 (10260): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-09-26 09:40:27 (10260): VM state change detected. (old = 'poweredoff', new = 'running')
2022-09-26 09:40:27 (10260): Detected: Web Application Enabled (http://localhost:60299)
2022-09-26 09:40:27 (10260): Detected: Remote Desktop Enabled (localhost:60301)
2022-09-26 09:40:27 (10260): Status Report: Job Duration: '64800.000000'
2022-09-26 09:40:27 (10260): Status Report: Elapsed Time: '40313.365433'
2022-09-26 09:40:27 (10260): Status Report: CPU Time: '3993.093750'
2022-09-26 09:40:27 (10260): Preference change detected
2022-09-26 09:40:27 (10260): Setting CPU throttle for VM. (50%)
2022-09-26 09:40:27 (10260): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-09-26 09:40:29 (10260): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-09-26 09:40:29 (10260): Guest Log: BIOS: Booting from Hard Disk...
2022-09-26 09:40:32 (10260): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-09-26 09:40:32 (10260): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-09-26 09:40:41 (10260): VM state change detected. (old = 'running', new = 'paused')
2022-09-26 09:40:51 (10260): VM state change detected. (old = 'paused', new = 'running')
2022-09-26 09:41:12 (10260): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-09-26 09:41:12 (10260): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-09-26 09:41:14 (10260): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-09-26 09:41:14 (10260): Guest Log: 00:00:00.000091 main     Log opened 2022-09-26T07:41:13.988141000Z
2022-09-26 09:41:14 (10260): Guest Log: 00:00:00.000198 main     OS Product: Linux
2022-09-26 09:41:14 (10260): Guest Log: 00:00:00.000231 main     OS Release: 4.14.232-19.cernvm.x86_64
2022-09-26 09:41:14 (10260): Guest Log: 00:00:00.000260 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-09-26 09:41:14 (10260): Guest Log: 00:00:00.000298 main     Executable: /usr/sbin/VBoxService
2022-09-26 09:41:14 (10260): Guest Log: 00:00:00.000299 main     Process ID: 2174
2022-09-26 09:41:14 (10260): Guest Log: 00:00:00.000299 main     Package type: LINUX_64BITS_GENERIC
2022-09-26 09:41:14 (10260): Guest Log: 00:00:00.004472 main     5.2.6 r120293 started. Verbose level = 0
2022-09-26 09:41:34 (10260): Guest Log: [INFO] Mounting the shared directory
2022-09-26 09:41:34 (10260): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-09-26 09:41:34 (10260): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-09-26 09:41:34 (10260): Guest Log: [INFO] Testing connection to cern.ch
2022-09-26 09:41:44 (10260): Guest Log: [DEBUG] Status run 1 of up to 3: 2
2022-09-26 09:41:51 (10260): Guest Log: [INFO] Testing connection to VCCS
2022-09-26 09:41:52 (10260): Guest Log: [INFO] Testing connection to HTCondor
2022-09-26 09:41:52 (10260): Guest Log: [INFO] Testing connection to WMAgent
2022-09-26 09:41:52 (10260): Guest Log: [INFO] Testing connection to EOSCMS
2022-09-26 09:41:52 (10260): Guest Log: [INFO] Testing connection to CMS-Factory
2022-09-26 09:41:52 (10260): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-09-26 09:41:52 (10260): Guest Log: [INFO] Testing connection to Frontier
2022-09-26 09:41:53 (10260): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2022-09-26 09:41:53 (10260): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier
2022-09-26 09:41:53 (10260): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-09-26 09:42:11 (10260): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-09-26 09:42:27 (10260): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-09-26 09:42:28 (10260): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-09-26 09:42:29 (10260): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-09-26 09:42:29 (10260): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-09-26 09:42:31 (10260): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-09-26 09:42:31 (10260): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-09-26 09:42:32 (10260): Guest Log: [INFO] Environment HTTP proxy: not set
2022-09-26 09:42:32 (10260): Guest Log: [INFO] Reading volunteer information
2022-09-26 09:42:32 (10260): VM state change detected. (old = 'running', new = 'paused')
2022-09-26 09:42:51 (10260): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-09-26 09:42:51 (10260): VM state change detected. (old = 'paused', new = 'running')
2022-09-26 09:42:52 (10260): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-09-26 09:42:53 (10260): Guest Log: [INFO] CMS application starting. Check log files.
2022-09-26 09:42:53 (10260): Guest Log: [INFO] Requesting an idtoken from LHC@home
2022-09-26 09:42:54 (10260): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2022-09-26 10:57:26 (10260): VM state change detected. (old = 'running', new = 'paused')
2022-09-26 10:57:36 (10260): VM state change detected. (old = 'paused', new = 'running')
2022-09-26 11:21:18 (10260): Status Report: Job Duration: '64800.000000'
2022-09-26 11:21:18 (10260): Status Report: Elapsed Time: '46313.365433'
2022-09-26 11:21:18 (10260): Status Report: CPU Time: '7558.390625'
2022-09-26 13:01:25 (10260): Status Report: Job Duration: '64800.000000'
2022-09-26 13:01:25 (10260): Status Report: Elapsed Time: '52313.365433'
2022-09-26 13:01:25 (10260): Status Report: CPU Time: '11162.687500'
2022-09-26 14:41:32 (10260): Status Report: Job Duration: '64800.000000'
2022-09-26 14:41:32 (10260): Status Report: Elapsed Time: '58313.365433'
2022-09-26 14:41:32 (10260): Status Report: CPU Time: '14737.812500'
2022-09-26 16:21:39 (10260): Status Report: Job Duration: '64800.000000'
2022-09-26 16:21:39 (10260): Status Report: Elapsed Time: '64313.365433'
2022-09-26 16:21:39 (10260): Status Report: CPU Time: '18349.671875'
2022-09-26 16:29:47 (10260): Powering off VM.
2022-09-26 16:29:47 (10260): Successfully stopped VM.
2022-09-26 16:29:47 (10260): Deregistering VM. (boinc_1f61dccbcb2f35cd, slot#4)
2022-09-26 16:29:48 (10260): Removing network bandwidth throttle group from VM.
2022-09-26 16:29:48 (10260): Removing VM from VirtualBox.
16:29:53 (10260): called boinc_finish(0)

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

Stderr output
