Name | veMNDmwH4c5nsSi4ap6QjLDmwznN0nGgGQJmpmIZDm19gKDmOqxOOn_0 |
Workunit | 223630326 |
Created | 16 Jun 2024, 12:35:56 UTC |
Sent | 16 Jun 2024, 17:35:32 UTC |
Report deadline | 24 Jun 2024, 17:35:32 UTC |
Received | 22 Jun 2024, 3:19:49 UTC |
Server state | Over |
Outcome | Computation error |
Client state | Compute error |
Exit status | 0 (0x00000000) |
Computer ID | 10836791 |
Run time | 5 days 8 hours 59 min 44 sec |
CPU time | 5 days 9 hours 2 min 47 sec |
Validate state | Invalid |
Credit | 0.00 |
Device peak FLOPS | 19.99 GFLOPS |
Application version | ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas) x86_64-pc-linux-gnu |
Peak working set size | 4.12 GB |
Peak swap size | 5.48 GB |
Peak disk usage | 6.43 GB |
<core_client_version>8.0.3</core_client_version> <![CDATA[ <stderr_txt> 2024-06-16 19:36:47 (203086): Detected: vboxwrapper 26206 2024-06-16 19:36:47 (203086): Detected: BOINC client v8.0.2 2024-06-16 19:36:48 (203086): Detected: VirtualBox VboxManage Interface (Version: 7.0.16) 2024-06-16 19:36:48 (203086): Successfully copied 'init_data.xml' to the shared directory. 2024-06-16 19:36:49 (203086): Create VM. (boinc_3a5d573af977df97, slot#89) 2024-06-16 19:36:50 (203086): Setting Memory Size for VM. (4096MB) 2024-06-16 19:36:51 (203086): Setting CPU Count for VM. (1) 2024-06-16 19:36:51 (203086): Setting Chipset Options for VM. 2024-06-16 19:36:52 (203086): Setting Graphics Controller Options for VM. 2024-06-16 19:36:52 (203086): Setting Boot Options for VM. 2024-06-16 19:36:52 (203086): Setting Network Configuration for NAT. 2024-06-16 19:36:53 (203086): Enabling VM Network Access. 2024-06-16 19:36:53 (203086): Disabling USB Support for VM. 2024-06-16 19:36:54 (203086): Disabling COM Port Support for VM. 2024-06-16 19:36:54 (203086): Disabling LPT Port Support for VM. 2024-06-16 19:36:55 (203086): Disabling Audio Support for VM. 2024-06-16 19:36:55 (203086): Disabling Clipboard Support for VM. 2024-06-16 19:36:56 (203086): Disabling Drag and Drop Support for VM. 2024-06-16 19:36:56 (203086): Adding storage controller(s) to VM. 2024-06-16 19:36:56 (203086): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi) 2024-06-16 19:36:57 (203086): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2024-06-16 19:36:58 (203086): forwarding host port 34771 to guest port 80 2024-06-16 19:36:58 (203086): Enabling remote desktop for VM. 2024-06-16 19:36:59 (203086): Enabling shared directory for VM. 2024-06-16 19:37:00 (203086): Starting VM using VBoxManage interface. (boinc_3a5d573af977df97, slot#89) 2024-06-16 19:37:02 (203086): Successfully started VM. (PID = '203966') 2024-06-16 19:37:02 (203086): Reporting VM Process ID to BOINC. 2024-06-16 19:37:02 (203086): Guest Log: BIOS: VirtualBox 7.0.16 2024-06-16 19:37:02 (203086): Guest Log: CPUID EDX: 0x178bfbff 2024-06-16 19:37:02 (203086): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-06-16 19:37:02 (203086): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-16 19:37:02 (203086): VM state change detected. (old = 'poweredoff', new = 'running') 2024-06-16 19:37:02 (203086): Detected: Web Application Enabled (http://localhost:34771) 2024-06-16 19:37:02 (203086): Detected: Remote Desktop Enabled (localhost:41323) 2024-06-16 19:37:02 (203086): Preference change detected 2024-06-16 19:37:02 (203086): Setting CPU throttle for VM. (100%) 2024-06-16 19:37:03 (203086): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-06-16 19:37:04 (203086): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-16 19:37:04 (203086): Guest Log: BIOS: Booting from Hard Disk... 2024-06-16 19:37:08 (203086): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-16 19:37:08 (203086): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2024-06-16 19:37:08 (203086): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2024-06-16 19:37:19 (203086): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-16 19:37:19 (203086): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-16 19:37:51 (203086): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2024-06-16 19:37:51 (203086): Guest Log: 00:00:00.000413 main Log opened 2024-06-16T17:37:49.477388000Z 2024-06-16 19:37:51 (203086): Guest Log: 00:00:00.000660 main OS Product: Linux 2024-06-16 19:37:51 (203086): Guest Log: 00:00:00.000787 main OS Release: 3.10.0-957.27.2.el7.x86_64 2024-06-16 19:37:51 (203086): Guest Log: 00:00:00.000856 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2024-06-16 19:37:51 (203086): Guest Log: 00:00:00.000913 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2024-06-16 19:37:51 (203086): Guest Log: 00:00:00.000914 main Process ID: 1237 2024-06-16 19:37:51 (203086): Guest Log: 00:00:00.000916 main Package type: LINUX_64BITS_GENERIC 2024-06-16 19:37:51 (203086): Guest Log: 00:00:00.006137 main 5.2.32 r132073 started. Verbose level = 0 2024-06-16 19:37:52 (203086): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2024-06-16 19:37:52 (203086): Guest Log: [INFO] Mounting shared directory 2024-06-16 19:37:52 (203086): Guest Log: [INFO] Checking for init_data.xml 2024-06-16 19:37:58 (203086): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2024-06-16 19:37:58 (203086): Guest Log: [INFO] Detected branch: prod 2024-06-16 19:37:59 (203086): Guest Log: This is the prod version of the ATLAS job wrapper 2024-06-16 19:37:59 (203086): Guest Log: Copying input files 2024-06-16 19:38:10 (203086): Guest Log: Copied input files into RunAtlas. 2024-06-16 19:38:10 (203086): Guest Log: Detected user-configured HTTP proxy at http://192.168.1.179:3128 - will set in /etc/cvmfs/default.local 2024-06-16 19:38:18 (203086): Guest Log: Running cvmfs_config stat atlas.cern.ch 2024-06-16 19:38:19 (203086): 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-06-16 19:38:19 (203086): Guest Log: 2.6.3.0 1509 0 29700 133946 4 1 3119736 4096000 0 65024 0 0 n/a 1141 1813 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.1.179:3128 1 2024-06-16 19:38:20 (203086): Guest Log: copied the webapp to /var/www 2024-06-16 19:38:21 (203086): Guest Log: core_number=1 2024-06-16 19:38:21 (203086): 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-06-16 19:38:21 (203086): Guest Log: *** Starting ATLAS job. (PandaID=6232407024 taskID=38920995) *** 2024-06-16 21:16:03 (203086): Status Report: Elapsed Time: '6000.000000' 2024-06-16 21:16:03 (203086): Status Report: CPU Time: '5276.670000' 2024-06-16 22:55:04 (203086): Status Report: Elapsed Time: '12000.000000' 2024-06-16 22:55:04 (203086): Status Report: CPU Time: '11230.120000' 2024-06-17 00:34:05 (203086): Status Report: Elapsed Time: '18000.000000' 2024-06-17 00:34:05 (203086): Status Report: CPU Time: '17185.900000' 2024-06-17 02:13:06 (203086): Status Report: Elapsed Time: '24000.000000' 2024-06-17 02:13:06 (203086): Status Report: CPU Time: '23139.680000' 2024-06-17 03:52:07 (203086): Status Report: Elapsed Time: '30000.000000' 2024-06-17 03:52:07 (203086): Status Report: CPU Time: '29093.650000' 2024-06-17 05:31:08 (203086): Status Report: Elapsed Time: '36000.000000' 2024-06-17 05:31:08 (203086): Status Report: CPU Time: '35050.180000' 2024-06-17 07:10:09 (203086): Status Report: Elapsed Time: '42000.000000' 2024-06-17 07:10:09 (203086): Status Report: CPU Time: '41004.560000' 2024-06-17 08:49:10 (203086): Status Report: Elapsed Time: '48000.000000' 2024-06-17 08:49:10 (203086): Status Report: CPU Time: '46958.360000' 2024-06-17 10:28:11 (203086): Status Report: Elapsed Time: '54000.000000' 2024-06-17 10:28:11 (203086): Status Report: CPU Time: '52912.900000' 2024-06-17 12:07:12 (203086): Status Report: Elapsed Time: '60000.000000' 2024-06-17 12:07:12 (203086): Status Report: CPU Time: '58869.270000' 2024-06-17 13:46:13 (203086): Status Report: Elapsed Time: '66000.000000' 2024-06-17 13:46:13 (203086): Status Report: CPU Time: '64823.040000' 2024-06-17 15:25:14 (203086): Status Report: Elapsed Time: '72000.000000' 2024-06-17 15:25:14 (203086): Status Report: CPU Time: '70776.660000' 2024-06-17 17:04:15 (203086): Status Report: Elapsed Time: '78000.000000' 2024-06-17 17:04:15 (203086): Status Report: CPU Time: '76730.750000' 2024-06-17 18:43:16 (203086): Status Report: Elapsed Time: '84000.000000' 2024-06-17 18:43:16 (203086): Status Report: CPU Time: '82686.900000' 2024-06-17 19:16:37 (203086): Stopping VM. 2024-06-17 19:17:11 (203086): Successfully stopped VM. 2024-06-17 19:18:28 (381473): Detected: vboxwrapper 26206 2024-06-17 19:18:28 (381473): Detected: BOINC client v8.0.3 2024-06-17 19:19:00 (381473): Detected: VirtualBox VboxManage Interface (Version: 7.0.16) 2024-06-17 19:19:04 (381473): Guest Log: BIOS: VirtualBox 7.0.16 2024-06-17 19:19:04 (381473): Guest Log: CPUID EDX: 0x178bfbff 2024-06-17 19:19:04 (381473): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-06-17 19:19:04 (381473): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-17 19:19:04 (381473): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-17 19:19:04 (381473): Guest Log: BIOS: Booting from Hard Disk... 2024-06-17 19:19:04 (381473): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-17 19:19:04 (381473): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2024-06-17 19:19:04 (381473): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2024-06-17 19:19:04 (381473): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-17 19:19:04 (381473): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-17 19:19:04 (381473): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2024-06-17 19:19:04 (381473): Guest Log: 00:00:00.000413 main Log opened 2024-06-16T17:37:49.477388000Z 2024-06-17 19:19:04 (381473): Guest Log: 00:00:00.000660 main OS Product: Linux 2024-06-17 19:19:04 (381473): Guest Log: 00:00:00.000787 main OS Release: 3.10.0-957.27.2.el7.x86_64 2024-06-17 19:19:04 (381473): Guest Log: 00:00:00.000856 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2024-06-17 19:19:04 (381473): Guest Log: 00:00:00.000913 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2024-06-17 19:19:04 (381473): Guest Log: 00:00:00.000914 main Process ID: 1237 2024-06-17 19:19:04 (381473): Guest Log: 00:00:00.000916 main Package type: LINUX_64BITS_GENERIC 2024-06-17 19:19:04 (381473): Guest Log: 00:00:00.006137 main 5.2.32 r132073 started. Verbose level = 0 2024-06-17 19:19:04 (381473): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2024-06-17 19:19:04 (381473): Guest Log: [INFO] Mounting shared directory 2024-06-17 19:19:04 (381473): Guest Log: [INFO] Checking for init_data.xml 2024-06-17 19:19:04 (381473): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2024-06-17 19:19:04 (381473): Guest Log: [INFO] Detected branch: prod 2024-06-17 19:19:04 (381473): Guest Log: This is the prod version of the ATLAS job wrapper 2024-06-17 19:19:04 (381473): Guest Log: Copying input files 2024-06-17 19:19:04 (381473): Guest Log: Copied input files into RunAtlas. 2024-06-17 19:19:04 (381473): Guest Log: Detected user-configured HTTP proxy at http://192.168.1.179:3128 - will set in /etc/cvmfs/default.local 2024-06-17 19:19:04 (381473): Guest Log: Running cvmfs_config stat atlas.cern.ch 2024-06-17 19:19:04 (381473): 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-06-17 19:19:04 (381473): Guest Log: 2.6.3.0 1509 0 29700 133946 4 1 3119736 4096000 0 65024 0 0 n/a 1141 1813 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.1.179:3128 1 2024-06-17 19:19:04 (381473): Guest Log: copied the webapp to /var/www 2024-06-17 19:19:04 (381473): Guest Log: core_number=1 2024-06-17 19:19:04 (381473): 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-06-17 19:19:04 (381473): Guest Log: *** Starting ATLAS job. (PandaID=6232407024 taskID=38920995) *** 2024-06-17 19:19:04 (381473): Starting VM using VBoxManage interface. (boinc_3a5d573af977df97, slot#89) 2024-06-17 19:19:35 (381473): Successfully started VM. (PID = '387642') 2024-06-17 19:19:35 (381473): Reporting VM Process ID to BOINC. 2024-06-17 19:19:35 (381473): VM state change detected. (old = 'poweredoff', new = 'running') 2024-06-17 19:19:35 (381473): Detected: Web Application Enabled (http://localhost:34771) 2024-06-17 19:19:35 (381473): Detected: Remote Desktop Enabled (localhost:41323) 2024-06-17 19:19:35 (381473): Status Report: Elapsed Time: '86021.000000' 2024-06-17 19:19:35 (381473): Status Report: CPU Time: '84691.170000' 2024-06-17 19:19:35 (381473): Preference change detected 2024-06-17 19:19:35 (381473): Setting CPU throttle for VM. (100%) 2024-06-17 19:19:35 (381473): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-06-17 20:58:36 (381473): Status Report: Elapsed Time: '92021.000000' 2024-06-17 20:58:36 (381473): Status Report: CPU Time: '90670.560000' 2024-06-17 22:37:37 (381473): Status Report: Elapsed Time: '98021.000000' 2024-06-17 22:37:37 (381473): Status Report: CPU Time: '96624.350000' 2024-06-18 00:16:38 (381473): Status Report: Elapsed Time: '104021.000000' 2024-06-18 00:16:38 (381473): Status Report: CPU Time: '102579.840000' 2024-06-18 01:55:39 (381473): Status Report: Elapsed Time: '110021.000000' 2024-06-18 01:55:39 (381473): Status Report: CPU Time: '108533.870000' 2024-06-18 03:34:40 (381473): Status Report: Elapsed Time: '116021.000000' 2024-06-18 03:34:40 (381473): Status Report: CPU Time: '114488.180000' 2024-06-18 05:13:41 (381473): Status Report: Elapsed Time: '122021.000000' 2024-06-18 05:13:41 (381473): Status Report: CPU Time: '120444.520000' 2024-06-18 06:52:42 (381473): Status Report: Elapsed Time: '128021.000000' 2024-06-18 06:52:42 (381473): Status Report: CPU Time: '126398.820000' 2024-06-18 08:31:43 (381473): Status Report: Elapsed Time: '134021.000000' 2024-06-18 08:31:43 (381473): Status Report: CPU Time: '132352.530000' 2024-06-18 10:10:44 (381473): Status Report: Elapsed Time: '140021.000000' 2024-06-18 10:10:44 (381473): Status Report: CPU Time: '138306.250000' 2024-06-18 11:49:45 (381473): Status Report: Elapsed Time: '146021.000000' 2024-06-18 11:49:45 (381473): Status Report: CPU Time: '144262.480000' 2024-06-18 13:28:46 (381473): Status Report: Elapsed Time: '152021.000000' 2024-06-18 13:28:46 (381473): Status Report: CPU Time: '150215.050000' 2024-06-18 15:07:47 (381473): Status Report: Elapsed Time: '158021.000000' 2024-06-18 15:07:47 (381473): Status Report: CPU Time: '156165.650000' 2024-06-18 16:46:47 (381473): Status Report: Elapsed Time: '164021.000000' 2024-06-18 16:46:47 (381473): Status Report: CPU Time: '162116.160000' 2024-06-18 18:25:48 (381473): Status Report: Elapsed Time: '170021.000000' 2024-06-18 18:25:48 (381473): Status Report: CPU Time: '168066.240000' 2024-06-18 20:04:49 (381473): Status Report: Elapsed Time: '176021.000000' 2024-06-18 20:04:49 (381473): Status Report: CPU Time: '174016.770000' 2024-06-18 21:43:50 (381473): Status Report: Elapsed Time: '182021.000000' 2024-06-18 21:43:50 (381473): Status Report: CPU Time: '179966.130000' 2024-06-18 23:22:51 (381473): Status Report: Elapsed Time: '188021.000000' 2024-06-18 23:22:51 (381473): Status Report: CPU Time: '185916.880000' 2024-06-19 00:19:25 (381473): Preference change detected 2024-06-19 00:19:25 (381473): Setting CPU throttle for VM. (100%) 2024-06-19 00:19:27 (381473): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-06-19 01:01:52 (381473): Status Report: Elapsed Time: '194021.027819' 2024-06-19 01:01:52 (381473): Status Report: CPU Time: '191867.120000' 2024-06-19 02:40:53 (381473): Status Report: Elapsed Time: '200021.027819' 2024-06-19 02:40:53 (381473): Status Report: CPU Time: '197818.420000' 2024-06-19 04:19:55 (381473): Status Report: Elapsed Time: '206021.027819' 2024-06-19 04:19:55 (381473): Status Report: CPU Time: '203770.330000' 2024-06-19 05:58:55 (381473): Status Report: Elapsed Time: '212021.027819' 2024-06-19 05:58:55 (381473): Status Report: CPU Time: '209724.010000' 2024-06-19 07:37:56 (381473): Status Report: Elapsed Time: '218021.027819' 2024-06-19 07:37:56 (381473): Status Report: CPU Time: '215675.870000' 2024-06-19 09:16:57 (381473): Status Report: Elapsed Time: '224021.027819' 2024-06-19 09:16:57 (381473): Status Report: CPU Time: '221626.990000' 2024-06-19 10:55:58 (381473): Status Report: Elapsed Time: '230021.027819' 2024-06-19 10:55:58 (381473): Status Report: CPU Time: '227577.650000' 2024-06-19 12:34:59 (381473): Status Report: Elapsed Time: '236021.027819' 2024-06-19 12:34:59 (381473): Status Report: CPU Time: '233530.810000' 2024-06-19 14:14:00 (381473): Status Report: Elapsed Time: '242021.027819' 2024-06-19 14:14:00 (381473): Status Report: CPU Time: '239481.750000' 2024-06-19 15:53:01 (381473): Status Report: Elapsed Time: '248021.027819' 2024-06-19 15:53:01 (381473): Status Report: CPU Time: '245432.500000' 2024-06-19 17:32:02 (381473): Status Report: Elapsed Time: '254021.027819' 2024-06-19 17:32:02 (381473): Status Report: CPU Time: '251384.030000' 2024-06-19 19:11:03 (381473): Status Report: Elapsed Time: '260021.027819' 2024-06-19 19:11:03 (381473): Status Report: CPU Time: '257336.180000' 2024-06-19 20:50:04 (381473): Status Report: Elapsed Time: '266021.027819' 2024-06-19 20:50:04 (381473): Status Report: CPU Time: '263287.990000' 2024-06-19 22:29:05 (381473): Status Report: Elapsed Time: '272021.027819' 2024-06-19 22:29:05 (381473): Status Report: CPU Time: '269238.860000' 2024-06-20 00:08:06 (381473): Status Report: Elapsed Time: '278021.027819' 2024-06-20 00:08:06 (381473): Status Report: CPU Time: '275192.370000' 2024-06-20 01:47:07 (381473): Status Report: Elapsed Time: '284021.027819' 2024-06-20 01:47:07 (381473): Status Report: CPU Time: '281142.500000' 2024-06-20 03:26:08 (381473): Status Report: Elapsed Time: '290021.027819' 2024-06-20 03:26:08 (381473): Status Report: CPU Time: '287092.800000' 2024-06-20 05:05:09 (381473): Status Report: Elapsed Time: '296021.027819' 2024-06-20 05:05:09 (381473): Status Report: CPU Time: '293043.970000' 2024-06-20 06:44:10 (381473): Status Report: Elapsed Time: '302021.027819' 2024-06-20 06:44:10 (381473): Status Report: CPU Time: '298995.500000' 2024-06-20 08:23:11 (381473): Status Report: Elapsed Time: '308021.027819' 2024-06-20 08:23:11 (381473): Status Report: CPU Time: '304946.780000' 2024-06-20 10:02:12 (381473): Status Report: Elapsed Time: '314021.027819' 2024-06-20 10:02:12 (381473): Status Report: CPU Time: '310897.360000' 2024-06-20 11:41:13 (381473): Status Report: Elapsed Time: '320021.027819' 2024-06-20 11:41:13 (381473): Status Report: CPU Time: '316849.530000' 2024-06-20 13:20:14 (381473): Status Report: Elapsed Time: '326021.027819' 2024-06-20 13:20:14 (381473): Status Report: CPU Time: '322800.070000' 2024-06-20 14:59:14 (381473): Status Report: Elapsed Time: '332021.027819' 2024-06-20 14:59:14 (381473): Status Report: CPU Time: '328749.740000' 2024-06-20 16:38:15 (381473): Status Report: Elapsed Time: '338021.027819' 2024-06-20 16:38:15 (381473): Status Report: CPU Time: '334697.480000' 2024-06-20 18:17:16 (381473): Status Report: Elapsed Time: '344021.027819' 2024-06-20 18:17:16 (381473): Status Report: CPU Time: '340647.290000' 2024-06-20 19:56:17 (381473): Status Report: Elapsed Time: '350021.027819' 2024-06-20 19:56:17 (381473): Status Report: CPU Time: '346599.240000' 2024-06-20 21:35:18 (381473): Status Report: Elapsed Time: '356021.027819' 2024-06-20 21:35:18 (381473): Status Report: CPU Time: '352549.200000' 2024-06-20 23:14:19 (381473): Status Report: Elapsed Time: '362021.027819' 2024-06-20 23:14:19 (381473): Status Report: CPU Time: '358501.610000' 2024-06-21 00:53:20 (381473): Status Report: Elapsed Time: '368021.027819' 2024-06-21 00:53:20 (381473): Status Report: CPU Time: '364452.250000' 2024-06-21 02:32:21 (381473): Status Report: Elapsed Time: '374021.027819' 2024-06-21 02:32:21 (381473): Status Report: CPU Time: '370403.660000' 2024-06-21 04:11:22 (381473): Status Report: Elapsed Time: '380021.027819' 2024-06-21 04:11:22 (381473): Status Report: CPU Time: '376353.740000' 2024-06-21 05:50:23 (381473): Status Report: Elapsed Time: '386021.027819' 2024-06-21 05:50:23 (381473): Status Report: CPU Time: '382306.310000' 2024-06-21 07:29:24 (381473): Status Report: Elapsed Time: '392021.027819' 2024-06-21 07:29:24 (381473): Status Report: CPU Time: '388259.550000' 2024-06-21 09:08:25 (381473): Status Report: Elapsed Time: '398021.027819' 2024-06-21 09:08:25 (381473): Status Report: CPU Time: '394213.010000' 2024-06-21 10:47:26 (381473): Status Report: Elapsed Time: '404021.027819' 2024-06-21 10:47:26 (381473): Status Report: CPU Time: '400166.390000' 2024-06-21 12:26:27 (381473): Status Report: Elapsed Time: '410021.027819' 2024-06-21 12:26:27 (381473): Status Report: CPU Time: '406121.970000' 2024-06-21 14:05:28 (381473): Status Report: Elapsed Time: '416021.027819' 2024-06-21 14:05:28 (381473): Status Report: CPU Time: '412076.040000' 2024-06-21 15:44:29 (381473): Status Report: Elapsed Time: '422021.027819' 2024-06-21 15:44:29 (381473): Status Report: CPU Time: '418030.020000' 2024-06-21 17:23:30 (381473): Status Report: Elapsed Time: '428021.027819' 2024-06-21 17:23:30 (381473): Status Report: CPU Time: '423987.120000' 2024-06-21 19:02:31 (381473): Status Report: Elapsed Time: '434021.027819' 2024-06-21 19:02:31 (381473): Status Report: CPU Time: '429941.640000' 2024-06-21 19:18:22 (381473): Stopping VM. 2024-06-21 19:19:04 (381473): Successfully stopped VM. 2024-06-21 19:22:55 (4329): Detected: vboxwrapper 26206 2024-06-21 19:22:55 (4329): Detected: BOINC client v8.0.3 2024-06-21 19:23:27 (4329): Detected: VirtualBox VboxManage Interface (Version: 7.0.16) 2024-06-21 19:23:31 (4329): Starting VM using VBoxManage interface. (boinc_3a5d573af977df97, slot#89) 2024-06-21 19:23:58 (4329): Successfully started VM. (PID = '11596') 2024-06-21 19:23:58 (4329): Reporting VM Process ID to BOINC. 2024-06-21 19:23:58 (4329): VM state change detected. (old = 'poweredoff', new = 'running') 2024-06-21 19:23:58 (4329): Detected: Web Application Enabled (http://localhost:34771) 2024-06-21 19:23:58 (4329): Detected: Remote Desktop Enabled (localhost:41323) 2024-06-21 19:23:58 (4329): Status Report: Elapsed Time: '434982.027819' 2024-06-21 19:23:58 (4329): Status Report: CPU Time: '430894.440000' 2024-06-21 19:23:58 (4329): Preference change detected 2024-06-21 19:23:58 (4329): Setting CPU throttle for VM. (100%) 2024-06-21 19:23:58 (4329): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-06-21 20:58:15 (4329): Preference change detected 2024-06-21 20:58:15 (4329): Setting CPU throttle for VM. (100%) 2024-06-21 20:58:16 (4329): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-06-21 21:02:59 (4329): Status Report: Elapsed Time: '440982.623874' 2024-06-21 21:02:59 (4329): Status Report: CPU Time: '436875.940000' 2024-06-21 22:42:00 (4329): Status Report: Elapsed Time: '446982.623874' 2024-06-21 22:42:00 (4329): Status Report: CPU Time: '442825.260000' 2024-06-22 00:21:01 (4329): Status Report: Elapsed Time: '452982.623874' 2024-06-22 00:21:01 (4329): Status Report: CPU Time: '448777.900000' 2024-06-22 02:00:02 (4329): Status Report: Elapsed Time: '458982.623874' 2024-06-22 02:00:02 (4329): Status Report: CPU Time: '454727.210000' 2024-06-22 03:39:03 (4329): Status Report: Elapsed Time: '464982.623874' 2024-06-22 03:39:03 (4329): Status Report: CPU Time: '460678.660000' 2024-06-22 04:44:01 (4329): Guest Log: *** Job finished *** 2024-06-22 04:44:01 (4329): Guest Log: *** The last 20 lines of the pilot log: *** 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:49,376 | INFO | [job] queue monitor thread has finished 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:49,562 | INFO | [data] copytool_out thread has finished 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:51,984 | INFO | [data] queue_monitor thread has finished 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:52,961 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139695106885440)>', '<ExcThread(monitor, started 139694658537216)>'] 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:53,906 | WARNING | job_aborted has been set - aborting pilot monitoring 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:53,906 | INFO | [monitor] control thread has ended 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:57,967 | INFO | all workflow threads have been joined 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:57,968 | INFO | end of generic workflow (traces error code: 0) 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:57,969 | INFO | traces error code: 0 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:57,970 | INFO | pilot has finished (exit code=0, shell exit code=0) 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,271 [wrapper] ==== pilot stdout END ==== 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,284 [wrapper] ==== wrapper stdout RESUME ==== 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,297 [wrapper] pilotpid: 6328 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,310 [wrapper] Pilot exit status: 0 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,375 [wrapper] pandaids: 6232407024 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,455 [wrapper] cleanup supervisor_pilot 2822 6329 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,470 [wrapper] Test setup, not cleaning 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,483 [wrapper] ==== wrapper stdout END ==== 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,498 [wrapper] ==== wrapper stderr END ==== 2024-06-22 04:44:01 (4329): Guest Log: 2024-06-22 02:43:58,524 [wrapper] apfmon messages muted 2024-06-22 04:44:01 (4329): Guest Log: *** Error codes and diagnostics *** 2024-06-22 04:44:01 (4329): Guest Log: "exeErrorCode": 0, 2024-06-22 04:44:01 (4329): Guest Log: "exeErrorDiag": "", 2024-06-22 04:44:01 (4329): Guest Log: "pilotErrorCode": 0, 2024-06-22 04:44:01 (4329): Guest Log: "pilotErrorDiag": "", 2024-06-22 04:44:01 (4329): Guest Log: *** Listing of results directory *** 2024-06-22 04:44:01 (4329): Guest Log: total 820520 2024-06-22 04:44:01 (4329): Guest Log: -rw-r--r--. 1 atlas atlas 469766 Jun 16 12:20 pilot3.tar.gz 2024-06-22 04:44:01 (4329): Guest Log: -rwx------. 1 atlas atlas 32308 Jun 16 12:35 runpilot2-wrapper.sh 2024-06-22 04:44:01 (4329): Guest Log: -rw-r--r--. 1 atlas atlas 5654 Jun 16 12:35 queuedata.json 2024-06-22 04:44:01 (4329): Guest Log: -rw-r--r--. 1 atlas atlas 482520 Jun 16 17:37 input.tar.gz 2024-06-22 04:44:01 (4329): Guest Log: -rw-r--r--. 1 atlas atlas 17537 Jun 16 17:37 start_atlas.sh 2024-06-22 04:44:01 (4329): Guest Log: -rw-r--r--. 1 atlas atlas 9665 Jun 16 17:38 init_data.xml 2024-06-22 04:44:01 (4329): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Jun 16 17:38 EVNT.38776180._000483.pool.root.1 -> /data/./ATLAS.root_0 2024-06-22 04:44:01 (4329): Guest Log: -rw-r--r--. 1 atlas atlas 2615 Jun 16 17:38 pandaJob.out 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 460 Jun 16 17:38 setup.sh.local 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 1020988 Jun 16 17:39 agis_schedconf.cvmfs.json 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 1316805 Jun 16 17:39 cric_ddmendpoints.json 2024-06-22 04:44:01 (4329): Guest Log: drwx------. 4 atlas atlas 4096 Jun 16 17:39 pilot3 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 345926807 Jun 22 02:38 HITS.38920995._054036.pool.root.1 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 1035 Jun 22 02:42 memory_monitor_summary.json 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 0 Jun 22 02:42 agis_ddmendpoints.agis.ALL.json 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 37626481 Jun 22 02:42 log.38920995._054036.job.log.tgz.1 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 96 Jun 22 02:43 pilot_heartbeat.json 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 7747 Jun 22 02:43 heartbeat.json 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 4457 Jun 22 02:43 pilotlog.txt 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 207785889 Jun 22 02:43 log.38920995._054036.job.log.1 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 357 Jun 22 02:43 output.list 2024-06-22 04:44:01 (4329): Guest Log: -rw-r--r--. 1 atlas atlas 620 Jun 22 02:43 runtime_log 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 245432320 Jun 22 02:43 result.tar.gz 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 657 Jun 22 02:43 veMNDmwH4c5nsSi4ap6QjLDmwznN0nGgGQJmpmIZDm19gKDmOqxOOn.diag 2024-06-22 04:44:01 (4329): Guest Log: -rw-r--r--. 1 atlas atlas 11174 Jun 22 02:43 runtime_log.err 2024-06-22 04:44:01 (4329): Guest Log: Looking for outputfile HITS.38920995._054036.pool.root.1 2024-06-22 04:44:01 (4329): Guest Log: HITS file was successfully produced 2024-06-22 04:44:01 (4329): Guest Log: -rw-------. 1 atlas atlas 345926807 Jun 22 02:38 /home/atlas/RunAtlas/HITS.38920995._054036.pool.root.1 2024-06-22 04:44:02 (4329): Guest Log: Successfully finished the ATLAS job! 2024-06-22 04:44:02 (4329): Guest Log: Copying the results back to the shared directory! 2024-06-22 04:44:07 (4329): Guest Log: *** Contents of shared directory: *** 2024-06-22 04:44:07 (4329): Guest Log: total 858532 2024-06-22 04:44:07 (4329): Guest Log: -rw-rw-r--. 1 root root 633180476 Jun 16 17:36 ATLAS.root_0 2024-06-22 04:44:07 (4329): Guest Log: -rw-rw-r--. 1 root root 9665 Jun 16 17:36 init_data.xml 2024-06-22 04:44:07 (4329): Guest Log: -rw-rw-r--. 1 root root 482520 Jun 16 17:36 input.tar.gz 2024-06-22 04:44:07 (4329): Guest Log: -rw-r--r--. 1 root root 245432320 Jun 22 02:44 result.tar.gz 2024-06-22 04:44:07 (4329): Guest Log: -rw-rw-r--. 1 root root 17537 Jun 16 17:36 start_atlas.sh 2024-06-22 04:44:07 (4329): Guest Log: *** Success! Shutting down the machine. *** 2024-06-22 04:44:08 (4329): VM Completion File Detected. 2024-06-22 04:44:08 (4329): Powering off VM. 2024-06-22 04:44:10 (4329): Successfully stopped VM. 2024-06-22 04:44:10 (4329): Deregistering VM. (boinc_3a5d573af977df97, slot#89) 2024-06-22 04:44:10 (4329): Removing network bandwidth throttle group from VM. 2024-06-22 04:44:11 (4329): Removing VM from VirtualBox. 04:44:16 (4329): called boinc_finish(0) </stderr_txt> <message> upload failure: <file_xfer_error> <file_name>veMNDmwH4c5nsSi4ap6QjLDmwznN0nGgGQJmpmIZDm19gKDmOqxOOn_0_r1122218559_ATLAS_result</file_name> <error_code>-131 (file size too big)</error_code> </file_xfer_error> </message> ]]>
©2024 CERN