Name T1tKDmNtEH9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmZ2CLDmzE4x2n_1
Workunit 239490629
Created 2 Mar 2026, 13:17:33 UTC
Sent 2 Mar 2026, 13:26:56 UTC
Report deadline 10 Mar 2026, 13:26:56 UTC
Received 4 Mar 2026, 9:37:18 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10864060
Run time 2 hours 55 min 46 sec
CPU time 15 hours 42 min 55 sec
Priority 28
Validate state Valid
Credit 354.05
Device peak FLOPS 39.57 GFLOPS
Application version ATLAS Simulation v3.03 (vbox64_mt_mcore_atlas)
x86_64-apple-darwin
Peak working set size 9.09 GB
Peak swap size 72.88 GB
Peak disk usage 200.32 MB

Stderr output

<core_client_version>8.2.8</core_client_version>
<![CDATA[
<stderr_txt>
2026-03-03 08:09:36 (54134): vboxwrapper version 26210
2026-03-03 08:09:36 (54134): BOINC client version: 8.2.8
2026-03-03 08:09:36 (54134): Detected: VirtualBox VboxManage Interface (Version: 7.2.4)
2026-03-03 08:09:36 (54134): Detected: Sandbox Configuration Enabled
2026-03-03 08:09:36 (54134): Successfully copied 'init_data.xml' to the shared directory.
2026-03-03 08:09:36 (54134): Create VM. (boinc_80e8cf7944ec9827, slot#4)
2026-03-03 08:09:36 (54134): Setting Memory Size for VM. (4600MB)
2026-03-03 08:09:37 (54134): Setting CPU Count for VM. (6)
2026-03-03 08:09:37 (54134): Setting Chipset Options for VM.
2026-03-03 08:09:37 (54134): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2026-03-03 08:09:37 (54134): Setting Boot Options for VM.
2026-03-03 08:09:37 (54134): Setting Network Configuration for NAT. (Driver: virtio)
2026-03-03 08:09:37 (54134): Enabling VM Network Access.
2026-03-03 08:09:37 (54134): Disabling USB Support for VM.
2026-03-03 08:09:37 (54134): Disabling COM Port Support for VM.
2026-03-03 08:09:37 (54134): Disabling Audio Support for VM.
2026-03-03 08:09:37 (54134): Disabling Clipboard Support for VM.
2026-03-03 08:09:37 (54134): Disabling Drag and Drop Support for VM.
2026-03-03 08:09:37 (54134): Adding storage controller(s) to VM.
2026-03-03 08:09:37 (54134): Adding virtual disk drive to VM. (ATLAS_vbox_3.03_image.vdi)
2026-03-03 08:09:38 (54134): Adding VirtualBox Guest Additions to VM.
2026-03-03 08:09:38 (54134): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2026-03-03 08:09:38 (54134): forwarding host port 52320 to guest port 80
2026-03-03 08:09:38 (54134): Enabling remote desktop for VM.
2026-03-03 08:09:38 (54134): Required extension pack not installed, remote desktop not enabled.
2026-03-03 08:09:38 (54134): Enabling shared directory for VM.
2026-03-03 08:09:38 (54134): Starting VM using VBoxManage interface. (boinc_80e8cf7944ec9827, slot#4)
2026-03-03 08:09:42 (54134): Successfully started VM. (PID = '54205')
2026-03-03 08:09:42 (54134): Reporting VM Process ID to BOINC.
2026-03-03 08:09:42 (54134): Guest Log: BIOS: VirtualBox 7.2.4
2026-03-03 08:09:42 (54134): Guest Log: CPUID EDX: 0x178bfbff
2026-03-03 08:09:42 (54134): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2026-03-03 08:09:42 (54134): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2026-03-03 08:09:42 (54134): VM state change detected. (old = 'poweredoff', new = 'running')
2026-03-03 08:09:42 (54134): Detected: Web Application Enabled (http://localhost:52320)
2026-03-03 08:09:42 (54134): Preference change detected
2026-03-03 08:09:42 (54134): Setting CPU throttle for VM. (100%)
2026-03-03 08:09:42 (54134): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2026-03-03 08:09:44 (54134): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2026-03-03 08:09:44 (54134): Guest Log: BIOS: Booting from Hard Disk...
2026-03-03 08:09:48 (54134): Guest Log: BIOS: KBD: unsupported int 16h function 03
2026-03-03 08:09:48 (54134): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2026-03-03 08:09:48 (54134): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2026-03-03 08:09:55 (54134): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2026-03-03 08:09:55 (54134): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2026-03-03 08:10:02 (54134): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2026-03-03 08:10:02 (54134): Guest Log: 00:00:00.000184 main     Log opened 2026-03-03T07:09:59.536215000Z
2026-03-03 08:10:02 (54134): Guest Log: 00:00:00.000310 main     OS Product: Linux
2026-03-03 08:10:02 (54134): Guest Log: 00:00:00.000362 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2026-03-03 08:10:02 (54134): Guest Log: 00:00:00.000406 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2026-03-03 08:10:02 (54134): Guest Log: 00:00:00.000454 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2026-03-03 08:10:02 (54134): Guest Log: 00:00:00.000455 main     Process ID: 1336
2026-03-03 08:10:02 (54134): Guest Log: 00:00:00.000456 main     Package type: LINUX_64BITS_GENERIC
2026-03-03 08:10:02 (54134): Guest Log: 00:00:00.002347 main     5.2.32 r132073 started. Verbose level = 0
2026-03-03 08:10:02 (54134): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2026-03-03 08:10:02 (54134): Guest Log: [INFO] Mounting shared directory
2026-03-03 08:10:02 (54134): Guest Log: [INFO] Checking for init_data.xml
2026-03-03 08:10:05 (54134): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2026-03-03 08:10:05 (54134): Guest Log: [INFO] Detected branch: prod
2026-03-03 08:10:05 (54134): Guest Log: This is the prod version of the ATLAS job wrapper
2026-03-03 08:10:05 (54134): Guest Log: Copying input files
2026-03-03 08:10:08 (54134): Guest Log: Copied input files into RunAtlas.
2026-03-03 08:10:08 (54134): Guest Log: This VM did not configure a local http proxy via BOINC.
2026-03-03 08:10:08 (54134): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2026-03-03 08:10:08 (54134): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2026-03-03 08:10:08 (54134): Guest Log: Further information can be found at the LHC@home message board.
2026-03-03 08:10:15 (54134): Guest Log: Running cvmfs_config stat atlas.cern.ch
2026-03-03 08:10:15 (54134): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2026-03-03 08:10:15 (54134): Guest Log: 2.6.3.0 1630 0 32164 156836 4 1 3117743 4096001 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2026-03-03 08:10:16 (54134): Guest Log: copied the webapp to /var/www
2026-03-03 08:10:16 (54134): Guest Log: ATHENA_PROC_NUMBER=6
2026-03-03 08:10:16 (54134): Guest Log: ATHENA_CORE_NUMBER=6
2026-03-03 08:10:16 (54134): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 
2026-03-03 08:10:16 (54134): Guest Log:  *** Starting ATLAS job. (PandaID=7035911684 taskID=48844857) ***
2026-03-03 08:28:51 (54134): VM state change detected. (old = 'running', new = 'paused')
2026-03-03 08:28:57 (54134): Error in resume VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_80e8cf7944ec9827" resume
Output:
VBoxManage: error: VM is paused due to host power management
VBoxManage: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee nsISupports
VBoxManage: error: Context: "Resume()" at line 393 of file VBoxManageControlVM.cpp

2026-03-03 08:28:57 (54134): Stopping VM.
2026-03-03 08:29:09 (54134): Successfully stopped VM.
2026-03-03 08:39:23 (54930): vboxwrapper version 26210
2026-03-03 08:39:23 (54930): BOINC client version: 8.2.8
2026-03-03 08:39:23 (54930): Detected: VirtualBox VboxManage Interface (Version: 7.2.4)
2026-03-03 08:39:23 (54930): Detected: Sandbox Configuration Enabled
2026-03-03 08:39:23 (54930): Guest Log: BIOS: VirtualBox 7.2.4
2026-03-03 08:39:23 (54930): Guest Log: CPUID EDX: 0x178bfbff
2026-03-03 08:39:23 (54930): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2026-03-03 08:39:23 (54930): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2026-03-03 08:39:23 (54930): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2026-03-03 08:39:23 (54930): Guest Log: BIOS: Booting from Hard Disk...
2026-03-03 08:39:23 (54930): Guest Log: BIOS: KBD: unsupported int 16h function 03
2026-03-03 08:39:23 (54930): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2026-03-03 08:39:23 (54930): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2026-03-03 08:39:23 (54930): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2026-03-03 08:39:23 (54930): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2026-03-03 08:39:23 (54930): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2026-03-03 08:39:23 (54930): Guest Log: 00:00:00.000184 main     Log opened 2026-03-03T07:09:59.536215000Z
2026-03-03 08:39:23 (54930): Guest Log: 00:00:00.000310 main     OS Product: Linux
2026-03-03 08:39:23 (54930): Guest Log: 00:00:00.000362 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2026-03-03 08:39:23 (54930): Guest Log: 00:00:00.000406 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2026-03-03 08:39:23 (54930): Guest Log: 00:00:00.000454 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2026-03-03 08:39:23 (54930): Guest Log: 00:00:00.000455 main     Process ID: 1336
2026-03-03 08:39:23 (54930): Guest Log: 00:00:00.000456 main     Package type: LINUX_64BITS_GENERIC
2026-03-03 08:39:23 (54930): Guest Log: 00:00:00.002347 main     5.2.32 r132073 started. Verbose level = 0
2026-03-03 08:39:23 (54930): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2026-03-03 08:39:23 (54930): Guest Log: [INFO] Mounting shared directory
2026-03-03 08:39:23 (54930): Guest Log: [INFO] Checking for init_data.xml
2026-03-03 08:39:23 (54930): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2026-03-03 08:39:23 (54930): Guest Log: [INFO] Detected branch: prod
2026-03-03 08:39:23 (54930): Guest Log: This is the prod version of the ATLAS job wrapper
2026-03-03 08:39:23 (54930): Guest Log: Copying input files
2026-03-03 08:39:23 (54930): Guest Log: Copied input files into RunAtlas.
2026-03-03 08:39:23 (54930): Guest Log: This VM did not configure a local http proxy via BOINC.
2026-03-03 08:39:23 (54930): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2026-03-03 08:39:23 (54930): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2026-03-03 08:39:23 (54930): Guest Log: Further information can be found at the LHC@home message board.
2026-03-03 08:39:23 (54930): Guest Log: Running cvmfs_config stat atlas.cern.ch
2026-03-03 08:39:23 (54930): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2026-03-03 08:39:23 (54930): Guest Log: 2.6.3.0 1630 0 32164 156836 4 1 3117743 4096001 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2026-03-03 08:39:23 (54930): Guest Log: copied the webapp to /var/www
2026-03-03 08:39:23 (54930): Guest Log: ATHENA_PROC_NUMBER=6
2026-03-03 08:39:23 (54930): Guest Log: ATHENA_CORE_NUMBER=6
2026-03-03 08:39:23 (54930): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 
2026-03-03 08:39:23 (54930): Guest Log:  *** Starting ATLAS job. (PandaID=7035911684 taskID=48844857) ***
2026-03-03 08:39:23 (54930): Starting VM using VBoxManage interface. (boinc_80e8cf7944ec9827, slot#4)
2026-03-03 08:39:34 (54930): Successfully started VM. (PID = '54962')
2026-03-03 08:39:34 (54930): Reporting VM Process ID to BOINC.
2026-03-03 08:39:34 (54930): VM state change detected. (old = 'poweredoff', new = 'running')
2026-03-03 08:39:34 (54930): Detected: Web Application Enabled (http://localhost:52320)
2026-03-03 08:39:34 (54930): Preference change detected
2026-03-03 08:39:34 (54930): Setting CPU throttle for VM. (100%)
2026-03-03 08:39:34 (54930): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2026-03-03 09:15:37 (54930): Guest Log: 00:20:02.579268 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 512 237 000ns (GuestNow=1 772 525 734 550 147 000 ns GuestLast=1 772 523 637 037 910 000 ns fSetTimeLastLoop=true )
2026-03-03 09:52:05 (54930): Guest Log: 00:21:42.686278 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 814 168 000ns (GuestNow=1 772 527 922 452 419 000 ns GuestLast=1 772 525 824 638 251 000 ns fSetTimeLastLoop=true )
2026-03-03 10:29:06 (54930): Guest Log: 00:25:03.626203 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 030 422 108 000ns (GuestNow=1 772 530 143 533 282 000 ns GuestLast=1 772 528 113 111 174 000 ns fSetTimeLastLoop=true )
2026-03-03 13:35:40 (54930): Guest Log: 00:41:50.070196 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 987 955 883 000ns (GuestNow=1 772 541 337 978 676 000 ns GuestLast=1 772 539 350 022 793 000 ns fSetTimeLastLoop=true )
2026-03-03 14:12:15 (54930): Guest Log: 00:44:20.933265 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 054 189 662 000ns (GuestNow=1 772 543 532 919 843 000 ns GuestLast=1 772 541 478 730 181 000 ns fSetTimeLastLoop=true )
2026-03-03 14:45:54 (54930): Guest Log: 00:47:43.035830 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 827 067 628 000ns (GuestNow=1 772 545 551 932 368 000 ns GuestLast=1 772 543 724 864 740 000 ns fSetTimeLastLoop=true )
2026-03-03 16:14:14 (54930): Guest Log: 00:52:44.592027 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 337 547 000ns (GuestNow=1 772 550 851 655 617 000 ns GuestLast=1 772 548 753 318 070 000 ns fSetTimeLastLoop=true )
2026-03-03 16:51:20 (54930): Guest Log: 00:55:15.661433 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 085 148 303 000ns (GuestNow=1 772 553 077 697 885 000 ns GuestLast=1 772 550 992 549 582 000 ns fSetTimeLastLoop=true )
2026-03-03 18:21:04 (54930): Guest Log: 01:00:18.842754 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 199 582 000ns (GuestNow=1 772 558 461 376 210 000 ns GuestLast=1 772 556 363 176 628 000 ns fSetTimeLastLoop=true )
2026-03-03 18:57:56 (54930): Guest Log: 01:02:59.131093 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 064 524 162 000ns (GuestNow=1 772 560 676 187 071 000 ns GuestLast=1 772 558 611 662 909 000 ns fSetTimeLastLoop=true )
2026-03-03 19:34:24 (54930): Guest Log: 01:04:39.197087 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 907 033 000ns (GuestNow=1 772 562 864 155 513 000 ns GuestLast=1 772 560 766 248 480 000 ns fSetTimeLastLoop=true )
2026-03-03 21:10:51 (54930): Guest Log: 01:09:39.492896 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 797 772 000ns (GuestNow=1 772 568 650 172 638 000 ns GuestLast=1 772 566 552 374 866 000 ns fSetTimeLastLoop=true )
2026-03-03 22:17:37 (54930): Guest Log: 01:15:30.031999 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 059 690 309 000ns (GuestNow=1 772 572 657 570 121 000 ns GuestLast=1 772 570 597 879 812 000 ns fSetTimeLastLoop=true )
2026-03-03 22:54:55 (54930): Guest Log: 01:18:00.162881 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 095 715 410 000ns (GuestNow=1 772 574 893 387 551 000 ns GuestLast=1 772 572 797 672 141 000 ns fSetTimeLastLoop=true )
2026-03-03 23:31:24 (54930): Guest Log: 01:19:40.226449 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 100 717 806 000ns (GuestNow=1 772 577 084 158 624 000 ns GuestLast=1 772 574 983 440 818 000 ns fSetTimeLastLoop=true )
2026-03-04 00:08:38 (54930): Guest Log: 01:22:10.350825 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 091 820 228 000ns (GuestNow=1 772 579 316 091 546 000 ns GuestLast=1 772 577 224 271 318 000 ns fSetTimeLastLoop=true )
2026-03-04 00:45:07 (54930): Guest Log: 01:23:50.449843 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 791 450 000ns (GuestNow=1 772 581 504 962 126 000 ns GuestLast=1 772 579 406 170 676 000 ns fSetTimeLastLoop=true )
2026-03-04 01:52:48 (54930): Guest Log: 01:27:12.218258 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 406 502 000ns (GuestNow=1 772 585 565 312 654 000 ns GuestLast=1 772 583 467 906 152 000 ns fSetTimeLastLoop=true )
2026-03-04 02:29:27 (54930): Guest Log: 01:29:43.066598 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 058 259 013 000ns (GuestNow=1 772 587 764 388 040 000 ns GuestLast=1 772 585 706 129 027 000 ns fSetTimeLastLoop=true )
2026-03-04 03:06:03 (54930): Guest Log: 01:31:33.137340 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 674 927 000ns (GuestNow=1 772 589 963 130 770 000 ns GuestLast=1 772 587 864 455 843 000 ns fSetTimeLastLoop=true )
2026-03-04 03:42:51 (54930): Guest Log: 01:34:03.245471 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 068 080 114 000ns (GuestNow=1 772 592 171 308 670 000 ns GuestLast=1 772 590 103 228 556 000 ns fSetTimeLastLoop=true )
2026-03-04 04:19:18 (54930): Guest Log: 01:35:43.344274 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 095 909 933 000ns (GuestNow=1 772 594 357 280 066 000 ns GuestLast=1 772 592 261 370 133 000 ns fSetTimeLastLoop=true )
2026-03-04 04:56:32 (54930): Guest Log: 01:38:13.717877 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 094 321 247 000ns (GuestNow=1 772 596 591 964 468 000 ns GuestLast=1 772 594 497 643 221 000 ns fSetTimeLastLoop=true )
2026-03-04 06:02:44 (54930): Guest Log: 01:41:33.913194 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 525 228 000ns (GuestNow=1 772 600 564 328 783 000 ns GuestLast=1 772 598 466 803 555 000 ns fSetTimeLastLoop=true )
2026-03-04 06:02:58 (54930): Status Report: Elapsed Time: '6000.034195'
2026-03-04 06:02:58 (54930): Status Report: CPU Time: '30670.190000'
2026-03-04 06:41:51 (54930): Guest Log: 01:49:56.373452 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 852 216 633 000ns (GuestNow=1 772 602 908 928 322 000 ns GuestLast=1 772 601 056 711 689 000 ns fSetTimeLastLoop=true )
2026-03-04 07:46:33 (54930): Stopping VM.
2026-03-04 07:46:53 (54930): Successfully stopped VM.
2026-03-04 07:55:25 (58886): vboxwrapper version 26210
2026-03-04 07:55:25 (58886): BOINC client version: 8.2.8
2026-03-04 07:55:28 (58886): Detected: VirtualBox VboxManage Interface (Version: 7.2.4)
2026-03-04 07:55:28 (58886): Detected: Sandbox Configuration Enabled
2026-03-04 07:55:28 (58886): Guest Log: 00:20:02.579268 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 512 237 000ns (GuestNow=1 772 525 734 550 147 000 ns GuestLast=1 772 523 637 037 910 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 00:21:42.686278 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 814 168 000ns (GuestNow=1 772 527 922 452 419 000 ns GuestLast=1 772 525 824 638 251 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 00:25:03.626203 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 030 422 108 000ns (GuestNow=1 772 530 143 533 282 000 ns GuestLast=1 772 528 113 111 174 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 00:41:50.070196 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 987 955 883 000ns (GuestNow=1 772 541 337 978 676 000 ns GuestLast=1 772 539 350 022 793 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 00:44:20.933265 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 054 189 662 000ns (GuestNow=1 772 543 532 919 843 000 ns GuestLast=1 772 541 478 730 181 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 00:47:43.035830 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 827 067 628 000ns (GuestNow=1 772 545 551 932 368 000 ns GuestLast=1 772 543 724 864 740 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 00:52:44.592027 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 337 547 000ns (GuestNow=1 772 550 851 655 617 000 ns GuestLast=1 772 548 753 318 070 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 00:55:15.661433 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 085 148 303 000ns (GuestNow=1 772 553 077 697 885 000 ns GuestLast=1 772 550 992 549 582 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:00:18.842754 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 199 582 000ns (GuestNow=1 772 558 461 376 210 000 ns GuestLast=1 772 556 363 176 628 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:02:59.131093 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 064 524 162 000ns (GuestNow=1 772 560 676 187 071 000 ns GuestLast=1 772 558 611 662 909 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:04:39.197087 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 907 033 000ns (GuestNow=1 772 562 864 155 513 000 ns GuestLast=1 772 560 766 248 480 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:09:39.492896 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 797 772 000ns (GuestNow=1 772 568 650 172 638 000 ns GuestLast=1 772 566 552 374 866 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:15:30.031999 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 059 690 309 000ns (GuestNow=1 772 572 657 570 121 000 ns GuestLast=1 772 570 597 879 812 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:18:00.162881 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 095 715 410 000ns (GuestNow=1 772 574 893 387 551 000 ns GuestLast=1 772 572 797 672 141 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:19:40.226449 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 100 717 806 000ns (GuestNow=1 772 577 084 158 624 000 ns GuestLast=1 772 574 983 440 818 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:22:10.350825 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 091 820 228 000ns (GuestNow=1 772 579 316 091 546 000 ns GuestLast=1 772 577 224 271 318 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:23:50.449843 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 791 450 000ns (GuestNow=1 772 581 504 962 126 000 ns GuestLast=1 772 579 406 170 676 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:27:12.218258 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 406 502 000ns (GuestNow=1 772 585 565 312 654 000 ns GuestLast=1 772 583 467 906 152 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:29:43.066598 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 058 259 013 000ns (GuestNow=1 772 587 764 388 040 000 ns GuestLast=1 772 585 706 129 027 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:31:33.137340 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 674 927 000ns (GuestNow=1 772 589 963 130 770 000 ns GuestLast=1 772 587 864 455 843 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:34:03.245471 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 068 080 114 000ns (GuestNow=1 772 592 171 308 670 000 ns GuestLast=1 772 590 103 228 556 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:35:43.344274 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 095 909 933 000ns (GuestNow=1 772 594 357 280 066 000 ns GuestLast=1 772 592 261 370 133 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:38:13.717877 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 094 321 247 000ns (GuestNow=1 772 596 591 964 468 000 ns GuestLast=1 772 594 497 643 221 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:41:33.913194 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 525 228 000ns (GuestNow=1 772 600 564 328 783 000 ns GuestLast=1 772 598 466 803 555 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): Guest Log: 01:49:56.373452 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 852 216 633 000ns (GuestNow=1 772 602 908 928 322 000 ns GuestLast=1 772 601 056 711 689 000 ns fSetTimeLastLoop=true )
2026-03-04 07:55:28 (58886): ERROR: VM failed to start
2026-03-04 07:55:33 (58886): 
   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.

2026-03-04 09:04:45 (60143): vboxwrapper version 26210
2026-03-04 09:04:45 (60143): BOINC client version: 8.2.8
2026-03-04 09:04:45 (60143): Detected: VirtualBox VboxManage Interface (Version: 7.2.4)
2026-03-04 09:04:45 (60143): Detected: Sandbox Configuration Enabled
2026-03-04 09:04:45 (60143): Guest Log: 00:20:02.579268 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 512 237 000ns (GuestNow=1 772 525 734 550 147 000 ns GuestLast=1 772 523 637 037 910 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 00:21:42.686278 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 814 168 000ns (GuestNow=1 772 527 922 452 419 000 ns GuestLast=1 772 525 824 638 251 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 00:25:03.626203 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 030 422 108 000ns (GuestNow=1 772 530 143 533 282 000 ns GuestLast=1 772 528 113 111 174 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 00:41:50.070196 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 987 955 883 000ns (GuestNow=1 772 541 337 978 676 000 ns GuestLast=1 772 539 350 022 793 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 00:44:20.933265 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 054 189 662 000ns (GuestNow=1 772 543 532 919 843 000 ns GuestLast=1 772 541 478 730 181 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 00:47:43.035830 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 827 067 628 000ns (GuestNow=1 772 545 551 932 368 000 ns GuestLast=1 772 543 724 864 740 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 00:52:44.592027 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 337 547 000ns (GuestNow=1 772 550 851 655 617 000 ns GuestLast=1 772 548 753 318 070 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 00:55:15.661433 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 085 148 303 000ns (GuestNow=1 772 553 077 697 885 000 ns GuestLast=1 772 550 992 549 582 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:00:18.842754 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 199 582 000ns (GuestNow=1 772 558 461 376 210 000 ns GuestLast=1 772 556 363 176 628 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:02:59.131093 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 064 524 162 000ns (GuestNow=1 772 560 676 187 071 000 ns GuestLast=1 772 558 611 662 909 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:04:39.197087 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 907 033 000ns (GuestNow=1 772 562 864 155 513 000 ns GuestLast=1 772 560 766 248 480 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:09:39.492896 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 797 772 000ns (GuestNow=1 772 568 650 172 638 000 ns GuestLast=1 772 566 552 374 866 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:15:30.031999 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 059 690 309 000ns (GuestNow=1 772 572 657 570 121 000 ns GuestLast=1 772 570 597 879 812 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:18:00.162881 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 095 715 410 000ns (GuestNow=1 772 574 893 387 551 000 ns GuestLast=1 772 572 797 672 141 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:19:40.226449 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 100 717 806 000ns (GuestNow=1 772 577 084 158 624 000 ns GuestLast=1 772 574 983 440 818 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:22:10.350825 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 091 820 228 000ns (GuestNow=1 772 579 316 091 546 000 ns GuestLast=1 772 577 224 271 318 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:23:50.449843 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 791 450 000ns (GuestNow=1 772 581 504 962 126 000 ns GuestLast=1 772 579 406 170 676 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:27:12.218258 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 406 502 000ns (GuestNow=1 772 585 565 312 654 000 ns GuestLast=1 772 583 467 906 152 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:29:43.066598 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 058 259 013 000ns (GuestNow=1 772 587 764 388 040 000 ns GuestLast=1 772 585 706 129 027 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:31:33.137340 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 098 674 927 000ns (GuestNow=1 772 589 963 130 770 000 ns GuestLast=1 772 587 864 455 843 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:34:03.245471 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 068 080 114 000ns (GuestNow=1 772 592 171 308 670 000 ns GuestLast=1 772 590 103 228 556 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:35:43.344274 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 095 909 933 000ns (GuestNow=1 772 594 357 280 066 000 ns GuestLast=1 772 592 261 370 133 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:38:13.717877 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 094 321 247 000ns (GuestNow=1 772 596 591 964 468 000 ns GuestLast=1 772 594 497 643 221 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:41:33.913194 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 097 525 228 000ns (GuestNow=1 772 600 564 328 783 000 ns GuestLast=1 772 598 466 803 555 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Guest Log: 01:49:56.373452 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 852 216 633 000ns (GuestNow=1 772 602 908 928 322 000 ns GuestLast=1 772 601 056 711 689 000 ns fSetTimeLastLoop=true )
2026-03-04 09:04:45 (60143): Starting VM using VBoxManage interface. (boinc_80e8cf7944ec9827, slot#4)
2026-03-04 09:04:55 (60143): Successfully started VM. (PID = '60175')
2026-03-04 09:04:55 (60143): Reporting VM Process ID to BOINC.
2026-03-04 09:04:55 (60143): VM state change detected. (old = 'poweredoff', new = 'running')
2026-03-04 09:04:55 (60143): Detected: Web Application Enabled (http://localhost:52320)
2026-03-04 09:04:55 (60143): Status Report: Elapsed Time: '6662.848749'
2026-03-04 09:04:55 (60143): Status Report: CPU Time: '34376.160000'
2026-03-04 09:04:55 (60143): Preference change detected
2026-03-04 09:04:55 (60143): Setting CPU throttle for VM. (100%)
2026-03-04 09:04:55 (60143): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2026-03-04 09:05:00 (60143): Guest Log: 01:53:16.867509 timesync vgsvcTimeSyncWorker: Radical host time change: 5 620 674 000 000ns (HostNow=1 772 611 499 837 000 000 ns HostLast=1 772 605 879 163 000 000 ns)
2026-03-04 09:05:10 (60143): Guest Log: 01:53:26.884904 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 664 521 136 000ns (GuestNow=1 772 611 509 855 931 000 ns GuestLast=1 772 604 845 334 795 000 ns fSetTimeLastLoop=true )
2026-03-04 09:06:16 (60143): Stopping VM.
2026-03-04 09:06:28 (60143): Successfully stopped VM.
2026-03-04 09:29:06 (1771): vboxwrapper version 26210
2026-03-04 09:29:06 (1771): BOINC client version: 8.2.8
2026-03-04 09:29:08 (1771): Detected: VirtualBox VboxManage Interface (Version: 7.2.4)
2026-03-04 09:29:08 (1771): Detected: Sandbox Configuration Enabled
2026-03-04 09:29:08 (1771): Guest Log: 01:53:16.867509 timesync vgsvcTimeSyncWorker: Radical host time change: 5 620 674 000 000ns (HostNow=1 772 611 499 837 000 000 ns HostLast=1 772 605 879 163 000 000 ns)
2026-03-04 09:29:08 (1771): Guest Log: 01:53:26.884904 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 664 521 136 000ns (GuestNow=1 772 611 509 855 931 000 ns GuestLast=1 772 604 845 334 795 000 ns fSetTimeLastLoop=true )
2026-03-04 09:29:08 (1771): Starting VM using VBoxManage interface. (boinc_80e8cf7944ec9827, slot#4)
2026-03-04 09:29:17 (1771): Successfully started VM. (PID = '1805')
2026-03-04 09:29:17 (1771): Reporting VM Process ID to BOINC.
2026-03-04 09:29:17 (1771): VM state change detected. (old = 'poweredoff', new = 'running')
2026-03-04 09:29:17 (1771): Detected: Web Application Enabled (http://localhost:52320)
2026-03-04 09:29:17 (1771): Status Report: Elapsed Time: '6743.848749'
2026-03-04 09:29:17 (1771): Status Report: CPU Time: '34848.000000'
2026-03-04 09:29:17 (1771): Preference change detected
2026-03-04 09:29:17 (1771): Setting CPU throttle for VM. (100%)
2026-03-04 09:29:17 (1771): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2026-03-04 10:36:42 (1771): Guest Log:  *** Job finished ***
2026-03-04 10:36:42 (1771): Guest Log:  *** The last 20 lines of the pilot log: ***
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:09,290 | INFO     | [payload] run_realtimelog thread has finished
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:10,135 [wrapper] supervise_pilot (15 min periods counter: 13)
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:30,944 | INFO     | [monitor] cgroup control has ended
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:33,049 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139685967230784)>', '<ExcThread(monitor, started 139685531731712)>']
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:33,188 | WARNING  | job_aborted has been set - aborting pilot monitoring
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:33,189 | INFO     | [monitor] control thread has ended
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,057 | INFO     | all workflow threads have been joined
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,057 | INFO     | end of generic workflow (traces error code: 0)
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,057 | INFO     | traces error code: 0
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,057 | INFO     | pilot has finished (exit code=0, shell exit code=0)
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,171 [wrapper] ==== pilot stdout END ====
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,181 [wrapper] ==== wrapper stdout RESUME ====
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,193 [wrapper] pilotpid: 6031
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,207 [wrapper] Pilot exit status: 0
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,303 [wrapper] pandaids: 7035911684
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,362 [wrapper] cleanup supervisor_pilot 28282 6032
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,375 [wrapper] Test setup, not cleaning
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,384 [wrapper] apfmon messages muted
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,395 [wrapper] ==== wrapper stdout END ====
2026-03-04 10:36:42 (1771): Guest Log: 2026-03-04 09:36:38,404 [wrapper] ==== wrapper stderr END ====
2026-03-04 10:36:42 (1771): Guest Log:  *** Error codes and diagnostics ***
2026-03-04 10:36:42 (1771): Guest Log:     "exeErrorCode": 0,
2026-03-04 10:36:42 (1771): Guest Log:     "exeErrorDiag": "",
2026-03-04 10:36:42 (1771): Guest Log:     "pilotErrorCode": 0,
2026-03-04 10:36:42 (1771): Guest Log:     "pilotErrorDiag": "",
2026-03-04 10:36:42 (1771): Guest Log:  *** Listing of results directory ***
2026-03-04 10:36:42 (1771): Guest Log: total 153312
2026-03-04 10:36:42 (1771): Guest Log: -rw-r--r--. 1 atlas atlas    584627 Mar  2 09:36 pilot3.tar.gz
2026-03-04 10:36:42 (1771): Guest Log: -rwx------. 1 atlas atlas     36322 Mar  2 09:37 runpilot2-wrapper.sh
2026-03-04 10:36:42 (1771): Guest Log: -rw-r--r--. 1 atlas atlas      5111 Mar  2 09:38 queuedata.json
2026-03-04 10:36:42 (1771): Guest Log: -rw-r-----. 1 atlas atlas     15845 Mar  3 07:10 start_atlas.sh
2026-03-04 10:36:42 (1771): Guest Log: -rw-r-----. 1 atlas atlas    597983 Mar  3 07:10 input.tar.gz
2026-03-04 10:36:42 (1771): Guest Log: -rw-r--r--. 1 atlas atlas      8026 Mar  3 07:10 init_data.xml
2026-03-04 10:36:42 (1771): Guest Log: lrwxrwxrwx. 1 atlas atlas        20 Mar  3 07:10 EVNT.48454437._000001.pool.root.1 -> /data/./ATLAS.root_0
2026-03-04 10:36:42 (1771): Guest Log: -rw-r--r--. 1 atlas atlas      2647 Mar  3 07:10 pandaJob.out
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas    998412 Mar  3 07:11 agis_schedconf.cvmfs.json
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas       438 Mar  3 07:11 workernode_map.json
2026-03-04 10:36:42 (1771): Guest Log: drwx------. 5 atlas atlas      4096 Mar  3 07:11 pilot3
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas        97 Mar  4 09:35 pilot_heartbeat.json
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas 149150136 Mar  4 09:35 HITS.48844857._000004.pool.root.1
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas      1034 Mar  4 09:35 memory_monitor_summary.json
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas   1516092 Mar  4 09:35 agis_ddmendpoints.agis.ALL.json
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas    390924 Mar  4 09:35 log.48844857._000004.job.log.tgz.1
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas      6380 Mar  4 09:35 heartbeat.json
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas      5195 Mar  4 09:36 pilotlog.txt
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas   1602092 Mar  4 09:36 log.48844857._000004.job.log.1
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas       357 Mar  4 09:36 output.list
2026-03-04 10:36:42 (1771): Guest Log: -rw-r--r--. 1 atlas atlas       620 Mar  4 09:36 runtime_log
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas   2007040 Mar  4 09:36 result.tar.gz
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas       681 Mar  4 09:36 T1tKDmNtEH9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmZ2CLDmzE4x2n.diag
2026-03-04 10:36:42 (1771): Guest Log: -rw-r--r--. 1 atlas atlas      8821 Mar  4 09:36 runtime_log.err
2026-03-04 10:36:42 (1771): Guest Log: Looking for outputfile HITS.48844857._000004.pool.root.1
2026-03-04 10:36:42 (1771): Guest Log: HITS file was successfully produced
2026-03-04 10:36:42 (1771): Guest Log: -rw-------. 1 atlas atlas 149150136 Mar  4 09:35 /home/atlas/RunAtlas/HITS.48844857._000004.pool.root.1
2026-03-04 10:36:42 (1771): Guest Log: Successfully finished the ATLAS job!
2026-03-04 10:36:42 (1771): Guest Log: Copying the results back to the shared directory!
2026-03-04 10:36:42 (1771): Guest Log:  *** Contents of shared directory: ***
2026-03-04 10:36:42 (1771): Guest Log: total 206964
2026-03-04 10:36:42 (1771): Guest Log: -rw-rw----. 1 root root 209301163 Mar  3 07:09 ATLAS.root_0
2026-03-04 10:36:42 (1771): Guest Log: -rw-rw-r--. 1 root root      8026 Mar  3 07:09 init_data.xml
2026-03-04 10:36:42 (1771): Guest Log: -rw-rw----. 1 root root    597983 Mar  3 07:09 input.tar.gz
2026-03-04 10:36:42 (1771): Guest Log: -rw-r--r--. 1 root root   2007040 Mar  4  2026 result.tar.gz
2026-03-04 10:36:42 (1771): Guest Log: -rw-rw----. 1 root root     15845 Mar  3 07:09 start_atlas.sh
2026-03-04 10:36:42 (1771): Guest Log:  *** Success! Shutting down the machine. ***
2026-03-04 10:36:42 (1771): VM Completion File Detected.
2026-03-04 10:36:42 (1771): Powering off VM.
2026-03-04 10:36:43 (1771): Successfully stopped VM.
2026-03-04 10:36:43 (1771): Deregistering VM. (boinc_80e8cf7944ec9827, slot#4)
2026-03-04 10:36:43 (1771): Removing network bandwidth throttle group from VM.
2026-03-04 10:36:43 (1771): Removing VM from VirtualBox.
2026-03-04 10:36:48 (1771): called boinc_finish(0)

</stderr_txt>
]]>


©2026 CERN