| Name | CMS_3304276_1767565778.439605_0 |
| Workunit | 238351034 |
| Created | 4 Jan 2026, 22:29:42 UTC |
| Sent | 4 Jan 2026, 22:38:30 UTC |
| Report deadline | 4 Feb 2026, 22:38:30 UTC |
| Received | 7 Jan 2026, 14:25:44 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10829322 |
| Run time | 18 hours 42 min 46 sec |
| CPU time | 1 days 19 hours 14 min 3 sec |
| Validate state | Valid |
| Credit | 4,019.65 |
| Device peak FLOPS | 25.84 GFLOPS |
| Application version | CMS Simulation v70.91 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 82.98 MB |
| Peak swap size | 88.54 MB |
| Peak disk usage | 2.37 GB |
Stderr output
<core_client_version>8.2.8</core_client_version> <![CDATA[ <stderr_txt> 2026-01-05 22:31:14 (13152): vboxwrapper version 26210 2026-01-05 22:31:14 (13152): BOINC client version: 8.2.8 2026-01-05 22:31:14 (13152): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2026-01-05 22:31:14 (13152): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2026-01-05 22:31:14 (13152): Successfully copied 'init_data.xml' to the shared directory. 2026-01-05 22:31:15 (13152): Create VM. (boinc_704352b798cab23c, slot#2) 2026-01-05 22:31:15 (13152): Setting Memory Size for VM. (4584MB) 2026-01-05 22:31:15 (13152): Setting CPU Count for VM. (4) 2026-01-05 22:31:16 (13152): Setting Chipset Options for VM. 2026-01-05 22:31:16 (13152): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB) 2026-01-05 22:31:16 (13152): Setting Boot Options for VM. 2026-01-05 22:31:17 (13152): Setting Network Configuration for NAT. (Driver: virtio) 2026-01-05 22:31:17 (13152): Enabling VM Network Access. 2026-01-05 22:31:17 (13152): Disabling USB Support for VM. 2026-01-05 22:31:18 (13152): Disabling COM Port Support for VM. 2026-01-05 22:31:18 (13152): Disabling LPT Port Support for VM. 2026-01-05 22:31:18 (13152): Disabling Audio Support for VM. 2026-01-05 22:31:18 (13152): Disabling Clipboard Support for VM. 2026-01-05 22:31:19 (13152): Disabling Drag and Drop Support for VM. 2026-01-05 22:31:19 (13152): Adding storage controller(s) to VM. 2026-01-05 22:31:19 (13152): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi) 2026-01-05 22:31:21 (13152): Adding VirtualBox Guest Additions to VM. 2026-01-05 22:31:21 (13152): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2026-01-05 22:31:22 (13152): forwarding host port 61209 to guest port 80 2026-01-05 22:31:22 (13152): Enabling remote desktop for VM. 2026-01-05 22:31:22 (13152): Required extension pack not installed, remote desktop not enabled. 2026-01-05 22:31:22 (13152): Enabling shared directory for VM. 2026-01-05 22:31:23 (13152): Starting VM using VBoxManage interface. (boinc_704352b798cab23c, slot#2) 2026-01-05 22:31:29 (13152): Successfully started VM. (PID = '8424') 2026-01-05 22:31:29 (13152): Reporting VM Process ID to BOINC. 2026-01-05 22:31:29 (13152): Guest Log: BIOS: VirtualBox 7.0.6 2026-01-05 22:31:29 (13152): Guest Log: CPUID EDX: 0x178bfbff 2026-01-05 22:31:29 (13152): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-01-05 22:31:29 (13152): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-01-05 22:31:29 (13152): VM state change detected. (old = 'poweredoff', new = 'running') 2026-01-05 22:31:29 (13152): Detected: Web Application Enabled (http://localhost:61209) 2026-01-05 22:31:29 (13152): Preference change detected 2026-01-05 22:31:29 (13152): Setting CPU throttle for VM. (60%) 2026-01-05 22:31:30 (13152): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2026-01-05 22:31:31 (13152): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-01-05 22:31:31 (13152): Guest Log: BIOS: Booting from Hard Disk... 2026-01-05 22:31:34 (13152): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-01-05 22:31:34 (13152): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-01-05 22:31:58 (13152): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-01-05 22:31:58 (13152): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-01-05 22:31:59 (13152): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2026-01-05 22:31:59 (13152): Guest Log: 00:00:00.000093 main Log opened 2026-01-05T21:32:00.220887000Z 2026-01-05 22:31:59 (13152): Guest Log: 00:00:00.000180 main OS Product: Linux 2026-01-05 22:31:59 (13152): Guest Log: 00:00:00.000212 main OS Release: 4.14.232-19.cernvm.x86_64 2026-01-05 22:31:59 (13152): Guest Log: 00:00:00.000238 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2026-01-05 22:31:59 (13152): Guest Log: 00:00:00.000263 main Executable: /usr/sbin/VBoxService 2026-01-05 22:31:59 (13152): Guest Log: 00:00:00.000264 main Process ID: 2275 2026-01-05 22:31:59 (13152): Guest Log: 00:00:00.000265 main Package type: LINUX_64BITS_GENERIC 2026-01-05 22:31:59 (13152): Guest Log: 00:00:00.001345 main 5.2.6 r120293 started. Verbose level = 0 2026-01-05 22:32:17 (13152): Guest Log: [INFO] Mounting the shared directory 2026-01-05 22:32:17 (13152): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2026-01-05 22:32:17 (13152): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2026-01-05 22:32:17 (13152): Guest Log: [INFO] Testing connection to cern.ch 2026-01-05 22:32:17 (13152): Guest Log: [INFO] Testing connection to VCCS 2026-01-05 22:32:17 (13152): Guest Log: [INFO] Testing connection to HTCondor-Collector 2026-01-05 22:32:18 (13152): Guest Log: [INFO] Testing connection to HTCondor-CCB 2026-01-05 22:32:18 (13152): Guest Log: [INFO] Testing connection to WMAgent 2026-01-05 22:32:18 (13152): Guest Log: [INFO] Testing connection to EOSCMS 2026-01-05 22:32:18 (13152): Guest Log: [INFO] Testing connection to CMS-Factory 2026-01-05 22:32:18 (13152): Guest Log: [INFO] Testing connection to CMS-Frontier 2026-01-05 22:32:19 (13152): Guest Log: [INFO] Testing connection to Frontier 2026-01-05 22:32:19 (13152): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2026-01-05 22:32:19 (13152): Guest Log: [INFO] Could not find a local HTTP proxy 2026-01-05 22:32:19 (13152): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2026-01-05 22:32:19 (13152): Guest Log: [INFO] This makes the application less efficient 2026-01-05 22:32:20 (13152): Guest Log: [INFO] It also puts higher load on the project servers 2026-01-05 22:32:20 (13152): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2026-01-05 22:32:20 (13152): Guest Log: [INFO] Advice can be found in the project forum 2026-01-05 22:32:20 (13152): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2026-01-05 22:32:29 (13152): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2026-01-05 22:32:33 (13152): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2026-01-05 22:32:34 (13152): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2026-01-05 22:32:34 (13152): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2026-01-05 22:32:35 (13152): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2026-01-05 22:32:36 (13152): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2026-01-05 22:32:36 (13152): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2026-01-05 22:32:36 (13152): Guest Log: [INFO] Environment HTTP proxy: not set 2026-01-05 22:32:36 (13152): Guest Log: [INFO] Reading volunteer information 2026-01-05 22:32:51 (13152): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2026-01-05 22:32:52 (13152): Guest Log: [INFO] Requesting an idtoken from LHC@home 2026-01-05 22:32:53 (13152): Guest Log: [INFO] CMS application starting. Check log files. 2026-01-05 22:39:08 (13152): VM state change detected. (old = 'running', new = 'paused') 2026-01-05 23:49:33 (13152): Error in resume VM for VM: -182 Command: VBoxManage -q controlvm "boinc_704352b798cab23c" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 395 of file VBoxManageControlVM.cpp 2026-01-05 23:49:34 (13152): Guest Log: 00:07:10.151035 timesync vgsvcTimeSyncWorker: Radical host time change: 4 211 249 000 000ns (HostNow=1 767 653 350 132 000 000 ns HostLast=1 767 649 138 883 000 000 ns) 2026-01-05 23:49:34 (13152): Guest Log: 00:07:20.225749 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 209 835 841 000ns (GuestNow=1 767 653 360 207 148 000 ns GuestLast=1 767 649 150 371 307 000 ns fSetTimeLastLoop=true ) 2026-01-05 23:49:34 (13152): VM state change detected. (old = 'paused', new = 'running') 2026-01-05 23:49:35 (13152): VM state change detected. (old = 'running', new = 'paused') 2026-01-05 23:49:39 (13152): VM state change detected. (old = 'paused', new = 'running') 2026-01-06 00:57:27 (13152): VM state change detected. (old = 'running', new = 'paused') 2026-01-06 00:57:28 (13152): VM state change detected. (old = 'paused', new = 'running') 2026-01-06 01:27:07 (13152): Status Report: Job Duration: '64800.000000' 2026-01-06 01:27:07 (13152): Status Report: Elapsed Time: '6000.993696' 2026-01-06 01:27:07 (13152): Status Report: CPU Time: '13263.968750' 2026-01-06 11:43:28 (9660): vboxwrapper version 26210 2026-01-06 11:43:28 (9660): BOINC client version: 8.2.8 2026-01-06 11:43:29 (9660): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2026-01-06 11:43:29 (9660): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2026-01-06 11:43:30 (9660): Guest Log: BIOS: VirtualBox 7.0.6 2026-01-06 11:43:30 (9660): Guest Log: CPUID EDX: 0x178bfbff 2026-01-06 11:43:30 (9660): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-01-06 11:43:30 (9660): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-01-06 11:43:30 (9660): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-01-06 11:43:30 (9660): Guest Log: BIOS: Booting from Hard Disk... 2026-01-06 11:43:30 (9660): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-01-06 11:43:30 (9660): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-01-06 11:43:30 (9660): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-01-06 11:43:30 (9660): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-01-06 11:43:30 (9660): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2026-01-06 11:43:30 (9660): Guest Log: 00:00:00.000093 main Log opened 2026-01-05T21:32:00.220887000Z 2026-01-06 11:43:30 (9660): Guest Log: 00:00:00.000180 main OS Product: Linux 2026-01-06 11:43:30 (9660): Guest Log: 00:00:00.000212 main OS Release: 4.14.232-19.cernvm.x86_64 2026-01-06 11:43:30 (9660): Guest Log: 00:00:00.000238 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2026-01-06 11:43:30 (9660): Guest Log: 00:00:00.000263 main Executable: /usr/sbin/VBoxService 2026-01-06 11:43:30 (9660): Guest Log: 00:00:00.000264 main Process ID: 2275 2026-01-06 11:43:30 (9660): Guest Log: 00:00:00.000265 main Package type: LINUX_64BITS_GENERIC 2026-01-06 11:43:30 (9660): Guest Log: 00:00:00.001345 main 5.2.6 r120293 started. Verbose level = 0 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Mounting the shared directory 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to cern.ch 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to VCCS 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to HTCondor-Collector 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to HTCondor-CCB 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to WMAgent 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to EOSCMS 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to CMS-Factory 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to CMS-Frontier 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to Frontier 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Could not find a local HTTP proxy 2026-01-06 11:43:30 (9660): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2026-01-06 11:43:30 (9660): Guest Log: [INFO] This makes the application less efficient 2026-01-06 11:43:30 (9660): Guest Log: [INFO] It also puts higher load on the project servers 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Advice can be found in the project forum 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2026-01-06 11:43:30 (9660): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Environment HTTP proxy: not set 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Reading volunteer information 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2026-01-06 11:43:30 (9660): Guest Log: [INFO] Requesting an idtoken from LHC@home 2026-01-06 11:43:30 (9660): Guest Log: [INFO] CMS application starting. Check log files. 2026-01-06 11:43:30 (9660): Guest Log: 00:07:10.151035 timesync vgsvcTimeSyncWorker: Radical host time change: 4 211 249 000 000ns (HostNow=1 767 653 350 132 000 000 ns HostLast=1 767 649 138 883 000 000 ns) 2026-01-06 11:43:30 (9660): Guest Log: 00:07:20.225749 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 209 835 841 000ns (GuestNow=1 767 653 360 207 148 000 ns GuestLast=1 767 649 150 371 307 000 ns fSetTimeLastLoop=true ) 2026-01-06 11:43:30 (9660): Starting VM using VBoxManage interface. (boinc_704352b798cab23c, slot#2) 2026-01-06 11:43:51 (9660): Successfully started VM. (PID = '17692') 2026-01-06 11:43:51 (9660): Reporting VM Process ID to BOINC. 2026-01-06 11:43:57 (9660): Guest Log: BIOS: VirtualBox 7.0.6 2026-01-06 11:43:57 (9660): Guest Log: CPUID EDX: 0x178bfbff 2026-01-06 11:43:57 (9660): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-01-06 11:43:57 (9660): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-01-06 11:43:57 (9660): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-01-06 11:43:57 (9660): Guest Log: BIOS: Booting from Hard Disk... 2026-01-06 11:43:57 (9660): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-01-06 11:43:57 (9660): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-01-06 11:43:57 (9660): VM state change detected. (old = 'poweredoff', new = 'running') 2026-01-06 11:43:57 (9660): Detected: Web Application Enabled (http://localhost:61209) 2026-01-06 11:43:57 (9660): Status Report: Job Duration: '64800.000000' 2026-01-06 11:43:57 (9660): Status Report: Elapsed Time: '10086.307909' 2026-01-06 11:43:57 (9660): Status Report: CPU Time: '23158.218750' 2026-01-06 11:43:57 (9660): Preference change detected 2026-01-06 11:43:57 (9660): Setting CPU throttle for VM. (60%) 2026-01-06 11:43:58 (9660): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2026-01-06 11:44:20 (9660): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-01-06 11:44:20 (9660): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-01-06 11:44:21 (9660): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2026-01-06 11:44:21 (9660): Guest Log: 00:00:00.000116 main Log opened 2026-01-06T10:44:22.360154000Z 2026-01-06 11:44:21 (9660): Guest Log: 00:00:00.000770 main OS Product: Linux 2026-01-06 11:44:21 (9660): Guest Log: 00:00:00.001131 main OS Release: 4.14.232-19.cernvm.x86_64 2026-01-06 11:44:21 (9660): Guest Log: 00:00:00.001396 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2026-01-06 11:44:21 (9660): Guest Log: 00:00:00.001601 main Executable: /usr/sbin/VBoxService 2026-01-06 11:44:21 (9660): Guest Log: 00:00:00.001602 main Process ID: 2287 2026-01-06 11:44:21 (9660): Guest Log: 00:00:00.001603 main Package type: LINUX_64BITS_GENERIC 2026-01-06 11:44:21 (9660): Guest Log: 00:00:00.003012 main 5.2.6 r120293 started. Verbose level = 0 2026-01-06 11:44:45 (9660): Guest Log: [INFO] Mounting the shared directory 2026-01-06 11:44:45 (9660): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2026-01-06 11:44:45 (9660): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2026-01-06 11:44:46 (9660): Guest Log: [INFO] Testing connection to cern.ch 2026-01-06 11:44:46 (9660): Guest Log: [INFO] Testing connection to VCCS 2026-01-06 11:44:46 (9660): Guest Log: [INFO] Testing connection to HTCondor-Collector 2026-01-06 11:44:46 (9660): Guest Log: [INFO] Testing connection to HTCondor-CCB 2026-01-06 11:44:46 (9660): Guest Log: [INFO] Testing connection to WMAgent 2026-01-06 11:44:47 (9660): Guest Log: [INFO] Testing connection to EOSCMS 2026-01-06 11:44:47 (9660): Guest Log: [INFO] Testing connection to CMS-Factory 2026-01-06 11:44:47 (9660): Guest Log: [INFO] Testing connection to CMS-Frontier 2026-01-06 11:44:47 (9660): Guest Log: [INFO] Testing connection to Frontier 2026-01-06 11:44:48 (9660): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2026-01-06 11:44:49 (9660): Guest Log: [INFO] Could not find a local HTTP proxy 2026-01-06 11:44:49 (9660): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2026-01-06 11:44:49 (9660): Guest Log: [INFO] This makes the application less efficient 2026-01-06 11:44:49 (9660): Guest Log: [INFO] It also puts higher load on the project servers 2026-01-06 11:44:49 (9660): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2026-01-06 11:44:49 (9660): Guest Log: [INFO] Advice can be found in the project forum 2026-01-06 11:44:49 (9660): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2026-01-06 11:44:58 (9660): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2026-01-06 11:45:02 (9660): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2026-01-06 11:45:03 (9660): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2026-01-06 11:45:04 (9660): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2026-01-06 11:45:06 (9660): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2026-01-06 11:45:07 (9660): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2026-01-06 11:45:07 (9660): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2026-01-06 11:45:07 (9660): Guest Log: [INFO] Environment HTTP proxy: not set 2026-01-06 11:45:07 (9660): Guest Log: [INFO] Reading volunteer information 2026-01-06 11:45:14 (9660): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2026-01-06 11:45:15 (9660): Guest Log: [INFO] Requesting an idtoken from LHC@home 2026-01-06 11:45:15 (9660): Guest Log: [INFO] CMS application starting. Check log files. 2026-01-06 11:48:36 (9660): VM state change detected. (old = 'running', new = 'paused') 2026-01-06 11:48:52 (9660): VM state change detected. (old = 'paused', new = 'running') 2026-01-06 13:25:32 (9660): Status Report: Job Duration: '64800.000000' 2026-01-06 13:25:32 (9660): Status Report: Elapsed Time: '16087.263683' 2026-01-06 13:25:32 (9660): Status Report: CPU Time: '36992.328125' 2026-01-06 14:15:24 (9660): VM state change detected. (old = 'running', new = 'paused') 2026-01-06 15:22:42 (9660): Error in resume VM for VM: -182 Command: VBoxManage -q controlvm "boinc_704352b798cab23c" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 395 of file VBoxManageControlVM.cpp 2026-01-06 15:22:42 (9660): Guest Log: 02:30:54.837716 timesync vgsvcTimeSyncWorker: Radical host time change: 4 018 341 000 000ns (HostNow=1 767 709 335 320 000 000 ns HostLast=1 767 705 316 979 000 000 ns) 2026-01-06 15:22:42 (9660): Guest Log: 02:31:04.839164 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 028 396 180 000ns (GuestNow=1 767 709 345 457 675 000 ns GuestLast=1 767 705 317 061 495 000 ns fSetTimeLastLoop=true ) 2026-01-06 15:22:42 (9660): VM state change detected. (old = 'paused', new = 'running') 2026-01-06 15:22:43 (9660): VM state change detected. (old = 'running', new = 'paused') 2026-01-06 15:22:44 (9660): VM state change detected. (old = 'paused', new = 'running') 2026-01-06 16:13:54 (9660): Status Report: Job Duration: '64800.000000' 2026-01-06 16:13:54 (9660): Status Report: Elapsed Time: '22087.454668' 2026-01-06 16:13:54 (9660): Status Report: CPU Time: '51474.218750' 2026-01-06 16:55:56 (9660): VM state change detected. (old = 'running', new = 'paused') 2026-01-06 16:57:10 (9660): VM state change detected. (old = 'paused', new = 'running') 2026-01-06 17:57:01 (9660): Status Report: Job Duration: '64800.000000' 2026-01-06 17:57:01 (9660): Status Report: Elapsed Time: '28087.454668' 2026-01-06 17:57:01 (9660): Status Report: CPU Time: '65765.125000' 2026-01-06 19:48:50 (9660): Status Report: Job Duration: '64800.000000' 2026-01-06 19:48:50 (9660): Status Report: Elapsed Time: '34088.397406' 2026-01-06 19:48:50 (9660): Status Report: CPU Time: '81498.343750' 2026-01-06 21:38:48 (9660): Status Report: Job Duration: '64800.000000' 2026-01-06 21:38:48 (9660): Status Report: Elapsed Time: '40088.950531' 2026-01-06 21:38:48 (9660): Status Report: CPU Time: '97166.500000' 2026-01-06 22:53:46 (9660): VM state change detected. (old = 'running', new = 'paused') 2026-01-06 22:54:06 (9660): VM state change detected. (old = 'paused', new = 'running') 2026-01-06 23:20:05 (9660): Status Report: Job Duration: '64800.000000' 2026-01-06 23:20:05 (9660): Status Report: Elapsed Time: '46088.950531' 2026-01-06 23:20:05 (9660): Status Report: CPU Time: '110606.234375' 2026-01-07 01:02:16 (9660): Status Report: Job Duration: '64800.000000' 2026-01-07 01:02:16 (9660): Status Report: Elapsed Time: '52089.764379' 2026-01-07 01:02:16 (9660): Status Report: CPU Time: '125192.765625' 2026-01-07 02:46:47 (9660): Status Report: Job Duration: '64800.000000' 2026-01-07 02:46:47 (9660): Status Report: Elapsed Time: '58090.702610' 2026-01-07 02:46:47 (9660): Status Report: CPU Time: '140055.625000' 2026-01-07 14:00:47 (18024): vboxwrapper version 26210 2026-01-07 14:00:48 (18024): BOINC client version: 8.2.8 2026-01-07 14:00:50 (18024): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2026-01-07 14:00:50 (18024): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2026-01-07 14:00:51 (18024): Guest Log: BIOS: VirtualBox 7.0.6 2026-01-07 14:00:51 (18024): Guest Log: CPUID EDX: 0x178bfbff 2026-01-07 14:00:51 (18024): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-01-07 14:00:51 (18024): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-01-07 14:00:51 (18024): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-01-07 14:00:51 (18024): Guest Log: BIOS: Booting from Hard Disk... 2026-01-07 14:00:51 (18024): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-01-07 14:00:51 (18024): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-01-07 14:00:51 (18024): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-01-07 14:00:51 (18024): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-01-07 14:00:51 (18024): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2026-01-07 14:00:51 (18024): Guest Log: 00:00:00.000116 main Log opened 2026-01-06T10:44:22.360154000Z 2026-01-07 14:00:51 (18024): Guest Log: 00:00:00.000770 main OS Product: Linux 2026-01-07 14:00:51 (18024): Guest Log: 00:00:00.001131 main OS Release: 4.14.232-19.cernvm.x86_64 2026-01-07 14:00:51 (18024): Guest Log: 00:00:00.001396 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2026-01-07 14:00:51 (18024): Guest Log: 00:00:00.001601 main Executable: /usr/sbin/VBoxService 2026-01-07 14:00:51 (18024): Guest Log: 00:00:00.001602 main Process ID: 2287 2026-01-07 14:00:51 (18024): Guest Log: 00:00:00.001603 main Package type: LINUX_64BITS_GENERIC 2026-01-07 14:00:51 (18024): Guest Log: 00:00:00.003012 main 5.2.6 r120293 started. Verbose level = 0 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Mounting the shared directory 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to cern.ch 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to VCCS 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to HTCondor-Collector 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to HTCondor-CCB 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to WMAgent 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to EOSCMS 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to CMS-Factory 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to CMS-Frontier 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to Frontier 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Could not find a local HTTP proxy 2026-01-07 14:00:51 (18024): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2026-01-07 14:00:51 (18024): Guest Log: [INFO] This makes the application less efficient 2026-01-07 14:00:51 (18024): Guest Log: [INFO] It also puts higher load on the project servers 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Advice can be found in the project forum 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2026-01-07 14:00:51 (18024): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Environment HTTP proxy: not set 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Reading volunteer information 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2026-01-07 14:00:51 (18024): Guest Log: [INFO] Requesting an idtoken from LHC@home 2026-01-07 14:00:51 (18024): Guest Log: [INFO] CMS application starting. Check log files. 2026-01-07 14:00:51 (18024): Guest Log: 02:30:54.837716 timesync vgsvcTimeSyncWorker: Radical host time change: 4 018 341 000 000ns (HostNow=1 767 709 335 320 000 000 ns HostLast=1 767 705 316 979 000 000 ns) 2026-01-07 14:00:51 (18024): Guest Log: 02:31:04.839164 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 028 396 180 000ns (GuestNow=1 767 709 345 457 675 000 ns GuestLast=1 767 705 317 061 495 000 ns fSetTimeLastLoop=true ) 2026-01-07 14:00:51 (18024): Starting VM using VBoxManage interface. (boinc_704352b798cab23c, slot#2) 2026-01-07 14:00:58 (18024): Successfully started VM. (PID = '10056') 2026-01-07 14:00:58 (18024): Reporting VM Process ID to BOINC. 2026-01-07 14:00:58 (18024): Guest Log: BIOS: VirtualBox 7.0.6 2026-01-07 14:00:58 (18024): Guest Log: CPUID EDX: 0x178bfbff 2026-01-07 14:00:58 (18024): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-01-07 14:00:58 (18024): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-01-07 14:00:58 (18024): VM state change detected. (old = 'poweredoff', new = 'running') 2026-01-07 14:00:58 (18024): Detected: Web Application Enabled (http://localhost:61209) 2026-01-07 14:00:59 (18024): VM state change detected. (old = 'running', new = 'paused') 2026-01-07 14:01:15 (18024): Status Report: Job Duration: '64800.000000' 2026-01-07 14:01:15 (18024): Status Report: Elapsed Time: '59815.702610' 2026-01-07 14:01:15 (18024): Status Report: CPU Time: '144372.015625' 2026-01-07 14:01:15 (18024): Preference change detected 2026-01-07 14:01:15 (18024): Setting CPU throttle for VM. (60%) 2026-01-07 14:01:15 (18024): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2026-01-07 14:01:16 (18024): VM state change detected. (old = 'paused', new = 'running') 2026-01-07 14:01:17 (18024): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-01-07 14:01:17 (18024): Guest Log: BIOS: Booting from Hard Disk... 2026-01-07 14:01:19 (18024): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-01-07 14:01:19 (18024): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-01-07 14:01:46 (18024): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-01-07 14:01:46 (18024): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-01-07 14:01:46 (18024): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2026-01-07 14:01:48 (18024): Guest Log: 00:00:00.000091 main Log opened 2026-01-07T13:01:47.230877000Z 2026-01-07 14:01:48 (18024): Guest Log: 00:00:00.000184 main OS Product: Linux 2026-01-07 14:01:48 (18024): Guest Log: 00:00:00.000219 main OS Release: 4.14.232-19.cernvm.x86_64 2026-01-07 14:01:48 (18024): Guest Log: 00:00:00.000247 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2026-01-07 14:01:48 (18024): Guest Log: 00:00:00.000274 main Executable: /usr/sbin/VBoxService 2026-01-07 14:01:48 (18024): Guest Log: 00:00:00.000275 main Process ID: 2286 2026-01-07 14:01:48 (18024): Guest Log: 00:00:00.000275 main Package type: LINUX_64BITS_GENERIC 2026-01-07 14:01:48 (18024): Guest Log: 00:00:00.000839 main 5.2.6 r120293 started. Verbose level = 0 2026-01-07 14:02:10 (18024): Guest Log: [INFO] Mounting the shared directory 2026-01-07 14:02:10 (18024): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2026-01-07 14:02:10 (18024): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2026-01-07 14:02:10 (18024): Guest Log: [INFO] Testing connection to cern.ch 2026-01-07 14:02:10 (18024): Guest Log: [INFO] Testing connection to VCCS 2026-01-07 14:02:10 (18024): Guest Log: [INFO] Testing connection to HTCondor-Collector 2026-01-07 14:02:11 (18024): Guest Log: [INFO] Testing connection to HTCondor-CCB 2026-01-07 14:02:11 (18024): Guest Log: [INFO] Testing connection to WMAgent 2026-01-07 14:02:11 (18024): Guest Log: [INFO] Testing connection to EOSCMS 2026-01-07 14:02:11 (18024): Guest Log: [INFO] Testing connection to CMS-Factory 2026-01-07 14:02:11 (18024): Guest Log: [INFO] Testing connection to CMS-Frontier 2026-01-07 14:02:12 (18024): Guest Log: [INFO] Testing connection to Frontier 2026-01-07 14:02:12 (18024): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2026-01-07 14:02:13 (18024): Guest Log: [INFO] Could not find a local HTTP proxy 2026-01-07 14:02:13 (18024): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2026-01-07 14:02:13 (18024): Guest Log: [INFO] This makes the application less efficient 2026-01-07 14:02:13 (18024): Guest Log: [INFO] It also puts higher load on the project servers 2026-01-07 14:02:13 (18024): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2026-01-07 14:02:13 (18024): Guest Log: [INFO] Advice can be found in the project forum 2026-01-07 14:02:14 (18024): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2026-01-07 14:02:23 (18024): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2026-01-07 14:02:27 (18024): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2026-01-07 14:02:27 (18024): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2026-01-07 14:02:28 (18024): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2026-01-07 14:02:29 (18024): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2026-01-07 14:02:30 (18024): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2026-01-07 14:02:30 (18024): Guest Log: [INFO] 2.7.2.0 http://s1swinburne-cvmfs.openhtc.io:8080 DIRECT 2026-01-07 14:02:30 (18024): Guest Log: [INFO] Environment HTTP proxy: not set 2026-01-07 14:02:30 (18024): Guest Log: [INFO] Reading volunteer information 2026-01-07 14:02:46 (18024): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2026-01-07 14:02:47 (18024): Guest Log: [INFO] Requesting an idtoken from LHC@home 2026-01-07 14:02:48 (18024): Guest Log: [INFO] CMS application starting. Check log files. 2026-01-07 15:25:29 (18024): Powering off VM. 2026-01-07 15:25:30 (18024): Successfully stopped VM. 2026-01-07 15:25:30 (18024): Deregistering VM. (boinc_704352b798cab23c, slot#2) 2026-01-07 15:25:30 (18024): Removing network bandwidth throttle group from VM. 2026-01-07 15:25:30 (18024): Removing VM from VirtualBox. 2026-01-07 15:25:36 (18024): called boinc_finish(0) </stderr_txt> ]]>
©2026 CERN