Name | CMS_1084633_1753104732.700867_0 |
Workunit | 233709038 |
Created | 21 Jul 2025, 13:32:13 UTC |
Sent | 21 Jul 2025, 15:42:48 UTC |
Report deadline | 21 Aug 2025, 15:42:48 UTC |
Received | 23 Jul 2025, 12:08:03 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10872878 |
Run time | 41 min 1 sec |
CPU time | 14 min 53 sec |
Validate state | Valid |
Credit | 108.32 |
Device peak FLOPS | 16.45 GFLOPS |
Application version | CMS Simulation v70.91 (vbox64_mt_mcore_cms) x86_64-pc-linux-gnu |
Peak working set size | 1.44 GB |
Peak swap size | 4.32 GB |
Peak disk usage | 2.86 GB |
<core_client_version>8.2.4</core_client_version> <![CDATA[ <stderr_txt> 2025-07-21 19:45:36 (33777): vboxwrapper version 26210 2025-07-21 19:45:36 (33777): BOINC client version: 8.2.4 2025-07-21 19:45:38 (33777): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-21 19:45:38 (33777): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-21 19:45:38 (33777): Successfully copied 'init_data.xml' to the shared directory. 2025-07-21 19:45:38 (33777): Create VM. (boinc_d34a93e74a8cac53, slot#1) 2025-07-21 19:45:38 (33777): Setting Memory Size for VM. (4584MB) 2025-07-21 19:45:38 (33777): Setting CPU Count for VM. (4) 2025-07-21 19:45:39 (33777): Setting Chipset Options for VM. 2025-07-21 19:45:39 (33777): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB) 2025-07-21 19:45:39 (33777): Setting Boot Options for VM. 2025-07-21 19:45:39 (33777): Setting Network Configuration for NAT. (Driver: virtio) 2025-07-21 19:45:39 (33777): Enabling VM Network Access. 2025-07-21 19:45:39 (33777): Disabling USB Support for VM. 2025-07-21 19:45:39 (33777): Disabling COM Port Support for VM. 2025-07-21 19:45:39 (33777): Disabling LPT Port Support for VM. 2025-07-21 19:45:39 (33777): Disabling Audio Support for VM. 2025-07-21 19:45:39 (33777): Disabling Clipboard Support for VM. 2025-07-21 19:45:39 (33777): Disabling Drag and Drop Support for VM. 2025-07-21 19:45:39 (33777): Adding storage controller(s) to VM. 2025-07-21 19:45:39 (33777): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi) 2025-07-21 19:45:39 (33777): Adding VirtualBox Guest Additions to VM. 2025-07-21 19:45:40 (33777): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2025-07-21 19:45:40 (33777): forwarding host port 33955 to guest port 80 2025-07-21 19:45:40 (33777): Enabling remote desktop for VM. 2025-07-21 19:45:40 (33777): Required extension pack not installed, remote desktop not enabled. 2025-07-21 19:45:40 (33777): Enabling shared directory for VM. 2025-07-21 19:45:40 (33777): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-21 19:45:41 (33777): Successfully started VM. (PID = '34306') 2025-07-21 19:45:41 (33777): Reporting VM Process ID to BOINC. 2025-07-21 19:45:41 (33777): Guest Log: BIOS: VirtualBox 6.1.50 2025-07-21 19:45:41 (33777): Guest Log: CPUID EDX: 0x178bfbff 2025-07-21 19:45:41 (33777): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-21 19:45:41 (33777): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-21 19:45:41 (33777): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-21 19:45:41 (33777): Detected: Web Application Enabled (http://localhost:33955) 2025-07-21 19:45:41 (33777): Preference change detected 2025-07-21 19:45:41 (33777): Setting CPU throttle for VM. (100%) 2025-07-21 19:45:41 (33777): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-21 19:45:43 (33777): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-21 19:45:43 (33777): Guest Log: BIOS: Booting from Hard Disk... 2025-07-21 19:45:46 (33777): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-21 19:45:46 (33777): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-21 19:46:22 (33777): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-21 19:46:22 (33777): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000) 2025-07-21 19:46:24 (33777): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-07-21 19:46:24 (33777): Guest Log: 00:00:00.000239 main Log opened 2025-07-21T17:46:23.439703000Z 2025-07-21 19:46:24 (33777): Guest Log: 00:00:00.001552 main OS Product: Linux 2025-07-21 19:46:24 (33777): Guest Log: 00:00:00.001660 main OS Release: 4.14.232-19.cernvm.x86_64 2025-07-21 19:46:24 (33777): Guest Log: 00:00:00.001680 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-07-21 19:46:24 (33777): Guest Log: 00:00:00.001697 main Executable: /usr/sbin/VBoxService 2025-07-21 19:46:24 (33777): Guest Log: 00:00:00.001698 main Process ID: 2280 2025-07-21 19:46:24 (33777): Guest Log: 00:00:00.001699 main Package type: LINUX_64BITS_GENERIC 2025-07-21 19:46:24 (33777): Guest Log: 00:00:00.008945 main 5.2.6 r120293 started. Verbose level = 0 2025-07-21 19:46:48 (33777): Guest Log: [INFO] Mounting the shared directory 2025-07-21 19:46:49 (33777): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-07-21 19:46:49 (33777): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-07-21 19:46:49 (33777): Guest Log: [INFO] Testing connection to cern.ch 2025-07-21 19:46:50 (33777): Guest Log: [INFO] Testing connection to VCCS 2025-07-21 19:46:51 (33777): Guest Log: [INFO] Testing connection to HTCondor 2025-07-21 19:46:51 (33777): Guest Log: [INFO] Testing connection to WMAgent 2025-07-21 19:46:52 (33777): Guest Log: [INFO] Testing connection to EOSCMS 2025-07-21 19:46:52 (33777): Guest Log: [INFO] Testing connection to CMS-Factory 2025-07-21 19:46:53 (33777): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-07-21 19:46:53 (33777): Guest Log: [INFO] Testing connection to Frontier 2025-07-21 19:46:53 (33777): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2025-07-21 19:46:55 (33777): Guest Log: [INFO] Could not find a local HTTP proxy 2025-07-21 19:46:56 (33777): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-07-21 19:46:56 (33777): Guest Log: [INFO] This makes the application less efficient 2025-07-21 19:46:56 (33777): Guest Log: [INFO] It also puts higher load on the project servers 2025-07-21 19:46:56 (33777): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-07-21 19:46:56 (33777): Guest Log: [INFO] Advice can be found in the project forum 2025-07-21 19:46:59 (33777): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-07-21 19:47:08 (33777): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-07-21 19:47:12 (33777): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-07-21 19:47:12 (33777): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-07-21 19:47:12 (33777): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-07-21 19:47:13 (33777): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-07-21 19:47:14 (33777): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-07-21 19:47:14 (33777): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-07-21 19:47:14 (33777): Guest Log: [INFO] Environment HTTP proxy: not set 2025-07-21 19:47:14 (33777): Guest Log: [INFO] Reading volunteer information 2025-07-21 19:47:55 (33777): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-07-21 19:47:56 (33777): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-07-21 19:47:58 (33777): Guest Log: [INFO] CMS application starting. Check log files. 2025-07-21 19:49:15 (33777): Stopping VM. 2025-07-21 19:49:17 (33777): Successfully stopped VM. 2025-07-21 19:58:25 (34455): vboxwrapper version 26210 2025-07-21 19:58:25 (34455): BOINC client version: 8.2.4 2025-07-21 19:58:25 (34455): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-21 19:58:25 (34455): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-21 19:58:25 (34455): Guest Log: BIOS: VirtualBox 6.1.50 2025-07-21 19:58:25 (34455): Guest Log: CPUID EDX: 0x178bfbff 2025-07-21 19:58:25 (34455): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-21 19:58:25 (34455): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-21 19:58:25 (34455): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-21 19:58:25 (34455): Guest Log: BIOS: Booting from Hard Disk... 2025-07-21 19:58:25 (34455): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-21 19:58:25 (34455): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-21 19:58:25 (34455): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-21 19:58:25 (34455): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000) 2025-07-21 19:58:25 (34455): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-07-21 19:58:25 (34455): Guest Log: 00:00:00.000239 main Log opened 2025-07-21T17:46:23.439703000Z 2025-07-21 19:58:25 (34455): Guest Log: 00:00:00.001552 main OS Product: Linux 2025-07-21 19:58:25 (34455): Guest Log: 00:00:00.001660 main OS Release: 4.14.232-19.cernvm.x86_64 2025-07-21 19:58:25 (34455): Guest Log: 00:00:00.001680 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-07-21 19:58:25 (34455): Guest Log: 00:00:00.001697 main Executable: /usr/sbin/VBoxService 2025-07-21 19:58:25 (34455): Guest Log: 00:00:00.001698 main Process ID: 2280 2025-07-21 19:58:25 (34455): Guest Log: 00:00:00.001699 main Package type: LINUX_64BITS_GENERIC 2025-07-21 19:58:25 (34455): Guest Log: 00:00:00.008945 main 5.2.6 r120293 started. Verbose level = 0 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Mounting the shared directory 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to cern.ch 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to VCCS 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to HTCondor 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to WMAgent 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to EOSCMS 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to CMS-Factory 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to Frontier 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Could not find a local HTTP proxy 2025-07-21 19:58:25 (34455): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-07-21 19:58:25 (34455): Guest Log: [INFO] This makes the application less efficient 2025-07-21 19:58:25 (34455): Guest Log: [INFO] It also puts higher load on the project servers 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Advice can be found in the project forum 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-07-21 19:58:25 (34455): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Environment HTTP proxy: not set 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Reading volunteer information 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-07-21 19:58:25 (34455): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-07-21 19:58:25 (34455): Guest Log: [INFO] CMS application starting. Check log files. 2025-07-21 19:58:25 (34455): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-21 19:58:29 (34455): Successfully started VM. (PID = '34576') 2025-07-21 19:58:29 (34455): Reporting VM Process ID to BOINC. 2025-07-21 19:58:29 (34455): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-21 19:58:29 (34455): Detected: Web Application Enabled (http://localhost:33955) 2025-07-21 19:58:29 (34455): Preference change detected 2025-07-21 19:58:29 (34455): Setting CPU throttle for VM. (100%) 2025-07-21 19:58:29 (34455): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-21 20:07:35 (34455): Stopping VM. 2025-07-21 20:07:38 (34455): Successfully stopped VM. 2025-07-22 08:14:53 (35218): vboxwrapper version 26210 2025-07-22 08:14:53 (35218): BOINC client version: 8.2.4 2025-07-22 08:14:53 (35218): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-22 08:14:53 (35218): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-22 08:14:53 (35218): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-22 08:14:56 (35218): Successfully started VM. (PID = '35338') 2025-07-22 08:14:56 (35218): Reporting VM Process ID to BOINC. 2025-07-22 08:14:56 (35218): Guest Log: 00:12:00.583432 timesync vgsvcTimeSyncWorker: Radical host time change: 43 650 000 000 000ns (HostNow=1 753 164 895 997 000 000 ns HostLast=1 753 121 245 997 000 000 ns) 2025-07-22 08:14:56 (35218): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-22 08:14:56 (35218): Detected: Web Application Enabled (http://localhost:33955) 2025-07-22 08:14:56 (35218): Preference change detected 2025-07-22 08:14:56 (35218): Setting CPU throttle for VM. (100%) 2025-07-22 08:14:56 (35218): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-22 08:15:06 (35218): Guest Log: 00:12:10.586516 timesync vgsvcTimeSyncWorker: Radical guest time change: 43 649 661 009 000ns (GuestNow=1 753 164 906 007 837 000 ns GuestLast=1 753 121 256 346 828 000 ns fSetTimeLastLoop=true ) 2025-07-22 08:18:57 (35218): Stopping VM. 2025-07-22 08:18:59 (35218): Successfully stopped VM. 2025-07-22 11:43:52 (35880): vboxwrapper version 26210 2025-07-22 11:43:52 (35880): BOINC client version: 8.2.4 2025-07-22 11:43:52 (35880): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-22 11:43:52 (35880): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-22 11:43:52 (35880): Guest Log: 00:12:00.583432 timesync vgsvcTimeSyncWorker: Radical host time change: 43 650 000 000 000ns (HostNow=1 753 164 895 997 000 000 ns HostLast=1 753 121 245 997 000 000 ns) 2025-07-22 11:43:52 (35880): Guest Log: 00:12:10.586516 timesync vgsvcTimeSyncWorker: Radical guest time change: 43 649 661 009 000ns (GuestNow=1 753 164 906 007 837 000 ns GuestLast=1 753 121 256 346 828 000 ns fSetTimeLastLoop=true ) 2025-07-22 11:43:52 (35880): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-22 11:43:56 (35880): Successfully started VM. (PID = '36001') 2025-07-22 11:43:56 (35880): Reporting VM Process ID to BOINC. 2025-07-22 11:43:56 (35880): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-22 11:43:56 (35880): Detected: Web Application Enabled (http://localhost:33955) 2025-07-22 11:43:56 (35880): Preference change detected 2025-07-22 11:43:56 (35880): Setting CPU throttle for VM. (100%) 2025-07-22 11:43:56 (35880): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-22 11:44:04 (35880): Guest Log: 00:16:10.798262 timesync vgsvcTimeSyncWorker: Radical host time change: 12 307 788 000 000ns (HostNow=1 753 177 443 774 000 000 ns HostLast=1 753 165 135 986 000 000 ns) 2025-07-22 11:44:13 (35880): Guest Log: 00:16:20.808167 timesync vgsvcTimeSyncWorker: Radical guest time change: 12 307 573 928 000ns (GuestNow=1 753 177 453 788 684 000 ns GuestLast=1 753 165 146 214 756 000 ns fSetTimeLastLoop=true ) 2025-07-22 11:50:01 (35880): Stopping VM. 2025-07-22 11:50:07 (35880): Successfully stopped VM. 2025-07-22 13:54:33 (36376): vboxwrapper version 26210 2025-07-22 13:54:33 (36376): BOINC client version: 8.2.4 2025-07-22 13:54:33 (36376): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-22 13:54:33 (36376): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-22 13:54:33 (36376): Guest Log: 00:16:10.798262 timesync vgsvcTimeSyncWorker: Radical host time change: 12 307 788 000 000ns (HostNow=1 753 177 443 774 000 000 ns HostLast=1 753 165 135 986 000 000 ns) 2025-07-22 13:54:33 (36376): Guest Log: 00:16:20.808167 timesync vgsvcTimeSyncWorker: Radical guest time change: 12 307 573 928 000ns (GuestNow=1 753 177 453 788 684 000 ns GuestLast=1 753 165 146 214 756 000 ns fSetTimeLastLoop=true ) 2025-07-22 13:54:33 (36376): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-22 13:54:39 (36376): Successfully started VM. (PID = '36497') 2025-07-22 13:54:39 (36376): Reporting VM Process ID to BOINC. 2025-07-22 13:54:39 (36376): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-22 13:54:39 (36376): Detected: Web Application Enabled (http://localhost:33955) 2025-07-22 13:54:39 (36376): Preference change detected 2025-07-22 13:54:39 (36376): Setting CPU throttle for VM. (100%) 2025-07-22 13:54:39 (36376): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-22 13:54:40 (36376): Guest Log: 00:22:10.860521 timesync vgsvcTimeSyncWorker: Radical host time change: 7 486 489 000 000ns (HostNow=1 753 185 280 053 000 000 ns HostLast=1 753 177 793 564 000 000 ns) 2025-07-22 13:54:50 (36376): Guest Log: 00:22:20.863324 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 486 223 074 000ns (GuestNow=1 753 185 290 059 955 000 ns GuestLast=1 753 177 803 836 881 000 ns fSetTimeLastLoop=true ) 2025-07-22 13:56:36 (36376): Stopping VM. 2025-07-22 14:01:53 (36737): vboxwrapper version 26210 2025-07-22 14:01:53 (36737): BOINC client version: 8.2.4 2025-07-22 14:01:53 (36737): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-22 14:01:53 (36737): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-22 14:01:53 (36737): Guest Log: 00:22:10.860521 timesync vgsvcTimeSyncWorker: Radical host time change: 7 486 489 000 000ns (HostNow=1 753 185 280 053 000 000 ns HostLast=1 753 177 793 564 000 000 ns) 2025-07-22 14:01:53 (36737): Guest Log: 00:22:20.863324 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 486 223 074 000ns (GuestNow=1 753 185 290 059 955 000 ns GuestLast=1 753 177 803 836 881 000 ns fSetTimeLastLoop=true ) 2025-07-22 14:01:53 (36737): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-22 14:01:54 (36737): Successfully started VM. (PID = '36858') 2025-07-22 14:01:54 (36737): Reporting VM Process ID to BOINC. 2025-07-22 14:01:54 (36737): Guest Log: BIOS: VirtualBox 6.1.50 2025-07-22 14:01:54 (36737): Guest Log: CPUID EDX: 0x178bfbff 2025-07-22 14:01:54 (36737): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-22 14:01:54 (36737): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-22 14:01:54 (36737): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-22 14:01:54 (36737): Detected: Web Application Enabled (http://localhost:33955) 2025-07-22 14:01:54 (36737): Preference change detected 2025-07-22 14:01:54 (36737): Setting CPU throttle for VM. (100%) 2025-07-22 14:01:54 (36737): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-22 14:01:56 (36737): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-22 14:01:56 (36737): Guest Log: BIOS: Booting from Hard Disk... 2025-07-22 14:01:59 (36737): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-22 14:01:59 (36737): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-22 14:02:33 (36737): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-22 14:02:33 (36737): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000) 2025-07-22 14:02:34 (36737): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-07-22 14:02:34 (36737): Guest Log: 00:00:00.000186 main Log opened 2025-07-22T12:02:33.694965000Z 2025-07-22 14:02:34 (36737): Guest Log: 00:00:00.000327 main OS Product: Linux 2025-07-22 14:02:34 (36737): Guest Log: 00:00:00.000350 main OS Release: 4.14.232-19.cernvm.x86_64 2025-07-22 14:02:34 (36737): Guest Log: 00:00:00.000367 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-07-22 14:02:34 (36737): Guest Log: 00:00:00.000385 main Executable: /usr/sbin/VBoxService 2025-07-22 14:02:34 (36737): Guest Log: 00:00:00.000386 main Process ID: 2281 2025-07-22 14:02:34 (36737): Guest Log: 00:00:00.000386 main Package type: LINUX_64BITS_GENERIC 2025-07-22 14:02:34 (36737): Guest Log: 00:00:00.023411 main 5.2.6 r120293 started. Verbose level = 0 2025-07-22 14:02:54 (36737): Stopping VM. 2025-07-22 14:02:56 (36737): Successfully stopped VM. 2025-07-22 14:14:28 (37228): vboxwrapper version 26210 2025-07-22 14:14:28 (37228): BOINC client version: 8.2.4 2025-07-22 14:14:28 (37228): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-22 14:14:28 (37228): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-22 14:14:28 (37228): Guest Log: BIOS: VirtualBox 6.1.50 2025-07-22 14:14:28 (37228): Guest Log: CPUID EDX: 0x178bfbff 2025-07-22 14:14:28 (37228): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-22 14:14:28 (37228): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-22 14:14:28 (37228): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-22 14:14:28 (37228): Guest Log: BIOS: Booting from Hard Disk... 2025-07-22 14:14:28 (37228): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-22 14:14:28 (37228): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-22 14:14:28 (37228): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-22 14:14:28 (37228): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000) 2025-07-22 14:14:28 (37228): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-07-22 14:14:28 (37228): Guest Log: 00:00:00.000186 main Log opened 2025-07-22T12:02:33.694965000Z 2025-07-22 14:14:28 (37228): Guest Log: 00:00:00.000327 main OS Product: Linux 2025-07-22 14:14:28 (37228): Guest Log: 00:00:00.000350 main OS Release: 4.14.232-19.cernvm.x86_64 2025-07-22 14:14:28 (37228): Guest Log: 00:00:00.000367 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-07-22 14:14:28 (37228): Guest Log: 00:00:00.000385 main Executable: /usr/sbin/VBoxService 2025-07-22 14:14:28 (37228): Guest Log: 00:00:00.000386 main Process ID: 2281 2025-07-22 14:14:28 (37228): Guest Log: 00:00:00.000386 main Package type: LINUX_64BITS_GENERIC 2025-07-22 14:14:28 (37228): Guest Log: 00:00:00.023411 main 5.2.6 r120293 started. Verbose level = 0 2025-07-22 14:14:28 (37228): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-22 14:14:31 (37228): Successfully started VM. (PID = '37349') 2025-07-22 14:14:31 (37228): Reporting VM Process ID to BOINC. 2025-07-22 14:14:31 (37228): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-22 14:14:31 (37228): Detected: Web Application Enabled (http://localhost:33955) 2025-07-22 14:14:31 (37228): Preference change detected 2025-07-22 14:14:31 (37228): Setting CPU throttle for VM. (100%) 2025-07-22 14:14:31 (37228): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-22 14:14:50 (37228): Guest Log: [INFO] Mounting the shared directory 2025-07-22 14:14:50 (37228): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-07-22 14:14:51 (37228): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-07-22 14:14:51 (37228): Guest Log: [INFO] Testing connection to cern.ch 2025-07-22 14:14:52 (37228): Guest Log: [INFO] Testing connection to VCCS 2025-07-22 14:14:52 (37228): Guest Log: [INFO] Testing connection to HTCondor 2025-07-22 14:14:52 (37228): Guest Log: [INFO] Testing connection to WMAgent 2025-07-22 14:14:53 (37228): Guest Log: [INFO] Testing connection to EOSCMS 2025-07-22 14:14:53 (37228): Guest Log: [INFO] Testing connection to CMS-Factory 2025-07-22 14:14:53 (37228): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-07-22 14:14:54 (37228): Guest Log: [INFO] Testing connection to Frontier 2025-07-22 14:14:54 (37228): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2025-07-22 14:14:56 (37228): Guest Log: [INFO] Could not find a local HTTP proxy 2025-07-22 14:14:56 (37228): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-07-22 14:14:56 (37228): Guest Log: [INFO] This makes the application less efficient 2025-07-22 14:14:56 (37228): Guest Log: [INFO] It also puts higher load on the project servers 2025-07-22 14:14:57 (37228): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-07-22 14:14:57 (37228): Guest Log: [INFO] Advice can be found in the project forum 2025-07-22 14:14:57 (37228): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-07-22 14:15:05 (37228): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-07-22 14:15:08 (37228): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-07-22 14:15:09 (37228): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-07-22 14:15:09 (37228): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-07-22 14:15:09 (37228): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-07-22 14:15:10 (37228): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-07-22 14:15:11 (37228): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-07-22 14:15:11 (37228): Guest Log: [INFO] Environment HTTP proxy: not set 2025-07-22 14:15:11 (37228): Guest Log: [INFO] Reading volunteer information 2025-07-22 14:15:16 (37228): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-07-22 14:15:17 (37228): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-07-22 14:15:17 (37228): Guest Log: [INFO] CMS application starting. Check log files. 2025-07-22 14:15:29 (37228): Stopping VM. 2025-07-22 14:15:32 (37228): Successfully stopped VM. 2025-07-22 14:20:34 (37434): vboxwrapper version 26210 2025-07-22 14:20:34 (37434): BOINC client version: 8.2.4 2025-07-22 14:20:34 (37434): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-22 14:20:34 (37434): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Mounting the shared directory 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to cern.ch 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to VCCS 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to HTCondor 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to WMAgent 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to EOSCMS 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to CMS-Factory 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to Frontier 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Could not find a local HTTP proxy 2025-07-22 14:20:34 (37434): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-07-22 14:20:34 (37434): Guest Log: [INFO] This makes the application less efficient 2025-07-22 14:20:34 (37434): Guest Log: [INFO] It also puts higher load on the project servers 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Advice can be found in the project forum 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-07-22 14:20:34 (37434): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Environment HTTP proxy: not set 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Reading volunteer information 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-07-22 14:20:34 (37434): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-07-22 14:20:34 (37434): Guest Log: [INFO] CMS application starting. Check log files. 2025-07-22 14:20:34 (37434): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-22 14:20:37 (37434): Successfully started VM. (PID = '37553') 2025-07-22 14:20:37 (37434): Reporting VM Process ID to BOINC. 2025-07-22 14:20:37 (37434): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-22 14:20:37 (37434): Detected: Web Application Enabled (http://localhost:33955) 2025-07-22 14:20:37 (37434): Preference change detected 2025-07-22 14:20:37 (37434): Setting CPU throttle for VM. (100%) 2025-07-22 14:20:37 (37434): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-22 14:23:52 (37434): VM state change detected. (old = 'running', new = 'paused') 2025-07-22 14:23:52 (37434): Stopping VM. 2025-07-22 14:41:37 (37915): vboxwrapper version 26210 2025-07-22 14:41:37 (37915): BOINC client version: 8.2.4 2025-07-22 14:41:37 (37915): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-22 14:41:37 (37915): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-22 14:41:37 (37915): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-22 14:41:39 (37915): Successfully started VM. (PID = '38045') 2025-07-22 14:41:39 (37915): Reporting VM Process ID to BOINC. 2025-07-22 14:41:39 (37915): Guest Log: BIOS: VirtualBox 6.1.50 2025-07-22 14:41:39 (37915): Guest Log: CPUID EDX: 0x178bfbff 2025-07-22 14:41:39 (37915): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-22 14:41:39 (37915): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-22 14:41:39 (37915): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-22 14:41:39 (37915): Detected: Web Application Enabled (http://localhost:33955) 2025-07-22 14:41:39 (37915): Preference change detected 2025-07-22 14:41:39 (37915): Setting CPU throttle for VM. (100%) 2025-07-22 14:41:39 (37915): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-22 14:41:40 (37915): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-22 14:41:40 (37915): Guest Log: BIOS: Booting from Hard Disk... 2025-07-22 14:41:43 (37915): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-22 14:41:43 (37915): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-22 14:42:19 (37915): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-22 14:42:19 (37915): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000) 2025-07-22 14:42:20 (37915): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-07-22 14:42:20 (37915): Guest Log: 00:00:00.000203 main Log opened 2025-07-22T12:42:20.171836000Z 2025-07-22 14:42:20 (37915): Guest Log: 00:00:00.002134 main OS Product: Linux 2025-07-22 14:42:20 (37915): Guest Log: 00:00:00.002221 main OS Release: 4.14.232-19.cernvm.x86_64 2025-07-22 14:42:20 (37915): Guest Log: 00:00:00.002253 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-07-22 14:42:20 (37915): Guest Log: 00:00:00.002273 main Executable: /usr/sbin/VBoxService 2025-07-22 14:42:20 (37915): Guest Log: 00:00:00.002274 main Process ID: 2285 2025-07-22 14:42:20 (37915): Guest Log: 00:00:00.002274 main Package type: LINUX_64BITS_GENERIC 2025-07-22 14:42:20 (37915): Guest Log: 00:00:00.019011 main 5.2.6 r120293 started. Verbose level = 0 2025-07-22 14:42:38 (37915): Guest Log: [INFO] Mounting the shared directory 2025-07-22 14:42:38 (37915): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-07-22 14:42:38 (37915): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-07-22 14:42:39 (37915): Guest Log: [INFO] Testing connection to cern.ch 2025-07-22 14:42:39 (37915): Guest Log: [INFO] Testing connection to VCCS 2025-07-22 14:42:39 (37915): Guest Log: [INFO] Testing connection to HTCondor 2025-07-22 14:42:40 (37915): Guest Log: [INFO] Testing connection to WMAgent 2025-07-22 14:42:40 (37915): Guest Log: [INFO] Testing connection to EOSCMS 2025-07-22 14:42:40 (37915): Guest Log: [INFO] Testing connection to CMS-Factory 2025-07-22 14:42:41 (37915): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-07-22 14:42:41 (37915): Guest Log: [INFO] Testing connection to Frontier 2025-07-22 14:42:41 (37915): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2025-07-22 14:42:43 (37915): Guest Log: [INFO] Could not find a local HTTP proxy 2025-07-22 14:42:43 (37915): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-07-22 14:42:43 (37915): Guest Log: [INFO] This makes the application less efficient 2025-07-22 14:42:44 (37915): Guest Log: [INFO] It also puts higher load on the project servers 2025-07-22 14:42:44 (37915): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-07-22 14:42:44 (37915): Guest Log: [INFO] Advice can be found in the project forum 2025-07-22 14:42:44 (37915): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-07-22 14:42:52 (37915): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-07-22 14:42:56 (37915): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-07-22 14:42:57 (37915): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-07-22 14:42:57 (37915): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-07-22 14:42:57 (37915): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-07-22 14:42:58 (37915): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-07-22 14:42:58 (37915): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-07-22 14:42:58 (37915): Guest Log: [INFO] Environment HTTP proxy: not set 2025-07-22 14:42:59 (37915): Guest Log: [INFO] Reading volunteer information 2025-07-22 14:43:00 (37915): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-07-22 14:43:01 (37915): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-07-22 14:43:02 (37915): Guest Log: [INFO] CMS application starting. Check log files. 2025-07-22 14:55:52 (37915): Stopping VM. 2025-07-22 14:56:00 (37915): Successfully stopped VM. 2025-07-23 14:07:24 (38773): vboxwrapper version 26210 2025-07-23 14:07:24 (38773): BOINC client version: 8.2.4 2025-07-23 14:07:24 (38773): Detected: VirtualBox VboxManage Interface (Version: 6.1.50) 2025-07-23 14:07:24 (38773): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-07-23 14:07:24 (38773): Guest Log: BIOS: VirtualBox 6.1.50 2025-07-23 14:07:24 (38773): Guest Log: CPUID EDX: 0x178bfbff 2025-07-23 14:07:24 (38773): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-23 14:07:24 (38773): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-23 14:07:24 (38773): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-23 14:07:24 (38773): Guest Log: BIOS: Booting from Hard Disk... 2025-07-23 14:07:24 (38773): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-23 14:07:24 (38773): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-23 14:07:24 (38773): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-23 14:07:24 (38773): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000) 2025-07-23 14:07:24 (38773): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-07-23 14:07:24 (38773): Guest Log: 00:00:00.000203 main Log opened 2025-07-22T12:42:20.171836000Z 2025-07-23 14:07:24 (38773): Guest Log: 00:00:00.002134 main OS Product: Linux 2025-07-23 14:07:24 (38773): Guest Log: 00:00:00.002221 main OS Release: 4.14.232-19.cernvm.x86_64 2025-07-23 14:07:24 (38773): Guest Log: 00:00:00.002253 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-07-23 14:07:24 (38773): Guest Log: 00:00:00.002273 main Executable: /usr/sbin/VBoxService 2025-07-23 14:07:24 (38773): Guest Log: 00:00:00.002274 main Process ID: 2285 2025-07-23 14:07:24 (38773): Guest Log: 00:00:00.002274 main Package type: LINUX_64BITS_GENERIC 2025-07-23 14:07:24 (38773): Guest Log: 00:00:00.019011 main 5.2.6 r120293 started. Verbose level = 0 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Mounting the shared directory 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to cern.ch 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to VCCS 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to HTCondor 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to WMAgent 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to EOSCMS 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to CMS-Factory 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to Frontier 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/ 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Could not find a local HTTP proxy 2025-07-23 14:07:24 (38773): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-07-23 14:07:24 (38773): Guest Log: [INFO] This makes the application less efficient 2025-07-23 14:07:24 (38773): Guest Log: [INFO] It also puts higher load on the project servers 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Advice can be found in the project forum 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-07-23 14:07:24 (38773): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Environment HTTP proxy: not set 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Reading volunteer information 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-07-23 14:07:24 (38773): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-07-23 14:07:24 (38773): Guest Log: [INFO] CMS application starting. Check log files. 2025-07-23 14:07:24 (38773): Starting VM using VBoxManage interface. (boinc_d34a93e74a8cac53, slot#1) 2025-07-23 14:07:31 (38773): Successfully started VM. (PID = '38894') 2025-07-23 14:07:31 (38773): Reporting VM Process ID to BOINC. 2025-07-23 14:07:31 (38773): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-23 14:07:31 (38773): Detected: Web Application Enabled (http://localhost:33955) 2025-07-23 14:07:31 (38773): Preference change detected 2025-07-23 14:07:31 (38773): Setting CPU throttle for VM. (100%) 2025-07-23 14:07:31 (38773): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-07-23 14:07:38 (38773): Guest Log: 00:13:40.900259 timesync vgsvcTimeSyncWorker: Radical host time change: 83 507 739 000 000ns (HostNow=1 753 272 458 335 000 000 ns HostLast=1 753 188 950 596 000 000 ns) 2025-07-23 14:07:49 (38773): Guest Log: 00:13:50.901675 timesync vgsvcTimeSyncWorker: Radical guest time change: 83 507 276 270 000ns (GuestNow=1 753 272 468 342 201 000 ns GuestLast=1 753 188 961 065 931 000 ns fSetTimeLastLoop=true ) 2025-07-23 14:07:49 (38773): Guest Log: [INFO] glidein exited with return value 0. 2025-07-23 14:07:49 (38773): Guest Log: [INFO] Shutting Down. 2025-07-23 14:07:49 (38773): VM Completion File Detected. 2025-07-23 14:07:49 (38773): VM Completion Message: glidein exited with return value 0. . 2025-07-23 14:07:49 (38773): Powering off VM. 2025-07-23 14:07:49 (38773): Successfully stopped VM. 2025-07-23 14:07:49 (38773): Deregistering VM. (boinc_d34a93e74a8cac53, slot#1) 2025-07-23 14:07:49 (38773): Removing network bandwidth throttle group from VM. 2025-07-23 14:07:49 (38773): Removing VM from VirtualBox. 2025-07-23 14:07:54 (38773): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN