Name vK4KDm0QcO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmXbWLDmdGlWEo_0
Workunit 231617542
Created 14 Apr 2025, 17:06:07 UTC
Sent 14 Apr 2025, 21:06:40 UTC
Report deadline 22 Apr 2025, 21:06:40 UTC
Received 17 Apr 2025, 12:47:16 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status 0 (0x00000000)
Computer ID 10861508
Run time 59 min 18 sec
CPU time 3 hours 27 min 47 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 33.68 GFLOPS
Application version ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas)
x86_64-pc-linux-gnu
Peak working set size 4.05 GB
Peak swap size 5.94 GB
Peak disk usage 1.84 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2025-04-14 22:07:13 (37303): Detected: vboxwrapper 26206
2025-04-14 22:07:13 (37303): Detected: BOINC client v8.0.2
2025-04-14 22:07:13 (37303): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-14 22:07:13 (37303): Successfully copied 'init_data.xml' to the shared directory.
2025-04-14 22:07:13 (37303): Create VM. (boinc_0726468ea6d26e76, slot#2)
2025-04-14 22:07:13 (37303): Setting Memory Size for VM. (4800MB)
2025-04-14 22:07:13 (37303): Setting CPU Count for VM. (8)
2025-04-14 22:07:14 (37303): Setting Chipset Options for VM.
2025-04-14 22:07:14 (37303): Setting Graphics Controller Options for VM.
2025-04-14 22:07:14 (37303): Setting Boot Options for VM.
2025-04-14 22:07:14 (37303): Setting Network Configuration for NAT.
2025-04-14 22:07:14 (37303): Enabling VM Network Access.
2025-04-14 22:07:14 (37303): Disabling USB Support for VM.
2025-04-14 22:07:14 (37303): Disabling COM Port Support for VM.
2025-04-14 22:07:14 (37303): Disabling LPT Port Support for VM.
2025-04-14 22:07:14 (37303): Disabling Audio Support for VM.
2025-04-14 22:07:14 (37303): Disabling Clipboard Support for VM.
2025-04-14 22:07:14 (37303): Disabling Drag and Drop Support for VM.
2025-04-14 22:07:14 (37303): Adding storage controller(s) to VM.
2025-04-14 22:07:14 (37303): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi)
2025-04-14 22:07:16 (37303): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-04-14 22:07:16 (37303): forwarding host port 58387 to guest port 80
2025-04-14 22:07:16 (37303): Enabling remote desktop for VM.
2025-04-14 22:07:16 (37303): Required extension pack not installed, remote desktop not enabled.
2025-04-14 22:07:16 (37303): Enabling shared directory for VM.
2025-04-14 22:07:16 (37303): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-14 22:07:17 (37303): Successfully started VM. (PID = '37900')
2025-04-14 22:07:17 (37303): Reporting VM Process ID to BOINC.
2025-04-14 22:07:17 (37303): Guest Log: BIOS: VirtualBox 7.1.6
2025-04-14 22:07:17 (37303): Guest Log: CPUID EDX: 0x178bfbff
2025-04-14 22:07:17 (37303): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-14 22:07:17 (37303): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-14 22:07:17 (37303): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-14 22:07:17 (37303): Detected: Web Application Enabled (http://localhost:58387)
2025-04-14 22:07:17 (37303): Preference change detected
2025-04-14 22:07:17 (37303): Setting CPU throttle for VM. (100%)
2025-04-14 22:07:17 (37303): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-14 22:07:19 (37303): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-14 22:07:19 (37303): Guest Log: BIOS: Booting from Hard Disk...
2025-04-14 22:07:22 (37303): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-14 22:07:22 (37303): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-14 22:07:22 (37303): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-14 22:07:28 (37303): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-14 22:07:28 (37303): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-14 22:07:33 (37303): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-14 22:07:33 (37303): Guest Log: 00:00:00.000287 main     Log opened 2025-04-14T21:07:32.896403000Z
2025-04-14 22:07:33 (37303): Guest Log: 00:00:00.000380 main     OS Product: Linux
2025-04-14 22:07:33 (37303): Guest Log: 00:00:00.000395 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-14 22:07:33 (37303): Guest Log: 00:00:00.000407 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-14 22:07:33 (37303): Guest Log: 00:00:00.000420 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-14 22:07:33 (37303): Guest Log: 00:00:00.000420 main     Process ID: 1216
2025-04-14 22:07:33 (37303): Guest Log: 00:00:00.000420 main     Package type: LINUX_64BITS_GENERIC
2025-04-14 22:07:33 (37303): Guest Log: 00:00:00.001765 main     5.2.32 r132073 started. Verbose level = 0
2025-04-14 22:08:03 (37303): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-14 22:08:03 (37303): Guest Log: [INFO] Mounting shared directory
2025-04-14 22:08:03 (37303): Guest Log: [INFO] Checking for init_data.xml
2025-04-14 22:08:26 (37303): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 22:10:46 (37303): VM state change detected. (old = 'paused', new = 'running')
2025-04-14 22:12:02 (37303): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-14 22:12:02 (37303): Guest Log: [INFO] Detected branch: prod
2025-04-14 22:12:02 (37303): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-14 22:12:02 (37303): Guest Log: Copying input files
2025-04-14 22:12:03 (37303): Guest Log: Copied input files into RunAtlas.
2025-04-14 22:12:03 (37303): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-14 22:12:03 (37303): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-14 22:12:03 (37303): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-14 22:12:03 (37303): Guest Log: Further information can be found at the LHC@home message board.
2025-04-14 22:12:56 (37303): Stopping VM.
2025-04-14 22:12:58 (37303): Successfully stopped VM.
2025-04-14 22:18:12 (40710): Detected: vboxwrapper 26206
2025-04-14 22:18:12 (40710): Detected: BOINC client v8.0.2
2025-04-14 22:18:13 (40710): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-14 22:18:13 (40710): Guest Log: BIOS: VirtualBox 7.1.6
2025-04-14 22:18:13 (40710): Guest Log: CPUID EDX: 0x178bfbff
2025-04-14 22:18:13 (40710): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-14 22:18:13 (40710): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-14 22:18:13 (40710): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-14 22:18:13 (40710): Guest Log: BIOS: Booting from Hard Disk...
2025-04-14 22:18:13 (40710): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-14 22:18:13 (40710): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-14 22:18:13 (40710): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-14 22:18:13 (40710): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-14 22:18:13 (40710): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-14 22:18:13 (40710): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-14 22:18:13 (40710): Guest Log: 00:00:00.000287 main     Log opened 2025-04-14T21:07:32.896403000Z
2025-04-14 22:18:13 (40710): Guest Log: 00:00:00.000380 main     OS Product: Linux
2025-04-14 22:18:13 (40710): Guest Log: 00:00:00.000395 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-14 22:18:13 (40710): Guest Log: 00:00:00.000407 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-14 22:18:13 (40710): Guest Log: 00:00:00.000420 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-14 22:18:13 (40710): Guest Log: 00:00:00.000420 main     Process ID: 1216
2025-04-14 22:18:13 (40710): Guest Log: 00:00:00.000420 main     Package type: LINUX_64BITS_GENERIC
2025-04-14 22:18:13 (40710): Guest Log: 00:00:00.001765 main     5.2.32 r132073 started. Verbose level = 0
2025-04-14 22:18:13 (40710): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-14 22:18:13 (40710): Guest Log: [INFO] Mounting shared directory
2025-04-14 22:18:13 (40710): Guest Log: [INFO] Checking for init_data.xml
2025-04-14 22:18:13 (40710): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-14 22:18:13 (40710): Guest Log: [INFO] Detected branch: prod
2025-04-14 22:18:13 (40710): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-14 22:18:13 (40710): Guest Log: Copying input files
2025-04-14 22:18:13 (40710): Guest Log: Copied input files into RunAtlas.
2025-04-14 22:18:13 (40710): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-14 22:18:13 (40710): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-14 22:18:13 (40710): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-14 22:18:13 (40710): Guest Log: Further information can be found at the LHC@home message board.
2025-04-14 22:18:13 (40710): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-14 22:18:14 (40710): Successfully started VM. (PID = '40848')
2025-04-14 22:18:14 (40710): Reporting VM Process ID to BOINC.
2025-04-14 22:18:14 (40710): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-14 22:18:14 (40710): Detected: Web Application Enabled (http://localhost:58387)
2025-04-14 22:18:14 (40710): Preference change detected
2025-04-14 22:18:14 (40710): Setting CPU throttle for VM. (100%)
2025-04-14 22:18:14 (40710): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-14 22:18:28 (40710): Stopping VM.
2025-04-14 22:18:30 (40710): Successfully stopped VM.
2025-04-14 22:52:34 (49628): Detected: vboxwrapper 26206
2025-04-14 22:52:34 (49628): Detected: BOINC client v8.0.2
2025-04-14 22:52:34 (49628): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-14 22:52:34 (49628): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-14 22:52:36 (49628): Successfully started VM. (PID = '49767')
2025-04-14 22:52:36 (49628): Reporting VM Process ID to BOINC.
2025-04-14 22:52:36 (49628): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-14 22:52:36 (49628): Detected: Web Application Enabled (http://localhost:58387)
2025-04-14 22:52:36 (49628): Preference change detected
2025-04-14 22:52:36 (49628): Setting CPU throttle for VM. (100%)
2025-04-14 22:52:36 (49628): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-14 22:52:41 (49628): Guest Log: 00:03:41.550720 timesync vgsvcTimeSyncWorker: Radical host time change: 2 055 889 000 000ns (HostNow=1 744 667 560 694 000 000 ns HostLast=1 744 665 504 805 000 000 ns)
2025-04-14 22:52:50 (49628): Guest Log: 00:03:51.802691 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 055 230 490 000ns (GuestNow=1 744 667 570 946 842 000 ns GuestLast=1 744 665 515 716 352 000 ns fSetTimeLastLoop=true )
2025-04-14 22:53:15 (49628): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-14 22:53:15 (49628): 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
2025-04-14 22:53:15 (49628): Guest Log: 2.6.3.0 1682 44 30192 144864 4 1 3119946 4096000 0 65024 0 0 n/a 1171 27 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2025-04-14 22:53:16 (49628): Guest Log: copied the webapp to /var/www
2025-04-14 22:53:16 (49628): Guest Log: ATHENA_PROC_NUMBER=8
2025-04-14 22:53:16 (49628): Guest Log: ATHENA_CORE_NUMBER=8
2025-04-14 22:53:16 (49628): 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 
2025-04-14 22:53:16 (49628): Guest Log:  *** Starting ATLAS job. (PandaID=6602132756 taskID=44075483) ***
2025-04-14 23:02:54 (49628): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 23:03:15 (49628): VM state change detected. (old = 'paused', new = 'running')
2025-04-14 23:07:15 (49628): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 23:07:36 (49628): VM state change detected. (old = 'paused', new = 'running')
2025-04-14 23:08:06 (49628): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 23:08:25 (49628): VM state change detected. (old = 'paused', new = 'running')
2025-04-14 23:08:36 (49628): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 23:08:56 (49628): VM state change detected. (old = 'paused', new = 'running')
2025-04-14 23:10:06 (49628): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 23:10:26 (49628): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 15:48:04 (1925): Detected: vboxwrapper 26206
2025-04-15 15:48:04 (1925): Detected: BOINC client v8.0.2
2025-04-15 15:48:04 (1925): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-15 15:48:05 (1925): Guest Log: 00:03:41.550720 timesync vgsvcTimeSyncWorker: Radical host time change: 2 055 889 000 000ns (HostNow=1 744 667 560 694 000 000 ns HostLast=1 744 665 504 805 000 000 ns)
2025-04-15 15:48:05 (1925): Guest Log: 00:03:51.802691 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 055 230 490 000ns (GuestNow=1 744 667 570 946 842 000 ns GuestLast=1 744 665 515 716 352 000 ns fSetTimeLastLoop=true )
2025-04-15 15:48:05 (1925): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-15 15:48:05 (1925): 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
2025-04-15 15:48:05 (1925): Guest Log: 2.6.3.0 1682 44 30192 144864 4 1 3119946 4096000 0 65024 0 0 n/a 1171 27 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2025-04-15 15:48:05 (1925): Guest Log: copied the webapp to /var/www
2025-04-15 15:48:05 (1925): Guest Log: ATHENA_PROC_NUMBER=8
2025-04-15 15:48:05 (1925): Guest Log: ATHENA_CORE_NUMBER=8
2025-04-15 15:48:05 (1925): 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 
2025-04-15 15:48:05 (1925): Guest Log:  *** Starting ATLAS job. (PandaID=6602132756 taskID=44075483) ***
2025-04-15 15:48:05 (1925): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-15 15:48:06 (1925): Successfully started VM. (PID = '2066')
2025-04-15 15:48:06 (1925): Reporting VM Process ID to BOINC.
2025-04-15 15:48:06 (1925): Guest Log: BIOS: VirtualBox 7.1.6
2025-04-15 15:48:06 (1925): Guest Log: CPUID EDX: 0x178bfbff
2025-04-15 15:48:06 (1925): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-15 15:48:06 (1925): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-15 15:48:06 (1925): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-15 15:48:06 (1925): Detected: Web Application Enabled (http://localhost:58387)
2025-04-15 15:48:06 (1925): Preference change detected
2025-04-15 15:48:06 (1925): Setting CPU throttle for VM. (100%)
2025-04-15 15:48:06 (1925): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-15 15:48:08 (1925): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-15 15:48:08 (1925): Guest Log: BIOS: Booting from Hard Disk...
2025-04-15 15:48:11 (1925): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-15 15:48:11 (1925): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-15 15:48:11 (1925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-15 15:48:18 (1925): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-15 15:48:18 (1925): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-15 15:48:21 (1925): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-15 15:48:21 (1925): Guest Log: 00:00:00.000128 main     Log opened 2025-04-15T14:48:20.382925000Z
2025-04-15 15:48:21 (1925): Guest Log: 00:00:00.000197 main     OS Product: Linux
2025-04-15 15:48:21 (1925): Guest Log: 00:00:00.000211 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-15 15:48:21 (1925): Guest Log: 00:00:00.000223 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-15 15:48:21 (1925): Guest Log: 00:00:00.000234 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-15 15:48:21 (1925): Guest Log: 00:00:00.000234 main     Process ID: 1358
2025-04-15 15:48:21 (1925): Guest Log: 00:00:00.000235 main     Package type: LINUX_64BITS_GENERIC
2025-04-15 15:48:21 (1925): Guest Log: 00:00:00.001241 main     5.2.32 r132073 started. Verbose level = 0
2025-04-15 15:48:34 (1925): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-15 15:48:34 (1925): Guest Log: [INFO] Mounting shared directory
2025-04-15 15:48:34 (1925): Guest Log: [INFO] Checking for init_data.xml
2025-04-15 15:48:56 (1925): Stopping VM.
2025-04-15 15:48:57 (1925): Successfully stopped VM.
2025-04-15 22:16:16 (77904): Detected: vboxwrapper 26206
2025-04-15 22:16:16 (77904): Detected: BOINC client v8.0.2
2025-04-15 22:16:16 (77904): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-15 22:16:17 (77904): Guest Log: BIOS: VirtualBox 7.1.6
2025-04-15 22:16:17 (77904): Guest Log: CPUID EDX: 0x178bfbff
2025-04-15 22:16:17 (77904): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-15 22:16:17 (77904): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-15 22:16:17 (77904): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-15 22:16:17 (77904): Guest Log: BIOS: Booting from Hard Disk...
2025-04-15 22:16:17 (77904): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-15 22:16:17 (77904): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-15 22:16:17 (77904): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-15 22:16:17 (77904): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-15 22:16:17 (77904): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-15 22:16:17 (77904): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-15 22:16:17 (77904): Guest Log: 00:00:00.000128 main     Log opened 2025-04-15T14:48:20.382925000Z
2025-04-15 22:16:17 (77904): Guest Log: 00:00:00.000197 main     OS Product: Linux
2025-04-15 22:16:17 (77904): Guest Log: 00:00:00.000211 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-15 22:16:17 (77904): Guest Log: 00:00:00.000223 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-15 22:16:17 (77904): Guest Log: 00:00:00.000234 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-15 22:16:17 (77904): Guest Log: 00:00:00.000234 main     Process ID: 1358
2025-04-15 22:16:17 (77904): Guest Log: 00:00:00.000235 main     Package type: LINUX_64BITS_GENERIC
2025-04-15 22:16:17 (77904): Guest Log: 00:00:00.001241 main     5.2.32 r132073 started. Verbose level = 0
2025-04-15 22:16:17 (77904): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-15 22:16:17 (77904): Guest Log: [INFO] Mounting shared directory
2025-04-15 22:16:17 (77904): Guest Log: [INFO] Checking for init_data.xml
2025-04-15 22:16:17 (77904): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-15 22:16:18 (77904): Successfully started VM. (PID = '78048')
2025-04-15 22:16:18 (77904): Reporting VM Process ID to BOINC.
2025-04-15 22:16:18 (77904): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-15 22:16:18 (77904): Detected: Web Application Enabled (http://localhost:58387)
2025-04-15 22:16:18 (77904): Preference change detected
2025-04-15 22:16:18 (77904): Setting CPU throttle for VM. (100%)
2025-04-15 22:16:18 (77904): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-15 22:16:20 (77904): Guest Log: 00:00:40.289082 timesync vgsvcTimeSyncWorker: Radical host time change: 23 250 864 000 000ns (HostNow=1 744 751 780 564 000 000 ns HostLast=1 744 728 529 700 000 000 ns)
2025-04-15 22:16:23 (77904): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 22:16:43 (77904): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 22:16:50 (77904): Guest Log: 00:00:50.372813 timesync vgsvcTimeSyncWorker: Radical guest time change: 23 249 979 072 000ns (GuestNow=1 744 751 790 649 142 000 ns GuestLast=1 744 728 540 670 070 000 ns fSetTimeLastLoop=true )
2025-04-15 22:17:04 (77904): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 22:17:24 (77904): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 22:17:53 (77904): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-15 22:17:53 (77904): Guest Log: [INFO] Detected branch: prod
2025-04-15 22:17:53 (77904): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-15 22:17:53 (77904): Guest Log: Copying input files
2025-04-15 22:17:54 (77904): Guest Log: Copied input files into RunAtlas.
2025-04-15 22:17:54 (77904): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-15 22:17:54 (77904): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-15 22:17:54 (77904): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-15 22:17:54 (77904): Guest Log: Further information can be found at the LHC@home message board.
2025-04-15 22:19:30 (77904): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-15 22:19:30 (77904): 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
2025-04-15 22:19:30 (77904): Guest Log: 2.6.3.0 1772 2 32176 144904 4 1 4012364 4096000 0 65024 0 0 n/a 1 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-04-15 22:19:30 (77904): Guest Log: copied the webapp to /var/www
2025-04-15 22:19:30 (77904): Guest Log: ATHENA_PROC_NUMBER=8
2025-04-15 22:19:30 (77904): Guest Log: ATHENA_CORE_NUMBER=8
2025-04-15 22:19:30 (77904): 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 
2025-04-15 22:19:30 (77904): Guest Log:  *** Starting ATLAS job. (PandaID=6602132756 taskID=44075483) ***
2025-04-15 22:21:54 (77904): Stopping VM.
2025-04-15 22:21:57 (77904): Successfully stopped VM.
2025-04-15 22:29:41 (81142): Detected: vboxwrapper 26206
2025-04-15 22:29:41 (81142): Detected: BOINC client v8.0.2
2025-04-15 22:29:41 (81142): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-15 22:29:41 (81142): Guest Log: 00:00:40.289082 timesync vgsvcTimeSyncWorker: Radical host time change: 23 250 864 000 000ns (HostNow=1 744 751 780 564 000 000 ns HostLast=1 744 728 529 700 000 000 ns)
2025-04-15 22:29:41 (81142): Guest Log: 00:00:50.372813 timesync vgsvcTimeSyncWorker: Radical guest time change: 23 249 979 072 000ns (GuestNow=1 744 751 790 649 142 000 ns GuestLast=1 744 728 540 670 070 000 ns fSetTimeLastLoop=true )
2025-04-15 22:29:41 (81142): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-15 22:29:41 (81142): Guest Log: [INFO] Detected branch: prod
2025-04-15 22:29:41 (81142): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-15 22:29:41 (81142): Guest Log: Copying input files
2025-04-15 22:29:41 (81142): Guest Log: Copied input files into RunAtlas.
2025-04-15 22:29:41 (81142): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-15 22:29:41 (81142): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-15 22:29:41 (81142): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-15 22:29:41 (81142): Guest Log: Further information can be found at the LHC@home message board.
2025-04-15 22:29:41 (81142): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-15 22:29:41 (81142): 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
2025-04-15 22:29:41 (81142): Guest Log: 2.6.3.0 1772 2 32176 144904 4 1 4012364 4096000 0 65024 0 0 n/a 1 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-04-15 22:29:41 (81142): Guest Log: copied the webapp to /var/www
2025-04-15 22:29:41 (81142): Guest Log: ATHENA_PROC_NUMBER=8
2025-04-15 22:29:41 (81142): Guest Log: ATHENA_CORE_NUMBER=8
2025-04-15 22:29:41 (81142): 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 
2025-04-15 22:29:41 (81142): Guest Log:  *** Starting ATLAS job. (PandaID=6602132756 taskID=44075483) ***
2025-04-15 22:29:41 (81142): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-15 22:29:44 (81142): Successfully started VM. (PID = '81298')
2025-04-15 22:29:44 (81142): Reporting VM Process ID to BOINC.
2025-04-15 22:29:44 (81142): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-15 22:29:44 (81142): Detected: Web Application Enabled (http://localhost:58387)
2025-04-15 22:29:44 (81142): Preference change detected
2025-04-15 22:29:44 (81142): Setting CPU throttle for VM. (100%)
2025-04-15 22:29:44 (81142): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-15 22:29:47 (81142): Stopping VM.
2025-04-15 22:29:50 (81142): Successfully stopped VM.
2025-04-15 22:50:58 (84277): Detected: vboxwrapper 26206
2025-04-15 22:50:58 (84277): Detected: BOINC client v8.0.2
2025-04-15 22:50:58 (84277): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-15 22:50:58 (84277): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-15 22:51:01 (84277): Successfully started VM. (PID = '84416')
2025-04-15 22:51:01 (84277): Reporting VM Process ID to BOINC.
2025-04-15 22:51:01 (84277): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-15 22:51:01 (84277): Detected: Web Application Enabled (http://localhost:58387)
2025-04-15 22:51:01 (84277): Preference change detected
2025-04-15 22:51:01 (84277): Setting CPU throttle for VM. (100%)
2025-04-15 22:51:01 (84277): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-15 22:51:14 (84277): Stopping VM.
2025-04-15 22:51:17 (84277): Successfully stopped VM.
2025-04-15 22:54:49 (85367): Detected: vboxwrapper 26206
2025-04-15 22:54:49 (85367): Detected: BOINC client v8.0.2
2025-04-15 22:54:50 (85367): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-15 22:54:50 (85367): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-15 22:54:52 (85367): Successfully started VM. (PID = '85508')
2025-04-15 22:54:52 (85367): Reporting VM Process ID to BOINC.
2025-04-15 22:54:52 (85367): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-15 22:54:52 (85367): Detected: Web Application Enabled (http://localhost:58387)
2025-04-15 22:54:52 (85367): Preference change detected
2025-04-15 22:54:52 (85367): Setting CPU throttle for VM. (100%)
2025-04-15 22:54:52 (85367): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-15 22:54:55 (85367): Stopping VM.
2025-04-15 22:54:59 (85367): Successfully stopped VM.
2025-04-16 00:21:17 (95685): Detected: vboxwrapper 26206
2025-04-16 00:21:17 (95685): Detected: BOINC client v8.0.2
2025-04-16 00:21:17 (95685): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-16 00:21:17 (95685): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-16 00:21:20 (95685): Successfully started VM. (PID = '95828')
2025-04-16 00:21:20 (95685): Reporting VM Process ID to BOINC.
2025-04-16 00:21:20 (95685): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-16 00:21:20 (95685): Detected: Web Application Enabled (http://localhost:58387)
2025-04-16 00:21:20 (95685): Preference change detected
2025-04-16 00:21:20 (95685): Setting CPU throttle for VM. (100%)
2025-04-16 00:21:20 (95685): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-16 00:21:26 (95685): Guest Log: 00:06:32.742611 timesync vgsvcTimeSyncWorker: Radical host time change: 5 193 026 000 000ns (HostNow=1 744 759 285 603 000 000 ns HostLast=1 744 754 092 577 000 000 ns)
2025-04-16 00:21:35 (95685): Guest Log: 00:06:42.789300 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 192 782 397 000ns (GuestNow=1 744 759 295 649 840 000 ns GuestLast=1 744 754 102 867 443 000 ns fSetTimeLastLoop=true )
2025-04-16 15:43:00 (1907): Detected: vboxwrapper 26206
2025-04-16 15:43:00 (1907): Detected: BOINC client v8.0.2
2025-04-16 15:43:00 (1907): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-16 15:43:01 (1907): Guest Log: 00:06:32.742611 timesync vgsvcTimeSyncWorker: Radical host time change: 5 193 026 000 000ns (HostNow=1 744 759 285 603 000 000 ns HostLast=1 744 754 092 577 000 000 ns)
2025-04-16 15:43:01 (1907): Guest Log: 00:06:42.789300 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 192 782 397 000ns (GuestNow=1 744 759 295 649 840 000 ns GuestLast=1 744 754 102 867 443 000 ns fSetTimeLastLoop=true )
2025-04-16 15:43:01 (1907): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-16 15:43:02 (1907): Successfully started VM. (PID = '2049')
2025-04-16 15:43:02 (1907): Reporting VM Process ID to BOINC.
2025-04-16 15:43:02 (1907): Guest Log: BIOS: VirtualBox 7.1.6
2025-04-16 15:43:02 (1907): Guest Log: CPUID EDX: 0x178bfbff
2025-04-16 15:43:02 (1907): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-16 15:43:02 (1907): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-16 15:43:02 (1907): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-16 15:43:02 (1907): Detected: Web Application Enabled (http://localhost:58387)
2025-04-16 15:43:02 (1907): Preference change detected
2025-04-16 15:43:02 (1907): Setting CPU throttle for VM. (100%)
2025-04-16 15:43:02 (1907): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-16 15:43:04 (1907): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-16 15:43:04 (1907): Guest Log: BIOS: Booting from Hard Disk...
2025-04-16 15:43:07 (1907): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-16 15:43:07 (1907): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-16 15:43:07 (1907): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-16 15:43:13 (1907): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-16 15:43:13 (1907): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-16 15:43:16 (1907): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-16 15:43:16 (1907): Guest Log: 00:00:00.000173 main     Log opened 2025-04-16T14:43:16.376234000Z
2025-04-16 15:43:16 (1907): Guest Log: 00:00:00.000251 main     OS Product: Linux
2025-04-16 15:43:16 (1907): Guest Log: 00:00:00.000264 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-16 15:43:16 (1907): Guest Log: 00:00:00.000276 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-16 15:43:16 (1907): Guest Log: 00:00:00.000287 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-16 15:43:16 (1907): Guest Log: 00:00:00.000287 main     Process ID: 1363
2025-04-16 15:43:16 (1907): Guest Log: 00:00:00.000287 main     Package type: LINUX_64BITS_GENERIC
2025-04-16 15:43:16 (1907): Guest Log: 00:00:00.002884 main     5.2.32 r132073 started. Verbose level = 0
2025-04-16 15:43:27 (1907): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-16 15:43:27 (1907): Guest Log: [INFO] Mounting shared directory
2025-04-16 15:43:27 (1907): Guest Log: [INFO] Checking for init_data.xml
2025-04-16 15:43:51 (1907): Stopping VM.
2025-04-16 15:43:52 (1907): Successfully stopped VM.
2025-04-16 16:07:54 (51927): Detected: vboxwrapper 26206
2025-04-16 16:07:54 (51927): Detected: BOINC client v8.0.2
2025-04-16 16:07:54 (51927): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-16 16:07:54 (51927): Guest Log: BIOS: VirtualBox 7.1.6
2025-04-16 16:07:54 (51927): Guest Log: CPUID EDX: 0x178bfbff
2025-04-16 16:07:54 (51927): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-16 16:07:54 (51927): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-16 16:07:54 (51927): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-16 16:07:54 (51927): Guest Log: BIOS: Booting from Hard Disk...
2025-04-16 16:07:54 (51927): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-16 16:07:54 (51927): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-16 16:07:54 (51927): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-16 16:07:54 (51927): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-16 16:07:54 (51927): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-16 16:07:54 (51927): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-16 16:07:54 (51927): Guest Log: 00:00:00.000173 main     Log opened 2025-04-16T14:43:16.376234000Z
2025-04-16 16:07:54 (51927): Guest Log: 00:00:00.000251 main     OS Product: Linux
2025-04-16 16:07:54 (51927): Guest Log: 00:00:00.000264 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-16 16:07:54 (51927): Guest Log: 00:00:00.000276 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-16 16:07:54 (51927): Guest Log: 00:00:00.000287 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-16 16:07:54 (51927): Guest Log: 00:00:00.000287 main     Process ID: 1363
2025-04-16 16:07:54 (51927): Guest Log: 00:00:00.000287 main     Package type: LINUX_64BITS_GENERIC
2025-04-16 16:07:54 (51927): Guest Log: 00:00:00.002884 main     5.2.32 r132073 started. Verbose level = 0
2025-04-16 16:07:54 (51927): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-16 16:07:54 (51927): Guest Log: [INFO] Mounting shared directory
2025-04-16 16:07:54 (51927): Guest Log: [INFO] Checking for init_data.xml
2025-04-16 16:07:54 (51927): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-16 16:07:56 (51927): Successfully started VM. (PID = '52071')
2025-04-16 16:07:56 (51927): Reporting VM Process ID to BOINC.
2025-04-16 16:07:56 (51927): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-16 16:07:56 (51927): Detected: Web Application Enabled (http://localhost:58387)
2025-04-16 16:07:56 (51927): Preference change detected
2025-04-16 16:07:56 (51927): Setting CPU throttle for VM. (100%)
2025-04-16 16:07:56 (51927): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-16 16:08:10 (51927): Stopping VM.
2025-04-16 16:08:11 (51927): Successfully stopped VM.
2025-04-16 17:27:49 (59211): Detected: vboxwrapper 26206
2025-04-16 17:27:49 (59211): Detected: BOINC client v8.0.2
2025-04-16 17:27:50 (59211): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-16 17:27:50 (59211): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-16 17:27:51 (59211): Successfully started VM. (PID = '59353')
2025-04-16 17:27:51 (59211): Reporting VM Process ID to BOINC.
2025-04-16 17:27:51 (59211): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-16 17:27:51 (59211): Detected: Web Application Enabled (http://localhost:58387)
2025-04-16 17:27:51 (59211): Preference change detected
2025-04-16 17:27:51 (59211): Setting CPU throttle for VM. (100%)
2025-04-16 17:27:51 (59211): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-16 17:27:56 (59211): Guest Log: 00:01:00.326776 timesync vgsvcTimeSyncWorker: Radical host time change: 4 789 947 000 000ns (HostNow=1 744 820 876 740 000 000 ns HostLast=1 744 816 086 793 000 000 ns)
2025-04-16 17:28:06 (59211): Guest Log: 00:01:10.374574 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 789 094 692 000ns (GuestNow=1 744 820 886 787 619 000 ns GuestLast=1 744 816 097 692 927 000 ns fSetTimeLastLoop=true )
2025-04-16 17:28:44 (59211): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-16 17:28:44 (59211): Guest Log: [INFO] Detected branch: prod
2025-04-16 17:28:44 (59211): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-16 17:28:44 (59211): Guest Log: Copying input files
2025-04-16 17:28:44 (59211): Guest Log: Copied input files into RunAtlas.
2025-04-16 17:28:45 (59211): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-16 17:28:45 (59211): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-16 17:28:45 (59211): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-16 17:28:45 (59211): Guest Log: Further information can be found at the LHC@home message board.
2025-04-16 17:29:25 (59211): Stopping VM.
2025-04-16 17:29:27 (59211): Successfully stopped VM.
2025-04-17 13:42:30 (3183): Detected: vboxwrapper 26206
2025-04-17 13:42:30 (3183): Detected: BOINC client v8.0.2
2025-04-17 13:42:30 (3183): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-17 13:42:30 (3183): Guest Log: 00:01:00.326776 timesync vgsvcTimeSyncWorker: Radical host time change: 4 789 947 000 000ns (HostNow=1 744 820 876 740 000 000 ns HostLast=1 744 816 086 793 000 000 ns)
2025-04-17 13:42:30 (3183): Guest Log: 00:01:10.374574 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 789 094 692 000ns (GuestNow=1 744 820 886 787 619 000 ns GuestLast=1 744 816 097 692 927 000 ns fSetTimeLastLoop=true )
2025-04-17 13:42:30 (3183): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-17 13:42:30 (3183): Guest Log: [INFO] Detected branch: prod
2025-04-17 13:42:30 (3183): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-17 13:42:30 (3183): Guest Log: Copying input files
2025-04-17 13:42:30 (3183): Guest Log: Copied input files into RunAtlas.
2025-04-17 13:42:30 (3183): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-17 13:42:30 (3183): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-17 13:42:30 (3183): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-17 13:42:30 (3183): Guest Log: Further information can be found at the LHC@home message board.
2025-04-17 13:42:30 (3183): Starting VM using VBoxManage interface. (boinc_0726468ea6d26e76, slot#2)
2025-04-17 13:42:32 (3183): Successfully started VM. (PID = '3324')
2025-04-17 13:42:32 (3183): Reporting VM Process ID to BOINC.
2025-04-17 13:42:32 (3183): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-17 13:42:32 (3183): Detected: Web Application Enabled (http://localhost:58387)
2025-04-17 13:42:32 (3183): Preference change detected
2025-04-17 13:42:32 (3183): Setting CPU throttle for VM. (100%)
2025-04-17 13:42:32 (3183): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-17 13:42:34 (3183): Guest Log: 00:02:40.633241 timesync vgsvcTimeSyncWorker: Radical host time change: 72 794 634 000 000ns (HostNow=1 744 893 754 092 000 000 ns HostLast=1 744 820 959 458 000 000 ns)
2025-04-17 13:42:39 (3183): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-17 13:42:39 (3183): 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
2025-04-17 13:42:39 (3183): Guest Log: 2.6.3.0 1859 1214 29576 144932 3 1 2190352 4096001 0 65024 1 0 n/a 0 0 http://s1sampa-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 0
2025-04-17 13:42:40 (3183): Guest Log: copied the webapp to /var/www
2025-04-17 13:42:40 (3183): Guest Log: ATHENA_PROC_NUMBER=8
2025-04-17 13:42:40 (3183): Guest Log: ATHENA_CORE_NUMBER=8
2025-04-17 13:42:40 (3183): 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 
2025-04-17 13:42:40 (3183): Guest Log:  *** Starting ATLAS job. (PandaID=6602132756 taskID=44075483) ***
2025-04-17 13:42:40 (3183): Guest Log:  *** Job finished ***
2025-04-17 13:42:40 (3183): Guest Log: Failed to produce a result! Shutting down the machine.
2025-04-17 13:42:40 (3183): Guest Log: FATAL:   while opening capability config file: open /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/1.2.2/etc/apptainer/capability.json: input/output error
2025-04-17 13:42:43 (3183): Guest Log: 00:02:50.635013 timesync vgsvcTimeSyncWorker: Radical guest time change: 72 787 047 284 000ns (GuestNow=1 744 893 764 093 853 000 ns GuestLast=1 744 820 977 046 569 000 ns fSetTimeLastLoop=true )
2025-04-17 13:45:44 (3183): Guest Log: 00:06:06.990449 control  Session 0 is about to close ...
2025-04-17 13:45:44 (3183): Guest Log: 00:06:06.990589 control  Stopping all guest processes ...
2025-04-17 13:45:44 (3183): Guest Log: 00:06:06.990603 control  Closing all guest files ...
2025-04-17 13:45:44 (3183): Guest Log: 00:06:06.990615 control  Guest control service stopped
2025-04-17 13:45:44 (3183): Guest Log: 00:06:06.990630 control  Guest control worker returned with rc=VINF_SUCCESS
2025-04-17 13:45:44 (3183): Guest Log: 00:06:06.990680 main     Session 0 is about to close ...
2025-04-17 13:45:44 (3183): Guest Log: 00:06:06.990706 main     Stopping all guest processes ...
2025-04-17 13:45:44 (3183): Guest Log: 00:06:06.990717 main     Closing all guest files ...
2025-04-17 13:45:44 (3183): Guest Log: 00:06:07.446625 main     Ended.
2025-04-17 13:45:46 (3183): VM is no longer is a running state. It is in 'poweredoff'.
2025-04-17 13:45:46 (3183): VM state change detected. (old = 'running', new = 'poweredoff')
2025-04-17 13:45:46 (3183): Powering off VM.
2025-04-17 13:45:46 (3183): Deregistering VM. (boinc_0726468ea6d26e76, slot#2)
2025-04-17 13:45:46 (3183): Removing network bandwidth throttle group from VM.
2025-04-17 13:45:46 (3183): Removing VM from VirtualBox.
2025-04-17 13:45:51 (3183): Virtual machine exited.
13:45:51 (3183): called boinc_finish(0)

</stderr_txt>
<message>
upload failure: <file_xfer_error>
  <file_name>vK4KDm0QcO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmXbWLDmdGlWEo_0_r1914580549_ATLAS_result</file_name>
  <error_code>-161 (not found)</error_code>
</file_xfer_error>
</message>
]]>


©2025 CERN