Name iGULDm7Qrf8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmMqFKDmhvCwBn_1
Workunit 237675812
Created 19 Nov 2025, 8:43:19 UTC
Sent 19 Nov 2025, 10:52:43 UTC
Report deadline 27 Nov 2025, 10:52:43 UTC
Received 24 Nov 2025, 8:46:45 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10796007
Run time 26 min 39 sec
CPU time 46 min 8 sec
Validate state Valid
Credit 97.77
Device peak FLOPS 37.95 GFLOPS
Application version ATLAS Simulation v3.03 (vbox64_mt_mcore_atlas)
windows_x86_64
Peak working set size 452.20 MB
Peak swap size 465.70 MB
Peak disk usage 3.84 GB

Stderr output

<core_client_version>7.16.20</core_client_version>
<![CDATA[
<stderr_txt>
25-11-19 12:57:57 (12088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-11-19 12:57:57 (12088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-11-19 12:58:07 (12088): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-19 12:58:07 (12088): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-11-19 12:58:18 (12088): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-11-19 12:58:18 (12088): Guest Log: 00:00:00.000184 main     Log opened 2025-11-19T12:58:16.707978000Z
2025-11-19 12:58:18 (12088): Guest Log: 00:00:00.000285 main     OS Product: Linux
2025-11-19 12:58:18 (12088): Guest Log: 00:00:00.000371 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-11-19 12:58:18 (12088): Guest Log: 00:00:00.000419 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-11-19 12:58:18 (12088): Guest Log: 00:00:00.000489 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-11-19 12:58:18 (12088): Guest Log: 00:00:00.000491 main     Process ID: 1374
2025-11-19 12:58:18 (12088): Guest Log: 00:00:00.000492 main     Package type: LINUX_64BITS_GENERIC
2025-11-19 12:58:18 (12088): Guest Log: 00:00:00.001602 main     5.2.32 r132073 started. Verbose level = 0
2025-11-19 12:58:18 (12088): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-11-19 12:58:18 (12088): Guest Log: [INFO] Mounting shared directory
2025-11-19 12:58:18 (12088): Guest Log: [INFO] Checking for init_data.xml
2025-11-19 12:58:21 (12088): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-11-19 12:58:21 (12088): Guest Log: [INFO] Detected branch: prod
2025-11-19 12:58:22 (12088): Guest Log: This is the prod version of the ATLAS job wrapper
2025-11-19 12:58:22 (12088): Guest Log: Copying input files
2025-11-19 12:58:27 (12088): Guest Log: Copied input files into RunAtlas.
2025-11-19 12:58:27 (12088): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-11-19 12:58:27 (12088): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-11-19 12:58:27 (12088): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-11-19 12:58:27 (12088): Guest Log: Further information can be found at the LHC@home message board.
2025-11-19 12:58:28 (12088): Guest Log: 00:00:10.010369 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 588 538 788 000ns (GuestNow=1 763 553 508 172 136 000 ns GuestLast=1 763 557 096 710 924 000 ns fSetTimeLastLoop=true )
2025-11-19 12:59:02 (12088): Stopping VM.
2025-11-19 12:59:07 (12088): Successfully stopped VM.
2025-11-19 13:02:01 (15328): vboxwrapper version 26210
2025-11-19 13:02:01 (15328): BOINC client version: 7.16.20
2025-11-19 13:02:02 (15328): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-19 13:02:02 (15328): Guest Log: BIOS: VirtualBox 6.0.14
2025-11-19 13:02:02 (15328): Guest Log: CPUID EDX: 0x178bfbff
2025-11-19 13:02:02 (15328): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-19 13:02:02 (15328): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-11-19 13:02:02 (15328): Guest Log: BIOS: Booting from Hard Disk...
2025-11-19 13:02:02 (15328): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-11-19 13:02:02 (15328): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-11-19 13:02:02 (15328): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-11-19 13:02:02 (15328): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-19 13:02:02 (15328): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-11-19 13:02:02 (15328): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-11-19 13:02:02 (15328): Guest Log: 00:00:00.000184 main     Log opened 2025-11-19T12:58:16.707978000Z
2025-11-19 13:02:02 (15328): Guest Log: 00:00:00.000285 main     OS Product: Linux
2025-11-19 13:02:02 (15328): Guest Log: 00:00:00.000371 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-11-19 13:02:02 (15328): Guest Log: 00:00:00.000419 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-11-19 13:02:02 (15328): Guest Log: 00:00:00.000489 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-11-19 13:02:02 (15328): Guest Log: 00:00:00.000491 main     Process ID: 1374
2025-11-19 13:02:02 (15328): Guest Log: 00:00:00.000492 main     Package type: LINUX_64BITS_GENERIC
2025-11-19 13:02:02 (15328): Guest Log: 00:00:00.001602 main     5.2.32 r132073 started. Verbose level = 0
2025-11-19 13:02:02 (15328): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-11-19 13:02:02 (15328): Guest Log: [INFO] Mounting shared directory
2025-11-19 13:02:02 (15328): Guest Log: [INFO] Checking for init_data.xml
2025-11-19 13:02:02 (15328): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-11-19 13:02:02 (15328): Guest Log: [INFO] Detected branch: prod
2025-11-19 13:02:02 (15328): Guest Log: This is the prod version of the ATLAS job wrapper
2025-11-19 13:02:02 (15328): Guest Log: Copying input files
2025-11-19 13:02:02 (15328): Guest Log: Copied input files into RunAtlas.
2025-11-19 13:02:02 (15328): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-11-19 13:02:02 (15328): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-11-19 13:02:02 (15328): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-11-19 13:02:02 (15328): Guest Log: Further information can be found at the LHC@home message board.
2025-11-19 13:02:02 (15328): Guest Log: 00:00:10.010369 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 588 538 788 000ns (GuestNow=1 763 553 508 172 136 000 ns GuestLast=1 763 557 096 710 924 000 ns fSetTimeLastLoop=true )
2025-11-19 13:02:02 (15328): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-19 13:02:12 (15328): Successfully started VM. (PID = '7676')
2025-11-19 13:02:12 (15328): Reporting VM Process ID to BOINC.
2025-11-19 13:02:12 (15328): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-19 13:02:12 (15328): Detected: Web Application Enabled (http://localhost:56687)
2025-11-19 13:02:12 (15328): Preference change detected
2025-11-19 13:02:12 (15328): Setting CPU throttle for VM. (100%)
2025-11-19 13:02:13 (15328): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-19 13:02:35 (15328): Stopping VM.
2025-11-19 13:02:40 (15328): Successfully stopped VM.
2025-11-19 13:14:47 (15548): vboxwrapper version 26210
2025-11-19 13:14:47 (15548): BOINC client version: 7.16.20
2025-11-19 13:14:47 (15548): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-19 13:14:48 (15548): ERROR: VM failed to start
2025-11-19 13:14:53 (15548): 
   BOINC will be notified that it needs to clean up the environment.
         This is a temporary problem and so this job will be rescheduled for another time.

2025-11-19 13:17:47 (15620): vboxwrapper version 26210
2025-11-19 13:17:47 (15620): BOINC client version: 7.16.20
2025-11-19 13:17:47 (15620): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-19 13:17:48 (15620): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-19 13:17:59 (15620): Successfully started VM. (PID = '2056')
2025-11-19 13:17:59 (15620): Reporting VM Process ID to BOINC.
2025-11-19 13:17:59 (15620): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-19 13:17:59 (15620): Detected: Web Application Enabled (http://localhost:56687)
2025-11-19 13:17:59 (15620): Preference change detected
2025-11-19 13:17:59 (15620): Setting CPU throttle for VM. (100%)
2025-11-19 13:18:00 (15620): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-19 13:18:05 (15620): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-11-19 13:18:06 (15620): 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-11-19 13:18:06 (15620): Guest Log: 2.6.3.0 1652 19 32208 153043 4 1 3117639 4096000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-11-19 13:18:07 (15620): Guest Log: copied the webapp to /var/www
2025-11-19 13:18:07 (15620): Guest Log: ATHENA_PROC_NUMBER=8
2025-11-19 13:18:07 (15620): Guest Log: ATHENA_CORE_NUMBER=8
2025-11-19 13:18:07 (15620): 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-11-19 13:18:08 (15620): Guest Log:  *** Starting ATLAS job. (PandaID=6892522514 taskID=47493029) ***
2025-11-19 13:21:29 (15620): Stopping VM.
2025-11-19 13:21:39 (15620): Successfully stopped VM.
2025-11-19 14:03:16 (4140): vboxwrapper version 26210
2025-11-19 14:03:16 (4140): BOINC client version: 7.16.20
2025-11-19 14:03:16 (4140): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-19 14:03:17 (4140): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-11-19 14:03:17 (4140): 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-11-19 14:03:17 (4140): Guest Log: 2.6.3.0 1652 19 32208 153043 4 1 3117639 4096000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-11-19 14:03:17 (4140): Guest Log: copied the webapp to /var/www
2025-11-19 14:03:17 (4140): Guest Log: ATHENA_PROC_NUMBER=8
2025-11-19 14:03:17 (4140): Guest Log: ATHENA_CORE_NUMBER=8
2025-11-19 14:03:17 (4140): 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-11-19 14:03:17 (4140): Guest Log:  *** Starting ATLAS job. (PandaID=6892522514 taskID=47493029) ***
2025-11-19 14:03:17 (4140): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-19 14:04:11 (4140): Successfully started VM. (PID = '13404')
2025-11-19 14:04:11 (4140): Reporting VM Process ID to BOINC.
2025-11-19 14:04:11 (4140): Guest Log: 00:04:40.133618 timesync vgsvcTimeSyncWorker: Radical host time change: 2 571 253 000 000ns (HostNow=1 763 557 451 153 000 000 ns HostLast=1 763 554 879 900 000 000 ns)
2025-11-19 14:04:11 (4140): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-19 14:04:11 (4140): Detected: Web Application Enabled (http://localhost:56687)
2025-11-19 14:04:11 (4140): Preference change detected
2025-11-19 14:04:11 (4140): Setting CPU throttle for VM. (100%)
2025-11-19 14:04:11 (4140): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-19 14:04:21 (4140): Guest Log: 00:04:50.133994 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 571 253 669 000ns (GuestNow=1 763 557 461 154 078 000 ns GuestLast=1 763 554 889 900 409 000 ns fSetTimeLastLoop=true )
2025-11-19 14:05:08 (4140): Stopping VM.
2025-11-19 14:05:19 (4140): Successfully stopped VM.
2025-11-19 14:08:07 (12044): vboxwrapper version 26210
2025-11-19 14:08:07 (12044): BOINC client version: 7.16.20
2025-11-19 14:08:07 (12044): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-19 14:08:08 (12044): Guest Log: 00:04:40.133618 timesync vgsvcTimeSyncWorker: Radical host time change: 2 571 253 000 000ns (HostNow=1 763 557 451 153 000 000 ns HostLast=1 763 554 879 900 000 000 ns)
2025-11-19 14:08:08 (12044): Guest Log: 00:04:50.133994 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 571 253 669 000ns (GuestNow=1 763 557 461 154 078 000 ns GuestLast=1 763 554 889 900 409 000 ns fSetTimeLastLoop=true )
2025-11-19 14:08:08 (12044): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-19 14:08:47 (12044): Successfully started VM. (PID = '10180')
2025-11-19 14:08:47 (12044): Reporting VM Process ID to BOINC.
2025-11-19 14:08:47 (12044): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-19 14:08:47 (12044): Detected: Web Application Enabled (http://localhost:56687)
2025-11-19 14:08:47 (12044): Preference change detected
2025-11-19 14:08:47 (12044): Setting CPU throttle for VM. (100%)
2025-11-19 14:08:48 (12044): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-19 14:10:19 (12044): Stopping VM.
2025-11-19 14:10:32 (12044): Successfully stopped VM.
2025-11-20 07:50:06 (6632): vboxwrapper version 26210
2025-11-20 07:50:06 (6632): BOINC client version: 7.16.20
2025-11-20 07:50:07 (6632): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 07:50:08 (6632): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 07:51:15 (6632): Successfully started VM. (PID = '6308')
2025-11-20 07:51:15 (6632): Reporting VM Process ID to BOINC.
2025-11-20 07:51:15 (6632): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 07:51:15 (6632): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 07:51:15 (6632): Preference change detected
2025-11-20 07:51:15 (6632): Setting CPU throttle for VM. (100%)
2025-11-20 07:51:15 (6632): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 07:51:24 (6632): Guest Log: 00:07:20.160735 timesync vgsvcTimeSyncWorker: Radical host time change: 63 664 156 000 000ns (HostNow=1 763 621 483 331 000 000 ns HostLast=1 763 557 819 175 000 000 ns)
2025-11-20 07:51:34 (6632): Guest Log: 00:07:30.162222 timesync vgsvcTimeSyncWorker: Radical guest time change: 63 664 153 635 000ns (GuestNow=1 763 621 493 332 918 000 ns GuestLast=1 763 557 829 179 283 000 ns fSetTimeLastLoop=true )
2025-11-20 07:51:50 (6632): Stopping VM.
2025-11-20 07:52:02 (6632): Successfully stopped VM.
2025-11-20 07:54:49 (9872): vboxwrapper version 26210
2025-11-20 07:54:49 (9872): BOINC client version: 7.16.20
2025-11-20 07:54:50 (9872): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 07:54:51 (9872): Guest Log: 00:07:20.160735 timesync vgsvcTimeSyncWorker: Radical host time change: 63 664 156 000 000ns (HostNow=1 763 621 483 331 000 000 ns HostLast=1 763 557 819 175 000 000 ns)
2025-11-20 07:54:51 (9872): Guest Log: 00:07:30.162222 timesync vgsvcTimeSyncWorker: Radical guest time change: 63 664 153 635 000ns (GuestNow=1 763 621 493 332 918 000 ns GuestLast=1 763 557 829 179 283 000 ns fSetTimeLastLoop=true )
2025-11-20 07:54:51 (9872): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 07:56:17 (9872): Successfully started VM. (PID = '15276')
2025-11-20 07:56:17 (9872): Reporting VM Process ID to BOINC.
2025-11-20 07:56:17 (9872): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 07:56:17 (9872): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 07:56:17 (9872): Preference change detected
2025-11-20 07:56:17 (9872): Setting CPU throttle for VM. (100%)
2025-11-20 07:56:18 (9872): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 07:57:10 (9872): Stopping VM.
2025-11-20 07:57:24 (9872): Successfully stopped VM.
2025-11-20 08:02:02 (3972): vboxwrapper version 26210
2025-11-20 08:02:02 (3972): BOINC client version: 7.16.20
2025-11-20 08:02:03 (3972): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 08:02:04 (3972): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 08:03:18 (3972): Successfully started VM. (PID = '10672')
2025-11-20 08:03:18 (3972): Reporting VM Process ID to BOINC.
2025-11-20 08:03:18 (3972): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 08:03:18 (3972): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 08:03:18 (3972): Preference change detected
2025-11-20 08:03:18 (3972): Setting CPU throttle for VM. (100%)
2025-11-20 08:03:19 (3972): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 08:06:51 (3972): Stopping VM.
2025-11-20 08:07:06 (3972): Successfully stopped VM.
2025-11-20 08:30:21 (10404): vboxwrapper version 26210
2025-11-20 08:30:21 (10404): BOINC client version: 7.16.20
2025-11-20 08:30:22 (10404): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 08:30:22 (10404): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 08:32:01 (10404): Successfully started VM. (PID = '14996')
2025-11-20 08:32:01 (10404): Reporting VM Process ID to BOINC.
2025-11-20 08:32:01 (10404): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 08:32:01 (10404): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 08:32:01 (10404): Preference change detected
2025-11-20 08:32:01 (10404): Setting CPU throttle for VM. (100%)
2025-11-20 08:32:01 (10404): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 08:32:03 (10404): Stopping VM.
2025-11-20 08:32:17 (10404): Successfully stopped VM.
2025-11-20 08:35:02 (9596): vboxwrapper version 26210
2025-11-20 08:35:02 (9596): BOINC client version: 7.16.20
2025-11-20 08:35:03 (9596): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 08:35:04 (9596): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 08:36:28 (9596): Successfully started VM. (PID = '12912')
2025-11-20 08:36:28 (9596): Reporting VM Process ID to BOINC.
2025-11-20 08:36:29 (9596): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 08:36:29 (9596): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 08:36:29 (9596): Preference change detected
2025-11-20 08:36:29 (9596): Setting CPU throttle for VM. (100%)
2025-11-20 08:36:29 (9596): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 08:37:26 (9596): Stopping VM.
2025-11-20 08:37:40 (9596): Successfully stopped VM.
2025-11-20 09:03:42 (14908): vboxwrapper version 26210
2025-11-20 09:03:42 (14908): BOINC client version: 7.16.20
2025-11-20 09:03:43 (14908): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 09:03:43 (14908): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 09:05:22 (14908): Successfully started VM. (PID = '13416')
2025-11-20 09:05:22 (14908): Reporting VM Process ID to BOINC.
2025-11-20 09:05:22 (14908): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 09:05:22 (14908): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 09:05:22 (14908): Stopping VM.
2025-11-20 09:05:37 (14908): Successfully stopped VM.
2025-11-20 09:16:11 (11276): vboxwrapper version 26210
2025-11-20 09:16:11 (11276): BOINC client version: 7.16.20
2025-11-20 09:16:13 (11276): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 09:16:13 (11276): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 09:17:42 (11276): Successfully started VM. (PID = '5884')
2025-11-20 09:17:42 (11276): Reporting VM Process ID to BOINC.
2025-11-20 09:17:42 (11276): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 09:17:42 (11276): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 09:17:42 (11276): Preference change detected
2025-11-20 09:17:42 (11276): Setting CPU throttle for VM. (100%)
2025-11-20 09:17:43 (11276): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 09:17:43 (11276): Guest Log: 00:13:20.281757 timesync vgsvcTimeSyncWorker: Radical host time change: 2 424 055 000 000ns (HostNow=1 763 626 663 725 000 000 ns HostLast=1 763 624 239 670 000 000 ns)
2025-11-20 09:17:53 (11276): Guest Log: 00:13:30.282061 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 424 056 879 000ns (GuestNow=1 763 626 673 725 466 000 ns GuestLast=1 763 624 249 668 587 000 ns fSetTimeLastLoop=true )
2025-11-20 09:18:07 (11276): Stopping VM.
2025-11-20 09:18:23 (11276): Successfully stopped VM.
2025-11-20 09:42:55 (15644): vboxwrapper version 26210
2025-11-20 09:42:55 (15644): BOINC client version: 7.16.20
2025-11-20 09:42:56 (15644): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 09:42:57 (15644): Guest Log: 00:13:20.281757 timesync vgsvcTimeSyncWorker: Radical host time change: 2 424 055 000 000ns (HostNow=1 763 626 663 725 000 000 ns HostLast=1 763 624 239 670 000 000 ns)
2025-11-20 09:42:57 (15644): Guest Log: 00:13:30.282061 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 424 056 879 000ns (GuestNow=1 763 626 673 725 466 000 ns GuestLast=1 763 624 249 668 587 000 ns fSetTimeLastLoop=true )
2025-11-20 09:42:57 (15644): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 09:44:27 (15644): Successfully started VM. (PID = '15184')
2025-11-20 09:44:27 (15644): Reporting VM Process ID to BOINC.
2025-11-20 09:44:27 (15644): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 09:44:27 (15644): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 09:44:27 (15644): Stopping VM.
2025-11-20 09:44:41 (15644): Successfully stopped VM.
2025-11-20 09:46:56 (8508): vboxwrapper version 26210
2025-11-20 09:46:56 (8508): BOINC client version: 7.16.20
2025-11-20 09:46:57 (8508): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 09:46:57 (8508): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 10:35:03 (16180): vboxwrapper version 26210
2025-11-20 10:35:03 (16180): BOINC client version: 7.16.20
2025-11-20 10:35:03 (16180): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 10:35:10 (16180): Guest Log: 00:13:50.291951 timesync vgsvcTimeSyncWorker: Radical host time change: 1 843 737 000 000ns (HostNow=1 763 628 527 472 000 000 ns HostLast=1 763 626 683 735 000 000 ns)
2025-11-20 10:35:10 (16180): Guest Log: 00:14:00.292596 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 843 738 346 000ns (GuestNow=1 763 628 537 472 952 000 ns GuestLast=1 763 626 693 734 606 000 ns fSetTimeLastLoop=true )
2025-11-20 10:35:10 (16180): VM was running
2025-11-20 10:35:10 (16180): Powering off VM.
2025-11-20 10:35:11 (16180): Guest Log: 00:13:50.291951 timesync vgsvcTimeSyncWorker: Radical host time change: 1 843 737 000 000ns (HostNow=1 763 628 527 472 000 000 ns HostLast=1 763 626 683 735 000 000 ns)
2025-11-20 10:35:11 (16180): Guest Log: 00:14:00.292596 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 843 738 346 000ns (GuestNow=1 763 628 537 472 952 000 ns GuestLast=1 763 626 693 734 606 000 ns fSetTimeLastLoop=true )
2025-11-20 10:35:11 (16180): Successfully stopped VM.
2025-11-20 10:35:11 (16180): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 10:35:15 (16180): Successfully started VM. (PID = '11496')
2025-11-20 10:35:15 (16180): Reporting VM Process ID to BOINC.
2025-11-20 10:35:15 (16180): Guest Log: BIOS: VirtualBox 6.0.14
2025-11-20 10:35:15 (16180): Guest Log: CPUID EDX: 0x178bfbff
2025-11-20 10:35:15 (16180): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-20 10:35:15 (16180): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 10:35:15 (16180): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 10:35:15 (16180): Preference change detected
2025-11-20 10:35:15 (16180): Setting CPU throttle for VM. (100%)
2025-11-20 10:35:15 (16180): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 10:35:17 (16180): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-11-20 10:35:17 (16180): Guest Log: BIOS: Booting from Hard Disk...
2025-11-20 10:35:21 (16180): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-11-20 10:35:21 (16180): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-11-20 10:35:21 (16180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-11-20 10:35:31 (16180): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-20 10:35:31 (16180): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-11-20 10:35:43 (16180): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-11-20 10:35:43 (16180): Guest Log: 00:00:00.000612 main     Log opened 2025-11-20T10:35:42.401773000Z
2025-11-20 10:35:43 (16180): Guest Log: 00:00:00.000855 main     OS Product: Linux
2025-11-20 10:35:43 (16180): Guest Log: 00:00:00.000953 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-11-20 10:35:43 (16180): Guest Log: 00:00:00.001125 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-11-20 10:35:43 (16180): Guest Log: 00:00:00.001267 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-11-20 10:35:43 (16180): Guest Log: 00:00:00.001271 main     Process ID: 1376
2025-11-20 10:35:43 (16180): Guest Log: 00:00:00.001274 main     Package type: LINUX_64BITS_GENERIC
2025-11-20 10:35:43 (16180): Guest Log: 00:00:00.003479 main     5.2.32 r132073 started. Verbose level = 0
2025-11-20 10:35:44 (16180): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-11-20 10:35:44 (16180): Guest Log: [INFO] Mounting shared directory
2025-11-20 10:35:44 (16180): Guest Log: [INFO] Checking for init_data.xml
2025-11-20 10:35:51 (16180): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-11-20 10:35:51 (16180): Guest Log: [INFO] Detected branch: prod
2025-11-20 10:35:52 (16180): Guest Log: This is the prod version of the ATLAS job wrapper
2025-11-20 10:35:52 (16180): Guest Log: Copying input files
2025-11-20 10:35:53 (16180): Guest Log: 00:00:10.007359 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 589 071 582 000ns (GuestNow=1 763 631 353 336 459 000 ns GuestLast=1 763 634 942 408 041 000 ns fSetTimeLastLoop=true )
2025-11-20 10:36:00 (16180): Guest Log: Copied input files into RunAtlas.
2025-11-20 10:36:00 (16180): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-11-20 10:36:00 (16180): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-11-20 10:36:00 (16180): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-11-20 10:36:00 (16180): Guest Log: Further information can be found at the LHC@home message board.
2025-11-20 10:36:11 (16180): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-11-20 10:36:11 (16180): 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-11-20 10:36:11 (16180): Guest Log: 2.6.3.0 1655 0 29928 153076 4 1 4041937 4096000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-11-20 10:36:13 (16180): Guest Log: copied the webapp to /var/www
2025-11-20 10:36:13 (16180): Guest Log: ATHENA_PROC_NUMBER=8
2025-11-20 10:36:13 (16180): Guest Log: ATHENA_CORE_NUMBER=8
2025-11-20 10:36:13 (16180): 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-11-20 10:36:13 (16180): Guest Log:  *** Starting ATLAS job. (PandaID=6892522514 taskID=47493029) ***
2025-11-20 10:36:27 (16180): Stopping VM.
2025-11-20 10:36:33 (16180): Successfully stopped VM.
2025-11-20 10:39:27 (2212): vboxwrapper version 26210
2025-11-20 10:39:27 (2212): BOINC client version: 7.16.20
2025-11-20 10:39:27 (2212): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 10:39:28 (2212): Guest Log: BIOS: VirtualBox 6.0.14
2025-11-20 10:39:28 (2212): Guest Log: CPUID EDX: 0x178bfbff
2025-11-20 10:39:28 (2212): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-20 10:39:28 (2212): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-11-20 10:39:28 (2212): Guest Log: BIOS: Booting from Hard Disk...
2025-11-20 10:39:28 (2212): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-11-20 10:39:28 (2212): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-11-20 10:39:28 (2212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-11-20 10:39:28 (2212): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-20 10:39:28 (2212): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000)
2025-11-20 10:39:28 (2212): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-11-20 10:39:28 (2212): Guest Log: 00:00:00.000612 main     Log opened 2025-11-20T10:35:42.401773000Z
2025-11-20 10:39:28 (2212): Guest Log: 00:00:00.000855 main     OS Product: Linux
2025-11-20 10:39:28 (2212): Guest Log: 00:00:00.000953 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-11-20 10:39:28 (2212): Guest Log: 00:00:00.001125 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-11-20 10:39:28 (2212): Guest Log: 00:00:00.001267 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-11-20 10:39:28 (2212): Guest Log: 00:00:00.001271 main     Process ID: 1376
2025-11-20 10:39:28 (2212): Guest Log: 00:00:00.001274 main     Package type: LINUX_64BITS_GENERIC
2025-11-20 10:39:28 (2212): Guest Log: 00:00:00.003479 main     5.2.32 r132073 started. Verbose level = 0
2025-11-20 10:39:28 (2212): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-11-20 10:39:28 (2212): Guest Log: [INFO] Mounting shared directory
2025-11-20 10:39:28 (2212): Guest Log: [INFO] Checking for init_data.xml
2025-11-20 10:39:28 (2212): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-11-20 10:39:28 (2212): Guest Log: [INFO] Detected branch: prod
2025-11-20 10:39:28 (2212): Guest Log: This is the prod version of the ATLAS job wrapper
2025-11-20 10:39:28 (2212): Guest Log: Copying input files
2025-11-20 10:39:28 (2212): Guest Log: 00:00:10.007359 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 589 071 582 000ns (GuestNow=1 763 631 353 336 459 000 ns GuestLast=1 763 634 942 408 041 000 ns fSetTimeLastLoop=true )
2025-11-20 10:39:28 (2212): Guest Log: Copied input files into RunAtlas.
2025-11-20 10:39:28 (2212): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-11-20 10:39:28 (2212): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-11-20 10:39:28 (2212): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-11-20 10:39:28 (2212): Guest Log: Further information can be found at the LHC@home message board.
2025-11-20 10:39:28 (2212): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-11-20 10:39:28 (2212): 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-11-20 10:39:28 (2212): Guest Log: 2.6.3.0 1655 0 29928 153076 4 1 4041937 4096000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-11-20 10:39:28 (2212): Guest Log: copied the webapp to /var/www
2025-11-20 10:39:28 (2212): Guest Log: ATHENA_PROC_NUMBER=8
2025-11-20 10:39:28 (2212): Guest Log: ATHENA_CORE_NUMBER=8
2025-11-20 10:39:28 (2212): 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-11-20 10:39:28 (2212): Guest Log:  *** Starting ATLAS job. (PandaID=6892522514 taskID=47493029) ***
2025-11-20 10:39:28 (2212): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 10:39:47 (2212): Successfully started VM. (PID = '10560')
2025-11-20 10:39:47 (2212): Reporting VM Process ID to BOINC.
2025-11-20 10:39:47 (2212): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 10:39:47 (2212): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 10:39:47 (2212): Preference change detected
2025-11-20 10:39:47 (2212): Setting CPU throttle for VM. (100%)
2025-11-20 10:39:48 (2212): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 10:41:14 (2212): Stopping VM.
2025-11-20 10:41:21 (2212): Successfully stopped VM.
2025-11-20 10:55:21 (4060): vboxwrapper version 26210
2025-11-20 10:55:21 (4060): BOINC client version: 7.16.20
2025-11-20 10:55:22 (4060): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 10:55:23 (4060): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 10:55:50 (4060): Successfully started VM. (PID = '11084')
2025-11-20 10:55:50 (4060): Reporting VM Process ID to BOINC.
2025-11-20 10:55:50 (4060): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 10:55:50 (4060): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 10:55:50 (4060): Stopping VM.
2025-11-20 10:55:57 (4060): Successfully stopped VM.
2025-11-20 11:05:27 (9224): vboxwrapper version 26210
2025-11-20 11:05:27 (9224): BOINC client version: 7.16.20
2025-11-20 11:05:28 (9224): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 11:05:28 (9224): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 11:06:03 (9224): Successfully started VM. (PID = '14740')
2025-11-20 11:06:03 (9224): Reporting VM Process ID to BOINC.
2025-11-20 11:06:03 (9224): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 11:06:03 (9224): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 11:06:03 (9224): Preference change detected
2025-11-20 11:06:03 (9224): Setting CPU throttle for VM. (100%)
2025-11-20 11:06:03 (9224): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 11:06:46 (9224): Stopping VM.
2025-11-20 11:06:55 (9224): Successfully stopped VM.
2025-11-20 11:31:38 (12936): vboxwrapper version 26210
2025-11-20 11:31:38 (12936): BOINC client version: 7.16.20
2025-11-20 11:31:39 (12936): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 11:31:40 (12936): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 11:32:11 (12936): Successfully started VM. (PID = '4028')
2025-11-20 11:32:11 (12936): Reporting VM Process ID to BOINC.
2025-11-20 11:32:11 (12936): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 11:32:11 (12936): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 11:32:11 (12936): Preference change detected
2025-11-20 11:32:11 (12936): Setting CPU throttle for VM. (100%)
2025-11-20 11:32:12 (12936): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 11:33:35 (12936): Stopping VM.
2025-11-20 11:33:47 (12936): Successfully stopped VM.
2025-11-20 11:39:10 (9640): vboxwrapper version 26210
2025-11-20 11:39:10 (9640): BOINC client version: 7.16.20
2025-11-20 11:39:11 (9640): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 11:39:12 (9640): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 11:40:00 (9640): Successfully started VM. (PID = '4660')
2025-11-20 11:40:00 (9640): Reporting VM Process ID to BOINC.
2025-11-20 11:40:00 (9640): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 11:40:00 (9640): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 11:40:00 (9640): Stopping VM.
2025-11-20 11:40:11 (9640): Successfully stopped VM.
2025-11-20 12:11:50 (8428): vboxwrapper version 26210
2025-11-20 12:11:50 (8428): BOINC client version: 7.16.20
2025-11-20 12:11:51 (8428): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 12:11:52 (8428): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 12:12:43 (8428): Successfully started VM. (PID = '10056')
2025-11-20 12:12:43 (8428): Reporting VM Process ID to BOINC.
2025-11-20 12:12:43 (8428): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 12:12:43 (8428): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 12:12:43 (8428): Preference change detected
2025-11-20 12:12:43 (8428): Setting CPU throttle for VM. (100%)
2025-11-20 12:12:43 (8428): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 12:12:48 (8428): Guest Log: 00:04:30.087135 timesync vgsvcTimeSyncWorker: Radical host time change: 2 354 826 000 000ns (HostNow=1 763 637 167 786 000 000 ns HostLast=1 763 634 812 960 000 000 ns)
2025-11-20 12:12:58 (8428): Guest Log: 00:04:40.087533 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 354 828 586 000ns (GuestNow=1 763 637 177 786 675 000 ns GuestLast=1 763 634 822 958 089 000 ns fSetTimeLastLoop=true )
2025-11-20 12:13:12 (8428): Stopping VM.
2025-11-20 12:13:23 (8428): Successfully stopped VM.
2025-11-20 12:26:36 (1080): vboxwrapper version 26210
2025-11-20 12:26:36 (1080): BOINC client version: 7.16.20
2025-11-20 12:26:37 (1080): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 12:26:37 (1080): Guest Log: 00:04:30.087135 timesync vgsvcTimeSyncWorker: Radical host time change: 2 354 826 000 000ns (HostNow=1 763 637 167 786 000 000 ns HostLast=1 763 634 812 960 000 000 ns)
2025-11-20 12:26:37 (1080): Guest Log: 00:04:40.087533 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 354 828 586 000ns (GuestNow=1 763 637 177 786 675 000 ns GuestLast=1 763 634 822 958 089 000 ns fSetTimeLastLoop=true )
2025-11-20 12:26:37 (1080): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 12:27:20 (1080): Successfully started VM. (PID = '15968')
2025-11-20 12:27:20 (1080): Reporting VM Process ID to BOINC.
2025-11-20 12:27:20 (1080): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 12:27:20 (1080): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 12:27:20 (1080): Preference change detected
2025-11-20 12:27:20 (1080): Setting CPU throttle for VM. (100%)
2025-11-20 12:27:20 (1080): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 12:27:36 (1080): Stopping VM.
2025-11-20 12:27:47 (1080): Successfully stopped VM.
2025-11-20 13:20:35 (11684): vboxwrapper version 26210
2025-11-20 13:20:35 (11684): BOINC client version: 7.16.20
2025-11-20 13:20:36 (11684): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 13:20:37 (11684): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 13:21:37 (11684): Successfully started VM. (PID = '11204')
2025-11-20 13:21:37 (11684): Reporting VM Process ID to BOINC.
2025-11-20 13:21:37 (11684): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 13:21:37 (11684): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 13:21:37 (11684): Preference change detected
2025-11-20 13:21:37 (11684): Setting CPU throttle for VM. (100%)
2025-11-20 13:21:38 (11684): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-20 13:21:45 (11684): Guest Log: 00:05:20.095209 timesync vgsvcTimeSyncWorker: Radical host time change: 3 250 428 000 000ns (HostNow=1 763 641 305 280 000 000 ns HostLast=1 763 638 054 852 000 000 ns)
2025-11-20 13:21:45 (11684): Stopping VM.
2025-11-20 13:21:57 (11684): Successfully stopped VM.
2025-11-20 13:24:45 (9204): vboxwrapper version 26210
2025-11-20 13:24:45 (9204): BOINC client version: 7.16.20
2025-11-20 13:24:46 (9204): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-20 13:24:47 (9204): Guest Log: 00:05:20.095209 timesync vgsvcTimeSyncWorker: Radical host time change: 3 250 428 000 000ns (HostNow=1 763 641 305 280 000 000 ns HostLast=1 763 638 054 852 000 000 ns)
2025-11-20 13:24:47 (9204): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-20 13:25:35 (9204): Successfully started VM. (PID = '15340')
2025-11-20 13:25:35 (9204): Reporting VM Process ID to BOINC.
2025-11-20 13:25:35 (9204): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-20 13:25:35 (9204): Detected: Web Application Enabled (http://localhost:56687)
2025-11-20 13:25:35 (9204): Stopping VM.
2025-11-20 13:25:45 (9204): Successfully stopped VM.
2025-11-24 07:56:18 (8616): vboxwrapper version 26210
2025-11-24 07:56:18 (8616): BOINC client version: 7.16.20
2025-11-24 07:56:19 (8616): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-24 07:56:20 (8616): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-24 07:56:58 (8616): Successfully started VM. (PID = '11868')
2025-11-24 07:56:58 (8616): Reporting VM Process ID to BOINC.
2025-11-24 07:56:58 (8616): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-24 07:56:58 (8616): Detected: Web Application Enabled (http://localhost:56687)
2025-11-24 07:56:58 (8616): Preference change detected
2025-11-24 07:56:58 (8616): Setting CPU throttle for VM. (100%)
2025-11-24 07:56:58 (8616): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-24 07:57:05 (8616): Stopping VM.
2025-11-24 07:57:16 (8616): Guest Log: 00:05:30.096335 timesync vgsvcTimeSyncWorker: Radical host time change: 326 120 053 000 000ns (HostNow=1 763 967 425 333 000 000 ns HostLast=1 763 641 305 280 000 000 ns)
2025-11-24 07:57:16 (8616): Guest Log: 00:05:30.096457 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 250 430 164 000ns (GuestNow=1 763 641 315 281 054 000 ns GuestLast=1 763 638 064 850 890 000 ns fSetTimeLastLoop=true )
2025-11-24 07:57:16 (8616): Successfully stopped VM.
2025-11-24 08:01:16 (11828): vboxwrapper version 26210
2025-11-24 08:01:16 (11828): BOINC client version: 7.16.20
2025-11-24 08:01:17 (11828): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-24 08:01:18 (11828): Guest Log: 00:05:30.096335 timesync vgsvcTimeSyncWorker: Radical host time change: 326 120 053 000 000ns (HostNow=1 763 967 425 333 000 000 ns HostLast=1 763 641 305 280 000 000 ns)
2025-11-24 08:01:18 (11828): Guest Log: 00:05:30.096457 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 250 430 164 000ns (GuestNow=1 763 641 315 281 054 000 ns GuestLast=1 763 638 064 850 890 000 ns fSetTimeLastLoop=true )
2025-11-24 08:01:18 (11828): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-24 08:02:20 (11828): Successfully started VM. (PID = '10036')
2025-11-24 08:02:20 (11828): Reporting VM Process ID to BOINC.
2025-11-24 08:02:20 (11828): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-24 08:02:20 (11828): Detected: Web Application Enabled (http://localhost:56687)
2025-11-24 08:02:20 (11828): Preference change detected
2025-11-24 08:02:20 (11828): Setting CPU throttle for VM. (100%)
2025-11-24 08:02:20 (11828): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-24 08:02:29 (11828): Guest Log: 00:05:40.097901 timesync vgsvcTimeSyncWorker: Radical guest time change: 326 120 053 442 000ns (GuestNow=1 763 967 435 334 496 000 ns GuestLast=1 763 641 315 281 054 000 ns fSetTimeLastLoop=true )
2025-11-24 08:02:36 (11828): Stopping VM.
2025-11-24 08:02:47 (11828): Successfully stopped VM.
2025-11-24 08:25:15 (8908): vboxwrapper version 26210
2025-11-24 08:25:15 (8908): BOINC client version: 7.16.20
2025-11-24 08:25:16 (8908): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-24 08:25:17 (8908): Guest Log: 00:05:40.097901 timesync vgsvcTimeSyncWorker: Radical guest time change: 326 120 053 442 000ns (GuestNow=1 763 967 435 334 496 000 ns GuestLast=1 763 641 315 281 054 000 ns fSetTimeLastLoop=true )
2025-11-24 08:25:17 (8908): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-24 08:28:46 (15556): vboxwrapper version 26210
2025-11-24 08:28:46 (15556): BOINC client version: 7.16.20
2025-11-24 08:28:47 (15556): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2025-11-24 08:28:48 (15556): Guest Log:  *** Job finished ***
2025-11-24 08:28:48 (15556): Guest Log:  *** The last 20 lines of the pilot log: ***
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:10,034 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140499547670336)>', '<ExcThread(cgroup_monitor, started 140498278790912)>']
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:10,477 | INFO     | [monitor] cgroup control has ended
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:12,044 | INFO     | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 140499547670336)>'])
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,081 | INFO     | all workflow threads have been joined
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,081 | INFO     | end of generic workflow (traces error code: 1213)
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,082 | INFO     | traces error code: 1213
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,083 | INFO     | an exit code was already set: 1213 (will be converted to a standard shell code)
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,083 | INFO     | pilot has finished (exit code=1213, shell exit code=81)
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,255 [wrapper] ==== pilot stdout END ====
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,275 [wrapper] ==== wrapper stdout RESUME ====
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,288 [wrapper] pilotpid: 6111
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,302 [wrapper] Pilot exit status: 81
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,347 [wrapper] pandaids: 6892522514
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,360 [wrapper] WARNING: pilot exitcode non-zero: 81
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,374 [wrapper] WARNING: pilot exitcode non-zero: 81
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,469 [wrapper] cleanup supervisor_pilot  6117 6112
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,480 [wrapper] Test setup, not cleaning
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,490 [wrapper] apfmon messages muted
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,501 [wrapper] ==== wrapper stdout END ====
2025-11-24 08:28:48 (15556): Guest Log: 2025-11-24 07:27:17,513 [wrapper] ==== wrapper stderr END ====
2025-11-24 08:28:48 (15556): Guest Log:  *** Error codes and diagnostics ***
2025-11-24 08:28:48 (15556): Guest Log:  *** Listing of results directory ***
2025-11-24 08:28:48 (15556): Guest Log: total 3988
2025-11-24 08:28:48 (15556): Guest Log: -rw-r--r--. 1 atlas atlas  576529 Nov 19 07:00 pilot3.tar.gz
2025-11-24 08:28:48 (15556): Guest Log: -rw-r--r--. 1 atlas atlas    5112 Nov 19 07:04 queuedata.json
2025-11-24 08:28:48 (15556): Guest Log: -rwx------. 1 atlas atlas   36292 Nov 19 07:05 runpilot2-wrapper.sh
2025-11-24 08:28:48 (15556): Guest Log: -rwxr-xr-x. 1 atlas atlas    8775 Nov 20 09:35 init_data.xml
2025-11-24 08:28:48 (15556): Guest Log: -rwxr-xr-x. 1 atlas atlas  590100 Nov 20 09:35 input.tar.gz
2025-11-24 08:28:48 (15556): Guest Log: -rwxr-xr-x. 1 atlas atlas   15120 Nov 20 09:35 start_atlas.sh
2025-11-24 08:28:48 (15556): Guest Log: lrwxrwxrwx. 1 atlas atlas      20 Nov 20 09:36 EVNT.47493027._000043.pool.root.1 -> /data/./ATLAS.root_0
2025-11-24 08:28:48 (15556): Guest Log: -rw-r--r--. 1 atlas atlas    2771 Nov 20 09:36 pandaJob.out
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas  989435 Nov 20 09:40 agis_schedconf.cvmfs.json
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas 1525063 Nov 20 09:40 agis_ddmendpoints.agis.ALL.json
2025-11-24 08:28:48 (15556): Guest Log: drwx------. 5 atlas atlas    4096 Nov 20 09:40 pilot3
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas     112 Nov 20 12:21 pilot_heartbeat.json
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas     932 Nov 24 06:57 heartbeat.json
2025-11-24 08:28:48 (15556): Guest Log: drwxrwx---. 2 atlas atlas    4096 Nov 24 07:02 PanDA_Pilot-6892522514
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas    1011 Nov 24 07:02 memory_monitor_summary.json
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas   79267 Nov 24 07:27 pilotlog.txt
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas   90666 Nov 24 07:27 log.47493029._000386.job.log.1
2025-11-24 08:28:48 (15556): Guest Log: -rw-r--r--. 1 atlas atlas     571 Nov 24 07:27 runtime_log
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas  102400 Nov 24 07:27 result.tar.gz
2025-11-24 08:28:48 (15556): Guest Log: -rw-r--r--. 1 atlas atlas    7954 Nov 24 07:27 runtime_log.err
2025-11-24 08:28:48 (15556): Guest Log: -rw-------. 1 atlas atlas     642 Nov 24 07:27 iGULDm7Qrf8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmMqFKDmhvCwBn.diag
2025-11-24 08:28:48 (15556): Guest Log: Looking for outputfile HITS.47493029._000386.pool.root.1
2025-11-24 08:28:48 (15556): Guest Log: No HITS file was produced
2025-11-24 08:28:48 (15556): Guest Log: Successfully finished the ATLAS job!
2025-11-24 08:28:48 (15556): Guest Log: Copying the results back to the shared directory!
2025-11-24 08:28:48 (15556): Guest Log:  *** Contents of shared directory: ***
2025-11-24 08:28:48 (15556): Guest Log: total 401940
2025-11-24 08:28:48 (15556): Guest Log: -rwxrwxrwx. 1 root root 410858647 Nov 19 11:57 ATLAS.root_0
2025-11-24 08:28:48 (15556): Guest Log: -rwxrwxrwx. 1 root root      8775 Nov 19 11:57 init_data.xml
2025-11-24 08:28:48 (15556): Guest Log: -rwxrwxrwx. 1 root root    590100 Nov 19 10:53 input.tar.gz
2025-11-24 08:28:48 (15556): Guest Log: -rwxrwxrwx. 1 root root    102400 Nov 24 07:27 result.tar.gz
2025-11-24 08:28:48 (15556): Guest Log: -rwxrwxrwx. 1 root root     15120 Nov 19 10:53 start_atlas.sh
2025-11-24 08:28:48 (15556): Guest Log:  *** Success! Shutting down the machine. ***
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.322883 control  Session 0 is about to close ...
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.323026 control  Stopping all guest processes ...
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.323075 control  Closing all guest files ...
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.323117 control  Guest control service stopped
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.323163 control  Guest control worker returned with rc=VINF_SUCCESS
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.323671 main     Session 0 is about to close ...
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.323744 main     Stopping all guest processes ...
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.323805 main     Closing all guest files ...
2025-11-24 08:28:48 (15556): Guest Log: 00:06:26.541295 main     Ended.
2025-11-24 08:28:48 (15556): Starting VM using VBoxManage interface. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-24 08:28:52 (15556): Successfully started VM. (PID = '13364')
2025-11-24 08:28:52 (15556): Reporting VM Process ID to BOINC.
2025-11-24 08:28:52 (15556): Guest Log: BIOS: VirtualBox 6.0.14
2025-11-24 08:28:52 (15556): Guest Log: CPUID EDX: 0x178bfbff
2025-11-24 08:28:52 (15556): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-24 08:28:52 (15556): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-24 08:28:52 (15556): Detected: Web Application Enabled (http://localhost:56687)
2025-11-24 08:28:52 (15556): VM Completion File Detected.
2025-11-24 08:28:52 (15556): Powering off VM.
2025-11-24 08:28:52 (15556): Successfully stopped VM.
2025-11-24 08:28:52 (15556): Deregistering VM. (boinc_4ad870693ff0ef6f, slot#7)
2025-11-24 08:28:52 (15556): Removing network bandwidth throttle group from VM.
2025-11-24 08:28:52 (15556): Removing VM from VirtualBox.
2025-11-24 08:28:58 (15556): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN