Name CMS_2472337_1736190479.829074_0
Workunit 229699720
Created 6 Jan 2025, 19:08:02 UTC
Sent 6 Jan 2025, 19:56:42 UTC
Report deadline 6 Feb 2025, 19:56:42 UTC
Received 10 Jan 2025, 10:21:09 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10822251
Run time 48 min 27 sec
CPU time 49 min 53 sec
Validate state Valid
Credit 243.66
Device peak FLOPS 15.33 GFLOPS
Application version CMS Simulation v70.30 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 86.82 MB
Peak swap size 87.61 MB
Peak disk usage 1.47 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2025-01-09 13:23:51 (20784): vboxwrapper version 26207
2025-01-09 13:23:51 (20784): BOINC client version: 8.0.2
2025-01-09 13:23:53 (20784): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-09 13:23:53 (20784): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-09 13:23:53 (20784): Successfully copied 'init_data.xml' to the shared directory.
2025-01-09 13:23:53 (20784): Create VM. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-09 13:23:54 (20784): Setting Memory Size for VM. (4584MB)
2025-01-09 13:23:54 (20784): Setting CPU Count for VM. (4)
2025-01-09 13:23:55 (20784): Setting Chipset Options for VM.
2025-01-09 13:23:55 (20784): Setting Graphics Controller Options for VM.
2025-01-09 13:23:55 (20784): Setting Boot Options for VM.
2025-01-09 13:23:55 (20784): Setting Network Configuration for NAT.
2025-01-09 13:23:56 (20784): Enabling VM Network Access.
2025-01-09 13:23:56 (20784): Disabling USB Support for VM.
2025-01-09 13:23:56 (20784): Disabling COM Port Support for VM.
2025-01-09 13:23:57 (20784): Disabling LPT Port Support for VM.
2025-01-09 13:23:57 (20784): Disabling Audio Support for VM.
2025-01-09 13:23:57 (20784): Disabling Clipboard Support for VM.
2025-01-09 13:23:57 (20784): Disabling Drag and Drop Support for VM.
2025-01-09 13:23:58 (20784): Adding storage controller(s) to VM.
2025-01-09 13:23:58 (20784): Adding virtual disk drive to VM. (CMS_2024_04_29_prod.vdi)
2025-01-09 13:24:00 (20784): Adding VirtualBox Guest Additions to VM.
2025-01-09 13:24:00 (20784): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-01-09 13:24:01 (20784): forwarding host port 54632 to guest port 80
2025-01-09 13:24:01 (20784): Enabling remote desktop for VM.
2025-01-09 13:24:01 (20784): Required extension pack not installed, remote desktop not enabled.
2025-01-09 13:24:01 (20784): Enabling shared directory for VM.
2025-01-09 13:24:02 (20784): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-09 13:24:19 (20784): Successfully started VM. (PID = '30960')
2025-01-09 13:24:19 (20784): Reporting VM Process ID to BOINC.
2025-01-09 13:24:19 (20784): Guest Log: BIOS: VirtualBox 7.0.8
2025-01-09 13:24:19 (20784): Guest Log: CPUID EDX: 0x178bfbff
2025-01-09 13:24:19 (20784): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-09 13:24:19 (20784): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-09 13:24:19 (20784): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-09 13:24:19 (20784): Detected: Web Application Enabled (http://localhost:54632)
2025-01-09 13:24:19 (20784): Preference change detected
2025-01-09 13:24:19 (20784): Setting CPU throttle for VM. (100%)
2025-01-09 13:24:19 (20784): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-09 13:24:21 (20784): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-09 13:24:21 (20784): Guest Log: BIOS: Booting from Hard Disk...
2025-01-09 13:24:24 (20784): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-09 13:24:24 (20784): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-09 13:24:57 (20784): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-09 13:24:57 (20784): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-09 13:24:59 (20784): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-09 13:24:59 (20784): Guest Log: 00:00:00.000239 main     Log opened 2025-01-09T13:24:57.979459000Z
2025-01-09 13:24:59 (20784): Guest Log: 00:00:00.001619 main     OS Product: Linux
2025-01-09 13:24:59 (20784): Guest Log: 00:00:00.001776 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-01-09 13:24:59 (20784): Guest Log: 00:00:00.001839 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-01-09 13:24:59 (20784): Guest Log: 00:00:00.001933 main     Executable: /usr/sbin/VBoxService
2025-01-09 13:24:59 (20784): Guest Log: 00:00:00.001935 main     Process ID: 2286
2025-01-09 13:24:59 (20784): Guest Log: 00:00:00.001936 main     Package type: LINUX_64BITS_GENERIC
2025-01-09 13:24:59 (20784): Guest Log: 00:00:00.004701 main     5.2.6 r120293 started. Verbose level = 0
2025-01-09 13:25:21 (20784): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 13:28:54 (20784): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 13:28:57 (20784): Guest Log: [INFO] Mounting the shared directory
2025-01-09 13:28:57 (20784): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-01-09 13:28:57 (20784): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-01-09 13:28:57 (20784): Guest Log: [INFO] Testing connection to cern.ch
2025-01-09 13:28:58 (20784): Guest Log: [INFO] Testing connection to VCCS
2025-01-09 13:28:58 (20784): Guest Log: [INFO] Testing connection to HTCondor
2025-01-09 13:28:58 (20784): Guest Log: [INFO] Testing connection to WMAgent
2025-01-09 13:28:58 (20784): Guest Log: [INFO] Testing connection to EOSCMS
2025-01-09 13:28:58 (20784): Guest Log: [INFO] Testing connection to CMS-Factory
2025-01-09 13:28:59 (20784): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-01-09 13:28:59 (20784): Guest Log: [INFO] Testing connection to Frontier
2025-01-09 13:28:59 (20784): Guest Log: [INFO] Could not find a local HTTP proxy
2025-01-09 13:28:59 (20784): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-01-09 13:28:59 (20784): Guest Log: [INFO] This makes the application less efficient
2025-01-09 13:28:59 (20784): Guest Log: [INFO] It also puts higher load on the project servers
2025-01-09 13:29:00 (20784): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-01-09 13:29:00 (20784): Guest Log: [INFO] Advice can be found in the project forum
2025-01-09 13:29:00 (20784): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-01-09 13:29:05 (20784): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-01-09 13:29:07 (20784): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-01-09 13:29:07 (20784): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-01-09 13:29:08 (20784): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-01-09 13:29:08 (20784): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-01-09 13:29:08 (20784): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-01-09 13:29:09 (20784): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2025-01-09 13:29:09 (20784): Guest Log: [INFO] Environment HTTP proxy: not set
2025-01-09 13:29:09 (20784): Guest Log: [INFO] Reading volunteer information
2025-01-09 13:29:20 (20784): Guest Log: [INFO] Using weak account key.
2025-01-09 13:29:20 (20784): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-01-09 13:29:21 (20784): Guest Log: [INFO] Using weak account key.
2025-01-09 13:29:21 (20784): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-01-09 13:29:22 (20784): Guest Log: [INFO] CMS application starting. Check log files.
2025-01-09 13:31:48 (20784): Stopping VM.
2025-01-09 13:31:55 (20784): Successfully stopped VM.
2025-01-09 14:21:21 (7424): vboxwrapper version 26207
2025-01-09 14:21:21 (7424): BOINC client version: 8.0.2
2025-01-09 14:21:22 (7424): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-09 14:21:22 (7424): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-09 14:21:23 (7424): Guest Log: BIOS: VirtualBox 7.0.8
2025-01-09 14:21:23 (7424): Guest Log: CPUID EDX: 0x178bfbff
2025-01-09 14:21:23 (7424): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-09 14:21:23 (7424): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-09 14:21:23 (7424): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-09 14:21:23 (7424): Guest Log: BIOS: Booting from Hard Disk...
2025-01-09 14:21:23 (7424): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-09 14:21:23 (7424): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-09 14:21:23 (7424): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-09 14:21:23 (7424): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-09 14:21:23 (7424): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-09 14:21:23 (7424): Guest Log: 00:00:00.000239 main     Log opened 2025-01-09T13:24:57.979459000Z
2025-01-09 14:21:23 (7424): Guest Log: 00:00:00.001619 main     OS Product: Linux
2025-01-09 14:21:23 (7424): Guest Log: 00:00:00.001776 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-01-09 14:21:23 (7424): Guest Log: 00:00:00.001839 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-01-09 14:21:23 (7424): Guest Log: 00:00:00.001933 main     Executable: /usr/sbin/VBoxService
2025-01-09 14:21:23 (7424): Guest Log: 00:00:00.001935 main     Process ID: 2286
2025-01-09 14:21:23 (7424): Guest Log: 00:00:00.001936 main     Package type: LINUX_64BITS_GENERIC
2025-01-09 14:21:23 (7424): Guest Log: 00:00:00.004701 main     5.2.6 r120293 started. Verbose level = 0
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Mounting the shared directory
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Testing connection to cern.ch
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Testing connection to VCCS
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Testing connection to HTCondor
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Testing connection to WMAgent
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Testing connection to EOSCMS
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Testing connection to CMS-Factory
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Testing connection to Frontier
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Could not find a local HTTP proxy
2025-01-09 14:21:23 (7424): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-01-09 14:21:23 (7424): Guest Log: [INFO] This makes the application less efficient
2025-01-09 14:21:23 (7424): Guest Log: [INFO] It also puts higher load on the project servers
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Advice can be found in the project forum
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-01-09 14:21:23 (7424): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Environment HTTP proxy: not set
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Reading volunteer information
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Using weak account key.
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Using weak account key.
2025-01-09 14:21:23 (7424): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-01-09 14:21:23 (7424): Guest Log: [INFO] CMS application starting. Check log files.
2025-01-09 14:21:23 (7424): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-09 14:21:35 (7424): Successfully started VM. (PID = '22072')
2025-01-09 14:21:35 (7424): Reporting VM Process ID to BOINC.
2025-01-09 14:21:35 (7424): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-09 14:21:35 (7424): Detected: Web Application Enabled (http://localhost:54632)
2025-01-09 14:21:35 (7424): Preference change detected
2025-01-09 14:21:35 (7424): Setting CPU throttle for VM. (100%)
2025-01-09 14:21:36 (7424): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-09 14:21:39 (7424): Guest Log: 00:03:22.547565 timesync vgsvcTimeSyncWorker: Radical host time change: 2 996 109 000 000ns (HostNow=1 736 432 499 537 000 000 ns HostLast=1 736 429 503 428 000 000 ns)
2025-01-09 14:21:49 (7424): Guest Log: 00:03:32.549127 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 209 012 203 000ns (GuestNow=1 736 432 509 538 725 000 ns GuestLast=1 736 429 300 526 522 000 ns fSetTimeLastLoop=true )
2025-01-09 14:21:49 (7424): Stopping VM.
2025-01-09 14:21:53 (7424): Successfully stopped VM.
2025-01-09 14:24:09 (30548): vboxwrapper version 26207
2025-01-09 14:24:09 (30548): BOINC client version: 8.0.2
2025-01-09 14:24:10 (30548): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-09 14:24:11 (30548): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-09 14:24:11 (30548): Guest Log: 00:03:22.547565 timesync vgsvcTimeSyncWorker: Radical host time change: 2 996 109 000 000ns (HostNow=1 736 432 499 537 000 000 ns HostLast=1 736 429 503 428 000 000 ns)
2025-01-09 14:24:11 (30548): Guest Log: 00:03:32.549127 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 209 012 203 000ns (GuestNow=1 736 432 509 538 725 000 ns GuestLast=1 736 429 300 526 522 000 ns fSetTimeLastLoop=true )
2025-01-09 14:24:11 (30548): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-09 14:24:24 (30548): Successfully started VM. (PID = '31976')
2025-01-09 14:24:24 (30548): Reporting VM Process ID to BOINC.
2025-01-09 14:24:24 (30548): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-09 14:24:24 (30548): Detected: Web Application Enabled (http://localhost:54632)
2025-01-09 14:24:24 (30548): Stopping VM.
2025-01-09 14:24:28 (30548): Successfully stopped VM.
2025-01-09 15:11:45 (16620): vboxwrapper version 26207
2025-01-09 15:11:45 (16620): BOINC client version: 8.0.2
2025-01-09 15:11:46 (16620): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-09 15:11:46 (16620): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-09 15:11:47 (16620): ERROR: VM failed to start
2025-01-09 15:11:52 (16620): 
   BOINC will be notified that it needs to clean up the environment.
         This is a temporary problem and so this job will be rescheduled for another time.

2025-01-09 17:34:56 (7924): vboxwrapper version 26207
2025-01-09 17:34:56 (7924): BOINC client version: 8.0.2
2025-01-09 17:34:58 (7924): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-09 17:34:58 (7924): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-09 17:34:59 (7924): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-09 17:35:19 (7924): Successfully started VM. (PID = '24232')
2025-01-09 17:35:19 (7924): Reporting VM Process ID to BOINC.
2025-01-09 17:35:19 (7924): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-09 17:35:19 (7924): Detected: Web Application Enabled (http://localhost:54632)
2025-01-09 17:35:20 (7924): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 17:41:05 (7924): Preference change detected
2025-01-09 17:41:05 (7924): Setting CPU throttle for VM. (100%)
2025-01-09 17:41:06 (7924): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-09 17:41:06 (7924): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 17:41:13 (7924): Guest Log: 00:03:42.552501 timesync vgsvcTimeSyncWorker: Radical host time change: 11 963 360 000 000ns (HostNow=1 736 444 472 899 000 000 ns HostLast=1 736 432 509 539 000 000 ns)
2025-01-09 17:41:23 (7924): Guest Log: 00:03:52.554647 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 963 359 409 000ns (GuestNow=1 736 444 482 901 316 000 ns GuestLast=1 736 432 519 541 907 000 ns fSetTimeLastLoop=true )
2025-01-09 17:42:53 (7924): Stopping VM.
2025-01-09 17:43:01 (7924): Successfully stopped VM.
2025-01-09 17:43:53 (32808): vboxwrapper version 26207
2025-01-09 17:43:53 (32808): BOINC client version: 8.0.2
2025-01-09 17:43:54 (32808): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-09 17:43:54 (32808): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-09 17:43:55 (32808): Guest Log: 00:03:42.552501 timesync vgsvcTimeSyncWorker: Radical host time change: 11 963 360 000 000ns (HostNow=1 736 444 472 899 000 000 ns HostLast=1 736 432 509 539 000 000 ns)
2025-01-09 17:43:55 (32808): Guest Log: 00:03:52.554647 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 963 359 409 000ns (GuestNow=1 736 444 482 901 316 000 ns GuestLast=1 736 432 519 541 907 000 ns fSetTimeLastLoop=true )
2025-01-09 17:43:55 (32808): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-09 17:44:15 (32808): Successfully started VM. (PID = '26904')
2025-01-09 17:44:15 (32808): Reporting VM Process ID to BOINC.
2025-01-09 17:44:15 (32808): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-09 17:44:15 (32808): Detected: Web Application Enabled (http://localhost:54632)
2025-01-09 17:44:15 (32808): Preference change detected
2025-01-09 17:44:15 (32808): Setting CPU throttle for VM. (100%)
2025-01-09 17:44:15 (32808): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-09 17:45:17 (32808): Stopping VM.
2025-01-09 17:45:25 (32808): Successfully stopped VM.
2025-01-09 17:46:16 (29512): vboxwrapper version 26207
2025-01-09 17:46:16 (29512): BOINC client version: 8.0.2
2025-01-09 17:46:17 (29512): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-09 17:46:17 (29512): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-09 17:46:17 (29512): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-09 17:46:41 (29512): Successfully started VM. (PID = '5220')
2025-01-09 17:46:41 (29512): Reporting VM Process ID to BOINC.
2025-01-09 17:46:41 (29512): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-09 17:46:41 (29512): Detected: Web Application Enabled (http://localhost:54632)
2025-01-09 17:46:41 (29512): Preference change detected
2025-01-09 17:46:41 (29512): Setting CPU throttle for VM. (100%)
2025-01-09 17:46:41 (29512): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-09 17:51:38 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 17:51:59 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 17:55:30 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 17:55:50 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 17:56:50 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 17:57:10 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:02:10 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:02:30 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:09:51 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:10:11 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:12:01 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:12:21 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:12:41 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:13:01 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:17:01 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:17:21 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:17:41 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:18:02 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:20:03 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:20:23 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:21:03 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:21:23 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:21:53 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:22:13 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:23:03 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:23:23 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:25:33 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:25:53 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:27:03 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:27:23 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:28:13 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:28:33 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:29:23 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:29:43 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:29:53 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:30:13 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:32:04 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:32:24 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:36:25 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:36:45 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:37:05 (29512): VM state change detected. (old = 'running', new = 'paused')
2025-01-09 18:37:25 (29512): VM state change detected. (old = 'paused', new = 'running')
2025-01-09 18:37:37 (29512): Stopping VM.
2025-01-09 18:38:20 (29512): Successfully stopped VM.
2025-01-10 10:14:42 (23456): vboxwrapper version 26207
2025-01-10 10:14:42 (23456): BOINC client version: 8.0.2
2025-01-10 10:14:43 (23456): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-10 10:14:43 (23456): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-10 10:14:44 (23456): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-10 10:15:13 (23456): Successfully started VM. (PID = '30956')
2025-01-10 10:15:13 (23456): Reporting VM Process ID to BOINC.
2025-01-10 10:15:13 (23456): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-10 10:15:13 (23456): Detected: Web Application Enabled (http://localhost:54632)
2025-01-10 10:15:13 (23456): Guest Log: 00:50:24.696417 timesync vgsvcTimeSyncWorker: Radical host time change: 56 264 963 000 000ns (HostNow=1 736 504 113 731 000 000 ns HostLast=1 736 447 848 768 000 000 ns)
2025-01-10 10:15:13 (23456): Preference change detected
2025-01-10 10:15:13 (23456): Setting CPU throttle for VM. (100%)
2025-01-10 10:15:14 (23456): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-10 10:15:23 (23456): Guest Log: 00:50:34.697364 timesync vgsvcTimeSyncWorker: Radical guest time change: 56 685 265 649 000ns (GuestNow=1 736 504 123 731 709 000 ns GuestLast=1 736 447 438 466 060 000 ns fSetTimeLastLoop=true )
2025-01-10 10:15:25 (23456): Stopping VM.
2025-01-10 10:15:40 (23456): Successfully stopped VM.
2025-01-10 10:16:24 (18756): vboxwrapper version 26207
2025-01-10 10:16:24 (18756): BOINC client version: 8.0.2
2025-01-10 10:16:25 (18756): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-10 10:16:26 (18756): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-10 10:16:26 (18756): Guest Log: 00:50:24.696417 timesync vgsvcTimeSyncWorker: Radical host time change: 56 264 963 000 000ns (HostNow=1 736 504 113 731 000 000 ns HostLast=1 736 447 848 768 000 000 ns)
2025-01-10 10:16:26 (18756): Guest Log: 00:50:34.697364 timesync vgsvcTimeSyncWorker: Radical guest time change: 56 685 265 649 000ns (GuestNow=1 736 504 123 731 709 000 ns GuestLast=1 736 447 438 466 060 000 ns fSetTimeLastLoop=true )
2025-01-10 10:16:26 (18756): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-10 10:16:59 (18756): Successfully started VM. (PID = '7496')
2025-01-10 10:16:59 (18756): Reporting VM Process ID to BOINC.
2025-01-10 10:16:59 (18756): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-10 10:16:59 (18756): Detected: Web Application Enabled (http://localhost:54632)
2025-01-10 10:16:59 (18756): Preference change detected
2025-01-10 10:16:59 (18756): Setting CPU throttle for VM. (100%)
2025-01-10 10:16:59 (18756): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-10 10:18:53 (18756): Stopping VM.
2025-01-10 10:19:08 (18756): Successfully stopped VM.
2025-01-10 10:19:53 (21380): vboxwrapper version 26207
2025-01-10 10:19:53 (21380): BOINC client version: 8.0.2
2025-01-10 10:19:54 (21380): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-10 10:19:54 (21380): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-10 10:19:55 (21380): Starting VM using VBoxManage interface. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-10 10:20:29 (21380): Successfully started VM. (PID = '2168')
2025-01-10 10:20:29 (21380): Reporting VM Process ID to BOINC.
2025-01-10 10:20:29 (21380): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-10 10:20:29 (21380): Detected: Web Application Enabled (http://localhost:54632)
2025-01-10 10:20:29 (21380): Preference change detected
2025-01-10 10:20:29 (21380): Setting CPU throttle for VM. (100%)
2025-01-10 10:20:29 (21380): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-10 10:20:57 (21380): Guest Log: [INFO] glidein exited with return value 0.
2025-01-10 10:20:57 (21380): Guest Log: [INFO] Shutting Down.
2025-01-10 10:20:57 (21380): VM Completion File Detected.
2025-01-10 10:20:57 (21380): VM Completion Message: glidein exited with return value 0.
.
2025-01-10 10:20:57 (21380): Powering off VM.
2025-01-10 10:20:58 (21380): Successfully stopped VM.
2025-01-10 10:20:58 (21380): Deregistering VM. (boinc_60e7c66e0ba9237c, slot#6)
2025-01-10 10:20:58 (21380): Removing network bandwidth throttle group from VM.
2025-01-10 10:20:58 (21380): Removing VM from VirtualBox.
2025-01-10 10:21:04 (21380): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN