Name CMS_2311310_1719176220.814839_0
Workunit 223716906
Created 23 Jun 2024, 20:57:05 UTC
Sent 23 Jun 2024, 21:36:55 UTC
Report deadline 24 Jul 2024, 21:36:55 UTC
Received 24 Jun 2024, 5:35:09 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10355384
Run time 7 hours 17 min 21 sec
CPU time 20 hours 8 min 14 sec
Validate state Valid
Credit 1,697.01
Device peak FLOPS 14.41 GFLOPS
Application version CMS Simulation v70.30 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 119.21 MB
Peak swap size 128.09 MB
Peak disk usage 6.79 GB

Stderr output

<core_client_version>7.22.2</core_client_version>
<![CDATA[
<stderr_txt>
2024-06-24 00:37:52 (30076): vboxwrapper version 26207
2024-06-24 00:37:52 (30076): BOINC client version: 7.22.2
2024-06-24 00:37:52 (30076): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2024-06-24 00:37:53 (30076): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-24 00:37:53 (30076): Successfully copied 'init_data.xml' to the shared directory.
2024-06-24 00:37:53 (30076): Create VM. (boinc_5e26976fe6fbbdd4, slot#4)
2024-06-24 00:37:54 (30076): Setting Memory Size for VM. (4584MB)
2024-06-24 00:37:54 (30076): Setting CPU Count for VM. (4)
2024-06-24 00:37:54 (30076): Setting Chipset Options for VM.
2024-06-24 00:37:55 (30076): Setting Graphics Controller Options for VM.
2024-06-24 00:37:55 (30076): Setting Boot Options for VM.
2024-06-24 00:37:55 (30076): Setting Network Configuration for NAT.
2024-06-24 00:37:56 (30076): Enabling VM Network Access.
2024-06-24 00:37:56 (30076): Disabling USB Support for VM.
2024-06-24 00:37:56 (30076): Disabling COM Port Support for VM.
2024-06-24 00:37:57 (30076): Disabling LPT Port Support for VM.
2024-06-24 00:37:57 (30076): Disabling Audio Support for VM.
2024-06-24 00:37:57 (30076): Disabling Clipboard Support for VM.
2024-06-24 00:37:58 (30076): Disabling Drag and Drop Support for VM.
2024-06-24 00:37:58 (30076): Adding storage controller(s) to VM.
2024-06-24 00:37:58 (30076): Adding virtual disk drive to VM. (CMS_2024_04_29_prod.vdi)
2024-06-24 00:37:59 (30076): Adding VirtualBox Guest Additions to VM.
2024-06-24 00:37:59 (30076): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-06-24 00:37:59 (30076): forwarding host port 63294 to guest port 80
2024-06-24 00:38:00 (30076): Enabling remote desktop for VM.
2024-06-24 00:38:01 (30076): Enabling shared directory for VM.
2024-06-24 00:38:02 (30076): Starting VM using VBoxManage interface. (boinc_5e26976fe6fbbdd4, slot#4)
2024-06-24 00:38:25 (30076): Successfully started VM. (PID = '49560')
2024-06-24 00:38:25 (30076): Reporting VM Process ID to BOINC.
2024-06-24 00:38:25 (30076): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 00:38:25 (30076): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 00:38:25 (30076): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 00:38:25 (30076): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 00:38:25 (30076): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-24 00:38:25 (30076): Detected: Web Application Enabled (http://localhost:63294)
2024-06-24 00:38:25 (30076): Detected: Remote Desktop Enabled (localhost:63295)
2024-06-24 00:38:25 (30076): Preference change detected
2024-06-24 00:38:25 (30076): Setting CPU throttle for VM. (90%)
2024-06-24 00:38:26 (30076): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 00:38:27 (30076): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 00:38:27 (30076): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 00:38:31 (30076): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 00:38:31 (30076): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 00:39:58 (30076): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 00:39:58 (30076): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 00:40:02 (30076): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 00:40:02 (30076): Guest Log: 00:00:00.000329 main     Log opened 2024-06-23T21:40:15.831531000Z
2024-06-24 00:40:02 (30076): Guest Log: 00:00:00.000554 main     OS Product: Linux
2024-06-24 00:40:02 (30076): Guest Log: 00:00:00.000613 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 00:40:02 (30076): Guest Log: 00:00:00.000664 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 00:40:02 (30076): Guest Log: 00:00:00.000723 main     Executable: /usr/sbin/VBoxService
2024-06-24 00:40:02 (30076): Guest Log: 00:00:00.000724 main     Process ID: 2289
2024-06-24 00:40:02 (30076): Guest Log: 00:00:00.000724 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 00:40:02 (30076): Guest Log: 00:00:00.001779 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 00:40:56 (30076): Guest Log: [INFO] Mounting the shared directory
2024-06-24 00:40:56 (30076): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 00:40:57 (30076): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 00:40:58 (30076): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 00:40:59 (30076): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 00:41:00 (30076): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 00:41:01 (30076): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 00:41:02 (30076): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 00:41:03 (30076): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 00:41:05 (30076): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 00:41:06 (30076): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 00:41:08 (30076): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 00:41:09 (30076): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 00:41:10 (30076): Guest Log: [INFO] This makes the application less efficient
2024-06-24 00:41:11 (30076): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 00:41:12 (30076): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 00:41:13 (30076): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 00:41:15 (30076): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 00:41:40 (30076): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 00:41:59 (30076): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 00:41:59 (30076): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 00:41:59 (30076): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 00:42:33 (30076): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 00:42:41 (30076): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 00:42:42 (30076): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2024-06-24 00:42:44 (30076): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 00:42:47 (30076): Guest Log: [INFO] Reading volunteer information
2024-06-24 00:43:02 (30076): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 00:43:07 (30076): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 00:43:09 (30076): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 00:45:05 (30076): Preference change detected
2024-06-24 00:45:05 (30076): Setting CPU throttle for VM. (90%)
2024-06-24 00:45:06 (30076): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 01:04:18 (30076): Preference change detected
2024-06-24 01:04:18 (30076): Setting CPU throttle for VM. (90%)
2024-06-24 01:04:18 (30076): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 01:22:47 (30076): Preference change detected
2024-06-24 01:22:47 (30076): Setting CPU throttle for VM. (90%)
2024-06-24 01:22:47 (30076): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 01:41:05 (30076): Preference change detected
2024-06-24 01:41:05 (30076): Setting CPU throttle for VM. (90%)
2024-06-24 01:41:05 (30076): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 02:00:59 (30076): Preference change detected
2024-06-24 02:00:59 (30076): Setting CPU throttle for VM. (90%)
2024-06-24 02:01:00 (30076): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 02:18:38 (30076): Status Report: Job Duration: '64800.000000'
2024-06-24 02:18:38 (30076): Status Report: Elapsed Time: '6000.000000'
2024-06-24 02:18:38 (30076): Status Report: CPU Time: '16941.443398'
2024-06-24 02:19:00 (30076): Preference change detected
2024-06-24 02:19:00 (30076): Setting CPU throttle for VM. (90%)
2024-06-24 02:19:00 (30076): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 02:36:42 (30076): Preference change detected
2024-06-24 02:36:42 (30076): Setting CPU throttle for VM. (90%)
2024-06-24 02:36:42 (30076): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 02:37:44 (30076): Stopping VM.
2024-06-24 02:38:30 (30076): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_5e26976fe6fbbdd4" savestate
Output:
0%...10%...20%...30%...40%...50%...
2024-06-24 02:38:30 (30076): VM did not stop when requested.
2024-06-24 02:38:30 (30076): VM was NOT successfully terminated.
2024-06-24 02:44:39 (33876): vboxwrapper version 26207
2024-06-24 02:44:39 (33876): BOINC client version: 7.22.2
2024-06-24 02:44:40 (33876): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2024-06-24 02:44:40 (33876): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-24 02:44:42 (33876): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 02:44:42 (33876): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 02:44:42 (33876): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 02:44:42 (33876): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 02:44:42 (33876): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 02:44:42 (33876): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 02:44:42 (33876): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 02:44:42 (33876): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 02:44:42 (33876): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 02:44:42 (33876): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 02:44:42 (33876): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 02:44:42 (33876): Guest Log: 00:00:00.000329 main     Log opened 2024-06-23T21:40:15.831531000Z
2024-06-24 02:44:42 (33876): Guest Log: 00:00:00.000554 main     OS Product: Linux
2024-06-24 02:44:42 (33876): Guest Log: 00:00:00.000613 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 02:44:42 (33876): Guest Log: 00:00:00.000664 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 02:44:42 (33876): Guest Log: 00:00:00.000723 main     Executable: /usr/sbin/VBoxService
2024-06-24 02:44:42 (33876): Guest Log: 00:00:00.000724 main     Process ID: 2289
2024-06-24 02:44:42 (33876): Guest Log: 00:00:00.000724 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 02:44:42 (33876): Guest Log: 00:00:00.001779 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Mounting the shared directory
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 02:44:42 (33876): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 02:44:42 (33876): Guest Log: [INFO] This makes the application less efficient
2024-06-24 02:44:42 (33876): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 02:44:42 (33876): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Reading volunteer information
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 02:44:42 (33876): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 02:44:42 (33876): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 02:44:42 (33876): Starting VM using VBoxManage interface. (boinc_5e26976fe6fbbdd4, slot#4)
2024-06-24 02:44:54 (33876): Successfully started VM. (PID = '12012')
2024-06-24 02:44:54 (33876): Reporting VM Process ID to BOINC.
2024-06-24 02:44:54 (33876): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 02:44:54 (33876): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 02:44:54 (33876): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 02:44:54 (33876): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 02:44:54 (33876): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-24 02:44:54 (33876): Detected: Web Application Enabled (http://localhost:63294)
2024-06-24 02:44:54 (33876): Detected: Remote Desktop Enabled (localhost:63295)
2024-06-24 02:44:54 (33876): Status Report: Job Duration: '64800.000000'
2024-06-24 02:44:54 (33876): Status Report: Elapsed Time: '7146.000000'
2024-06-24 02:44:54 (33876): Status Report: CPU Time: '21030.401209'
2024-06-24 02:44:54 (33876): Preference change detected
2024-06-24 02:44:54 (33876): Setting CPU throttle for VM. (90%)
2024-06-24 02:44:54 (33876): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 02:44:56 (33876): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 02:44:56 (33876): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 02:45:00 (33876): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 02:45:00 (33876): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 02:46:01 (33876): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 02:46:01 (33876): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 02:46:03 (33876): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 02:46:03 (33876): Guest Log: 00:00:00.000279 main     Log opened 2024-06-23T23:46:02.482482000Z
2024-06-24 02:46:03 (33876): Guest Log: 00:00:00.000437 main     OS Product: Linux
2024-06-24 02:46:03 (33876): Guest Log: 00:00:00.000499 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 02:46:03 (33876): Guest Log: 00:00:00.000570 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 02:46:03 (33876): Guest Log: 00:00:00.000621 main     Executable: /usr/sbin/VBoxService
2024-06-24 02:46:03 (33876): Guest Log: 00:00:00.000622 main     Process ID: 2281
2024-06-24 02:46:03 (33876): Guest Log: 00:00:00.000624 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 02:46:03 (33876): Guest Log: 00:00:00.002700 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 02:47:10 (33876): Guest Log: [INFO] Mounting the shared directory
2024-06-24 02:47:11 (33876): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 02:47:12 (33876): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 02:47:13 (33876): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 02:47:15 (33876): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 02:47:17 (33876): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 02:47:18 (33876): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 02:47:19 (33876): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 02:47:20 (33876): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 02:47:21 (33876): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 02:47:22 (33876): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 02:47:25 (33876): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 02:47:26 (33876): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 02:47:27 (33876): Guest Log: [INFO] This makes the application less efficient
2024-06-24 02:47:27 (33876): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 02:47:27 (33876): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 02:47:27 (33876): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 02:47:28 (33876): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 02:48:03 (33876): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 02:48:21 (33876): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 02:48:24 (33876): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 02:48:53 (33876): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 02:48:56 (33876): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 02:49:00 (33876): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 02:49:01 (33876): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2024-06-24 02:49:01 (33876): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 02:49:03 (33876): Guest Log: [INFO] Reading volunteer information
2024-06-24 02:49:10 (33876): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 02:49:17 (33876): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 02:49:19 (33876): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 02:54:52 (33876): Preference change detected
2024-06-24 02:54:52 (33876): Setting CPU throttle for VM. (90%)
2024-06-24 02:54:52 (33876): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 03:12:56 (33876): Preference change detected
2024-06-24 03:12:56 (33876): Setting CPU throttle for VM. (90%)
2024-06-24 03:12:57 (33876): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 03:30:30 (33876): Preference change detected
2024-06-24 03:30:30 (33876): Setting CPU throttle for VM. (90%)
2024-06-24 03:30:30 (33876): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 03:46:45 (33876): Stopping VM.
2024-06-24 03:47:31 (33876): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_5e26976fe6fbbdd4" savestate
Output:
0%...10%...20%...30%...40%...50%...
2024-06-24 03:47:31 (33876): VM did not stop when requested.
2024-06-24 03:47:31 (33876): VM was NOT successfully terminated.
2024-06-24 03:48:02 (37824): vboxwrapper version 26207
2024-06-24 03:48:02 (37824): BOINC client version: 7.22.2
2024-06-24 03:48:02 (37824): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2024-06-24 03:48:03 (37824): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-24 03:48:04 (37824): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 03:48:04 (37824): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 03:48:04 (37824): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 03:48:04 (37824): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 03:48:04 (37824): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 03:48:04 (37824): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 03:48:04 (37824): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 03:48:04 (37824): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 03:48:04 (37824): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 03:48:04 (37824): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 03:48:04 (37824): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 03:48:04 (37824): Guest Log: 00:00:00.000279 main     Log opened 2024-06-23T23:46:02.482482000Z
2024-06-24 03:48:04 (37824): Guest Log: 00:00:00.000437 main     OS Product: Linux
2024-06-24 03:48:04 (37824): Guest Log: 00:00:00.000499 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 03:48:04 (37824): Guest Log: 00:00:00.000570 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 03:48:04 (37824): Guest Log: 00:00:00.000621 main     Executable: /usr/sbin/VBoxService
2024-06-24 03:48:04 (37824): Guest Log: 00:00:00.000622 main     Process ID: 2281
2024-06-24 03:48:04 (37824): Guest Log: 00:00:00.000624 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 03:48:04 (37824): Guest Log: 00:00:00.002700 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Mounting the shared directory
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 03:48:04 (37824): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 03:48:04 (37824): Guest Log: [INFO] This makes the application less efficient
2024-06-24 03:48:04 (37824): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 03:48:04 (37824): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Reading volunteer information
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 03:48:04 (37824): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 03:48:04 (37824): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 03:48:04 (37824): Starting VM using VBoxManage interface. (boinc_5e26976fe6fbbdd4, slot#4)
2024-06-24 03:48:22 (37824): Successfully started VM. (PID = '25952')
2024-06-24 03:48:22 (37824): Reporting VM Process ID to BOINC.
2024-06-24 03:48:22 (37824): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 03:48:22 (37824): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 03:48:22 (37824): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 03:48:22 (37824): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 03:48:22 (37824): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-24 03:48:22 (37824): Detected: Web Application Enabled (http://localhost:63294)
2024-06-24 03:48:22 (37824): Detected: Remote Desktop Enabled (localhost:63295)
2024-06-24 03:48:22 (37824): Status Report: Job Duration: '64800.000000'
2024-06-24 03:48:22 (37824): Status Report: Elapsed Time: '10858.000000'
2024-06-24 03:48:22 (37824): Status Report: CPU Time: '31629.826754'
2024-06-24 03:48:22 (37824): Preference change detected
2024-06-24 03:48:22 (37824): Setting CPU throttle for VM. (90%)
2024-06-24 03:48:22 (37824): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 03:48:24 (37824): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 03:48:24 (37824): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 03:48:28 (37824): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 03:48:28 (37824): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 03:49:19 (37824): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 03:49:19 (37824): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 03:49:21 (37824): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 03:49:21 (37824): Guest Log: 00:00:00.001428 main     Log opened 2024-06-24T00:49:21.202823000Z
2024-06-24 03:49:21 (37824): Guest Log: 00:00:00.002231 main     OS Product: Linux
2024-06-24 03:49:21 (37824): Guest Log: 00:00:00.002312 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 03:49:21 (37824): Guest Log: 00:00:00.002370 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 03:49:21 (37824): Guest Log: 00:00:00.002423 main     Executable: /usr/sbin/VBoxService
2024-06-24 03:49:21 (37824): Guest Log: 00:00:00.002425 main     Process ID: 2285
2024-06-24 03:49:21 (37824): Guest Log: 00:00:00.002426 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 03:49:21 (37824): Guest Log: 00:00:00.005209 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 03:49:43 (37824): Guest Log: [INFO] Mounting the shared directory
2024-06-24 03:49:44 (37824): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 03:49:44 (37824): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 03:49:44 (37824): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 03:49:45 (37824): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 03:49:45 (37824): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 03:49:45 (37824): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 03:49:46 (37824): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 03:49:46 (37824): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 03:49:47 (37824): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 03:49:47 (37824): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 03:49:48 (37824): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 03:49:49 (37824): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 03:49:49 (37824): Guest Log: [INFO] This makes the application less efficient
2024-06-24 03:49:49 (37824): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 03:49:49 (37824): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 03:49:49 (37824): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 03:49:50 (37824): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 03:50:00 (37824): Preference change detected
2024-06-24 03:50:00 (37824): Setting CPU throttle for VM. (90%)
2024-06-24 03:50:00 (37824): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 03:50:15 (37824): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 03:50:35 (37824): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 03:50:36 (37824): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 03:50:36 (37824): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 03:51:04 (37824): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 03:51:09 (37824): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 03:51:10 (37824): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2024-06-24 03:51:11 (37824): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 03:51:12 (37824): Guest Log: [INFO] Reading volunteer information
2024-06-24 03:51:20 (37824): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 03:51:27 (37824): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 03:51:30 (37824): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 04:08:05 (37824): Preference change detected
2024-06-24 04:08:05 (37824): Setting CPU throttle for VM. (90%)
2024-06-24 04:08:05 (37824): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 04:26:47 (37824): Preference change detected
2024-06-24 04:26:47 (37824): Setting CPU throttle for VM. (90%)
2024-06-24 04:26:48 (37824): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 04:45:34 (37824): Preference change detected
2024-06-24 04:45:34 (37824): Setting CPU throttle for VM. (90%)
2024-06-24 04:45:34 (37824): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 05:03:00 (37824): Preference change detected
2024-06-24 05:03:00 (37824): Setting CPU throttle for VM. (90%)
2024-06-24 05:03:00 (37824): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 05:03:08 (37824): Stopping VM.
2024-06-24 05:03:54 (37824): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_5e26976fe6fbbdd4" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...
2024-06-24 05:03:54 (37824): VM did not stop when requested.
2024-06-24 05:03:54 (37824): VM was NOT successfully terminated.
2024-06-24 05:06:18 (41352): vboxwrapper version 26207
2024-06-24 05:06:18 (41352): BOINC client version: 7.22.2
2024-06-24 05:06:19 (41352): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2024-06-24 05:06:19 (41352): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-24 05:06:21 (41352): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 05:06:21 (41352): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 05:06:21 (41352): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 05:06:21 (41352): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 05:06:21 (41352): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 05:06:21 (41352): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 05:06:21 (41352): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 05:06:21 (41352): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 05:06:21 (41352): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 05:06:21 (41352): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 05:06:21 (41352): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 05:06:21 (41352): Guest Log: 00:00:00.001428 main     Log opened 2024-06-24T00:49:21.202823000Z
2024-06-24 05:06:21 (41352): Guest Log: 00:00:00.002231 main     OS Product: Linux
2024-06-24 05:06:21 (41352): Guest Log: 00:00:00.002312 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 05:06:21 (41352): Guest Log: 00:00:00.002370 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 05:06:21 (41352): Guest Log: 00:00:00.002423 main     Executable: /usr/sbin/VBoxService
2024-06-24 05:06:21 (41352): Guest Log: 00:00:00.002425 main     Process ID: 2285
2024-06-24 05:06:21 (41352): Guest Log: 00:00:00.002426 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 05:06:21 (41352): Guest Log: 00:00:00.005209 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Mounting the shared directory
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 05:06:21 (41352): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 05:06:21 (41352): Guest Log: [INFO] This makes the application less efficient
2024-06-24 05:06:21 (41352): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 05:06:21 (41352): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Reading volunteer information
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 05:06:21 (41352): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 05:06:21 (41352): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 05:06:21 (41352): Starting VM using VBoxManage interface. (boinc_5e26976fe6fbbdd4, slot#4)
2024-06-24 05:06:41 (41352): Successfully started VM. (PID = '45348')
2024-06-24 05:06:41 (41352): Reporting VM Process ID to BOINC.
2024-06-24 05:06:41 (41352): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 05:06:41 (41352): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 05:06:41 (41352): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 05:06:41 (41352): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 05:06:41 (41352): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-24 05:06:41 (41352): Detected: Web Application Enabled (http://localhost:63294)
2024-06-24 05:06:41 (41352): Detected: Remote Desktop Enabled (localhost:63295)
2024-06-24 05:06:41 (41352): Status Report: Job Duration: '64800.000000'
2024-06-24 05:06:41 (41352): Status Report: Elapsed Time: '15345.000000'
2024-06-24 05:06:41 (41352): Status Report: CPU Time: '44719.075059'
2024-06-24 05:06:41 (41352): Preference change detected
2024-06-24 05:06:41 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 05:06:41 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 05:06:43 (41352): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 05:06:43 (41352): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 05:06:48 (41352): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 05:06:48 (41352): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 05:07:52 (41352): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 05:07:52 (41352): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 05:07:57 (41352): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 05:07:57 (41352): Guest Log: 00:00:00.000461 main     Log opened 2024-06-24T02:08:16.248559000Z
2024-06-24 05:07:57 (41352): Guest Log: 00:00:00.000664 main     OS Product: Linux
2024-06-24 05:07:57 (41352): Guest Log: 00:00:00.000753 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 05:07:57 (41352): Guest Log: 00:00:00.000835 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 05:07:57 (41352): Guest Log: 00:00:00.000905 main     Executable: /usr/sbin/VBoxService
2024-06-24 05:07:57 (41352): Guest Log: 00:00:00.000908 main     Process ID: 2290
2024-06-24 05:07:57 (41352): Guest Log: 00:00:00.000909 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 05:07:57 (41352): Guest Log: 00:00:00.002727 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 05:09:27 (41352): Guest Log: [INFO] Mounting the shared directory
2024-06-24 05:09:29 (41352): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 05:09:30 (41352): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 05:09:31 (41352): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 05:09:32 (41352): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 05:09:33 (41352): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 05:09:35 (41352): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 05:09:36 (41352): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 05:09:37 (41352): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 05:09:39 (41352): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 05:09:40 (41352): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 05:09:44 (41352): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 05:09:45 (41352): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 05:09:46 (41352): Guest Log: [INFO] This makes the application less efficient
2024-06-24 05:09:47 (41352): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 05:09:48 (41352): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 05:09:49 (41352): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 05:09:51 (41352): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 05:10:49 (41352): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 05:11:11 (41352): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 05:11:12 (41352): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 05:11:12 (41352): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 05:11:27 (41352): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 05:11:30 (41352): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 05:11:30 (41352): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2024-06-24 05:11:30 (41352): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 05:11:31 (41352): Guest Log: [INFO] Reading volunteer information
2024-06-24 05:11:35 (41352): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 05:11:38 (41352): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 05:11:40 (41352): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 05:22:28 (41352): Preference change detected
2024-06-24 05:22:28 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 05:22:28 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 05:40:04 (41352): Preference change detected
2024-06-24 05:40:04 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 05:40:04 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 05:59:09 (41352): Preference change detected
2024-06-24 05:59:09 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 05:59:10 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 06:06:35 (41352): Preference change detected
2024-06-24 06:06:35 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 06:06:36 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 06:23:46 (41352): Preference change detected
2024-06-24 06:23:46 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 06:23:46 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 06:41:56 (41352): Preference change detected
2024-06-24 06:41:56 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 06:41:56 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 06:46:40 (41352): Status Report: Job Duration: '64800.000000'
2024-06-24 06:46:40 (41352): Status Report: Elapsed Time: '21345.000000'
2024-06-24 06:46:40 (41352): Status Report: CPU Time: '63762.787933'
2024-06-24 06:59:01 (41352): Preference change detected
2024-06-24 06:59:01 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 06:59:01 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 07:16:44 (41352): Preference change detected
2024-06-24 07:16:44 (41352): Setting CPU throttle for VM. (90%)
2024-06-24 07:16:44 (41352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 07:33:14 (41352): Stopping VM.
2024-06-24 07:34:00 (41352): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_5e26976fe6fbbdd4" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...
2024-06-24 07:34:00 (41352): VM did not stop when requested.
2024-06-24 07:34:00 (41352): VM was NOT successfully terminated.
2024-06-24 07:59:49 (23496): vboxwrapper version 26207
2024-06-24 07:59:49 (23496): BOINC client version: 7.22.2
2024-06-24 07:59:49 (23496): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2024-06-24 07:59:50 (23496): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-24 07:59:52 (23496): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 07:59:52 (23496): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 07:59:52 (23496): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 07:59:52 (23496): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 07:59:52 (23496): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 07:59:52 (23496): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 07:59:52 (23496): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 07:59:52 (23496): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 07:59:52 (23496): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 07:59:52 (23496): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 07:59:52 (23496): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 07:59:52 (23496): Guest Log: 00:00:00.000461 main     Log opened 2024-06-24T02:08:16.248559000Z
2024-06-24 07:59:52 (23496): Guest Log: 00:00:00.000664 main     OS Product: Linux
2024-06-24 07:59:52 (23496): Guest Log: 00:00:00.000753 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 07:59:52 (23496): Guest Log: 00:00:00.000835 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 07:59:52 (23496): Guest Log: 00:00:00.000905 main     Executable: /usr/sbin/VBoxService
2024-06-24 07:59:52 (23496): Guest Log: 00:00:00.000908 main     Process ID: 2290
2024-06-24 07:59:52 (23496): Guest Log: 00:00:00.000909 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 07:59:52 (23496): Guest Log: 00:00:00.002727 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Mounting the shared directory
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 07:59:52 (23496): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 07:59:52 (23496): Guest Log: [INFO] This makes the application less efficient
2024-06-24 07:59:52 (23496): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 07:59:52 (23496): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Reading volunteer information
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 07:59:52 (23496): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 07:59:52 (23496): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 07:59:52 (23496): Starting VM using VBoxManage interface. (boinc_5e26976fe6fbbdd4, slot#4)
2024-06-24 08:00:10 (23496): Successfully started VM. (PID = '43176')
2024-06-24 08:00:10 (23496): Reporting VM Process ID to BOINC.
2024-06-24 08:00:10 (23496): Guest Log: BIOS: VirtualBox 7.0.8
2024-06-24 08:00:10 (23496): Guest Log: CPUID EDX: 0x178bfbff
2024-06-24 08:00:10 (23496): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-24 08:00:10 (23496): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-24 08:00:10 (23496): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-24 08:00:10 (23496): Detected: Web Application Enabled (http://localhost:63294)
2024-06-24 08:00:10 (23496): Detected: Remote Desktop Enabled (localhost:63295)
2024-06-24 08:00:10 (23496): Status Report: Job Duration: '64800.000000'
2024-06-24 08:00:10 (23496): Status Report: Elapsed Time: '24139.000000'
2024-06-24 08:00:10 (23496): Status Report: CPU Time: '70826.684814'
2024-06-24 08:00:10 (23496): Preference change detected
2024-06-24 08:00:10 (23496): Setting CPU throttle for VM. (90%)
2024-06-24 08:00:10 (23496): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 08:00:12 (23496): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-24 08:00:12 (23496): Guest Log: BIOS: Booting from Hard Disk...
2024-06-24 08:00:17 (23496): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-24 08:00:17 (23496): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-24 08:01:27 (23496): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-24 08:01:27 (23496): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-24 08:01:33 (23496): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-24 08:01:33 (23496): Guest Log: 00:00:00.000576 main     Log opened 2024-06-24T05:01:33.087247000Z
2024-06-24 08:01:33 (23496): Guest Log: 00:00:00.000937 main     OS Product: Linux
2024-06-24 08:01:33 (23496): Guest Log: 00:00:00.001096 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-24 08:01:33 (23496): Guest Log: 00:00:00.001222 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-24 08:01:33 (23496): Guest Log: 00:00:00.001441 main     Executable: /usr/sbin/VBoxService
2024-06-24 08:01:33 (23496): Guest Log: 00:00:00.001446 main     Process ID: 2293
2024-06-24 08:01:33 (23496): Guest Log: 00:00:00.001449 main     Package type: LINUX_64BITS_GENERIC
2024-06-24 08:01:33 (23496): Guest Log: 00:00:00.005144 main     5.2.6 r120293 started. Verbose level = 0
2024-06-24 08:02:52 (23496): Guest Log: [INFO] Mounting the shared directory
2024-06-24 08:02:52 (23496): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-24 08:02:53 (23496): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-24 08:02:54 (23496): Guest Log: [INFO] Testing connection to cern.ch
2024-06-24 08:02:55 (23496): Guest Log: [INFO] Testing connection to VCCS
2024-06-24 08:02:56 (23496): Guest Log: [INFO] Testing connection to HTCondor
2024-06-24 08:02:57 (23496): Guest Log: [INFO] Testing connection to WMAgent
2024-06-24 08:02:58 (23496): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-24 08:02:59 (23496): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-24 08:03:00 (23496): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-24 08:03:01 (23496): Guest Log: [INFO] Testing connection to Frontier
2024-06-24 08:03:03 (23496): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-24 08:03:04 (23496): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-24 08:03:04 (23496): Guest Log: [INFO] This makes the application less efficient
2024-06-24 08:03:05 (23496): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-24 08:03:05 (23496): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-24 08:03:06 (23496): Guest Log: [INFO] Advice can be found in the project forum
2024-06-24 08:03:07 (23496): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-24 08:03:27 (23496): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-24 08:03:44 (23496): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-24 08:03:44 (23496): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-24 08:03:44 (23496): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-24 08:03:44 (23496): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-24 08:03:48 (23496): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-24 08:03:48 (23496): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2024-06-24 08:03:49 (23496): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-24 08:03:51 (23496): Guest Log: [INFO] Reading volunteer information
2024-06-24 08:03:59 (23496): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-24 08:04:04 (23496): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-24 08:04:06 (23496): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-24 08:12:05 (23496): Preference change detected
2024-06-24 08:12:05 (23496): Setting CPU throttle for VM. (90%)
2024-06-24 08:12:05 (23496): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 08:29:08 (23496): Preference change detected
2024-06-24 08:29:08 (23496): Setting CPU throttle for VM. (90%)
2024-06-24 08:29:08 (23496): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-24 08:34:47 (23496): Guest Log: [INFO] glidein exited with return value 0.
2024-06-24 08:34:47 (23496): Guest Log: [INFO] Shutting Down.
2024-06-24 08:34:47 (23496): VM Completion File Detected.
2024-06-24 08:34:47 (23496): VM Completion Message: glidein exited with return value 0.
.
2024-06-24 08:34:47 (23496): Powering off VM.
2024-06-24 08:34:49 (23496): Successfully stopped VM.
2024-06-24 08:34:49 (23496): Deregistering VM. (boinc_5e26976fe6fbbdd4, slot#4)
2024-06-24 08:34:49 (23496): Removing network bandwidth throttle group from VM.
2024-06-24 08:34:50 (23496): Removing VM from VirtualBox.
2024-06-24 08:34:55 (23496): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN