Name | wZaLDmBvbE6n7OlckoGmwREmGgkVDo1bjSoqOlfODmxYrKDmiBGten_0 |
Workunit | 225690173 |
Created | 28 Sep 2024, 2:11:03 UTC |
Sent | 28 Sep 2024, 2:11:08 UTC |
Report deadline | 6 Oct 2024, 2:11:08 UTC |
Received | 28 Sep 2024, 17:37:19 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10700026 |
Run time | 26 min 52 sec |
CPU time | 9 min 10 sec |
Validate state | Valid |
Credit | 82.02 |
Device peak FLOPS | 53.93 GFLOPS |
Application version | ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas) x86_64-apple-darwin |
Peak working set size | 9.24 GB |
Peak swap size | 71.25 GB |
Peak disk usage | 422.86 MB |
<core_client_version>8.0.2</core_client_version> <![CDATA[ <stderr_txt> 2024-09-28 02:23:54 (74429): Detected: vboxwrapper 26206 2024-09-28 02:23:54 (74429): Detected: BOINC client v8.0.2 2024-09-28 02:23:54 (74429): Detected: VirtualBox VboxManage Interface (Version: 7.0.4) 2024-09-28 02:23:54 (74429): Detected: Sandbox Configuration Enabled 2024-09-28 02:23:54 (74429): Successfully copied 'init_data.xml' to the shared directory. 2024-09-28 02:23:54 (74429): Create VM. (boinc_446f2e2ee66e39bf, slot#4) 2024-09-28 02:23:54 (74429): Setting Memory Size for VM. (4800MB) 2024-09-28 02:23:54 (74429): Setting CPU Count for VM. (8) 2024-09-28 02:23:54 (74429): Setting Chipset Options for VM. 2024-09-28 02:23:54 (74429): Setting Graphics Controller Options for VM. 2024-09-28 02:23:54 (74429): Setting Boot Options for VM. 2024-09-28 02:23:55 (74429): Setting Network Configuration for NAT. 2024-09-28 02:23:55 (74429): Enabling VM Network Access. 2024-09-28 02:23:55 (74429): Disabling USB Support for VM. 2024-09-28 02:23:55 (74429): Disabling COM Port Support for VM. 2024-09-28 02:23:55 (74429): Disabling Audio Support for VM. 2024-09-28 02:23:55 (74429): Disabling Clipboard Support for VM. 2024-09-28 02:23:55 (74429): Disabling Drag and Drop Support for VM. 2024-09-28 02:23:55 (74429): Adding storage controller(s) to VM. 2024-09-28 02:23:55 (74429): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi) 2024-09-28 02:23:57 (74429): Adding VirtualBox Guest Additions to VM. 2024-09-28 02:23:57 (74429): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2024-09-28 02:23:57 (74429): forwarding host port 56126 to guest port 80 2024-09-28 02:23:58 (74429): Enabling remote desktop for VM. 2024-09-28 02:23:58 (74429): Required extension pack not installed, remote desktop not enabled. 2024-09-28 02:23:58 (74429): Enabling shared directory for VM. 2024-09-28 02:23:58 (74429): Starting VM using VBoxManage interface. (boinc_446f2e2ee66e39bf, slot#4) 2024-09-28 02:24:02 (74429): Successfully started VM. (PID = '74502') 2024-09-28 02:24:02 (74429): Reporting VM Process ID to BOINC. 2024-09-28 02:24:02 (74429): Guest Log: BIOS: VirtualBox 7.0.4 2024-09-28 02:24:02 (74429): Guest Log: CPUID EDX: 0x178bfbff 2024-09-28 02:24:02 (74429): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-09-28 02:24:02 (74429): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-09-28 02:24:02 (74429): VM state change detected. (old = 'poweredoff', new = 'running') 2024-09-28 02:24:02 (74429): Detected: Web Application Enabled (http://localhost:56126) 2024-09-28 02:24:03 (74429): VM state change detected. (old = 'running', new = 'paused') 2024-09-28 02:24:20 (74429): Preference change detected 2024-09-28 02:24:20 (74429): Setting CPU throttle for VM. (100%) 2024-09-28 02:24:20 (74429): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-09-28 02:24:21 (74429): VM state change detected. (old = 'paused', new = 'running') 2024-09-28 02:24:23 (74429): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-09-28 02:24:23 (74429): Guest Log: BIOS: Booting from Hard Disk... 2024-09-28 02:24:29 (74429): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-09-28 02:24:29 (74429): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2024-09-28 02:24:29 (74429): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2024-09-28 02:24:37 (74429): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-09-28 02:24:37 (74429): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-09-28 02:24:48 (74429): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2024-09-28 02:24:48 (74429): Guest Log: 00:00:00.000126 main Log opened 2024-09-28T08:24:28.973041000Z 2024-09-28 02:24:48 (74429): Guest Log: 00:00:00.000226 main OS Product: Linux 2024-09-28 02:24:48 (74429): Guest Log: 00:00:00.000283 main OS Release: 3.10.0-957.27.2.el7.x86_64 2024-09-28 02:24:48 (74429): Guest Log: 00:00:00.000338 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2024-09-28 02:24:48 (74429): Guest Log: 00:00:00.000394 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2024-09-28 02:24:48 (74429): Guest Log: 00:00:00.000395 main Process ID: 1363 2024-09-28 02:24:48 (74429): Guest Log: 00:00:00.000395 main Package type: LINUX_64BITS_GENERIC 2024-09-28 02:24:48 (74429): Guest Log: 00:00:00.001114 main 5.2.32 r132073 started. Verbose level = 0 2024-09-28 02:24:49 (74429): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2024-09-28 02:24:49 (74429): Guest Log: [INFO] Mounting shared directory 2024-09-28 02:24:49 (74429): Guest Log: [INFO] Checking for init_data.xml 2024-09-28 02:24:57 (74429): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2024-09-28 02:24:57 (74429): Guest Log: [INFO] Detected branch: prod 2024-09-28 02:24:57 (74429): Guest Log: This is the prod version of the ATLAS job wrapper 2024-09-28 02:24:57 (74429): Guest Log: Copying input files 2024-09-28 02:25:00 (74429): Guest Log: Copied input files into RunAtlas. 2024-09-28 02:25:01 (74429): Guest Log: This VM did not configure a local http proxy via BOINC. 2024-09-28 02:25:01 (74429): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2024-09-28 02:25:01 (74429): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2024-09-28 02:25:01 (74429): Guest Log: Further information can be found at the LHC@home message board. 2024-09-28 02:25:10 (74429): Guest Log: Running cvmfs_config stat atlas.cern.ch 2024-09-28 02:25:11 (74429): 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-09-28 02:25:11 (74429): Guest Log: 2.6.3.0 1644 0 30156 137738 4 1 3117398 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 2024-09-28 02:25:12 (74429): Guest Log: copied the webapp to /var/www 2024-09-28 02:25:12 (74429): Guest Log: ATHENA_PROC_NUMBER=8 2024-09-28 02:25:12 (74429): Guest Log: ATHENA_CORE_NUMBER=8 2024-09-28 02:25:12 (74429): 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-09-28 02:25:13 (74429): Guest Log: *** Starting ATLAS job. (PandaID=6349540124 taskID=41079445) *** 2024-09-28 02:37:00 (74429): VM state change detected. (old = 'running', new = 'paused') 2024-09-28 02:37:21 (74429): VM state change detected. (old = 'paused', new = 'running') 2024-09-28 02:51:21 (74429): Guest Log: *** Job finished *** 2024-09-28 02:51:21 (74429): Guest Log: *** The last 20 lines of the pilot log: *** 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:46:41,096 | INFO | queue data_out not empty: found 1 job(s) 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:46:43,102 | INFO | proceeding with server update 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:46:43,102 | WARNING | queue monitor detected a set abort_job (due to a kill signal) 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:46:43,103 | INFO | preparing for final server update for job 6349540124 in state='failed' 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:46:43,103 | INFO | 141 s passed since kill signal was intercepted - make sure that stage-out has finished 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:46:43,103 | WARNING | reset time_since_kill to 60 since value is out of allowed limits 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:47:21,669 [wrapper] The pilot process (6023) is still running after 3m. Sending SIGKILL (9). 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:47:21,676 [wrapper] The pilot process (6023) is still running after 3m. Sending SIGKILL (9). 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:47:21,689 [wrapper] ==== pilot stdout END ==== 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:47:21,696 [wrapper] ==== wrapper stdout RESUME ==== 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:47:21,703 [wrapper] pilotpid: 6023 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:47:21,710 [wrapper] Pilot exit status: 137 2024-09-28 02:51:21 (74429): Guest Log: ./runpilot2-wrapper.sh: line 970: /usr/bin/xargs: Input/output error 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:50:40,193 [wrapper] pandaids: 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:50:40,200 [wrapper] apfmon messages muted 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:50:40,257 [wrapper] No supervise_pilot CHILD process found 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:50:40,264 [wrapper] Test setup, not cleaning 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:50:40,271 [wrapper] ==== wrapper stdout END ==== 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:50:40,279 [wrapper] ==== wrapper stderr END ==== 2024-09-28 02:51:21 (74429): Guest Log: 2024-09-28 08:50:40,295 [wrapper] apfmon messages muted 2024-09-28 02:51:21 (74429): Guest Log: *** Error codes and diagnostics *** 2024-09-28 02:51:21 (74429): Guest Log: *** Listing of results directory *** 2024-09-28 02:51:21 (74429): Guest Log: total 4060 2024-09-28 02:51:21 (74429): Guest Log: -rw-r--r--. 1 atlas atlas 484599 Sep 28 01:48 pilot3.tar.gz 2024-09-28 02:51:21 (74429): Guest Log: -rwx------. 1 atlas atlas 33814 Sep 28 01:59 runpilot2-wrapper.sh 2024-09-28 02:51:21 (74429): Guest Log: -rw-r--r--. 1 atlas atlas 5653 Sep 28 02:01 queuedata.json 2024-09-28 02:51:21 (74429): Guest Log: -rw-r-----. 1 atlas atlas 17537 Sep 28 08:24 start_atlas.sh 2024-09-28 02:51:21 (74429): Guest Log: -rw-r-----. 1 atlas atlas 498189 Sep 28 08:24 input.tar.gz 2024-09-28 02:51:21 (74429): Guest Log: -rw-r--r--. 1 atlas atlas 8726 Sep 28 08:24 init_data.xml 2024-09-28 02:51:21 (74429): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Sep 28 08:24 EVNT.41079443._000125.pool.root.1 -> /data/./ATLAS.root_0 2024-09-28 02:51:21 (74429): Guest Log: -rw-r--r--. 1 atlas atlas 2580 Sep 28 08:24 pandaJob.out 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 424 Sep 28 08:25 setup.sh.local 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 1012113 Sep 28 08:26 agis_schedconf.cvmfs.json 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 1615815 Sep 28 08:26 agis_ddmendpoints.agis.ALL.json 2024-09-28 02:51:21 (74429): Guest Log: drwx------. 4 atlas atlas 4096 Sep 28 08:26 pilot3 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 577 Sep 28 08:28 heartbeat.json 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 95 Sep 28 08:43 pilot_heartbeat.json 2024-09-28 02:51:21 (74429): Guest Log: drwxrwx---. 2 atlas atlas 4096 Sep 28 08:44 PanDA_Pilot-6349540124 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 1016 Sep 28 08:44 memory_monitor_summary.json 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 123424 Sep 28 08:46 pilotlog.txt 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 137114 Sep 28 08:50 log.41079445._000716.job.log.1 2024-09-28 02:51:21 (74429): Guest Log: -rw-r--r--. 1 atlas atlas 571 Sep 28 08:50 runtime_log 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 143360 Sep 28 08:50 result.tar.gz 2024-09-28 02:51:21 (74429): Guest Log: -rw-------. 1 atlas atlas 636 Sep 28 08:50 wZaLDmBvbE6n7OlckoGmwREmGgkVDo1bjSoqOlfODmxYrKDmiBGten.diag 2024-09-28 02:51:21 (74429): Guest Log: -rw-r--r--. 1 atlas atlas 10272 Sep 28 08:50 runtime_log.err 2024-09-28 02:51:21 (74429): Guest Log: Looking for outputfile HITS.41079445._000716.pool.root.1 2024-09-28 02:51:21 (74429): Guest Log: No HITS file was produced 2024-09-28 02:51:21 (74429): Guest Log: Successfully finished the ATLAS job! 2024-09-28 02:51:21 (74429): Guest Log: Copying the results back to the shared directory! 2024-09-28 02:51:21 (74429): Guest Log: *** Contents of shared directory: *** 2024-09-28 02:51:21 (74429): Guest Log: total 443092 2024-09-28 02:51:21 (74429): Guest Log: -rw-rw----. 1 root root 442832656 Sep 28 08:23 ATLAS.root_0 2024-09-28 02:51:21 (74429): Guest Log: -rw-rw-r--. 1 root root 8726 Sep 28 08:23 init_data.xml 2024-09-28 02:51:21 (74429): Guest Log: -rw-rw----. 1 root root 498189 Sep 28 08:23 input.tar.gz 2024-09-28 02:51:21 (74429): Guest Log: -rw-r--r--. 1 root root 143360 Sep 28 2024 result.tar.gz 2024-09-28 02:51:21 (74429): Guest Log: -rw-rw----. 1 root root 17537 Sep 28 08:23 start_atlas.sh 2024-09-28 02:51:21 (74429): Guest Log: *** Success! Shutting down the machine. *** 2024-09-28 02:51:21 (74429): VM Completion File Detected. 2024-09-28 02:51:21 (74429): Powering off VM. 2024-09-28 02:51:21 (74429): Successfully stopped VM. 2024-09-28 02:51:21 (74429): Deregistering VM. (boinc_446f2e2ee66e39bf, slot#4) 2024-09-28 02:51:22 (74429): Removing network bandwidth throttle group from VM. 2024-09-28 02:51:22 (74429): Removing VM from VirtualBox. 02:51:27 (74429): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN