Name wP2MDmKc2TvnShfckohDCDFpABFKDmABFKDmQ6FKDmRFFKDmEnKIvn_4
Workunit 1938667
Created 8 Oct 2019, 6:43:51 UTC
Sent 8 Oct 2019, 12:23:07 UTC
Report deadline 15 Oct 2019, 12:23:07 UTC
Received 8 Oct 2019, 18:34:29 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 3682
Run time 14 min 57 sec
CPU time 27 min 46 sec
Validate state Valid
Credit 37.05
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 297.28 MB
Peak swap size 8.30 GB
Peak disk usage 3.65 GB

Stderr output

<core_client_version>7.16.1</core_client_version>
<![CDATA[
<stderr_txt>
2019-10-08 20:04:08 (1089003): vboxwrapper (7.7.26197): starting
2019-10-08 20:04:08 (1089003): Feature: Checkpoint interval offset (336 seconds)
2019-10-08 20:04:08 (1089003): Detected: VirtualBox VboxManage Interface (Version: 5.2.32)
2019-10-08 20:04:08 (1089003): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-10-08 20:04:08 (1089003): Successfully copied 'init_data.xml' to the shared directory.
2019-10-08 20:04:08 (1089003): Create VM. (boinc_349edf1011f563ff, slot#0)
2019-10-08 20:04:08 (1089003): Setting Memory Size for VM. (6600MB)
2019-10-08 20:04:08 (1089003): Setting CPU Count for VM. (4)
2019-10-08 20:04:08 (1089003): Setting Chipset Options for VM.
2019-10-08 20:04:08 (1089003): Setting Boot Options for VM.
2019-10-08 20:04:09 (1089003): Setting Network Configuration for NAT.
2019-10-08 20:04:09 (1089003): Enabling VM Network Access.
2019-10-08 20:04:09 (1089003): Disabling USB Support for VM.
2019-10-08 20:04:09 (1089003): Disabling COM Port Support for VM.
2019-10-08 20:04:09 (1089003): Disabling LPT Port Support for VM.
2019-10-08 20:04:09 (1089003): Disabling Audio Support for VM.
2019-10-08 20:04:09 (1089003): Disabling Clipboard Support for VM.
2019-10-08 20:04:09 (1089003): Disabling Drag and Drop Support for VM.
2019-10-08 20:04:09 (1089003): Adding storage controller(s) to VM.
2019-10-08 20:04:09 (1089003): Adding virtual disk drive to VM. (vm_image.vdi)
2019-10-08 20:04:09 (1089003): Adding VirtualBox Guest Additions to VM.
2019-10-08 20:04:09 (1089003): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-10-08 20:04:09 (1089003): forwarding host port 24609 to guest port 80
2019-10-08 20:04:09 (1089003): Enabling remote desktop for VM.
2019-10-08 20:04:09 (1089003): Enabling shared directory for VM.
2019-10-08 20:04:09 (1089003): Starting VM. (boinc_349edf1011f563ff, slot#0)
2019-10-08 20:04:11 (1089003): Successfully started VM. (PID = '1089469')
2019-10-08 20:04:11 (1089003): Reporting VM Process ID to BOINC.
2019-10-08 20:04:11 (1089003): Guest Log: BIOS: VirtualBox 5.2.32
2019-10-08 20:04:11 (1089003): Guest Log: CPUID EDX: 0x178bfbff
2019-10-08 20:04:11 (1089003): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-10-08 20:04:11 (1089003): VM state change detected. (old = 'poweroff', new = 'running')
2019-10-08 20:04:11 (1089003): Detected: Web Application Enabled (http://localhost:24609)
2019-10-08 20:04:11 (1089003): Detected: Remote Desktop Enabled (localhost:64986)
2019-10-08 20:04:11 (1089003): Preference change detected
2019-10-08 20:04:11 (1089003): Setting CPU throttle for VM. (100%)
2019-10-08 20:04:11 (1089003): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-10-08 20:04:13 (1089003): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-10-08 20:04:13 (1089003): Guest Log: BIOS: Booting from Hard Disk...
2019-10-08 20:04:15 (1089003): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-10-08 20:04:15 (1089003): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2019-10-08 20:04:15 (1089003): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2019-10-08 20:04:18 (1089003): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-10-08 20:04:18 (1089003): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-10-08 20:04:20 (1089003): Guest Log: Checking CVMFS...
2019-10-08 20:04:23 (1089003): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2019-10-08 20:04:23 (1089003): Guest Log: 00:00:00.000178 main     Log opened 2019-10-08T20:04:21.984203000Z
2019-10-08 20:04:23 (1089003): Guest Log: 00:00:00.000259 main     OS Product: Linux
2019-10-08 20:04:23 (1089003): Guest Log: 00:00:00.000285 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2019-10-08 20:04:23 (1089003): Guest Log: 00:00:00.000304 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2019-10-08 20:04:23 (1089003): Guest Log: 00:00:00.000322 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2019-10-08 20:04:23 (1089003): Guest Log: 00:00:00.000322 main     Process ID: 1694
2019-10-08 20:04:23 (1089003): Guest Log: 00:00:00.000323 main     Package type: LINUX_64BITS_GENERIC
2019-10-08 20:04:23 (1089003): Guest Log: 00:00:00.001423 main     5.2.32 r132073 started. Verbose level = 0
2019-10-08 20:04:25 (1089003): Guest Log: CVMFS is ok
2019-10-08 20:04:25 (1089003): Guest Log: Mounting shared directory
2019-10-08 20:04:26 (1089003): Guest Log: Copying input files
2019-10-08 20:04:27 (1089003): Guest Log: Copied input files into RunAtlas.
2019-10-08 20:04:28 (1089003): Guest Log: copied the webapp to /var/www
2019-10-08 20:04:28 (1089003): Guest Log: set up http_proxy http://pcoslo5:3128
2019-10-08 20:04:28 (1089003): Guest Log: Detected squid proxy http://pcoslo5:3128 - will set in /etc/cvmfs/default.local
2019-10-08 20:04:33 (1089003): Guest Log: 00:00:10.007615 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 188 856 453 000ns (GuestNow=1 570 557 873 130 073 000 ns GuestLast=1 570 565 061 986 526 000 ns fSetTimeLastLoop=true )
2019-10-08 20:06:33 (1089003): Guest Log: ATHENA_PROC_NUMBER=4
2019-10-08 20:06:34 (1089003): Guest Log:  *** Starting ATLAS job. (PandaID=4002876565 taskID=000649-4) ***
2019-10-08 20:18:58 (1089003): Guest Log:  *** Job finished ***
2019-10-08 20:18:58 (1089003): Guest Log:  *** The last 20 lines of the pilot log: ***
2019-10-08 20:18:58 (1089003): Guest Log: 2019-10-08 18:18:58 UTC [wrapper] apfmon messages muted
2019-10-08 20:18:58 (1089003): Guest Log: ---- find pandaID.out ----
2019-10-08 20:18:58 (1089003): Guest Log: total 56
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------.  1 atlas atlas 11357 Jul 25 14:38 LICENSE
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------.  1 atlas atlas    20 Sep  9 11:04 MANIFEST.IN
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------.  1 atlas atlas    11 Oct  8 18:06 pandaIDs.out
2019-10-08 20:18:58 (1089003): Guest Log: drwx------. 14 atlas atlas   216 Oct  8 18:06 pilot
2019-10-08 20:18:58 (1089003): Guest Log: -rwx------.  1 atlas atlas 20136 Sep  9 11:04 pilot.py
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------.  1 atlas atlas     9 Sep  9 11:04 PILOTVERSION
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------.  1 atlas atlas  2251 Jul 25 14:38 README.md
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------.  1 atlas atlas   760 Aug 22 09:01 setup.py
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------.  1 atlas atlas   221 Jul 25 14:38 TODO.md
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas 11 Oct  8 18:06 /home/atlas/RunAtlas/pilot2/pandaIDs.out
2019-10-08 20:18:58 (1089003): Guest Log: 4002876565
2019-10-08 20:18:58 (1089003): Guest Log: 2019-10-08 18:18:58 UTC [wrapper] Test setup, not cleaning
2019-10-08 20:18:58 (1089003): Guest Log: 2019-10-08 18:18:58 UTC [wrapper] ==== wrapper stdout END ====
2019-10-08 20:18:58 (1089003): Guest Log: 2019-10-08 18:18:58 UTC [wrapper] ==== wrapper stderr END ====
2019-10-08 20:18:58 (1089003): Guest Log: 2019-10-08 18:18:58 UTC [wrapper] wrapper wrapperexiting ec=0, duration=744
2019-10-08 20:18:58 (1089003): Guest Log: 2019-10-08 18:18:58 UTC [wrapper] apfmon messages muted
2019-10-08 20:18:58 (1089003): Guest Log:  *** Error codes and diagnostics ***
2019-10-08 20:18:58 (1089003): Guest Log:     "exeErrorCode": 0,
2019-10-08 20:18:58 (1089003): Guest Log:     "exeErrorDiag": "",
2019-10-08 20:18:58 (1089003): Guest Log:     "pilotErrorCode": 0,
2019-10-08 20:18:58 (1089003): Guest Log:     "pilotErrorDiag": "",
2019-10-08 20:18:58 (1089003): Guest Log:  *** Listing of results directory ***
2019-10-08 20:18:58 (1089003): Guest Log: total 22532
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 atlas atlas  259319 Sep 16 09:27 pilot2.tar.gz
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 atlas atlas    4480 Sep 16 09:35 queuedata.json
2019-10-08 20:18:58 (1089003): Guest Log: -rwx------. 1 atlas atlas   12641 Sep 16 09:36 runpilot2-wrapper.sh
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas    2938 Sep 16 09:36 pandaJobData.out
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 atlas atlas  267447 Oct  8 18:04 input.tar.gz
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 atlas atlas     815 Oct  8 18:04 RTE.tar.gz
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 atlas atlas    8465 Oct  8 18:04 start_atlas.sh
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 atlas atlas    6280 Oct  8 18:04 init_data.xml
2019-10-08 20:18:58 (1089003): Guest Log: lrwxrwxrwx. 1 atlas atlas      20 Oct  8 18:04 EVNT.14296418._001447.pool.root.1 -> /data/./ATLAS.root_0
2019-10-08 20:18:58 (1089003): Guest Log: drwxr-xr-x. 3 atlas atlas      17 Oct  8 18:06 APPS
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas     240 Oct  8 18:06 setup.sh.local
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas 3936114 Oct  8 18:06 agis_schedconf.cvmfs.json
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas 7613799 Oct  8 18:06 agis_ddmendpoints.json
2019-10-08 20:18:58 (1089003): Guest Log: drwx------. 3 atlas atlas     229 Oct  8 18:06 pilot2
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas 9100715 Oct  8 18:17 HITS.000649-402071-4901._078090.pool.root.1
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas     834 Oct  8 18:18 memory_monitor_summary.json
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas  711360 Oct  8 18:18 log.000649-402071-4901._078090.job.log.tgz.1
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas   11008 Oct  8 18:18 heartbeat.json
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas   13076 Oct  8 18:18 pilotlog.txt
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas  162457 Oct  8 18:18 log.14568781._078090.job.log.1
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas     504 Oct  8 18:18 wP2MDmKc2TvnShfckohDCDFpABFKDmABFKDmQ6FKDmRFFKDmEnKIvn.diag
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 atlas atlas    7761 Oct  8 18:18 runtime_log.err
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas     493 Oct  8 18:18 output.list
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 atlas atlas     716 Oct  8 18:18 runtime_log
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas  901120 Oct  8 18:18 result.tar.gz
2019-10-08 20:18:58 (1089003): Guest Log: Looking for outputfile HITS.000649-402071-4901._078090.pool.root.1
2019-10-08 20:18:58 (1089003): Guest Log: HITS file was successfully produced
2019-10-08 20:18:58 (1089003): Guest Log: -rw-------. 1 atlas atlas 9100715 Oct  8 18:17 /home/atlas/RunAtlas/HITS.000649-402071-4901._078090.pool.root.1
2019-10-08 20:18:58 (1089003): Guest Log: Successfully finished the ATLAS job!
2019-10-08 20:18:58 (1089003): Guest Log: Copying the results back to the shared directory!
2019-10-08 20:18:58 (1089003): Guest Log:  *** Contents of shared directory: ***
2019-10-08 20:18:58 (1089003): Guest Log: total 366748
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 root root 365251149 Oct  8 18:04 ATLAS.root_0
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 root root   9100715 Oct  8 18:17 HITS.pool.root.1
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 root root      6280 Oct  8 18:04 init_data.xml
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 root root    267447 Oct  8 18:04 input.tar.gz
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 root root    901120 Oct  8 18:18 result.tar.gz
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 root root       815 Oct  8 18:04 RTE.tar.gz
2019-10-08 20:18:58 (1089003): Guest Log: -rw-r--r--. 1 root root      8465 Oct  8 18:04 start_atlas.sh
2019-10-08 20:18:58 (1089003): Guest Log:  *** Success! Shutting down the machine. ***
2019-10-08 20:18:58 (1089003): VM Completion File Detected.
2019-10-08 20:18:58 (1089003): Powering off VM.
2019-10-08 20:18:59 (1089003): Successfully stopped VM.
2019-10-08 20:18:59 (1089003): Deregistering VM. (boinc_349edf1011f563ff, slot#0)
2019-10-08 20:18:59 (1089003): Removing network bandwidth throttle group from VM.
2019-10-08 20:18:59 (1089003): Removing storage controller(s) from VM.
2019-10-08 20:18:59 (1089003): Removing VM from VirtualBox.
2019-10-08 20:18:59 (1089003): Removing virtual disk drive from VirtualBox.
20:19:04 (1089003): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN