| Name | xZrNDmMAvJ9n9Rq4apOajLDm4fhM0noT9bVooX4SDmgtaLDm8tjscm_1 |
| Workunit | 239747207 |
| Created | 9 Mar 2026, 23:47:23 UTC |
| Sent | 9 Mar 2026, 23:48:58 UTC |
| Report deadline | 17 Mar 2026, 23:48:58 UTC |
| Received | 18 Mar 2026, 2:12:28 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10629762 |
| Run time | 7 hours 39 min 5 sec |
| CPU time | 1 days 0 hours 41 min 22 sec |
| Priority | 28 |
| Validate state | Valid |
| Credit | 1,484.64 |
| Device peak FLOPS | 38.33 GFLOPS |
| Application version | ATLAS Simulation v3.03 (vbox64_mt_mcore_atlas) x86_64-apple-darwin |
| Peak working set size | 9.17 GB |
| Peak swap size | 70.19 GB |
| Peak disk usage | 418.19 MB |
<core_client_version>8.2.8</core_client_version> <![CDATA[ <stderr_txt> 2026-03-11 03:57:38 (32532): vboxwrapper version 26210 2026-03-11 03:57:38 (32532): BOINC client version: 8.2.8 2026-03-11 03:57:39 (32532): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-11 03:57:39 (32532): Detected: Sandbox Configuration Enabled 2026-03-11 03:57:39 (32532): Successfully copied 'init_data.xml' to the shared directory. 2026-03-11 03:57:39 (32532): Create VM. (boinc_3c28521f8736e982, slot#0) 2026-03-11 03:57:39 (32532): Setting Memory Size for VM. (4800MB) 2026-03-11 03:57:39 (32532): Setting CPU Count for VM. (8) 2026-03-11 03:57:39 (32532): Setting Chipset Options for VM. 2026-03-11 03:57:39 (32532): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB) 2026-03-11 03:57:40 (32532): Setting Boot Options for VM. 2026-03-11 03:57:40 (32532): Setting Network Configuration for NAT. (Driver: virtio) 2026-03-11 03:57:40 (32532): Enabling VM Network Access. 2026-03-11 03:57:40 (32532): Disabling USB Support for VM. 2026-03-11 03:57:40 (32532): Disabling COM Port Support for VM. 2026-03-11 03:57:40 (32532): Disabling Audio Support for VM. 2026-03-11 03:57:41 (32532): Disabling Clipboard Support for VM. 2026-03-11 03:57:41 (32532): Disabling Drag and Drop Support for VM. 2026-03-11 03:57:41 (32532): Adding storage controller(s) to VM. 2026-03-11 03:57:41 (32532): Adding virtual disk drive to VM. (ATLAS_vbox_3.03_image.vdi) 2026-03-11 03:57:42 (32532): Adding VirtualBox Guest Additions to VM. 2026-03-11 03:57:42 (32532): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2026-03-11 03:57:42 (32532): forwarding host port 51494 to guest port 80 2026-03-11 03:57:42 (32532): Enabling remote desktop for VM. 2026-03-11 03:57:43 (32532): Required extension pack not installed, remote desktop not enabled. 2026-03-11 03:57:43 (32532): Enabling shared directory for VM. 2026-03-11 03:57:43 (32532): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-11 03:57:53 (32532): Successfully started VM. (PID = '32609') 2026-03-11 03:57:53 (32532): Reporting VM Process ID to BOINC. 2026-03-11 03:57:53 (32532): Guest Log: BIOS: VirtualBox 7.1.6 2026-03-11 03:57:53 (32532): Guest Log: CPUID EDX: 0x178bfbff 2026-03-11 03:57:53 (32532): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-03-11 03:57:53 (32532): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-03-11 03:57:53 (32532): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-11 03:57:53 (32532): Detected: Web Application Enabled (http://localhost:51494) 2026-03-11 03:57:53 (32532): Preference change detected 2026-03-11 03:57:53 (32532): Setting CPU throttle for VM. (20%) 2026-03-11 03:57:53 (32532): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-11 03:57:55 (32532): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-03-11 03:57:55 (32532): Guest Log: BIOS: Booting from Hard Disk... 2026-03-11 03:57:59 (32532): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-03-11 03:57:59 (32532): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2026-03-11 03:57:59 (32532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2026-03-11 03:58:54 (32532): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-03-11 03:58:54 (32532): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-03-11 04:00:42 (32532): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2026-03-11 04:00:42 (32532): Guest Log: 00:00:00.000366 main Log opened 2026-03-11T02:00:39.193286000Z 2026-03-11 04:00:42 (32532): Guest Log: 00:00:00.000723 main OS Product: Linux 2026-03-11 04:00:42 (32532): Guest Log: 00:00:00.001075 main OS Release: 3.10.0-957.27.2.el7.x86_64 2026-03-11 04:00:42 (32532): Guest Log: 00:00:00.001530 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2026-03-11 04:00:42 (32532): Guest Log: 00:00:00.001641 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2026-03-11 04:00:42 (32532): Guest Log: 00:00:00.001644 main Process ID: 1411 2026-03-11 04:00:42 (32532): Guest Log: 00:00:00.001645 main Package type: LINUX_64BITS_GENERIC 2026-03-11 04:00:42 (32532): Guest Log: 00:00:00.005630 main 5.2.32 r132073 started. Verbose level = 0 2026-03-11 04:00:43 (32532): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2026-03-11 04:00:44 (32532): Guest Log: [INFO] Mounting shared directory 2026-03-11 04:00:45 (32532): Guest Log: [INFO] Checking for init_data.xml 2026-03-11 04:01:04 (32532): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2026-03-11 04:01:04 (32532): Guest Log: [INFO] Detected branch: prod 2026-03-11 04:01:07 (32532): Guest Log: This is the prod version of the ATLAS job wrapper 2026-03-11 04:01:07 (32532): Guest Log: Copying input files 2026-03-11 04:01:48 (32532): Guest Log: Copied input files into RunAtlas. 2026-03-11 04:01:50 (32532): Guest Log: This VM did not configure a local http proxy via BOINC. 2026-03-11 04:01:50 (32532): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2026-03-11 04:01:50 (32532): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2026-03-11 04:01:50 (32532): Guest Log: Further information can be found at the LHC@home message board. 2026-03-11 04:02:09 (32532): Guest Log: Running cvmfs_config stat atlas.cern.ch 2026-03-11 04:02:12 (32532): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2026-03-11 04:02:12 (32532): Guest Log: 2.6.3.0 1690 1 30160 157137 3 1 3117743 4096001 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2026-03-11 04:02:20 (32532): Guest Log: copied the webapp to /var/www 2026-03-11 04:02:20 (32532): Guest Log: ATHENA_PROC_NUMBER=8 2026-03-11 04:02:21 (32532): Guest Log: ATHENA_CORE_NUMBER=8 2026-03-11 04:02:22 (32532): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2026-03-11 04:02:23 (32532): Guest Log: *** Starting ATLAS job. (PandaID=7041159158 taskID=48955015) *** 2026-03-11 05:37:54 (32532): Status Report: Elapsed Time: '6000.558815' 2026-03-11 05:37:54 (32532): Status Report: CPU Time: '11915.340000' 2026-03-11 06:00:01 (32532): Stopping VM. 2026-03-11 06:00:48 (32532): Successfully stopped VM. 2026-03-11 23:00:01 (37015): vboxwrapper version 26210 2026-03-11 23:00:01 (37015): BOINC client version: 8.2.8 2026-03-11 23:00:02 (37015): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-11 23:00:02 (37015): Detected: Sandbox Configuration Enabled 2026-03-11 23:00:02 (37015): Guest Log: BIOS: VirtualBox 7.1.6 2026-03-11 23:00:02 (37015): Guest Log: CPUID EDX: 0x178bfbff 2026-03-11 23:00:02 (37015): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-03-11 23:00:02 (37015): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-03-11 23:00:02 (37015): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-03-11 23:00:02 (37015): Guest Log: BIOS: Booting from Hard Disk... 2026-03-11 23:00:02 (37015): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-03-11 23:00:02 (37015): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2026-03-11 23:00:02 (37015): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2026-03-11 23:00:02 (37015): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-03-11 23:00:02 (37015): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-03-11 23:00:02 (37015): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2026-03-11 23:00:02 (37015): Guest Log: 00:00:00.000366 main Log opened 2026-03-11T02:00:39.193286000Z 2026-03-11 23:00:02 (37015): Guest Log: 00:00:00.000723 main OS Product: Linux 2026-03-11 23:00:02 (37015): Guest Log: 00:00:00.001075 main OS Release: 3.10.0-957.27.2.el7.x86_64 2026-03-11 23:00:02 (37015): Guest Log: 00:00:00.001530 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2026-03-11 23:00:02 (37015): Guest Log: 00:00:00.001641 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2026-03-11 23:00:02 (37015): Guest Log: 00:00:00.001644 main Process ID: 1411 2026-03-11 23:00:02 (37015): Guest Log: 00:00:00.001645 main Package type: LINUX_64BITS_GENERIC 2026-03-11 23:00:02 (37015): Guest Log: 00:00:00.005630 main 5.2.32 r132073 started. Verbose level = 0 2026-03-11 23:00:02 (37015): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2026-03-11 23:00:02 (37015): Guest Log: [INFO] Mounting shared directory 2026-03-11 23:00:02 (37015): Guest Log: [INFO] Checking for init_data.xml 2026-03-11 23:00:02 (37015): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2026-03-11 23:00:02 (37015): Guest Log: [INFO] Detected branch: prod 2026-03-11 23:00:02 (37015): Guest Log: This is the prod version of the ATLAS job wrapper 2026-03-11 23:00:02 (37015): Guest Log: Copying input files 2026-03-11 23:00:02 (37015): Guest Log: Copied input files into RunAtlas. 2026-03-11 23:00:02 (37015): Guest Log: This VM did not configure a local http proxy via BOINC. 2026-03-11 23:00:02 (37015): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2026-03-11 23:00:02 (37015): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2026-03-11 23:00:02 (37015): Guest Log: Further information can be found at the LHC@home message board. 2026-03-11 23:00:02 (37015): Guest Log: Running cvmfs_config stat atlas.cern.ch 2026-03-11 23:00:02 (37015): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2026-03-11 23:00:02 (37015): Guest Log: 2.6.3.0 1690 1 30160 157137 3 1 3117743 4096001 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2026-03-11 23:00:02 (37015): Guest Log: copied the webapp to /var/www 2026-03-11 23:00:02 (37015): Guest Log: ATHENA_PROC_NUMBER=8 2026-03-11 23:00:02 (37015): Guest Log: ATHENA_CORE_NUMBER=8 2026-03-11 23:00:02 (37015): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2026-03-11 23:00:02 (37015): Guest Log: *** Starting ATLAS job. (PandaID=7041159158 taskID=48955015) *** 2026-03-11 23:00:02 (37015): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-11 23:00:21 (37015): Successfully started VM. (PID = '37030') 2026-03-11 23:00:21 (37015): Reporting VM Process ID to BOINC. 2026-03-11 23:00:21 (37015): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-11 23:00:21 (37015): Detected: Web Application Enabled (http://localhost:51494) 2026-03-11 23:00:21 (37015): Status Report: Elapsed Time: '7327.558815' 2026-03-11 23:00:21 (37015): Status Report: CPU Time: '16898.020000' 2026-03-11 23:00:21 (37015): Preference change detected 2026-03-11 23:00:21 (37015): Setting CPU throttle for VM. (20%) 2026-03-11 23:00:21 (37015): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-11 23:00:27 (37015): Guest Log: 01:58:53.543661 timesync vgsvcTimeSyncWorker: Radical host time change: 61 220 440 000 000ns (HostNow=1 773 262 785 259 000 000 ns HostLast=1 773 201 564 819 000 000 ns) 2026-03-11 23:00:37 (37015): Guest Log: 01:59:03.587175 timesync vgsvcTimeSyncWorker: Radical guest time change: 61 223 053 607 000ns (GuestNow=1 773 262 795 546 282 000 ns GuestLast=1 773 201 572 492 675 000 ns fSetTimeLastLoop=true ) 2026-03-12 00:36:42 (37015): Stopping VM. 2026-03-15 00:51:13 (46568): vboxwrapper version 26210 2026-03-15 00:51:13 (46568): BOINC client version: 8.2.8 2026-03-15 00:51:17 (46568): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-15 00:51:17 (46568): Detected: Sandbox Configuration Enabled 2026-03-15 00:51:18 (46568): Guest Log: 01:58:53.543661 timesync vgsvcTimeSyncWorker: Radical host time change: 61 220 440 000 000ns (HostNow=1 773 262 785 259 000 000 ns HostLast=1 773 201 564 819 000 000 ns) 2026-03-15 00:51:18 (46568): Guest Log: 01:59:03.587175 timesync vgsvcTimeSyncWorker: Radical guest time change: 61 223 053 607 000ns (GuestNow=1 773 262 795 546 282 000 ns GuestLast=1 773 201 572 492 675 000 ns fSetTimeLastLoop=true ) 2026-03-15 00:51:18 (46568): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-15 00:51:28 (46568): Successfully started VM. (PID = '46610') 2026-03-15 00:51:28 (46568): Reporting VM Process ID to BOINC. 2026-03-15 00:51:28 (46568): Guest Log: BIOS: VirtualBox 7.1.6 2026-03-15 00:51:28 (46568): Guest Log: CPUID EDX: 0x178bfbff 2026-03-15 00:51:28 (46568): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-03-15 00:51:28 (46568): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-03-15 00:51:28 (46568): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-15 00:51:28 (46568): Detected: Web Application Enabled (http://localhost:51494) 2026-03-15 00:51:29 (46568): VM state change detected. (old = 'running', new = 'paused') 2026-03-15 00:51:44 (46568): Status Report: Elapsed Time: '13108.355560' 2026-03-15 00:51:44 (46568): Status Report: CPU Time: '38266.500000' 2026-03-15 00:51:44 (46568): Preference change detected 2026-03-15 00:51:44 (46568): Setting CPU throttle for VM. (20%) 2026-03-15 00:51:44 (46568): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-15 00:51:45 (46568): VM state change detected. (old = 'paused', new = 'running') 2026-03-15 00:51:46 (46568): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-03-15 00:51:46 (46568): Guest Log: BIOS: Booting from Hard Disk... 2026-03-15 00:51:51 (46568): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-03-15 00:51:51 (46568): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2026-03-15 00:51:51 (46568): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2026-03-15 00:52:08 (46568): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-03-15 00:52:08 (46568): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-03-15 00:52:47 (46568): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2026-03-15 00:52:47 (46568): Guest Log: 00:00:00.000149 main Log opened 2026-03-14T22:52:29.637699000Z 2026-03-15 00:52:47 (46568): Guest Log: 00:00:00.000512 main OS Product: Linux 2026-03-15 00:52:47 (46568): Guest Log: 00:00:00.000565 main OS Release: 3.10.0-957.27.2.el7.x86_64 2026-03-15 00:52:47 (46568): Guest Log: 00:00:00.000612 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2026-03-15 00:52:47 (46568): Guest Log: 00:00:00.000661 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2026-03-15 00:52:47 (46568): Guest Log: 00:00:00.000662 main Process ID: 1380 2026-03-15 00:52:47 (46568): Guest Log: 00:00:00.000663 main Package type: LINUX_64BITS_GENERIC 2026-03-15 00:52:47 (46568): Guest Log: 00:00:00.002959 main 5.2.32 r132073 started. Verbose level = 0 2026-03-15 00:52:48 (46568): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2026-03-15 00:52:48 (46568): Guest Log: [INFO] Mounting shared directory 2026-03-15 00:52:48 (46568): Guest Log: [INFO] Checking for init_data.xml 2026-03-15 00:53:53 (46568): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2026-03-15 00:53:53 (46568): Guest Log: [INFO] Detected branch: prod 2026-03-15 00:53:53 (46568): Guest Log: This is the prod version of the ATLAS job wrapper 2026-03-15 00:53:53 (46568): Guest Log: Copying input files 2026-03-15 00:54:16 (46568): Guest Log: Copied input files into RunAtlas. 2026-03-15 00:54:17 (46568): Guest Log: This VM did not configure a local http proxy via BOINC. 2026-03-15 00:54:17 (46568): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2026-03-15 00:54:17 (46568): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2026-03-15 00:54:17 (46568): Guest Log: Further information can be found at the LHC@home message board. 2026-03-15 00:54:31 (46568): Guest Log: Running cvmfs_config stat atlas.cern.ch 2026-03-15 00:54:31 (46568): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2026-03-15 00:54:31 (46568): Guest Log: 2.6.3.0 1678 0 32016 157292 3 1 3885379 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2026-03-15 00:54:34 (46568): Guest Log: copied the webapp to /var/www 2026-03-15 00:54:34 (46568): Guest Log: ATHENA_PROC_NUMBER=8 2026-03-15 00:54:34 (46568): Guest Log: ATHENA_CORE_NUMBER=8 2026-03-15 00:54:34 (46568): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2026-03-15 00:54:34 (46568): Guest Log: *** Starting ATLAS job. (PandaID=7041159158 taskID=48955015) *** 2026-03-15 02:28:44 (46568): Preference change detected 2026-03-15 02:28:44 (46568): Setting CPU throttle for VM. (20%) 2026-03-15 02:28:45 (46568): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-15 02:28:45 (46568): Stopping VM. 2026-03-15 02:29:40 (46568): Successfully stopped VM. 2026-03-16 23:00:00 (52243): vboxwrapper version 26210 2026-03-16 23:00:00 (52243): BOINC client version: 8.2.8 2026-03-16 23:00:02 (52243): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-16 23:00:02 (52243): Detected: Sandbox Configuration Enabled 2026-03-16 23:00:02 (52243): Guest Log: BIOS: VirtualBox 7.1.6 2026-03-16 23:00:02 (52243): Guest Log: CPUID EDX: 0x178bfbff 2026-03-16 23:00:02 (52243): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2026-03-16 23:00:02 (52243): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-03-16 23:00:02 (52243): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-03-16 23:00:02 (52243): Guest Log: BIOS: Booting from Hard Disk... 2026-03-16 23:00:02 (52243): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-03-16 23:00:02 (52243): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2026-03-16 23:00:02 (52243): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2026-03-16 23:00:02 (52243): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-03-16 23:00:02 (52243): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2026-03-16 23:00:02 (52243): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2026-03-16 23:00:02 (52243): Guest Log: 00:00:00.000149 main Log opened 2026-03-14T22:52:29.637699000Z 2026-03-16 23:00:02 (52243): Guest Log: 00:00:00.000512 main OS Product: Linux 2026-03-16 23:00:02 (52243): Guest Log: 00:00:00.000565 main OS Release: 3.10.0-957.27.2.el7.x86_64 2026-03-16 23:00:02 (52243): Guest Log: 00:00:00.000612 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2026-03-16 23:00:02 (52243): Guest Log: 00:00:00.000661 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2026-03-16 23:00:02 (52243): Guest Log: 00:00:00.000662 main Process ID: 1380 2026-03-16 23:00:02 (52243): Guest Log: 00:00:00.000663 main Package type: LINUX_64BITS_GENERIC 2026-03-16 23:00:02 (52243): Guest Log: 00:00:00.002959 main 5.2.32 r132073 started. Verbose level = 0 2026-03-16 23:00:02 (52243): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2026-03-16 23:00:02 (52243): Guest Log: [INFO] Mounting shared directory 2026-03-16 23:00:02 (52243): Guest Log: [INFO] Checking for init_data.xml 2026-03-16 23:00:02 (52243): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2026-03-16 23:00:02 (52243): Guest Log: [INFO] Detected branch: prod 2026-03-16 23:00:02 (52243): Guest Log: This is the prod version of the ATLAS job wrapper 2026-03-16 23:00:02 (52243): Guest Log: Copying input files 2026-03-16 23:00:02 (52243): Guest Log: Copied input files into RunAtlas. 2026-03-16 23:00:02 (52243): Guest Log: This VM did not configure a local http proxy via BOINC. 2026-03-16 23:00:02 (52243): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2026-03-16 23:00:02 (52243): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2026-03-16 23:00:02 (52243): Guest Log: Further information can be found at the LHC@home message board. 2026-03-16 23:00:02 (52243): Guest Log: Running cvmfs_config stat atlas.cern.ch 2026-03-16 23:00:02 (52243): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2026-03-16 23:00:02 (52243): Guest Log: 2.6.3.0 1678 0 32016 157292 3 1 3885379 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2026-03-16 23:00:02 (52243): Guest Log: copied the webapp to /var/www 2026-03-16 23:00:02 (52243): Guest Log: ATHENA_PROC_NUMBER=8 2026-03-16 23:00:02 (52243): Guest Log: ATHENA_CORE_NUMBER=8 2026-03-16 23:00:02 (52243): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2026-03-16 23:00:02 (52243): Guest Log: *** Starting ATLAS job. (PandaID=7041159158 taskID=48955015) *** 2026-03-16 23:00:02 (52243): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-16 23:00:27 (52243): Successfully started VM. (PID = '52258') 2026-03-16 23:00:27 (52243): Reporting VM Process ID to BOINC. 2026-03-16 23:00:27 (52243): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-16 23:00:27 (52243): Detected: Web Application Enabled (http://localhost:51494) 2026-03-16 23:00:27 (52243): Status Report: Elapsed Time: '18927.794535' 2026-03-16 23:00:27 (52243): Status Report: CPU Time: '56068.970000' 2026-03-16 23:00:27 (52243): Preference change detected 2026-03-16 23:00:27 (52243): Setting CPU throttle for VM. (20%) 2026-03-16 23:00:27 (52243): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-16 23:00:33 (52243): Guest Log: 01:36:04.775266 timesync vgsvcTimeSyncWorker: Radical host time change: 160 302 018 000 000ns (HostNow=1 773 694 790 144 000 000 ns HostLast=1 773 534 488 126 000 000 ns) 2026-03-16 23:00:43 (52243): Guest Log: 01:36:14.832076 timesync vgsvcTimeSyncWorker: Radical guest time change: 160 285 804 948 000ns (GuestNow=1 773 694 800 208 925 000 ns GuestLast=1 773 534 514 403 977 000 ns fSetTimeLastLoop=true ) 2026-03-16 23:03:08 (52243): Stopping VM. 2026-03-16 23:03:46 (52243): Successfully stopped VM. 2026-03-16 23:10:31 (52352): vboxwrapper version 26210 2026-03-16 23:10:31 (52352): BOINC client version: 8.2.8 2026-03-16 23:10:31 (52352): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-16 23:10:31 (52352): Detected: Sandbox Configuration Enabled 2026-03-16 23:10:32 (52352): Guest Log: 01:36:04.775266 timesync vgsvcTimeSyncWorker: Radical host time change: 160 302 018 000 000ns (HostNow=1 773 694 790 144 000 000 ns HostLast=1 773 534 488 126 000 000 ns) 2026-03-16 23:10:32 (52352): Guest Log: 01:36:14.832076 timesync vgsvcTimeSyncWorker: Radical guest time change: 160 285 804 948 000ns (GuestNow=1 773 694 800 208 925 000 ns GuestLast=1 773 534 514 403 977 000 ns fSetTimeLastLoop=true ) 2026-03-16 23:10:32 (52352): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-16 23:10:45 (52352): Successfully started VM. (PID = '52367') 2026-03-16 23:10:45 (52352): Reporting VM Process ID to BOINC. 2026-03-16 23:10:45 (52352): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-16 23:10:45 (52352): Detected: Web Application Enabled (http://localhost:51494) 2026-03-16 23:10:45 (52352): Status Report: Elapsed Time: '19086.794535' 2026-03-16 23:10:45 (52352): Status Report: CPU Time: '56638.330000' 2026-03-16 23:10:45 (52352): Preference change detected 2026-03-16 23:10:45 (52352): Setting CPU throttle for VM. (20%) 2026-03-16 23:10:45 (52352): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-16 23:12:47 (52352): Stopping VM. 2026-03-16 23:13:30 (52352): Successfully stopped VM. 2026-03-16 23:16:32 (52423): vboxwrapper version 26210 2026-03-16 23:16:32 (52423): BOINC client version: 8.2.8 2026-03-16 23:16:32 (52423): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-16 23:16:32 (52423): Detected: Sandbox Configuration Enabled 2026-03-16 23:16:32 (52423): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-16 23:16:51 (52423): Successfully started VM. (PID = '52438') 2026-03-16 23:16:51 (52423): Reporting VM Process ID to BOINC. 2026-03-16 23:16:51 (52423): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-16 23:16:51 (52423): Detected: Web Application Enabled (http://localhost:51494) 2026-03-16 23:16:51 (52423): Status Report: Elapsed Time: '19208.794535' 2026-03-16 23:16:51 (52423): Status Report: CPU Time: '57084.000000' 2026-03-16 23:16:51 (52423): Preference change detected 2026-03-16 23:16:51 (52423): Setting CPU throttle for VM. (20%) 2026-03-16 23:16:51 (52423): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-16 23:17:44 (52423): Stopping VM. 2026-03-16 23:18:27 (52423): Successfully stopped VM. 2026-03-16 23:20:48 (52476): vboxwrapper version 26210 2026-03-16 23:20:48 (52476): BOINC client version: 8.2.8 2026-03-16 23:20:48 (52476): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-16 23:20:48 (52476): Detected: Sandbox Configuration Enabled 2026-03-16 23:20:49 (52476): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-16 23:21:12 (52476): Successfully started VM. (PID = '52491') 2026-03-16 23:21:12 (52476): Reporting VM Process ID to BOINC. 2026-03-16 23:21:12 (52476): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-16 23:21:12 (52476): Detected: Web Application Enabled (http://localhost:51494) 2026-03-16 23:21:12 (52476): Status Report: Elapsed Time: '19261.794535' 2026-03-16 23:21:12 (52476): Status Report: CPU Time: '57281.500000' 2026-03-16 23:21:12 (52476): Preference change detected 2026-03-16 23:21:12 (52476): Setting CPU throttle for VM. (20%) 2026-03-16 23:21:12 (52476): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-16 23:27:13 (52476): Stopping VM. 2026-03-16 23:27:52 (52476): Successfully stopped VM. 2026-03-16 23:32:04 (52609): vboxwrapper version 26210 2026-03-16 23:32:04 (52609): BOINC client version: 8.2.8 2026-03-16 23:32:04 (52609): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-16 23:32:04 (52609): Detected: Sandbox Configuration Enabled 2026-03-16 23:32:04 (52609): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-16 23:32:17 (52609): Successfully started VM. (PID = '52624') 2026-03-16 23:32:17 (52609): Reporting VM Process ID to BOINC. 2026-03-16 23:32:17 (52609): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-16 23:32:17 (52609): Detected: Web Application Enabled (http://localhost:51494) 2026-03-16 23:32:17 (52609): Status Report: Elapsed Time: '19622.794535' 2026-03-16 23:32:17 (52609): Status Report: CPU Time: '58541.260000' 2026-03-16 23:32:17 (52609): Preference change detected 2026-03-16 23:32:17 (52609): Setting CPU throttle for VM. (20%) 2026-03-16 23:32:17 (52609): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-16 23:45:53 (52609): Stopping VM. 2026-03-16 23:46:36 (52609): Successfully stopped VM. 2026-03-16 23:50:56 (52868): vboxwrapper version 26210 2026-03-16 23:50:56 (52868): BOINC client version: 8.2.8 2026-03-16 23:50:56 (52868): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-16 23:50:56 (52868): Detected: Sandbox Configuration Enabled 2026-03-16 23:50:57 (52868): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-16 23:51:09 (52868): Successfully started VM. (PID = '52883') 2026-03-16 23:51:09 (52868): Reporting VM Process ID to BOINC. 2026-03-16 23:51:09 (52868): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-16 23:51:09 (52868): Detected: Web Application Enabled (http://localhost:51494) 2026-03-16 23:51:09 (52868): Status Report: Elapsed Time: '20438.794535' 2026-03-16 23:51:09 (52868): Status Report: CPU Time: '61481.020000' 2026-03-16 23:51:09 (52868): Preference change detected 2026-03-16 23:51:09 (52868): Setting CPU throttle for VM. (20%) 2026-03-16 23:51:09 (52868): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-17 00:10:01 (52868): Stopping VM. 2026-03-17 00:10:48 (52868): Successfully stopped VM. 2026-03-17 23:36:02 (54566): vboxwrapper version 26210 2026-03-17 23:36:02 (54566): BOINC client version: 8.2.8 2026-03-17 23:36:03 (54566): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-17 23:36:03 (54566): Detected: Sandbox Configuration Enabled 2026-03-17 23:36:03 (54566): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-17 23:36:24 (54566): Successfully started VM. (PID = '54581') 2026-03-17 23:36:24 (54566): Reporting VM Process ID to BOINC. 2026-03-17 23:36:24 (54566): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-17 23:36:24 (54566): Detected: Web Application Enabled (http://localhost:51494) 2026-03-17 23:36:24 (54566): Status Report: Elapsed Time: '21570.794535' 2026-03-17 23:36:24 (54566): Status Report: CPU Time: '65610.310000' 2026-03-17 23:36:24 (54566): Preference change detected 2026-03-17 23:36:24 (54566): Setting CPU throttle for VM. (20%) 2026-03-17 23:36:24 (54566): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-17 23:36:33 (54566): Guest Log: 02:20:18.678535 timesync vgsvcTimeSyncWorker: Radical host time change: 84 382 231 000 000ns (HostNow=1 773 783 338 733 000 000 ns HostLast=1 773 698 956 502 000 000 ns) 2026-03-17 23:36:43 (54566): Guest Log: 02:20:28.689737 timesync vgsvcTimeSyncWorker: Radical guest time change: 84 341 757 401 000ns (GuestNow=1 773 783 348 744 949 000 ns GuestLast=1 773 699 006 987 548 000 ns fSetTimeLastLoop=true ) 2026-03-17 23:40:33 (54566): Stopping VM. 2026-03-17 23:41:16 (54566): Successfully stopped VM. 2026-03-17 23:49:28 (54696): vboxwrapper version 26210 2026-03-17 23:49:28 (54696): BOINC client version: 8.2.8 2026-03-17 23:49:28 (54696): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-17 23:49:28 (54696): Detected: Sandbox Configuration Enabled 2026-03-17 23:49:29 (54696): Guest Log: 02:20:18.678535 timesync vgsvcTimeSyncWorker: Radical host time change: 84 382 231 000 000ns (HostNow=1 773 783 338 733 000 000 ns HostLast=1 773 698 956 502 000 000 ns) 2026-03-17 23:49:29 (54696): Guest Log: 02:20:28.689737 timesync vgsvcTimeSyncWorker: Radical guest time change: 84 341 757 401 000ns (GuestNow=1 773 783 348 744 949 000 ns GuestLast=1 773 699 006 987 548 000 ns fSetTimeLastLoop=true ) 2026-03-17 23:49:29 (54696): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-17 23:49:42 (54696): Successfully started VM. (PID = '54711') 2026-03-17 23:49:42 (54696): Reporting VM Process ID to BOINC. 2026-03-17 23:49:42 (54696): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-17 23:49:42 (54696): Detected: Web Application Enabled (http://localhost:51494) 2026-03-17 23:49:42 (54696): Status Report: Elapsed Time: '21819.794535' 2026-03-17 23:49:42 (54696): Status Report: CPU Time: '66507.710000' 2026-03-17 23:49:42 (54696): Preference change detected 2026-03-17 23:49:42 (54696): Setting CPU throttle for VM. (20%) 2026-03-17 23:49:42 (54696): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-17 23:58:53 (54696): Stopping VM. 2026-03-17 23:59:34 (54696): Successfully stopped VM. 2026-03-18 02:38:52 (1881): vboxwrapper version 26210 2026-03-18 02:38:52 (1881): BOINC client version: 8.2.8 2026-03-18 02:38:53 (1881): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2026-03-18 02:38:53 (1881): Detected: Sandbox Configuration Enabled 2026-03-18 02:38:53 (1881): Starting VM using VBoxManage interface. (boinc_3c28521f8736e982, slot#0) 2026-03-18 02:39:11 (1881): Successfully started VM. (PID = '1897') 2026-03-18 02:39:11 (1881): Reporting VM Process ID to BOINC. 2026-03-18 02:39:11 (1881): Guest Log: 02:33:32.746159 timesync vgsvcTimeSyncWorker: Radical host time change: 9 617 803 000 000ns (HostNow=1 773 794 318 961 000 000 ns HostLast=1 773 784 701 158 000 000 ns) 2026-03-18 02:39:11 (1881): VM state change detected. (old = 'poweredoff', new = 'running') 2026-03-18 02:39:11 (1881): Detected: Web Application Enabled (http://localhost:51494) 2026-03-18 02:39:11 (1881): Status Report: Elapsed Time: '22370.794535' 2026-03-18 02:39:11 (1881): Status Report: CPU Time: '68456.690000' 2026-03-18 02:39:11 (1881): Preference change detected 2026-03-18 02:39:11 (1881): Setting CPU throttle for VM. (20%) 2026-03-18 02:39:11 (1881): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-03-18 02:39:21 (1881): Guest Log: 02:33:42.751579 timesync vgsvcTimeSyncWorker: Radical guest time change: 9 629 571 750 000ns (GuestNow=1 773 794 328 973 820 000 ns GuestLast=1 773 784 699 402 070 000 ns fSetTimeLastLoop=true ) 2026-03-18 04:11:57 (1881): Guest Log: *** Job finished *** 2026-03-18 04:11:58 (1881): Guest Log: *** The last 20 lines of the pilot log: *** 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:05,341 | INFO | found 0 job(s) in 20 queues 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:05,341 | WARNING | pilot monitor received instruction that args.graceful_stop has been set 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:05,341 | WARNING | will wait for a maximum of 300 s for threads to finish 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:06,495 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140496048662336)>', '<ExcThread(monitor, started 140495024027392)>'] 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:07,395 | WARNING | job_aborted has been set - aborting pilot monitoring 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:07,395 | INFO | [monitor] control thread has ended 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:11,496 | INFO | all workflow threads have been joined 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:11,496 | INFO | end of generic workflow (traces error code: 0) 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:11,497 | INFO | traces error code: 0 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:11,497 | INFO | pilot has finished (exit code=0, shell exit code=0) 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:12,395 [wrapper] ==== pilot stdout END ==== 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:13,087 [wrapper] ==== wrapper stdout RESUME ==== 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:13,340 [wrapper] pilotpid: 6125 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:13,454 [wrapper] Pilot exit status: 0 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:14,852 [wrapper] pandaids: 7041159158 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:15,837 [wrapper] cleanup supervisor_pilot 19725 6126 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:16,054 [wrapper] Test setup, not cleaning 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:16,782 [wrapper] apfmon messages muted 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:17,287 [wrapper] ==== wrapper stdout END ==== 2026-03-18 04:11:58 (1881): Guest Log: 2026-03-18 02:11:17,396 [wrapper] ==== wrapper stderr END ==== 2026-03-18 04:11:58 (1881): Guest Log: *** Error codes and diagnostics *** 2026-03-18 04:11:58 (1881): Guest Log: "exeErrorCode": 0, 2026-03-18 04:11:58 (1881): Guest Log: "exeErrorDiag": "", 2026-03-18 04:11:58 (1881): Guest Log: "pilotErrorCode": 0, 2026-03-18 04:11:58 (1881): Guest Log: "pilotErrorDiag": "", 2026-03-18 04:11:59 (1881): Guest Log: *** Listing of results directory *** 2026-03-18 04:11:59 (1881): Guest Log: total 192012 2026-03-18 04:11:59 (1881): Guest Log: -rw-r--r--. 1 atlas atlas 584627 Mar 9 19:08 pilot3.tar.gz 2026-03-18 04:11:59 (1881): Guest Log: -rwx------. 1 atlas atlas 36322 Mar 9 19:09 runpilot2-wrapper.sh 2026-03-18 04:11:59 (1881): Guest Log: -rw-r--r--. 1 atlas atlas 5111 Mar 9 19:10 queuedata.json 2026-03-18 04:11:59 (1881): Guest Log: -rw-r-----. 1 atlas atlas 15845 Mar 14 22:53 start_atlas.sh 2026-03-18 04:11:59 (1881): Guest Log: -rw-r-----. 1 atlas atlas 597955 Mar 14 22:53 input.tar.gz 2026-03-18 04:11:59 (1881): Guest Log: -rw-r--r--. 1 atlas atlas 9890 Mar 14 22:53 init_data.xml 2026-03-18 04:11:59 (1881): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Mar 14 22:53 EVNT.46701403._002258.pool.root.1 -> /data/./ATLAS.root_0 2026-03-18 04:11:59 (1881): Guest Log: -rw-r--r--. 1 atlas atlas 2572 Mar 14 22:54 pandaJob.out 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 1006481 Mar 14 22:56 agis_schedconf.cvmfs.json 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 410 Mar 14 22:56 workernode_map.json 2026-03-18 04:11:59 (1881): Guest Log: drwx------. 5 atlas atlas 4096 Mar 14 22:56 pilot3 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 188186369 Mar 18 02:05 HITS.48955015._010289.pool.root.1 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 1029 Mar 18 02:09 memory_monitor_summary.json 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 1511579 Mar 18 02:10 agis_ddmendpoints.agis.ALL.json 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 99 Mar 18 02:10 pilot_heartbeat.json 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 470949 Mar 18 02:10 log.48955015._010289.job.log.tgz.1 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 6339 Mar 18 02:10 heartbeat.json 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 4988 Mar 18 02:11 pilotlog.txt 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 1811764 Mar 18 02:11 log.48955015._010289.job.log.1 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 357 Mar 18 02:11 output.list 2026-03-18 04:11:59 (1881): Guest Log: -rw-r--r--. 1 atlas atlas 620 Mar 18 02:11 runtime_log 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 2304000 Mar 18 02:11 result.tar.gz 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 666 Mar 18 02:11 xZrNDmMAvJ9n9Rq4apOajLDm4fhM0noT9bVooX4SDmgtaLDm8tjscm.diag 2026-03-18 04:11:59 (1881): Guest Log: -rw-r--r--. 1 atlas atlas 8761 Mar 18 02:11 runtime_log.err 2026-03-18 04:11:59 (1881): Guest Log: Looking for outputfile HITS.48955015._010289.pool.root.1 2026-03-18 04:11:59 (1881): Guest Log: HITS file was successfully produced 2026-03-18 04:11:59 (1881): Guest Log: -rw-------. 1 atlas atlas 188186369 Mar 18 02:05 /home/atlas/RunAtlas/HITS.48955015._010289.pool.root.1 2026-03-18 04:12:02 (1881): Guest Log: Successfully finished the ATLAS job! 2026-03-18 04:12:02 (1881): Guest Log: Copying the results back to the shared directory! 2026-03-18 04:12:04 (1881): Guest Log: *** Contents of shared directory: *** 2026-03-18 04:12:04 (1881): Guest Log: total 430272 2026-03-18 04:12:04 (1881): Guest Log: -rw-rw----. 1 root root 437665277 Mar 11 01:57 ATLAS.root_0 2026-03-18 04:12:04 (1881): Guest Log: -rw-rw-r--. 1 root root 9890 Mar 11 01:57 init_data.xml 2026-03-18 04:12:04 (1881): Guest Log: -rw-rw----. 1 root root 597955 Mar 11 01:57 input.tar.gz 2026-03-18 04:12:04 (1881): Guest Log: -rw-r--r--. 1 root root 2304000 Mar 18 2026 result.tar.gz 2026-03-18 04:12:04 (1881): Guest Log: -rw-rw----. 1 root root 15845 Mar 11 01:57 start_atlas.sh 2026-03-18 04:12:05 (1881): Guest Log: *** Success! Shutting down the machine. *** 2026-03-18 04:12:06 (1881): VM Completion File Detected. 2026-03-18 04:12:06 (1881): Powering off VM. 2026-03-18 04:12:07 (1881): Successfully stopped VM. 2026-03-18 04:12:07 (1881): Deregistering VM. (boinc_3c28521f8736e982, slot#0) 2026-03-18 04:12:07 (1881): Removing network bandwidth throttle group from VM. 2026-03-18 04:12:07 (1881): Removing VM from VirtualBox. 2026-03-18 04:12:13 (1881): called boinc_finish(0) </stderr_txt> ]]>
©2026 CERN