Name | KrENDmXf2TvnShfckohDCDFpABFKDmABFKDmQ6FKDmzFFKDmZMZvIn_4 |
Workunit | 1938735 |
Created | 7 Oct 2019, 17:15:57 UTC |
Sent | 15 Oct 2019, 3:31:19 UTC |
Report deadline | 22 Oct 2019, 3:31:19 UTC |
Received | 15 Oct 2019, 4:17:31 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 3682 |
Run time | 14 min 46 sec |
CPU time | 27 min 19 sec |
Validate state | Valid |
Credit | 36.59 |
Device peak FLOPS | 17.83 GFLOPS |
Application version | ATLAS Simulation v0.87 (vbox64_mt_mcore_atlas) x86_64-pc-linux-gnu |
Peak working set size | 282.02 MB |
Peak swap size | 8.23 GB |
Peak disk usage | 3.59 GB |
<core_client_version>7.16.1</core_client_version> <![CDATA[ <stderr_txt> 2019-10-15 05:32:04 (112776): vboxwrapper (7.7.26197): starting 2019-10-15 05:32:04 (112776): Feature: Checkpoint interval offset (365 seconds) 2019-10-15 05:32:04 (112776): Detected: VirtualBox VboxManage Interface (Version: 5.2.32) 2019-10-15 05:32:04 (112776): Detected: Minimum checkpoint interval (900.000000 seconds) 2019-10-15 05:32:04 (112776): Successfully copied 'init_data.xml' to the shared directory. 2019-10-15 05:32:04 (112776): Create VM. (boinc_630a9063f96125a8, slot#0) 2019-10-15 05:32:04 (112776): Setting Memory Size for VM. (6600MB) 2019-10-15 05:32:04 (112776): Setting CPU Count for VM. (4) 2019-10-15 05:32:05 (112776): Setting Chipset Options for VM. 2019-10-15 05:32:05 (112776): Setting Boot Options for VM. 2019-10-15 05:32:05 (112776): Setting Network Configuration for NAT. 2019-10-15 05:32:05 (112776): Enabling VM Network Access. 2019-10-15 05:32:05 (112776): Disabling USB Support for VM. 2019-10-15 05:32:05 (112776): Disabling COM Port Support for VM. 2019-10-15 05:32:05 (112776): Disabling LPT Port Support for VM. 2019-10-15 05:32:05 (112776): Disabling Audio Support for VM. 2019-10-15 05:32:05 (112776): Disabling Clipboard Support for VM. 2019-10-15 05:32:05 (112776): Disabling Drag and Drop Support for VM. 2019-10-15 05:32:05 (112776): Adding storage controller(s) to VM. 2019-10-15 05:32:05 (112776): Adding virtual disk drive to VM. (vm_image.vdi) 2019-10-15 05:32:05 (112776): Adding VirtualBox Guest Additions to VM. 2019-10-15 05:32:05 (112776): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-10-15 05:32:05 (112776): forwarding host port 48780 to guest port 80 2019-10-15 05:32:05 (112776): Enabling remote desktop for VM. 2019-10-15 05:32:06 (112776): Enabling shared directory for VM. 2019-10-15 05:32:06 (112776): Starting VM. (boinc_630a9063f96125a8, slot#0) 2019-10-15 05:32:07 (112776): Successfully started VM. (PID = '113242') 2019-10-15 05:32:07 (112776): Reporting VM Process ID to BOINC. 2019-10-15 05:32:07 (112776): Guest Log: BIOS: VirtualBox 5.2.32 2019-10-15 05:32:07 (112776): Guest Log: CPUID EDX: 0x178bfbff 2019-10-15 05:32:07 (112776): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-10-15 05:32:07 (112776): VM state change detected. (old = 'poweroff', new = 'running') 2019-10-15 05:32:07 (112776): Detected: Web Application Enabled (http://localhost:48780) 2019-10-15 05:32:07 (112776): Detected: Remote Desktop Enabled (localhost:48261) 2019-10-15 05:32:07 (112776): Preference change detected 2019-10-15 05:32:07 (112776): Setting CPU throttle for VM. (100%) 2019-10-15 05:32:08 (112776): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2019-10-15 05:32:09 (112776): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-10-15 05:32:09 (112776): Guest Log: BIOS: Booting from Hard Disk... 2019-10-15 05:32:11 (112776): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-10-15 05:32:11 (112776): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2019-10-15 05:32:11 (112776): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2019-10-15 05:32:13 (112776): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-10-15 05:32:13 (112776): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-10-15 05:32:16 (112776): Guest Log: Checking CVMFS... 2019-10-15 05:32:18 (112776): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2019-10-15 05:32:18 (112776): Guest Log: 00:00:00.000142 main Log opened 2019-10-15T05:32:16.303229000Z 2019-10-15 05:32:18 (112776): Guest Log: 00:00:00.000301 main OS Product: Linux 2019-10-15 05:32:18 (112776): Guest Log: 00:00:00.000357 main OS Release: 3.10.0-957.27.2.el7.x86_64 2019-10-15 05:32:18 (112776): Guest Log: 00:00:00.000399 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2019-10-15 05:32:18 (112776): Guest Log: 00:00:00.000453 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2019-10-15 05:32:18 (112776): Guest Log: 00:00:00.000454 main Process ID: 1571 2019-10-15 05:32:18 (112776): Guest Log: 00:00:00.000454 main Package type: LINUX_64BITS_GENERIC 2019-10-15 05:32:18 (112776): Guest Log: 00:00:00.001695 main 5.2.32 r132073 started. Verbose level = 0 2019-10-15 05:32:19 (112776): Guest Log: CVMFS is ok 2019-10-15 05:32:19 (112776): Guest Log: Mounting shared directory 2019-10-15 05:32:19 (112776): Guest Log: Copying input files 2019-10-15 05:32:21 (112776): Guest Log: Copied input files into RunAtlas. 2019-10-15 05:32:21 (112776): Guest Log: copied the webapp to /var/www 2019-10-15 05:32:21 (112776): Guest Log: set up http_proxy http://pcoslo5:3128 2019-10-15 05:32:21 (112776): Guest Log: Detected squid proxy http://pcoslo5:3128 - will set in /etc/cvmfs/default.local 2019-10-15 05:32:28 (112776): Guest Log: 00:00:10.003203 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 188 737 796 000ns (GuestNow=1 571 110 347 568 221 000 ns GuestLast=1 571 117 536 306 017 000 ns fSetTimeLastLoop=true ) 2019-10-15 05:34:25 (112776): Guest Log: ATHENA_PROC_NUMBER=4 2019-10-15 05:34:25 (112776): Guest Log: *** Starting ATLAS job. (PandaID=4002876565 taskID=000649-4) *** 2019-10-15 05:46:42 (112776): Guest Log: *** Job finished *** 2019-10-15 05:46:42 (112776): Guest Log: *** The last 20 lines of the pilot log: *** 2019-10-15 05:46:42 (112776): Guest Log: 2019-10-15 03:46:42 UTC [wrapper] apfmon messages muted 2019-10-15 05:46:42 (112776): Guest Log: ---- find pandaID.out ---- 2019-10-15 05:46:42 (112776): Guest Log: total 56 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 11357 Jul 25 14:38 LICENSE 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 20 Sep 9 11:04 MANIFEST.IN 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 11 Oct 15 03:34 pandaIDs.out 2019-10-15 05:46:42 (112776): Guest Log: drwx------. 14 atlas atlas 216 Oct 15 03:34 pilot 2019-10-15 05:46:42 (112776): Guest Log: -rwx------. 1 atlas atlas 20136 Sep 9 11:04 pilot.py 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 9 Sep 9 11:04 PILOTVERSION 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 2251 Jul 25 14:38 README.md 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 760 Aug 22 09:01 setup.py 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 221 Jul 25 14:38 TODO.md 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 11 Oct 15 03:34 /home/atlas/RunAtlas/pilot2/pandaIDs.out 2019-10-15 05:46:42 (112776): Guest Log: 4002876565 2019-10-15 05:46:42 (112776): Guest Log: 2019-10-15 03:46:42 UTC [wrapper] Test setup, not cleaning 2019-10-15 05:46:42 (112776): Guest Log: 2019-10-15 03:46:42 UTC [wrapper] ==== wrapper stdout END ==== 2019-10-15 05:46:42 (112776): Guest Log: 2019-10-15 03:46:42 UTC [wrapper] ==== wrapper stderr END ==== 2019-10-15 05:46:42 (112776): Guest Log: 2019-10-15 03:46:42 UTC [wrapper] wrapper wrapperexiting ec=0, duration=738 2019-10-15 05:46:42 (112776): Guest Log: 2019-10-15 03:46:42 UTC [wrapper] apfmon messages muted 2019-10-15 05:46:42 (112776): Guest Log: *** Error codes and diagnostics *** 2019-10-15 05:46:42 (112776): Guest Log: "exeErrorCode": 0, 2019-10-15 05:46:42 (112776): Guest Log: "exeErrorDiag": "", 2019-10-15 05:46:42 (112776): Guest Log: "pilotErrorCode": 0, 2019-10-15 05:46:42 (112776): Guest Log: "pilotErrorDiag": "", 2019-10-15 05:46:42 (112776): Guest Log: *** Listing of results directory *** 2019-10-15 05:46:42 (112776): Guest Log: total 22556 2019-10-15 05:46:42 (112776): Guest Log: -rw-r--r--. 1 atlas atlas 259319 Sep 16 09:27 pilot2.tar.gz 2019-10-15 05:46:42 (112776): Guest Log: -rwx------. 1 atlas atlas 12641 Sep 16 09:40 runpilot2-wrapper.sh 2019-10-15 05:46:42 (112776): Guest Log: -rw-r--r--. 1 atlas atlas 4480 Sep 16 09:40 queuedata.json 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 2948 Sep 16 09:40 pandaJobData.out 2019-10-15 05:46:42 (112776): Guest Log: -rw-r--r--. 1 atlas atlas 267438 Oct 15 03:32 input.tar.gz 2019-10-15 05:46:42 (112776): Guest Log: -rw-r--r--. 1 atlas atlas 815 Oct 15 03:32 RTE.tar.gz 2019-10-15 05:46:42 (112776): Guest Log: -rw-r--r--. 1 atlas atlas 8465 Oct 15 03:32 start_atlas.sh 2019-10-15 05:46:42 (112776): Guest Log: -rw-r--r--. 1 atlas atlas 6280 Oct 15 03:32 init_data.xml 2019-10-15 05:46:42 (112776): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Oct 15 03:32 EVNT.14296418._001447.pool.root.1 -> /data/./ATLAS.root_0 2019-10-15 05:46:42 (112776): Guest Log: drwxr-xr-x. 3 atlas atlas 17 Oct 15 03:34 APPS 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 240 Oct 15 03:34 setup.sh.local 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 3952360 Oct 15 03:34 agis_schedconf.cvmfs.json 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 7640262 Oct 15 03:34 agis_ddmendpoints.json 2019-10-15 05:46:42 (112776): Guest Log: drwx------. 3 atlas atlas 229 Oct 15 03:34 pilot2 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 9091278 Oct 15 03:45 HITS.000649-404567-25669._078090.pool.root.1 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 834 Oct 15 03:45 memory_monitor_summary.json 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 711478 Oct 15 03:45 log.000649-404567-25669._078090.job.log.tgz.1 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 11002 Oct 15 03:46 heartbeat.json 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 12257 Oct 15 03:46 pilotlog.txt 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 161614 Oct 15 03:46 log.14568781._078090.job.log.1 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 504 Oct 15 03:46 KrENDmXf2TvnShfckohDCDFpABFKDmABFKDmQ6FKDmzFFKDmZMZvIn.diag 2019-10-15 05:46:42 (112776): Guest Log: -rw-r--r--. 1 atlas atlas 7769 Oct 15 03:46 runtime_log.err 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 496 Oct 15 03:46 output.list 2019-10-15 05:46:42 (112776): Guest Log: -rw-r--r--. 1 atlas atlas 717 Oct 15 03:46 runtime_log 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 890880 Oct 15 03:46 result.tar.gz 2019-10-15 05:46:42 (112776): Guest Log: Looking for outputfile HITS.000649-404567-25669._078090.pool.root.1 2019-10-15 05:46:42 (112776): Guest Log: HITS file was successfully produced 2019-10-15 05:46:42 (112776): Guest Log: -rw-------. 1 atlas atlas 9091278 Oct 15 03:45 /home/atlas/RunAtlas/HITS.000649-404567-25669._078090.pool.root.1 2019-10-15 05:46:42 (112776): Guest Log: Successfully finished the ATLAS job! 2019-10-15 05:46:42 (112776): Guest Log: Copying the results back to the shared directory! 2019-10-15 05:46:42 (112776): Guest Log: *** Contents of shared directory: *** 2019-10-15 05:46:43 (112776): Guest Log: total 366732 2019-10-15 05:46:43 (112776): Guest Log: -rw-r--r--. 1 root root 365251149 Oct 15 03:32 ATLAS.root_0 2019-10-15 05:46:43 (112776): Guest Log: -rw-r--r--. 1 root root 9091278 Oct 15 03:45 HITS.pool.root.1 2019-10-15 05:46:43 (112776): Guest Log: -rw-r--r--. 1 root root 6280 Oct 15 03:32 init_data.xml 2019-10-15 05:46:43 (112776): Guest Log: -rw-r--r--. 1 root root 267438 Oct 15 03:32 input.tar.gz 2019-10-15 05:46:43 (112776): Guest Log: -rw-r--r--. 1 root root 890880 Oct 15 03:46 result.tar.gz 2019-10-15 05:46:43 (112776): Guest Log: -rw-r--r--. 1 root root 815 Oct 15 03:32 RTE.tar.gz 2019-10-15 05:46:43 (112776): Guest Log: -rw-r--r--. 1 root root 8465 Oct 15 03:32 start_atlas.sh 2019-10-15 05:46:43 (112776): Guest Log: *** Success! Shutting down the machine. *** 2019-10-15 05:46:43 (112776): VM Completion File Detected. 2019-10-15 05:46:43 (112776): Powering off VM. 2019-10-15 05:46:44 (112776): Successfully stopped VM. 2019-10-15 05:46:44 (112776): Deregistering VM. (boinc_630a9063f96125a8, slot#0) 2019-10-15 05:46:44 (112776): Removing network bandwidth throttle group from VM. 2019-10-15 05:46:44 (112776): Removing storage controller(s) from VM. 2019-10-15 05:46:44 (112776): Removing VM from VirtualBox. 2019-10-15 05:46:44 (112776): Removing virtual disk drive from VirtualBox. 05:46:49 (112776): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN