Name CMS_3064375_1765071970.797037_0
Workunit 237850832
Created 7 Dec 2025, 1:46:15 UTC
Sent 7 Dec 2025, 3:31:46 UTC
Report deadline 7 Jan 2026, 3:31:46 UTC
Received 12 Dec 2025, 8:13:27 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10651600
Run time 2 hours 51 min 15 sec
CPU time 1 hours 59 min 8 sec
Validate state Valid
Credit 777.40
Device peak FLOPS 26.73 GFLOPS
Application version CMS Simulation v70.91 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 89.69 MB
Peak swap size 89.60 MB
Peak disk usage 2.37 GB

Stderr output

<core_client_version>8.2.4</core_client_version>
<![CDATA[
<stderr_txt>
2025-12-09 17:33:39 (16884): vboxwrapper version 26210
2025-12-09 17:33:39 (16884): BOINC client version: 8.2.4
2025-12-09 17:33:40 (16884): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2025-12-09 17:33:40 (16884): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-12-09 17:33:40 (16884): Successfully copied 'init_data.xml' to the shared directory.
2025-12-09 17:33:40 (16884): Create VM. (boinc_7af408cd3d871a2b, slot#1)
2025-12-09 17:33:41 (16884): Setting Memory Size for VM. (4584MB)
2025-12-09 17:33:41 (16884): Setting CPU Count for VM. (4)
2025-12-09 17:33:41 (16884): Setting Chipset Options for VM.
2025-12-09 17:33:42 (16884): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-12-09 17:33:42 (16884): Setting Boot Options for VM.
2025-12-09 17:33:43 (16884): Setting Network Configuration for NAT. (Driver: virtio)
2025-12-09 17:33:43 (16884): Enabling VM Network Access.
2025-12-09 17:33:43 (16884): Disabling USB Support for VM.
2025-12-09 17:33:43 (16884): Disabling COM Port Support for VM.
2025-12-09 17:33:44 (16884): Disabling LPT Port Support for VM.
2025-12-09 17:33:44 (16884): Disabling Audio Support for VM.
2025-12-09 17:33:44 (16884): Disabling Clipboard Support for VM.
2025-12-09 17:33:44 (16884): Disabling Drag and Drop Support for VM.
2025-12-09 17:33:45 (16884): Adding storage controller(s) to VM.
2025-12-09 17:33:45 (16884): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi)
2025-12-09 17:33:46 (16884): Adding VirtualBox Guest Additions to VM.
2025-12-09 17:33:46 (16884): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-12-09 17:33:47 (16884): forwarding host port 7635 to guest port 80
2025-12-09 17:33:47 (16884): Enabling remote desktop for VM.
2025-12-09 17:33:47 (16884): Required extension pack not installed, remote desktop not enabled.
2025-12-09 17:33:47 (16884): Enabling shared directory for VM.
2025-12-09 17:33:48 (16884): Starting VM using VBoxManage interface. (boinc_7af408cd3d871a2b, slot#1)
2025-12-09 17:33:53 (16884): Successfully started VM. (PID = '15480')
2025-12-09 17:33:53 (16884): Reporting VM Process ID to BOINC.
2025-12-09 17:33:53 (16884): Guest Log: BIOS: VirtualBox 6.1.34
2025-12-09 17:33:53 (16884): Guest Log: CPUID EDX: 0x178bfbff
2025-12-09 17:33:53 (16884): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-12-09 17:33:53 (16884): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-12-09 17:33:53 (16884): VM state change detected. (old = 'poweredoff', new = 'running')
2025-12-09 17:33:53 (16884): Detected: Web Application Enabled (http://localhost:7635)
2025-12-09 17:33:53 (16884): Preference change detected
2025-12-09 17:33:53 (16884): Setting CPU throttle for VM. (60%)
2025-12-09 17:33:53 (16884): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-12-09 17:33:55 (16884): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-12-09 17:33:55 (16884): Guest Log: BIOS: Booting from Hard Disk...
2025-12-09 17:34:00 (16884): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-12-09 17:34:00 (16884): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-12-09 17:34:14 (16884): VM state change detected. (old = 'running', new = 'paused')
2025-12-09 17:37:15 (16884): VM state change detected. (old = 'paused', new = 'running')
2025-12-09 17:37:50 (16884): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-12-09 17:37:50 (16884): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-12-09 17:37:54 (16884): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-12-09 17:37:54 (16884): Guest Log: 00:00:00.000227 main     Log opened 2025-12-09T09:35:03.456230000Z
2025-12-09 17:37:54 (16884): Guest Log: 00:00:00.000393 main     OS Product: Linux
2025-12-09 17:37:54 (16884): Guest Log: 00:00:00.000502 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-12-09 17:37:54 (16884): Guest Log: 00:00:00.000605 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-12-09 17:37:54 (16884): Guest Log: 00:00:00.000706 main     Executable: /usr/sbin/VBoxService
2025-12-09 17:37:54 (16884): Guest Log: 00:00:00.000707 main     Process ID: 2288
2025-12-09 17:37:54 (16884): Guest Log: 00:00:00.000707 main     Package type: LINUX_64BITS_GENERIC
2025-12-09 17:37:54 (16884): Guest Log: 00:00:00.004490 main     5.2.6 r120293 started. Verbose level = 0
2025-12-09 17:38:42 (16884): Guest Log: [INFO] Mounting the shared directory
2025-12-09 17:38:43 (16884): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-12-09 17:38:43 (16884): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-12-09 17:38:46 (16884): Guest Log: [INFO] Testing connection to cern.ch
2025-12-09 17:38:46 (16884): Guest Log: [INFO] Testing connection to VCCS
2025-12-09 17:38:49 (16884): Guest Log: [INFO] Testing connection to HTCondor-Collector
2025-12-09 17:38:50 (16884): Guest Log: [INFO] Testing connection to HTCondor-CCB
2025-12-09 17:38:51 (16884): Guest Log: [INFO] Testing connection to WMAgent
2025-12-09 17:38:52 (16884): Guest Log: [INFO] Testing connection to EOSCMS
2025-12-09 17:38:57 (16884): Guest Log: [INFO] Testing connection to CMS-Factory
2025-12-09 17:38:58 (16884): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-12-09 17:38:59 (16884): Guest Log: [INFO] Testing connection to Frontier
2025-12-09 17:39:00 (16884): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-12-09 17:39:04 (16884): Guest Log: [INFO] Could not find a local HTTP proxy
2025-12-09 17:39:04 (16884): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-12-09 17:39:05 (16884): Guest Log: [INFO] This makes the application less efficient
2025-12-09 17:39:05 (16884): Guest Log: [INFO] It also puts higher load on the project servers
2025-12-09 17:39:05 (16884): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-12-09 17:39:06 (16884): Guest Log: [INFO] Advice can be found in the project forum
2025-12-09 17:39:23 (16884): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-12-09 17:39:43 (16884): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-12-09 17:39:54 (16884): VM state change detected. (old = 'running', new = 'paused')
2025-12-10 11:20:25 (19132): vboxwrapper version 26210
2025-12-10 11:20:25 (19132): BOINC client version: 8.2.4
2025-12-10 11:20:26 (19132): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2025-12-10 11:20:27 (19132): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-12-10 11:20:27 (19132): Guest Log: BIOS: VirtualBox 6.1.34
2025-12-10 11:20:27 (19132): Guest Log: CPUID EDX: 0x178bfbff
2025-12-10 11:20:27 (19132): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-12-10 11:20:27 (19132): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-12-10 11:20:27 (19132): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-12-10 11:20:27 (19132): Guest Log: BIOS: Booting from Hard Disk...
2025-12-10 11:20:27 (19132): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-12-10 11:20:27 (19132): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-12-10 11:20:27 (19132): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-12-10 11:20:27 (19132): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-12-10 11:20:27 (19132): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-12-10 11:20:27 (19132): Guest Log: 00:00:00.000227 main     Log opened 2025-12-09T09:35:03.456230000Z
2025-12-10 11:20:27 (19132): Guest Log: 00:00:00.000393 main     OS Product: Linux
2025-12-10 11:20:27 (19132): Guest Log: 00:00:00.000502 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-12-10 11:20:27 (19132): Guest Log: 00:00:00.000605 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-12-10 11:20:27 (19132): Guest Log: 00:00:00.000706 main     Executable: /usr/sbin/VBoxService
2025-12-10 11:20:27 (19132): Guest Log: 00:00:00.000707 main     Process ID: 2288
2025-12-10 11:20:27 (19132): Guest Log: 00:00:00.000707 main     Package type: LINUX_64BITS_GENERIC
2025-12-10 11:20:27 (19132): Guest Log: 00:00:00.004490 main     5.2.6 r120293 started. Verbose level = 0
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Mounting the shared directory
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to cern.ch
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to VCCS
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to HTCondor-Collector
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to HTCondor-CCB
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to WMAgent
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to EOSCMS
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to CMS-Factory
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to Frontier
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Could not find a local HTTP proxy
2025-12-10 11:20:27 (19132): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-12-10 11:20:27 (19132): Guest Log: [INFO] This makes the application less efficient
2025-12-10 11:20:27 (19132): Guest Log: [INFO] It also puts higher load on the project servers
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Advice can be found in the project forum
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-12-10 11:20:27 (19132): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-12-10 11:20:27 (19132): Starting VM using VBoxManage interface. (boinc_7af408cd3d871a2b, slot#1)
2025-12-10 11:20:33 (19132): Successfully started VM. (PID = '22240')
2025-12-10 11:20:33 (19132): Reporting VM Process ID to BOINC.
2025-12-10 11:20:33 (19132): Guest Log: BIOS: VirtualBox 6.1.34
2025-12-10 11:20:33 (19132): Guest Log: CPUID EDX: 0x178bfbff
2025-12-10 11:20:33 (19132): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-12-10 11:20:33 (19132): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-12-10 11:20:33 (19132): VM state change detected. (old = 'poweredoff', new = 'running')
2025-12-10 11:20:33 (19132): Detected: Web Application Enabled (http://localhost:7635)
2025-12-10 11:20:33 (19132): Preference change detected
2025-12-10 11:20:33 (19132): Setting CPU throttle for VM. (60%)
2025-12-10 11:20:34 (19132): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-12-10 11:20:35 (19132): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-12-10 11:20:35 (19132): Guest Log: BIOS: Booting from Hard Disk...
2025-12-10 11:20:40 (19132): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-12-10 11:20:40 (19132): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-12-10 11:21:25 (19132): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-12-10 11:21:25 (19132): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-12-10 11:21:31 (19132): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-12-10 11:21:31 (19132): Guest Log: 00:00:00.000349 main     Log opened 2025-12-10T03:21:32.246878000Z
2025-12-10 11:21:31 (19132): Guest Log: 00:00:00.000556 main     OS Product: Linux
2025-12-10 11:21:31 (19132): Guest Log: 00:00:00.000670 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-12-10 11:21:31 (19132): Guest Log: 00:00:00.000810 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-12-10 11:21:31 (19132): Guest Log: 00:00:00.000911 main     Executable: /usr/sbin/VBoxService
2025-12-10 11:21:31 (19132): Guest Log: 00:00:00.000912 main     Process ID: 2285
2025-12-10 11:21:31 (19132): Guest Log: 00:00:00.000913 main     Package type: LINUX_64BITS_GENERIC
2025-12-10 11:21:31 (19132): Guest Log: 00:00:00.003419 main     5.2.6 r120293 started. Verbose level = 0
2025-12-10 11:23:10 (19132): Guest Log: [INFO] Mounting the shared directory
2025-12-10 11:23:11 (19132): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-12-10 11:23:11 (19132): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-12-10 11:23:12 (19132): Guest Log: [INFO] Testing connection to cern.ch
2025-12-10 11:23:12 (19132): Guest Log: [INFO] Testing connection to VCCS
2025-12-10 11:23:13 (19132): Guest Log: [INFO] Testing connection to HTCondor-Collector
2025-12-10 11:23:14 (19132): Guest Log: [INFO] Testing connection to HTCondor-CCB
2025-12-10 11:23:16 (19132): Guest Log: [INFO] Testing connection to WMAgent
2025-12-10 11:23:17 (19132): Guest Log: [INFO] Testing connection to EOSCMS
2025-12-10 11:23:18 (19132): Guest Log: [INFO] Testing connection to CMS-Factory
2025-12-10 11:23:19 (19132): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-12-10 11:23:21 (19132): Guest Log: [INFO] Testing connection to Frontier
2025-12-10 11:23:22 (19132): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-12-10 11:23:27 (19132): Guest Log: [INFO] Could not find a local HTTP proxy
2025-12-10 11:23:27 (19132): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-12-10 11:23:28 (19132): Guest Log: [INFO] This makes the application less efficient
2025-12-10 11:23:28 (19132): Guest Log: [INFO] It also puts higher load on the project servers
2025-12-10 11:23:28 (19132): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-12-10 11:23:29 (19132): Guest Log: [INFO] Advice can be found in the project forum
2025-12-10 11:23:32 (19132): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-12-10 11:24:16 (19132): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-12-10 11:24:24 (19132): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-12-10 11:24:32 (19132): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-12-10 11:24:35 (19132): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-12-10 11:24:35 (19132): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-12-10 11:24:38 (19132): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-12-10 11:24:39 (19132): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-12-10 11:24:39 (19132): Guest Log: [INFO] Environment HTTP proxy: not set
2025-12-10 11:24:40 (19132): Guest Log: [INFO] Reading volunteer information
2025-12-10 11:27:28 (19132): VM state change detected. (old = 'running', new = 'paused')
2025-12-10 11:30:28 (19132): VM state change detected. (old = 'paused', new = 'running')
2025-12-10 11:30:59 (19132): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-12-10 11:31:07 (19132): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-12-10 11:31:13 (19132): Guest Log: [INFO] CMS application starting. Check log files.
2025-12-10 11:34:48 (19132): VM state change detected. (old = 'running', new = 'paused')
2025-12-10 11:52:30 (19132): VM state change detected. (old = 'paused', new = 'running')
2025-12-10 11:53:04 (19132): VM state change detected. (old = 'running', new = 'paused')
2025-12-10 12:39:09 (19132): VM state change detected. (old = 'paused', new = 'running')
2025-12-10 12:39:18 (19132): Guest Log: 00:11:00.871247 timesync vgsvcTimeSyncWorker: Radical host time change: 2 774 674 000 000ns (HostNow=1 765 341 558 397 000 000 ns HostLast=1 765 338 783 723 000 000 ns)
2025-12-10 12:39:28 (19132): Guest Log: 00:11:10.877643 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 774 679 592 000ns (GuestNow=1 765 341 568 403 671 000 ns GuestLast=1 765 338 793 724 079 000 ns fSetTimeLastLoop=true )
2025-12-10 12:46:17 (19132): VM state change detected. (old = 'running', new = 'paused')
2025-12-10 12:49:17 (19132): VM state change detected. (old = 'paused', new = 'running')
2025-12-10 13:37:30 (19132): VM state change detected. (old = 'running', new = 'paused')
2025-12-10 21:31:17 (19132): VM state change detected. (old = 'paused', new = 'stopping')
2025-12-10 21:31:17 (19132): Stopping VM.
2025-12-10 21:31:17 (19132): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_7af408cd3d871a2b" savestate
Output:

2025-12-10 21:31:17 (19132): VM did not stop when requested.
2025-12-10 21:31:17 (19132): VM was NOT successfully terminated.
2025-12-11 11:17:18 (17648): vboxwrapper version 26210
2025-12-11 11:17:18 (17648): BOINC client version: 8.2.4
2025-12-11 11:17:20 (17648): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2025-12-11 11:17:21 (17648): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-12-11 11:17:21 (17648): Guest Log: BIOS: VirtualBox 6.1.34
2025-12-11 11:17:21 (17648): Guest Log: CPUID EDX: 0x178bfbff
2025-12-11 11:17:21 (17648): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-12-11 11:17:21 (17648): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-12-11 11:17:21 (17648): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-12-11 11:17:21 (17648): Guest Log: BIOS: Booting from Hard Disk...
2025-12-11 11:17:21 (17648): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-12-11 11:17:21 (17648): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-12-11 11:17:21 (17648): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-12-11 11:17:21 (17648): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-12-11 11:17:21 (17648): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-12-11 11:17:21 (17648): Guest Log: 00:00:00.000349 main     Log opened 2025-12-10T03:21:32.246878000Z
2025-12-11 11:17:21 (17648): Guest Log: 00:00:00.000556 main     OS Product: Linux
2025-12-11 11:17:21 (17648): Guest Log: 00:00:00.000670 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-12-11 11:17:21 (17648): Guest Log: 00:00:00.000810 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-12-11 11:17:21 (17648): Guest Log: 00:00:00.000911 main     Executable: /usr/sbin/VBoxService
2025-12-11 11:17:21 (17648): Guest Log: 00:00:00.000912 main     Process ID: 2285
2025-12-11 11:17:21 (17648): Guest Log: 00:00:00.000913 main     Package type: LINUX_64BITS_GENERIC
2025-12-11 11:17:21 (17648): Guest Log: 00:00:00.003419 main     5.2.6 r120293 started. Verbose level = 0
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Mounting the shared directory
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to cern.ch
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to VCCS
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to HTCondor-Collector
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to HTCondor-CCB
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to WMAgent
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to EOSCMS
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to CMS-Factory
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to Frontier
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Could not find a local HTTP proxy
2025-12-11 11:17:21 (17648): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-12-11 11:17:21 (17648): Guest Log: [INFO] This makes the application less efficient
2025-12-11 11:17:21 (17648): Guest Log: [INFO] It also puts higher load on the project servers
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Advice can be found in the project forum
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-12-11 11:17:21 (17648): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Environment HTTP proxy: not set
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Reading volunteer information
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-12-11 11:17:21 (17648): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-12-11 11:17:21 (17648): Guest Log: [INFO] CMS application starting. Check log files.
2025-12-11 11:17:21 (17648): Guest Log: 00:11:00.871247 timesync vgsvcTimeSyncWorker: Radical host time change: 2 774 674 000 000ns (HostNow=1 765 341 558 397 000 000 ns HostLast=1 765 338 783 723 000 000 ns)
2025-12-11 11:17:21 (17648): Guest Log: 00:11:10.877643 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 774 679 592 000ns (GuestNow=1 765 341 568 403 671 000 ns GuestLast=1 765 338 793 724 079 000 ns fSetTimeLastLoop=true )
2025-12-11 11:17:21 (17648): Starting VM using VBoxManage interface. (boinc_7af408cd3d871a2b, slot#1)
2025-12-11 11:17:27 (17648): Successfully started VM. (PID = '7136')
2025-12-11 11:17:27 (17648): Reporting VM Process ID to BOINC.
2025-12-11 11:17:27 (17648): Guest Log: BIOS: VirtualBox 6.1.34
2025-12-11 11:17:27 (17648): Guest Log: CPUID EDX: 0x178bfbff
2025-12-11 11:17:27 (17648): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-12-11 11:17:27 (17648): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-12-11 11:17:27 (17648): VM state change detected. (old = 'poweredoff', new = 'running')
2025-12-11 11:17:27 (17648): Detected: Web Application Enabled (http://localhost:7635)
2025-12-11 11:17:27 (17648): Preference change detected
2025-12-11 11:17:27 (17648): Setting CPU throttle for VM. (60%)
2025-12-11 11:17:28 (17648): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-12-11 11:17:29 (17648): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-12-11 11:17:29 (17648): Guest Log: BIOS: Booting from Hard Disk...
2025-12-11 11:17:34 (17648): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-12-11 11:17:34 (17648): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-12-11 11:18:26 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-11 11:18:46 (17648): VM state change detected. (old = 'paused', new = 'running')
2025-12-11 11:18:49 (17648): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-12-11 11:18:49 (17648): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-12-11 11:18:52 (17648): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-12-11 11:18:52 (17648): Guest Log: 00:00:00.000526 main     Log opened 2025-12-11T03:18:31.359532000Z
2025-12-11 11:18:52 (17648): Guest Log: 00:00:00.000718 main     OS Product: Linux
2025-12-11 11:18:52 (17648): Guest Log: 00:00:00.000969 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-12-11 11:18:52 (17648): Guest Log: 00:00:00.001094 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-12-11 11:18:52 (17648): Guest Log: 00:00:00.001210 main     Executable: /usr/sbin/VBoxService
2025-12-11 11:18:52 (17648): Guest Log: 00:00:00.001211 main     Process ID: 2294
2025-12-11 11:18:52 (17648): Guest Log: 00:00:00.001212 main     Package type: LINUX_64BITS_GENERIC
2025-12-11 11:18:52 (17648): Guest Log: 00:00:00.004185 main     5.2.6 r120293 started. Verbose level = 0
2025-12-11 11:19:35 (17648): Guest Log: [INFO] Mounting the shared directory
2025-12-11 11:19:36 (17648): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-12-11 11:19:37 (17648): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-12-11 11:19:37 (17648): Guest Log: [INFO] Testing connection to cern.ch
2025-12-11 11:19:38 (17648): Guest Log: [INFO] Testing connection to VCCS
2025-12-11 11:19:39 (17648): Guest Log: [INFO] Testing connection to HTCondor-Collector
2025-12-11 11:19:42 (17648): Guest Log: [INFO] Testing connection to HTCondor-CCB
2025-12-11 11:19:43 (17648): Guest Log: [INFO] Testing connection to WMAgent
2025-12-11 11:19:44 (17648): Guest Log: [INFO] Testing connection to EOSCMS
2025-12-11 11:19:48 (17648): Guest Log: [INFO] Testing connection to CMS-Factory
2025-12-11 11:19:49 (17648): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-12-11 11:19:50 (17648): Guest Log: [INFO] Testing connection to Frontier
2025-12-11 11:19:53 (17648): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-12-11 11:19:59 (17648): Guest Log: [INFO] Could not find a local HTTP proxy
2025-12-11 11:19:59 (17648): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-12-11 11:20:00 (17648): Guest Log: [INFO] This makes the application less efficient
2025-12-11 11:20:00 (17648): Guest Log: [INFO] It also puts higher load on the project servers
2025-12-11 11:20:00 (17648): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-12-11 11:20:01 (17648): Guest Log: [INFO] Advice can be found in the project forum
2025-12-11 11:20:01 (17648): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-12-11 11:20:16 (17648): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-12-11 11:20:27 (17648): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-12-11 11:20:27 (17648): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-12-11 11:20:30 (17648): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-12-11 11:20:30 (17648): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-12-11 11:20:33 (17648): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-12-11 11:20:33 (17648): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-12-11 11:20:34 (17648): Guest Log: [INFO] Environment HTTP proxy: not set
2025-12-11 11:20:34 (17648): Guest Log: [INFO] Reading volunteer information
2025-12-11 11:20:56 (17648): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-12-11 11:21:00 (17648): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-12-11 11:21:03 (17648): Guest Log: [INFO] CMS application starting. Check log files.
2025-12-11 11:24:21 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-11 11:27:21 (17648): VM state change detected. (old = 'paused', new = 'running')
2025-12-11 11:38:19 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-11 11:58:02 (17648): VM state change detected. (old = 'paused', new = 'running')
2025-12-11 12:04:35 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-11 12:55:05 (17648): Guest Log: 00:23:01.161652 timesync vgsvcTimeSyncWorker: Radical host time change: 3 040 404 000 000ns (HostNow=1 765 428 905 378 000 000 ns HostLast=1 765 425 864 974 000 000 ns)
2025-12-11 12:55:05 (17648): VM state change detected. (old = 'paused', new = 'running')
2025-12-11 12:55:15 (17648): Guest Log: 00:23:11.162762 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 040 238 436 000ns (GuestNow=1 765 428 915 379 459 000 ns GuestLast=1 765 425 875 141 023 000 ns fSetTimeLastLoop=true )
2025-12-11 13:01:54 (17648): Status Report: Job Duration: '64800.000000'
2025-12-11 13:01:54 (17648): Status Report: Elapsed Time: '6000.000000'
2025-12-11 13:01:54 (17648): Status Report: CPU Time: '2331.515625'
2025-12-11 13:02:12 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-11 13:05:13 (17648): VM state change detected. (old = 'paused', new = 'running')
2025-12-11 13:34:03 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-11 17:26:46 (17648): VM state change detected. (old = 'paused', new = 'running')
2025-12-11 17:26:51 (17648): Guest Log: 00:59:04.696133 timesync vgsvcTimeSyncWorker: Radical host time change: 13 972 187 000 000ns (HostNow=1 765 445 211 077 000 000 ns HostLast=1 765 431 238 890 000 000 ns)
2025-12-11 17:27:01 (17648): Guest Log: 00:59:14.728747 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 152 383 882 000ns (GuestNow=1 765 445 221 203 146 000 ns GuestLast=1 765 431 068 819 264 000 ns fSetTimeLastLoop=true )
2025-12-11 17:28:11 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-11 17:28:31 (17648): VM state change detected. (old = 'paused', new = 'running')
2025-12-11 17:33:52 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-11 17:36:52 (17648): VM state change detected. (old = 'paused', new = 'running')
2025-12-11 17:37:26 (17648): VM state change detected. (old = 'running', new = 'paused')
2025-12-12 11:17:26 (6856): vboxwrapper version 26210
2025-12-12 11:17:26 (6856): BOINC client version: 8.2.4
2025-12-12 11:17:27 (6856): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2025-12-12 11:17:27 (6856): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-12-12 11:17:28 (6856): Guest Log: BIOS: VirtualBox 6.1.34
2025-12-12 11:17:28 (6856): Guest Log: CPUID EDX: 0x178bfbff
2025-12-12 11:17:28 (6856): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-12-12 11:17:28 (6856): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-12-12 11:17:28 (6856): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-12-12 11:17:28 (6856): Guest Log: BIOS: Booting from Hard Disk...
2025-12-12 11:17:28 (6856): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-12-12 11:17:28 (6856): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-12-12 11:17:28 (6856): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-12-12 11:17:28 (6856): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-12-12 11:17:28 (6856): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-12-12 11:17:28 (6856): Guest Log: 00:00:00.000526 main     Log opened 2025-12-11T03:18:31.359532000Z
2025-12-12 11:17:28 (6856): Guest Log: 00:00:00.000718 main     OS Product: Linux
2025-12-12 11:17:28 (6856): Guest Log: 00:00:00.000969 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-12-12 11:17:28 (6856): Guest Log: 00:00:00.001094 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-12-12 11:17:28 (6856): Guest Log: 00:00:00.001210 main     Executable: /usr/sbin/VBoxService
2025-12-12 11:17:28 (6856): Guest Log: 00:00:00.001211 main     Process ID: 2294
2025-12-12 11:17:28 (6856): Guest Log: 00:00:00.001212 main     Package type: LINUX_64BITS_GENERIC
2025-12-12 11:17:28 (6856): Guest Log: 00:00:00.004185 main     5.2.6 r120293 started. Verbose level = 0
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Mounting the shared directory
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to cern.ch
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to VCCS
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to HTCondor-Collector
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to HTCondor-CCB
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to WMAgent
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to EOSCMS
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to CMS-Factory
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to Frontier
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Could not find a local HTTP proxy
2025-12-12 11:17:28 (6856): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-12-12 11:17:28 (6856): Guest Log: [INFO] This makes the application less efficient
2025-12-12 11:17:28 (6856): Guest Log: [INFO] It also puts higher load on the project servers
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Advice can be found in the project forum
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-12-12 11:17:28 (6856): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Environment HTTP proxy: not set
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Reading volunteer information
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-12-12 11:17:28 (6856): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-12-12 11:17:28 (6856): Guest Log: [INFO] CMS application starting. Check log files.
2025-12-12 11:17:28 (6856): Guest Log: 00:23:01.161652 timesync vgsvcTimeSyncWorker: Radical host time change: 3 040 404 000 000ns (HostNow=1 765 428 905 378 000 000 ns HostLast=1 765 425 864 974 000 000 ns)
2025-12-12 11:17:28 (6856): Guest Log: 00:23:11.162762 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 040 238 436 000ns (GuestNow=1 765 428 915 379 459 000 ns GuestLast=1 765 425 875 141 023 000 ns fSetTimeLastLoop=true )
2025-12-12 11:17:28 (6856): Guest Log: 00:59:04.696133 timesync vgsvcTimeSyncWorker: Radical host time change: 13 972 187 000 000ns (HostNow=1 765 445 211 077 000 000 ns HostLast=1 765 431 238 890 000 000 ns)
2025-12-12 11:17:28 (6856): Guest Log: 00:59:14.728747 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 152 383 882 000ns (GuestNow=1 765 445 221 203 146 000 ns GuestLast=1 765 431 068 819 264 000 ns fSetTimeLastLoop=true )
2025-12-12 11:17:28 (6856): Starting VM using VBoxManage interface. (boinc_7af408cd3d871a2b, slot#1)
2025-12-12 11:17:34 (6856): Successfully started VM. (PID = '12132')
2025-12-12 11:17:34 (6856): Reporting VM Process ID to BOINC.
2025-12-12 11:17:34 (6856): Guest Log: BIOS: VirtualBox 6.1.34
2025-12-12 11:17:34 (6856): Guest Log: CPUID EDX: 0x178bfbff
2025-12-12 11:17:34 (6856): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-12-12 11:17:34 (6856): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-12-12 11:17:34 (6856): VM state change detected. (old = 'poweredoff', new = 'running')
2025-12-12 11:17:34 (6856): Detected: Web Application Enabled (http://localhost:7635)
2025-12-12 11:17:34 (6856): Status Report: Job Duration: '64800.000000'
2025-12-12 11:17:34 (6856): Status Report: Elapsed Time: '8126.000000'
2025-12-12 11:17:34 (6856): Status Report: CPU Time: '5949.953125'
2025-12-12 11:17:34 (6856): Preference change detected
2025-12-12 11:17:34 (6856): Setting CPU throttle for VM. (60%)
2025-12-12 11:17:34 (6856): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-12-12 11:17:36 (6856): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-12-12 11:17:36 (6856): Guest Log: BIOS: Booting from Hard Disk...
2025-12-12 11:17:41 (6856): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-12-12 11:17:41 (6856): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-12-12 11:18:26 (6856): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-12-12 11:18:26 (6856): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-12-12 11:18:31 (6856): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-12-12 11:18:31 (6856): Guest Log: 00:00:00.000117 main     Log opened 2025-12-12T03:18:31.032441000Z
2025-12-12 11:18:31 (6856): Guest Log: 00:00:00.000327 main     OS Product: Linux
2025-12-12 11:18:31 (6856): Guest Log: 00:00:00.000457 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-12-12 11:18:31 (6856): Guest Log: 00:00:00.000577 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-12-12 11:18:31 (6856): Guest Log: 00:00:00.000690 main     Executable: /usr/sbin/VBoxService
2025-12-12 11:18:31 (6856): Guest Log: 00:00:00.000691 main     Process ID: 2267
2025-12-12 11:18:31 (6856): Guest Log: 00:00:00.000691 main     Package type: LINUX_64BITS_GENERIC
2025-12-12 11:18:31 (6856): Guest Log: 00:00:00.002974 main     5.2.6 r120293 started. Verbose level = 0
2025-12-12 11:18:38 (6856): VM state change detected. (old = 'running', new = 'paused')
2025-12-12 11:18:58 (6856): VM state change detected. (old = 'paused', new = 'running')
2025-12-12 11:19:33 (6856): Guest Log: [INFO] Mounting the shared directory
2025-12-12 11:19:34 (6856): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-12-12 11:19:35 (6856): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-12-12 11:19:35 (6856): Guest Log: [INFO] Testing connection to cern.ch
2025-12-12 11:19:36 (6856): Guest Log: [INFO] Testing connection to VCCS
2025-12-12 11:19:37 (6856): Guest Log: [INFO] Testing connection to HTCondor-Collector
2025-12-12 11:19:38 (6856): Guest Log: [INFO] Testing connection to HTCondor-CCB
2025-12-12 11:19:39 (6856): Guest Log: [INFO] Testing connection to WMAgent
2025-12-12 11:19:40 (6856): Guest Log: [INFO] Testing connection to EOSCMS
2025-12-12 11:19:41 (6856): Guest Log: [INFO] Testing connection to CMS-Factory
2025-12-12 11:19:42 (6856): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-12-12 11:19:45 (6856): Guest Log: [INFO] Testing connection to Frontier
2025-12-12 11:19:45 (6856): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-12-12 11:19:51 (6856): Guest Log: [INFO] Could not find a local HTTP proxy
2025-12-12 11:19:51 (6856): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-12-12 11:19:51 (6856): Guest Log: [INFO] This makes the application less efficient
2025-12-12 11:19:52 (6856): Guest Log: [INFO] It also puts higher load on the project servers
2025-12-12 11:19:52 (6856): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-12-12 11:19:52 (6856): Guest Log: [INFO] Advice can be found in the project forum
2025-12-12 11:19:53 (6856): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-12-12 11:20:11 (6856): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-12-12 11:20:20 (6856): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-12-12 11:20:20 (6856): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-12-12 11:20:22 (6856): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-12-12 11:20:24 (6856): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-12-12 11:20:26 (6856): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-12-12 11:20:27 (6856): Guest Log: [INFO] 2.7.2.0 http://s1swinburne-cvmfs.openhtc.io:8080 DIRECT
2025-12-12 11:20:27 (6856): Guest Log: [INFO] Environment HTTP proxy: not set
2025-12-12 11:20:28 (6856): Guest Log: [INFO] Reading volunteer information
2025-12-12 11:21:12 (6856): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-12-12 11:21:18 (6856): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-12-12 11:21:21 (6856): Guest Log: [INFO] CMS application starting. Check log files.
2025-12-12 11:24:33 (6856): VM state change detected. (old = 'running', new = 'paused')
2025-12-12 11:39:22 (6856): VM state change detected. (old = 'paused', new = 'running')
2025-12-12 11:46:28 (6856): VM state change detected. (old = 'running', new = 'paused')
2025-12-12 12:23:49 (6856): VM state change detected. (old = 'paused', new = 'running')
2025-12-12 12:23:52 (6856): Guest Log: 00:12:50.417487 timesync vgsvcTimeSyncWorker: Radical host time change: 2 251 217 000 000ns (HostNow=1 765 513 431 790 000 000 ns HostLast=1 765 511 180 573 000 000 ns)
2025-12-12 12:24:02 (6856): Guest Log: 00:13:00.428677 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 160 351 963 000ns (GuestNow=1 765 513 441 801 450 000 ns GuestLast=1 765 510 281 449 487 000 ns fSetTimeLastLoop=true )
2025-12-12 12:30:56 (6856): VM state change detected. (old = 'running', new = 'paused')
2025-12-12 12:33:57 (6856): VM state change detected. (old = 'paused', new = 'running')
2025-12-12 12:40:27 (6856): VM state change detected. (old = 'running', new = 'paused')
2025-12-12 13:49:25 (6856): VM state change detected. (old = 'paused', new = 'running')
2025-12-12 13:49:30 (6856): Guest Log: 00:26:30.782116 timesync vgsvcTimeSyncWorker: Radical host time change: 4 146 977 000 000ns (HostNow=1 765 518 569 833 000 000 ns HostLast=1 765 514 422 856 000 000 ns)
2025-12-12 13:49:40 (6856): Guest Log: 00:26:40.783118 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 327 680 676 000ns (GuestNow=1 765 518 579 834 794 000 ns GuestLast=1 765 514 252 154 118 000 ns fSetTimeLastLoop=true )
2025-12-12 13:56:31 (6856): VM state change detected. (old = 'running', new = 'paused')
2025-12-12 16:12:51 (6856): Guest Log: 00:33:31.455463 timesync vgsvcTimeSyncWorker: Radical host time change: 8 190 065 000 000ns (HostNow=1 765 527 170 242 000 000 ns HostLast=1 765 518 980 177 000 000 ns)
2025-12-12 16:12:51 (6856): VM state change detected. (old = 'paused', new = 'running')
2025-12-12 16:13:01 (6856): Guest Log: 00:33:41.469143 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 189 736 370 000ns (GuestNow=1 765 527 180 243 291 000 ns GuestLast=1 765 518 990 506 921 000 ns fSetTimeLastLoop=true )
2025-12-12 16:13:09 (6856): Guest Log: [INFO] glidein exited with return value 0.
2025-12-12 16:13:09 (6856): Guest Log: [INFO] Shutting Down.
2025-12-12 16:13:09 (6856): VM Completion File Detected.
2025-12-12 16:13:09 (6856): VM Completion Message: glidein exited with return value 0.
.
2025-12-12 16:13:09 (6856): Powering off VM.
2025-12-12 16:13:10 (6856): Successfully stopped VM.
2025-12-12 16:13:10 (6856): Deregistering VM. (boinc_7af408cd3d871a2b, slot#1)
2025-12-12 16:13:10 (6856): Removing network bandwidth throttle group from VM.
2025-12-12 16:13:10 (6856): Removing VM from VirtualBox.
2025-12-12 16:13:16 (6856): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN