Name | iPdKDmCJ2R5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmVrKKDmFxYOBo_0 |
Workunit | 223056746 |
Created | 17 May 2024, 2:15:38 UTC |
Sent | 17 May 2024, 8:46:32 UTC |
Report deadline | 30 May 2024, 18:24:37 UTC |
Received | 23 May 2024, 4:18:58 UTC |
Server state | Over |
Outcome | No reply |
Client state | Compute error |
Exit status | 0 (0x00000000) |
Computer ID | 10836791 |
Run time | 5 days 18 hours 12 min 31 sec |
CPU time | 5 days 18 hours 9 min 41 sec |
Validate state | Initial |
Credit | 0.00 |
Device peak FLOPS | 20.64 GFLOPS |
Application version | ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas) x86_64-pc-linux-gnu |
Peak working set size | 4.14 GB |
Peak swap size | 5.87 GB |
Peak disk usage | 5.63 GB |
<core_client_version>8.0.1</core_client_version> <![CDATA[ <stderr_txt> 2024-05-17 10:46:58 (1150341): Detected: vboxwrapper 26206 2024-05-17 10:46:58 (1150341): Detected: BOINC client v8.0.1 2024-05-17 10:46:58 (1150341): Detected: VirtualBox VboxManage Interface (Version: 7.0.16) 2024-05-17 10:46:59 (1150341): Successfully copied 'init_data.xml' to the shared directory. 2024-05-17 10:46:59 (1150341): Create VM. (boinc_da3cbe950647f947, slot#133) 2024-05-17 10:47:00 (1150341): Setting Memory Size for VM. (4096MB) 2024-05-17 10:47:01 (1150341): Setting CPU Count for VM. (1) 2024-05-17 10:47:01 (1150341): Setting Chipset Options for VM. 2024-05-17 10:47:01 (1150341): Setting Graphics Controller Options for VM. 2024-05-17 10:47:02 (1150341): Setting Boot Options for VM. 2024-05-17 10:47:02 (1150341): Setting Network Configuration for NAT. 2024-05-17 10:47:02 (1150341): Enabling VM Network Access. 2024-05-17 10:47:03 (1150341): Disabling USB Support for VM. 2024-05-17 10:47:03 (1150341): Disabling COM Port Support for VM. 2024-05-17 10:47:03 (1150341): Disabling LPT Port Support for VM. 2024-05-17 10:47:04 (1150341): Disabling Audio Support for VM. 2024-05-17 10:47:04 (1150341): Disabling Clipboard Support for VM. 2024-05-17 10:47:04 (1150341): Disabling Drag and Drop Support for VM. 2024-05-17 10:47:05 (1150341): Adding storage controller(s) to VM. 2024-05-17 10:47:05 (1150341): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi) 2024-05-17 10:47:06 (1150341): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2024-05-17 10:47:06 (1150341): forwarding host port 52069 to guest port 80 2024-05-17 10:47:06 (1150341): Enabling remote desktop for VM. 2024-05-17 10:47:07 (1150341): Enabling shared directory for VM. 2024-05-17 10:47:08 (1150341): Starting VM using VBoxManage interface. (boinc_da3cbe950647f947, slot#133) 2024-05-17 10:47:09 (1150341): Successfully started VM. (PID = '1150973') 2024-05-17 10:47:09 (1150341): Reporting VM Process ID to BOINC. 2024-05-17 10:47:09 (1150341): Guest Log: BIOS: VirtualBox 7.0.16 2024-05-17 10:47:09 (1150341): Guest Log: CPUID EDX: 0x178bfbff 2024-05-17 10:47:09 (1150341): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-05-17 10:47:09 (1150341): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-05-17 10:47:09 (1150341): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-17 10:47:09 (1150341): Detected: Web Application Enabled (http://localhost:52069) 2024-05-17 10:47:09 (1150341): Detected: Remote Desktop Enabled (localhost:44995) 2024-05-17 10:47:09 (1150341): Preference change detected 2024-05-17 10:47:09 (1150341): Setting CPU throttle for VM. (100%) 2024-05-17 10:47:10 (1150341): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-05-17 10:47:11 (1150341): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-05-17 10:47:11 (1150341): Guest Log: BIOS: Booting from Hard Disk... 2024-05-17 10:47:15 (1150341): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-05-17 10:47:15 (1150341): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2024-05-17 10:47:15 (1150341): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2024-05-17 10:47:23 (1150341): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-05-17 10:47:23 (1150341): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-05-17 10:47:46 (1150341): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2024-05-17 10:47:46 (1150341): Guest Log: 00:00:00.000360 main Log opened 2024-05-17T08:47:43.922835000Z 2024-05-17 10:47:46 (1150341): Guest Log: 00:00:00.000577 main OS Product: Linux 2024-05-17 10:47:46 (1150341): Guest Log: 00:00:00.000643 main OS Release: 3.10.0-957.27.2.el7.x86_64 2024-05-17 10:47:46 (1150341): Guest Log: 00:00:00.000699 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2024-05-17 10:47:46 (1150341): Guest Log: 00:00:00.000756 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2024-05-17 10:47:46 (1150341): Guest Log: 00:00:00.000758 main Process ID: 1239 2024-05-17 10:47:46 (1150341): Guest Log: 00:00:00.000759 main Package type: LINUX_64BITS_GENERIC 2024-05-17 10:47:46 (1150341): Guest Log: 00:00:00.006157 main 5.2.32 r132073 started. Verbose level = 0 2024-05-17 10:47:46 (1150341): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2024-05-17 10:47:46 (1150341): Guest Log: [INFO] Mounting shared directory 2024-05-17 10:47:46 (1150341): Guest Log: [INFO] Checking for init_data.xml 2024-05-17 10:47:49 (1150341): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2024-05-17 10:47:49 (1150341): Guest Log: [INFO] Detected branch: prod 2024-05-17 10:47:49 (1150341): Guest Log: This is the prod version of the ATLAS job wrapper 2024-05-17 10:47:49 (1150341): Guest Log: Copying input files 2024-05-17 10:47:55 (1150341): Guest Log: Copied input files into RunAtlas. 2024-05-17 10:47:55 (1150341): Guest Log: Detected user-configured HTTP proxy at http://192.168.1.179:3128 - will set in /etc/cvmfs/default.local 2024-05-17 10:48:09 (1150341): Guest Log: Running cvmfs_config stat atlas.cern.ch 2024-05-17 10:48:09 (1150341): 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 2024-05-17 10:48:09 (1150341): Guest Log: 2.6.3.0 1508 0 31560 132831 4 1 3116989 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.1.179:3128 1 2024-05-17 10:48:10 (1150341): Guest Log: copied the webapp to /var/www 2024-05-17 10:48:10 (1150341): Guest Log: core_number=1 2024-05-17 10:48:10 (1150341): 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 2024-05-17 10:48:10 (1150341): Guest Log: *** Starting ATLAS job. (PandaID=6207691358 taskID=38920982) *** 2024-05-17 12:26:10 (1150341): Status Report: Elapsed Time: '6000.000000' 2024-05-17 12:26:10 (1150341): Status Report: CPU Time: '5270.250000' 2024-05-17 14:05:11 (1150341): Status Report: Elapsed Time: '12000.000000' 2024-05-17 14:05:11 (1150341): Status Report: CPU Time: '11222.160000' 2024-05-17 15:01:08 (1150341): Stopping VM. 2024-05-17 15:02:00 (1150341): Successfully stopped VM. 2024-05-17 15:04:08 (1178096): Detected: vboxwrapper 26206 2024-05-17 15:04:08 (1178096): Detected: BOINC client v8.0.1 2024-05-17 15:04:09 (1178096): Detected: VirtualBox VboxManage Interface (Version: 7.0.16) 2024-05-17 15:04:11 (1178096): Guest Log: BIOS: VirtualBox 7.0.16 2024-05-17 15:04:11 (1178096): Guest Log: CPUID EDX: 0x178bfbff 2024-05-17 15:04:11 (1178096): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-05-17 15:04:11 (1178096): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-05-17 15:04:11 (1178096): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-05-17 15:04:11 (1178096): Guest Log: BIOS: Booting from Hard Disk... 2024-05-17 15:04:11 (1178096): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-05-17 15:04:11 (1178096): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2024-05-17 15:04:11 (1178096): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2024-05-17 15:04:11 (1178096): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-05-17 15:04:11 (1178096): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-05-17 15:04:11 (1178096): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2024-05-17 15:04:11 (1178096): Guest Log: 00:00:00.000360 main Log opened 2024-05-17T08:47:43.922835000Z 2024-05-17 15:04:11 (1178096): Guest Log: 00:00:00.000577 main OS Product: Linux 2024-05-17 15:04:11 (1178096): Guest Log: 00:00:00.000643 main OS Release: 3.10.0-957.27.2.el7.x86_64 2024-05-17 15:04:11 (1178096): Guest Log: 00:00:00.000699 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2024-05-17 15:04:11 (1178096): Guest Log: 00:00:00.000756 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2024-05-17 15:04:11 (1178096): Guest Log: 00:00:00.000758 main Process ID: 1239 2024-05-17 15:04:11 (1178096): Guest Log: 00:00:00.000759 main Package type: LINUX_64BITS_GENERIC 2024-05-17 15:04:11 (1178096): Guest Log: 00:00:00.006157 main 5.2.32 r132073 started. Verbose level = 0 2024-05-17 15:04:11 (1178096): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2024-05-17 15:04:11 (1178096): Guest Log: [INFO] Mounting shared directory 2024-05-17 15:04:11 (1178096): Guest Log: [INFO] Checking for init_data.xml 2024-05-17 15:04:11 (1178096): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2024-05-17 15:04:11 (1178096): Guest Log: [INFO] Detected branch: prod 2024-05-17 15:04:11 (1178096): Guest Log: This is the prod version of the ATLAS job wrapper 2024-05-17 15:04:11 (1178096): Guest Log: Copying input files 2024-05-17 15:04:11 (1178096): Guest Log: Copied input files into RunAtlas. 2024-05-17 15:04:11 (1178096): Guest Log: Detected user-configured HTTP proxy at http://192.168.1.179:3128 - will set in /etc/cvmfs/default.local 2024-05-17 15:04:11 (1178096): Guest Log: Running cvmfs_config stat atlas.cern.ch 2024-05-17 15:04:11 (1178096): 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 2024-05-17 15:04:11 (1178096): Guest Log: 2.6.3.0 1508 0 31560 132831 4 1 3116989 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.1.179:3128 1 2024-05-17 15:04:11 (1178096): Guest Log: copied the webapp to /var/www 2024-05-17 15:04:11 (1178096): Guest Log: core_number=1 2024-05-17 15:04:11 (1178096): 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 2024-05-17 15:04:11 (1178096): Guest Log: *** Starting ATLAS job. (PandaID=6207691358 taskID=38920982) *** 2024-05-17 15:04:11 (1178096): Starting VM using VBoxManage interface. (boinc_da3cbe950647f947, slot#133) 2024-05-17 15:04:35 (1178096): Successfully started VM. (PID = '1178172') 2024-05-17 15:04:35 (1178096): Reporting VM Process ID to BOINC. 2024-05-17 15:04:35 (1178096): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-17 15:04:35 (1178096): Detected: Web Application Enabled (http://localhost:52069) 2024-05-17 15:04:35 (1178096): Detected: Remote Desktop Enabled (localhost:44995) 2024-05-17 15:04:35 (1178096): Status Report: Elapsed Time: '15390.000000' 2024-05-17 15:04:35 (1178096): Status Report: CPU Time: '14585.020000' 2024-05-17 15:04:35 (1178096): Preference change detected 2024-05-17 15:04:35 (1178096): Setting CPU throttle for VM. (100%) 2024-05-17 15:04:36 (1178096): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-05-17 16:43:36 (1178096): Status Report: Elapsed Time: '21390.000000' 2024-05-17 16:43:36 (1178096): Status Report: CPU Time: '20559.850000' 2024-05-17 18:22:37 (1178096): Status Report: Elapsed Time: '27390.000000' 2024-05-17 18:22:37 (1178096): Status Report: CPU Time: '26513.110000' 2024-05-17 19:48:47 (1178096): Stopping VM. 2024-05-17 19:49:32 (1178096): Successfully stopped VM. 2024-05-17 19:52:57 (1212635): Detected: vboxwrapper 26206 2024-05-17 19:52:57 (1212635): Detected: BOINC client v8.0.1 2024-05-17 19:52:57 (1212635): Detected: VirtualBox VboxManage Interface (Version: 7.0.16) 2024-05-17 19:52:59 (1212635): Starting VM using VBoxManage interface. (boinc_da3cbe950647f947, slot#133) 2024-05-17 19:53:21 (1212635): Successfully started VM. (PID = '1212949') 2024-05-17 19:53:21 (1212635): Reporting VM Process ID to BOINC. 2024-05-17 19:53:22 (1212635): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-17 19:53:22 (1212635): Detected: Web Application Enabled (http://localhost:52069) 2024-05-17 19:53:22 (1212635): Detected: Remote Desktop Enabled (localhost:44995) 2024-05-17 19:53:22 (1212635): Status Report: Elapsed Time: '32611.000000' 2024-05-17 19:53:22 (1212635): Status Report: CPU Time: '31691.130000' 2024-05-17 19:53:22 (1212635): Preference change detected 2024-05-17 19:53:22 (1212635): Setting CPU throttle for VM. (100%) 2024-05-17 19:53:22 (1212635): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-05-17 20:20:09 (1212635): Stopping VM. 2024-05-17 20:20:25 (1212635): Successfully stopped VM. 2024-05-17 20:22:01 (1221977): Detected: vboxwrapper 26206 2024-05-17 20:22:01 (1221977): Detected: BOINC client v8.0.1 2024-05-17 20:22:02 (1221977): Detected: VirtualBox VboxManage Interface (Version: 7.0.16) 2024-05-17 20:22:05 (1221977): Starting VM using VBoxManage interface. (boinc_da3cbe950647f947, slot#133) 2024-05-17 20:22:37 (1221977): Successfully started VM. (PID = '1225999') 2024-05-17 20:22:37 (1221977): Reporting VM Process ID to BOINC. 2024-05-17 20:22:37 (1221977): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-17 20:22:37 (1221977): Detected: Web Application Enabled (http://localhost:52069) 2024-05-17 20:22:37 (1221977): Detected: Remote Desktop Enabled (localhost:44995) 2024-05-17 20:22:37 (1221977): Status Report: Elapsed Time: '34234.000000' 2024-05-17 20:22:37 (1221977): Status Report: CPU Time: '33320.480000' 2024-05-17 20:22:37 (1221977): Preference change detected 2024-05-17 20:22:37 (1221977): Setting CPU throttle for VM. (100%) 2024-05-17 20:22:37 (1221977): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-05-17 22:01:38 (1221977): Status Report: Elapsed Time: '40234.000000' 2024-05-17 22:01:38 (1221977): Status Report: CPU Time: '39302.680000' 2024-05-17 23:40:39 (1221977): Status Report: Elapsed Time: '46234.000000' 2024-05-17 23:40:39 (1221977): Status Report: CPU Time: '45261.060000' 2024-05-18 01:19:40 (1221977): Status Report: Elapsed Time: '52234.000000' 2024-05-18 01:19:40 (1221977): Status Report: CPU Time: '51218.060000' 2024-05-18 02:58:41 (1221977): Status Report: Elapsed Time: '58234.000000' 2024-05-18 02:58:41 (1221977): Status Report: CPU Time: '57174.160000' 2024-05-18 04:37:42 (1221977): Status Report: Elapsed Time: '64234.000000' 2024-05-18 04:37:42 (1221977): Status Report: CPU Time: '63130.990000' 2024-05-18 06:16:43 (1221977): Status Report: Elapsed Time: '70234.000000' 2024-05-18 06:16:43 (1221977): Status Report: CPU Time: '69089.760000' 2024-05-18 07:55:44 (1221977): Status Report: Elapsed Time: '76234.000000' 2024-05-18 07:55:44 (1221977): Status Report: CPU Time: '75047.620000' 2024-05-18 09:34:45 (1221977): Status Report: Elapsed Time: '82234.000000' 2024-05-18 09:34:45 (1221977): Status Report: CPU Time: '81004.290000' 2024-05-18 11:13:46 (1221977): Status Report: Elapsed Time: '88234.000000' 2024-05-18 11:13:46 (1221977): Status Report: CPU Time: '86963.820000' 2024-05-18 12:52:47 (1221977): Status Report: Elapsed Time: '94234.000000' 2024-05-18 12:52:47 (1221977): Status Report: CPU Time: '92921.090000' 2024-05-18 14:31:48 (1221977): Status Report: Elapsed Time: '100234.000000' 2024-05-18 14:31:48 (1221977): Status Report: CPU Time: '98877.530000' 2024-05-18 16:10:49 (1221977): Status Report: Elapsed Time: '106234.000000' 2024-05-18 16:10:49 (1221977): Status Report: CPU Time: '104833.780000' 2024-05-18 17:49:50 (1221977): Status Report: Elapsed Time: '112234.000000' 2024-05-18 17:49:50 (1221977): Status Report: CPU Time: '110792.050000' 2024-05-18 19:28:51 (1221977): Status Report: Elapsed Time: '118234.000000' 2024-05-18 19:28:51 (1221977): Status Report: CPU Time: '116748.620000' 2024-05-18 21:07:52 (1221977): Status Report: Elapsed Time: '124234.000000' 2024-05-18 21:07:52 (1221977): Status Report: CPU Time: '122705.250000' 2024-05-18 22:46:53 (1221977): Status Report: Elapsed Time: '130234.000000' 2024-05-18 22:46:53 (1221977): Status Report: CPU Time: '128661.420000' 2024-05-19 00:25:54 (1221977): Status Report: Elapsed Time: '136234.000000' 2024-05-19 00:25:54 (1221977): Status Report: CPU Time: '134619.750000' 2024-05-19 02:04:55 (1221977): Status Report: Elapsed Time: '142234.000000' 2024-05-19 02:04:55 (1221977): Status Report: CPU Time: '140576.550000' 2024-05-19 02:35:42 (1221977): Stopping VM. 2024-05-19 02:44:06 (1464679): Detected: vboxwrapper 26206 2024-05-19 02:44:06 (1464679): Detected: BOINC client v8.0.1 2024-05-19 02:44:07 (1464679): Detected: VirtualBox VboxManage Interface (Version: 7.0.16) 2024-05-19 02:44:10 (1464679): Starting VM using VBoxManage interface. (boinc_da3cbe950647f947, slot#133) 2024-05-19 02:44:12 (1464679): Successfully started VM. (PID = '1464779') 2024-05-19 02:44:12 (1464679): Reporting VM Process ID to BOINC. 2024-05-19 02:44:12 (1464679): Guest Log: BIOS: VirtualBox 7.0.16 2024-05-19 02:44:12 (1464679): Guest Log: CPUID EDX: 0x178bfbff 2024-05-19 02:44:12 (1464679): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-05-19 02:44:12 (1464679): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-05-19 02:44:12 (1464679): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-19 02:44:12 (1464679): Detected: Web Application Enabled (http://localhost:52069) 2024-05-19 02:44:12 (1464679): Detected: Remote Desktop Enabled (localhost:44995) 2024-05-19 02:44:12 (1464679): Status Report: Elapsed Time: '144100.000000' 2024-05-19 02:44:12 (1464679): Status Report: CPU Time: '142423.520000' 2024-05-19 02:44:12 (1464679): Preference change detected 2024-05-19 02:44:12 (1464679): Setting CPU throttle for VM. (100%) 2024-05-19 02:44:13 (1464679): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-05-19 02:44:14 (1464679): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-05-19 02:44:14 (1464679): Guest Log: BIOS: Booting from Hard Disk... 2024-05-19 02:44:18 (1464679): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-05-19 02:44:18 (1464679): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2024-05-19 02:44:18 (1464679): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2024-05-19 02:44:30 (1464679): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-05-19 02:44:30 (1464679): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-05-19 02:45:08 (1464679): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2024-05-19 02:45:08 (1464679): Guest Log: 00:00:00.000554 main Log opened 2024-05-19T00:45:05.908673000Z 2024-05-19 02:45:08 (1464679): Guest Log: 00:00:00.000846 main OS Product: Linux 2024-05-19 02:45:08 (1464679): Guest Log: 00:00:00.000926 main OS Release: 3.10.0-957.27.2.el7.x86_64 2024-05-19 02:45:08 (1464679): Guest Log: 00:00:00.000988 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2024-05-19 02:45:08 (1464679): Guest Log: 00:00:00.001047 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2024-05-19 02:45:08 (1464679): Guest Log: 00:00:00.001049 main Process ID: 1261 2024-05-19 02:45:08 (1464679): Guest Log: 00:00:00.001051 main Package type: LINUX_64BITS_GENERIC 2024-05-19 02:45:08 (1464679): Guest Log: 00:00:00.006028 main 5.2.32 r132073 started. Verbose level = 0 2024-05-19 02:45:09 (1464679): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2024-05-19 02:45:09 (1464679): Guest Log: [INFO] Mounting shared directory 2024-05-19 02:45:09 (1464679): Guest Log: [INFO] Checking for init_data.xml 2024-05-19 02:45:15 (1464679): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2024-05-19 02:45:15 (1464679): Guest Log: [INFO] Detected branch: prod 2024-05-19 02:45:15 (1464679): Guest Log: This is the prod version of the ATLAS job wrapper 2024-05-19 02:45:15 (1464679): Guest Log: Copying input files 2024-05-19 02:45:26 (1464679): Guest Log: Copied input files into RunAtlas. 2024-05-19 02:45:27 (1464679): Guest Log: Detected user-configured HTTP proxy at http://192.168.1.179:3128 - will set in /etc/cvmfs/default.local 2024-05-19 02:45:36 (1464679): Guest Log: Running cvmfs_config stat atlas.cern.ch 2024-05-19 02:45:37 (1464679): 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 2024-05-19 02:45:37 (1464679): Guest Log: 2.6.3.0 1534 0 31420 132895 3 1 2720708 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.1.179:3128 1 2024-05-19 02:45:39 (1464679): Guest Log: copied the webapp to /var/www 2024-05-19 02:45:39 (1464679): Guest Log: core_number=1 2024-05-19 02:45:39 (1464679): 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 2024-05-19 02:45:39 (1464679): Guest Log: *** Starting ATLAS job. (PandaID=6207691358 taskID=38920982) *** 2024-05-19 04:23:13 (1464679): Status Report: Elapsed Time: '150100.000000' 2024-05-19 04:23:13 (1464679): Status Report: CPU Time: '147698.870000' 2024-05-19 06:02:14 (1464679): Status Report: Elapsed Time: '156100.000000' 2024-05-19 06:02:14 (1464679): Status Report: CPU Time: '153654.060000' 2024-05-19 07:41:15 (1464679): Status Report: Elapsed Time: '162100.000000' 2024-05-19 07:41:15 (1464679): Status Report: CPU Time: '159608.490000' 2024-05-19 09:20:16 (1464679): Status Report: Elapsed Time: '168100.000000' 2024-05-19 09:20:16 (1464679): Status Report: CPU Time: '165563.410000' 2024-05-19 10:59:17 (1464679): Status Report: Elapsed Time: '174100.000000' 2024-05-19 10:59:17 (1464679): Status Report: CPU Time: '171517.590000' 2024-05-19 12:38:18 (1464679): Status Report: Elapsed Time: '180100.000000' 2024-05-19 12:38:18 (1464679): Status Report: CPU Time: '177473.880000' 2024-05-19 14:17:19 (1464679): Status Report: Elapsed Time: '186100.000000' 2024-05-19 14:17:19 (1464679): Status Report: CPU Time: '183427.680000' 2024-05-19 15:56:20 (1464679): Status Report: Elapsed Time: '192100.000000' 2024-05-19 15:56:20 (1464679): Status Report: CPU Time: '189382.030000' 2024-05-19 17:35:21 (1464679): Status Report: Elapsed Time: '198100.000000' 2024-05-19 17:35:21 (1464679): Status Report: CPU Time: '195338.880000' 2024-05-19 19:14:22 (1464679): Status Report: Elapsed Time: '204100.000000' 2024-05-19 19:14:22 (1464679): Status Report: CPU Time: '201292.470000' 2024-05-19 20:53:24 (1464679): Status Report: Elapsed Time: '210100.000000' 2024-05-19 20:53:24 (1464679): Status Report: CPU Time: '207246.330000' 2024-05-19 22:32:25 (1464679): Status Report: Elapsed Time: '216100.000000' 2024-05-19 22:32:25 (1464679): Status Report: CPU Time: '213199.890000' 2024-05-20 00:11:26 (1464679): Status Report: Elapsed Time: '222100.000000' 2024-05-20 00:11:26 (1464679): Status Report: CPU Time: '219155.630000' 2024-05-20 01:50:27 (1464679): Status Report: Elapsed Time: '228100.000000' 2024-05-20 01:50:27 (1464679): Status Report: CPU Time: '225109.090000' 2024-05-20 03:29:28 (1464679): Status Report: Elapsed Time: '234100.000000' 2024-05-20 03:29:28 (1464679): Status Report: CPU Time: '231062.040000' 2024-05-20 05:08:29 (1464679): Status Report: Elapsed Time: '240100.000000' 2024-05-20 05:08:29 (1464679): Status Report: CPU Time: '237014.900000' 2024-05-20 06:47:30 (1464679): Status Report: Elapsed Time: '246100.000000' 2024-05-20 06:47:30 (1464679): Status Report: CPU Time: '242971.400000' 2024-05-20 08:26:31 (1464679): Status Report: Elapsed Time: '252100.000000' 2024-05-20 08:26:31 (1464679): Status Report: CPU Time: '248925.810000' 2024-05-20 10:05:32 (1464679): Status Report: Elapsed Time: '258100.000000' 2024-05-20 10:05:32 (1464679): Status Report: CPU Time: '254880.560000' 2024-05-20 11:44:33 (1464679): Status Report: Elapsed Time: '264100.000000' 2024-05-20 11:44:33 (1464679): Status Report: CPU Time: '260838.180000' 2024-05-20 13:23:34 (1464679): Status Report: Elapsed Time: '270100.000000' 2024-05-20 13:23:34 (1464679): Status Report: CPU Time: '266793.530000' 2024-05-20 15:02:35 (1464679): Status Report: Elapsed Time: '276100.000000' 2024-05-20 15:02:35 (1464679): Status Report: CPU Time: '272748.320000' 2024-05-20 16:41:36 (1464679): Status Report: Elapsed Time: '282100.000000' 2024-05-20 16:41:36 (1464679): Status Report: CPU Time: '278702.530000' 2024-05-20 18:20:37 (1464679): Status Report: Elapsed Time: '288100.000000' 2024-05-20 18:20:37 (1464679): Status Report: CPU Time: '284658.260000' 2024-05-20 19:59:38 (1464679): Status Report: Elapsed Time: '294100.000000' 2024-05-20 19:59:38 (1464679): Status Report: CPU Time: '290612.930000' 2024-05-20 21:38:39 (1464679): Status Report: Elapsed Time: '300100.000000' 2024-05-20 21:38:39 (1464679): Status Report: CPU Time: '296567.620000' 2024-05-20 23:17:40 (1464679): Status Report: Elapsed Time: '306100.000000' 2024-05-20 23:17:40 (1464679): Status Report: CPU Time: '302523.450000' 2024-05-21 00:56:41 (1464679): Status Report: Elapsed Time: '312100.000000' 2024-05-21 00:56:41 (1464679): Status Report: CPU Time: '308477.600000' 2024-05-21 02:35:42 (1464679): Status Report: Elapsed Time: '318100.000000' 2024-05-21 02:35:42 (1464679): Status Report: CPU Time: '314431.970000' 2024-05-21 04:14:43 (1464679): Status Report: Elapsed Time: '324100.000000' 2024-05-21 04:14:43 (1464679): Status Report: CPU Time: '320386.300000' 2024-05-21 05:53:44 (1464679): Status Report: Elapsed Time: '330100.000000' 2024-05-21 05:53:44 (1464679): Status Report: CPU Time: '326342.420000' 2024-05-21 07:32:45 (1464679): Status Report: Elapsed Time: '336100.000000' 2024-05-21 07:32:45 (1464679): Status Report: CPU Time: '332296.640000' 2024-05-21 09:11:46 (1464679): Status Report: Elapsed Time: '342100.000000' 2024-05-21 09:11:46 (1464679): Status Report: CPU Time: '338250.830000' 2024-05-21 10:50:47 (1464679): Status Report: Elapsed Time: '348100.000000' 2024-05-21 10:50:47 (1464679): Status Report: CPU Time: '344204.510000' 2024-05-21 12:29:48 (1464679): Status Report: Elapsed Time: '354100.000000' 2024-05-21 12:29:48 (1464679): Status Report: CPU Time: '350159.120000' 2024-05-21 14:08:49 (1464679): Status Report: Elapsed Time: '360100.000000' 2024-05-21 14:08:49 (1464679): Status Report: CPU Time: '356112.760000' 2024-05-21 15:47:50 (1464679): Status Report: Elapsed Time: '366100.000000' 2024-05-21 15:47:50 (1464679): Status Report: CPU Time: '362067.010000' 2024-05-21 17:26:51 (1464679): Status Report: Elapsed Time: '372100.000000' 2024-05-21 17:26:51 (1464679): Status Report: CPU Time: '368022.900000' 2024-05-21 19:05:52 (1464679): Status Report: Elapsed Time: '378100.000000' 2024-05-21 19:05:52 (1464679): Status Report: CPU Time: '373979.860000' 2024-05-21 20:44:53 (1464679): Status Report: Elapsed Time: '384100.000000' 2024-05-21 20:44:53 (1464679): Status Report: CPU Time: '379934.780000' 2024-05-21 22:23:54 (1464679): Status Report: Elapsed Time: '390100.000000' 2024-05-21 22:23:54 (1464679): Status Report: CPU Time: '385889.210000' 2024-05-22 00:02:55 (1464679): Status Report: Elapsed Time: '396100.000000' 2024-05-22 00:02:55 (1464679): Status Report: CPU Time: '391844.850000' 2024-05-22 01:41:56 (1464679): Status Report: Elapsed Time: '402100.000000' 2024-05-22 01:41:56 (1464679): Status Report: CPU Time: '397799.400000' 2024-05-22 03:20:57 (1464679): Status Report: Elapsed Time: '408100.000000' 2024-05-22 03:20:57 (1464679): Status Report: CPU Time: '403753.990000' 2024-05-22 04:59:58 (1464679): Status Report: Elapsed Time: '414100.000000' 2024-05-22 04:59:58 (1464679): Status Report: CPU Time: '409708.450000' 2024-05-22 06:38:59 (1464679): Status Report: Elapsed Time: '420100.000000' 2024-05-22 06:38:59 (1464679): Status Report: CPU Time: '415664.900000' 2024-05-22 08:18:00 (1464679): Status Report: Elapsed Time: '426100.000000' 2024-05-22 08:18:00 (1464679): Status Report: CPU Time: '421619.600000' 2024-05-22 09:57:01 (1464679): Status Report: Elapsed Time: '432100.000000' 2024-05-22 09:57:01 (1464679): Status Report: CPU Time: '427573.920000' 2024-05-22 11:36:02 (1464679): Status Report: Elapsed Time: '438100.000000' 2024-05-22 11:36:02 (1464679): Status Report: CPU Time: '433529.900000' 2024-05-22 13:15:03 (1464679): Status Report: Elapsed Time: '444100.000000' 2024-05-22 13:15:03 (1464679): Status Report: CPU Time: '439484.910000' 2024-05-22 14:54:04 (1464679): Status Report: Elapsed Time: '450100.000000' 2024-05-22 14:54:04 (1464679): Status Report: CPU Time: '445439.980000' 2024-05-22 16:33:05 (1464679): Status Report: Elapsed Time: '456100.000000' 2024-05-22 16:33:05 (1464679): Status Report: CPU Time: '451394.880000' 2024-05-22 18:12:06 (1464679): Status Report: Elapsed Time: '462100.000000' 2024-05-22 18:12:06 (1464679): Status Report: CPU Time: '457351.090000' 2024-05-22 19:51:07 (1464679): Status Report: Elapsed Time: '468100.000000' 2024-05-22 19:51:07 (1464679): Status Report: CPU Time: '463306.040000' 2024-05-22 21:30:08 (1464679): Status Report: Elapsed Time: '474100.000000' 2024-05-22 21:30:08 (1464679): Status Report: CPU Time: '469261.060000' 2024-05-22 23:09:09 (1464679): Status Report: Elapsed Time: '480100.000000' 2024-05-22 23:09:09 (1464679): Status Report: CPU Time: '475214.880000' 2024-05-23 00:48:11 (1464679): Status Report: Elapsed Time: '486100.000000' 2024-05-23 00:48:11 (1464679): Status Report: CPU Time: '481171.990000' 2024-05-23 02:27:12 (1464679): Status Report: Elapsed Time: '492100.000000' 2024-05-23 02:27:12 (1464679): Status Report: CPU Time: '487126.010000' 2024-05-23 04:06:13 (1464679): Status Report: Elapsed Time: '498100.000000' 2024-05-23 04:06:13 (1464679): Status Report: CPU Time: '493079.720000' 2024-05-23 05:18:05 (1464679): Guest Log: *** Job finished *** 2024-05-23 05:18:05 (1464679): Guest Log: *** The last 20 lines of the pilot log: *** 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:17:53,646 | INFO | [data] copytool_out thread has finished 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:17:54,234 | INFO | [job] queue monitor thread has finished 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:17:55,525 | INFO | [data] queue_monitor thread has finished 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:17:57,392 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140046779512640)>', '<ExcThread(monitor, started 140046132836096)>'] 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:17:57,615 | WARNING | job_aborted has been set - aborting pilot monitoring 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:17:57,615 | INFO | [monitor] control thread has ended 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,398 | INFO | all workflow threads have been joined 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,399 | INFO | end of generic workflow (traces error code: 0) 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,400 | INFO | traces error code: 0 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,400 | INFO | pilot has finished (exit code=0, shell exit code=0) 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,622 [wrapper] ==== pilot stdout END ==== 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,635 [wrapper] ==== wrapper stdout RESUME ==== 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,648 [wrapper] pilotpid: 6352 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,663 [wrapper] Pilot exit status: 0 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,735 [wrapper] pandaids: 6207691358 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,833 [wrapper] cleanup: SIGTERM to supervisor_pilot 6264 6353 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,849 [wrapper] Test setup, not cleaning 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,862 [wrapper] ==== wrapper stdout END ==== 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,875 [wrapper] ==== wrapper stderr END ==== 2024-05-23 05:18:05 (1464679): Guest Log: 2024-05-23 03:18:02,902 [wrapper] apfmon messages muted 2024-05-23 05:18:05 (1464679): Guest Log: *** Error codes and diagnostics *** 2024-05-23 05:18:05 (1464679): Guest Log: "exeErrorCode": 0, 2024-05-23 05:18:05 (1464679): Guest Log: "exeErrorDiag": "", 2024-05-23 05:18:05 (1464679): Guest Log: "pilotErrorCode": 0, 2024-05-23 05:18:05 (1464679): Guest Log: "pilotErrorDiag": "", 2024-05-23 05:18:05 (1464679): Guest Log: *** Listing of results directory *** 2024-05-23 05:18:05 (1464679): Guest Log: total 630436 2024-05-23 05:18:05 (1464679): Guest Log: -rw-r--r--. 1 atlas atlas 467845 May 17 01:57 pilot3.tar.gz 2024-05-23 05:18:05 (1464679): Guest Log: -rw-r--r--. 1 atlas atlas 5633 May 17 02:14 queuedata.json 2024-05-23 05:18:05 (1464679): Guest Log: -rwx------. 1 atlas atlas 32251 May 17 02:15 runpilot2-wrapper.sh 2024-05-23 05:18:05 (1464679): Guest Log: -rw-r--r--. 1 atlas atlas 480005 May 19 00:45 input.tar.gz 2024-05-23 05:18:05 (1464679): Guest Log: -rw-r--r--. 1 atlas atlas 17537 May 19 00:45 start_atlas.sh 2024-05-23 05:18:05 (1464679): Guest Log: -rw-r--r--. 1 atlas atlas 9666 May 19 00:45 init_data.xml 2024-05-23 05:18:05 (1464679): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 May 19 00:45 EVNT.38776160._000054.pool.root.1 -> /data/./ATLAS.root_0 2024-05-23 05:18:05 (1464679): Guest Log: -rw-r--r--. 1 atlas atlas 2622 May 19 00:45 pandaJob.out 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 460 May 19 00:45 setup.sh.local 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 1013712 May 19 00:46 agis_schedconf.cvmfs.json 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 1324701 May 19 00:46 cric_ddmendpoints.json 2024-05-23 05:18:05 (1464679): Guest Log: drwx------. 4 atlas atlas 4096 May 19 00:46 pilot3 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 307589908 May 23 03:14 HITS.38920982._003009.pool.root.1 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 1034 May 23 03:16 memory_monitor_summary.json 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 0 May 23 03:16 agis_ddmendpoints.agis.ALL.json 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 24801835 May 23 03:17 log.38920982._003009.job.log.tgz.1 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 7736 May 23 03:17 heartbeat.json 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 95 May 23 03:17 pilot_heartbeat.json 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 4271 May 23 03:18 pilotlog.txt 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 142452932 May 23 03:18 log.38920982._003009.job.log.1 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 357 May 23 03:18 output.list 2024-05-23 05:18:05 (1464679): Guest Log: -rw-r--r--. 1 atlas atlas 620 May 23 03:18 runtime_log 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 167270400 May 23 03:18 result.tar.gz 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 657 May 23 03:18 iPdKDmCJ2R5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmVrKKDmFxYOBo.diag 2024-05-23 05:18:05 (1464679): Guest Log: -rw-r--r--. 1 atlas atlas 11174 May 23 03:18 runtime_log.err 2024-05-23 05:18:05 (1464679): Guest Log: Looking for outputfile HITS.38920982._003009.pool.root.1 2024-05-23 05:18:05 (1464679): Guest Log: HITS file was successfully produced 2024-05-23 05:18:05 (1464679): Guest Log: -rw-------. 1 atlas atlas 307589908 May 23 03:14 /home/atlas/RunAtlas/HITS.38920982._003009.pool.root.1 2024-05-23 05:18:06 (1464679): Guest Log: Successfully finished the ATLAS job! 2024-05-23 05:18:06 (1464679): Guest Log: Copying the results back to the shared directory! 2024-05-23 05:18:09 (1464679): Guest Log: *** Contents of shared directory: *** 2024-05-23 05:18:09 (1464679): Guest Log: total 778144 2024-05-23 05:18:09 (1464679): Guest Log: -rw-r--r--. 1 root root 629024638 May 17 08:46 ATLAS.root_0 2024-05-23 05:18:09 (1464679): Guest Log: -rw-r--r--. 1 root root 9666 May 17 08:46 init_data.xml 2024-05-23 05:18:09 (1464679): Guest Log: -rw-r--r--. 1 root root 480005 May 17 08:46 input.tar.gz 2024-05-23 05:18:09 (1464679): Guest Log: -rw-r--r--. 1 root root 167270400 May 23 03:18 result.tar.gz 2024-05-23 05:18:09 (1464679): Guest Log: -rw-r--r--. 1 root root 17537 May 17 08:46 start_atlas.sh 2024-05-23 05:18:09 (1464679): Guest Log: *** Success! Shutting down the machine. *** 2024-05-23 05:18:09 (1464679): VM Completion File Detected. 2024-05-23 05:18:09 (1464679): Powering off VM. 2024-05-23 05:18:10 (1464679): Successfully stopped VM. 2024-05-23 05:18:10 (1464679): Deregistering VM. (boinc_da3cbe950647f947, slot#133) 2024-05-23 05:18:11 (1464679): Removing network bandwidth throttle group from VM. 2024-05-23 05:18:12 (1464679): Removing VM from VirtualBox. 05:18:17 (1464679): called boinc_finish(0) </stderr_txt> <message> upload failure: <file_xfer_error> <file_name>iPdKDmCJ2R5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmVrKKDmFxYOBo_0_r817183332_ATLAS_result</file_name> <error_code>-131 (file size too big)</error_code> </file_xfer_error> </message> ]]>
©2024 CERN